builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-042 starttime: 1465623579.15 results: success (0) buildid: 20160610220925 builduid: 09d13e40a44841008b89ba4b17d5834f revision: 2719065dd5a6045af640e32222b5d4359ae87000 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-10 22:39:39.151782) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-10 22:39:39.152278) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-10 22:39:39.152631) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-10 22:39:39.197691) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 22:39:39.198010) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1465617770.572704-728091675 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-10 22:39:39-- 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% 24.1M=0s 2016-06-10 22:39:40 (24.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.104330 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 22:39:39.316168) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 22:39:39.316500) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1465617770.572704-728091675 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017789 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 22:39:39.366183) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-10 22:39:39.366582) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 2719065dd5a6045af640e32222b5d4359ae87000 --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 2719065dd5a6045af640e32222b5d4359ae87000 --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=74d6aec007b0fa31a864ebd7000001f8-1465617770.572704-728091675 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-10 22:39:40,170 truncating revision to first 12 chars 2016-06-10 22:39:40,170 Setting DEBUG logging. 2016-06-10 22:39:40,170 attempt 1/10 2016-06-10 22:39:40,170 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/2719065dd5a6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-10 22:39:41,568 unpacking tar archive at: fx-team-2719065dd5a6/testing/mozharness/ program finished with exit code 0 elapsedTime=1.745006 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-10 22:39:41.129915) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-10 22:39:41.130665) ========= script_repo_revision: 2719065dd5a6045af640e32222b5d4359ae87000 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-10 22:39:41.131808) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-10 22:39:41.132529) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-10 22:39:41.145572) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2016-06-10 22:39:41.145909) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=74d6aec007b0fa31a864ebd7000001f8-1465617770.572704-728091675 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:39:42 INFO - MultiFileLogger online at 20160610 22:39:42 in /builds/slave/test 22:39:42 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 22:39:42 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 22:39:42 INFO - {'append_to_log': False, 22:39:42 INFO - 'base_work_dir': '/builds/slave/test', 22:39:42 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 22:39:42 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 22:39:42 INFO - 'branch': 'Fx-Team-Non-PGO', 22:39:42 INFO - 'buildbot_json_path': 'buildprops.json', 22:39:42 INFO - 'config_files': ('talos/linux_config.py',), 22:39:42 INFO - 'default_actions': ('clobber', 22:39:42 INFO - 'read-buildbot-config', 22:39:42 INFO - 'download-and-extract', 22:39:42 INFO - 'populate-webroot', 22:39:42 INFO - 'create-virtualenv', 22:39:42 INFO - 'install', 22:39:42 INFO - 'run-tests'), 22:39:42 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:39:42 INFO - 'download_minidump_stackwalk': True, 22:39:42 INFO - 'download_symbols': 'ondemand', 22:39:42 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:39:42 INFO - 'tooltool.py': '/tools/tooltool.py', 22:39:42 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:39:42 INFO - '/tools/misc-python/virtualenv.py')}, 22:39:42 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:39:42 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:39:42 INFO - 'installer_path': 'installer.exe', 22:39:42 INFO - 'log_level': 'info', 22:39:42 INFO - 'log_name': 'talos', 22:39:42 INFO - 'log_to_console': True, 22:39:42 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:39:42 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:39:42 INFO - 'opt_config_files': (), 22:39:42 INFO - 'pip_index': False, 22:39:42 INFO - 'sps_profile': False, 22:39:42 INFO - 'sps_profile_interval': 0, 22:39:42 INFO - 'suite': 'dromaeojs-e10s', 22:39:42 INFO - 'system_bits': '32', 22:39:42 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:39:42 INFO - 'title': 'talos-linux64-ix-042', 22:39:42 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:39:42 INFO - 'use_talos_json': True, 22:39:42 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 22:39:42 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:39:42 INFO - 'work_dir': 'build'} 22:39:42 INFO - ##### 22:39:42 INFO - ##### Running clobber step. 22:39:42 INFO - ##### 22:39:42 INFO - Running pre-action listener: _resource_record_pre_action 22:39:42 INFO - Running main action method: clobber 22:39:42 INFO - rmtree: /builds/slave/test/build 22:39:42 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 22:39:42 INFO - Running post-action listener: _resource_record_post_action 22:39:42 INFO - ##### 22:39:42 INFO - ##### Finished clobber step (success) 22:39:42 INFO - ##### 22:39:42 INFO - ##### 22:39:42 INFO - ##### Running read-buildbot-config step. 22:39:42 INFO - ##### 22:39:42 INFO - Running pre-action listener: _resource_record_pre_action 22:39:42 INFO - Running main action method: read_buildbot_config 22:39:42 INFO - Using buildbot properties: 22:39:42 INFO - { 22:39:42 INFO - "project": "", 22:39:42 INFO - "product": "firefox", 22:39:42 INFO - "script_repo_revision": "production", 22:39:42 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 22:39:42 INFO - "repository": "", 22:39:42 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 22:39:42 INFO - "buildid": "20160610220925", 22:39:42 INFO - "pgo_build": "False", 22:39:42 INFO - "basedir": "/builds/slave/test", 22:39:42 INFO - "buildnumber": 1584, 22:39:42 INFO - "slavename": "talos-linux64-ix-042", 22:39:42 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 22:39:42 INFO - "platform": "ubuntu64_hw", 22:39:42 INFO - "scheduler": "tests-fx-team-linux64-talos", 22:39:42 INFO - "branch": "fx-team", 22:39:42 INFO - "repo_path": "integration/fx-team", 22:39:42 INFO - "revision": "2719065dd5a6045af640e32222b5d4359ae87000", 22:39:42 INFO - "stage_platform": "linux64", 22:39:42 INFO - "builduid": "09d13e40a44841008b89ba4b17d5834f", 22:39:42 INFO - "slavebuilddir": "test" 22:39:42 INFO - } 22:39:42 INFO - Found installer url https://queue.taskcluster.net/v1/task/EtyFhpBfQlaK5wofT7rF7Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 22:39:42 INFO - Running post-action listener: _resource_record_post_action 22:39:42 INFO - ##### 22:39:42 INFO - ##### Finished read-buildbot-config step (success) 22:39:42 INFO - ##### 22:39:42 INFO - ##### 22:39:42 INFO - ##### Running download-and-extract step. 22:39:42 INFO - ##### 22:39:42 INFO - Running pre-action listener: _resource_record_pre_action 22:39:42 INFO - Running main action method: download_and_extract 22:39:42 INFO - mkdir: /builds/slave/test/build/tests 22:39:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:39:42 INFO - https://queue.taskcluster.net/v1/task/EtyFhpBfQlaK5wofT7rF7Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 22:39:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EtyFhpBfQlaK5wofT7rF7Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 22:39:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EtyFhpBfQlaK5wofT7rF7Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 22:39:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EtyFhpBfQlaK5wofT7rF7Q/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 22:39:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EtyFhpBfQlaK5wofT7rF7Q/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 22:39:44 INFO - Downloaded 1361 bytes. 22:39:44 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 22:39:44 INFO - Using the following test package requirements: 22:39:44 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 22:39:44 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:39:44 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 22:39:44 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:39:44 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 22:39:44 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:39:44 INFO - u'jsshell-linux-x86_64.zip'], 22:39:44 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:39:44 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 22:39:44 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 22:39:44 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:39:44 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 22:39:44 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:39:44 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 22:39:44 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:39:44 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 22:39:44 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 22:39:44 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 22:39:44 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:39:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:39:44 INFO - https://queue.taskcluster.net/v1/task/EtyFhpBfQlaK5wofT7rF7Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:39:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EtyFhpBfQlaK5wofT7rF7Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 22:39:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EtyFhpBfQlaK5wofT7rF7Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 22:39:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EtyFhpBfQlaK5wofT7rF7Q/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 22:39:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EtyFhpBfQlaK5wofT7rF7Q/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 22:39:45 INFO - Downloaded 22891347 bytes. 22:39:45 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'] 22:39:45 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 22:39:47 INFO - Return code: 0 22:39:47 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 22:39:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:39:47 INFO - https://queue.taskcluster.net/v1/task/EtyFhpBfQlaK5wofT7rF7Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:39:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EtyFhpBfQlaK5wofT7rF7Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 22:39:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EtyFhpBfQlaK5wofT7rF7Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 22:39:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EtyFhpBfQlaK5wofT7rF7Q/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 22:39:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EtyFhpBfQlaK5wofT7rF7Q/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 22:39:57 INFO - Downloaded 22891347 bytes. 22:39:57 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'] 22:39:57 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 22:39:58 INFO - Return code: 0 22:39:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:39:58 INFO - https://queue.taskcluster.net/v1/task/EtyFhpBfQlaK5wofT7rF7Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 22:39:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EtyFhpBfQlaK5wofT7rF7Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 22:39:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EtyFhpBfQlaK5wofT7rF7Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 22:39:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EtyFhpBfQlaK5wofT7rF7Q/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 22:39:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EtyFhpBfQlaK5wofT7rF7Q/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 22:39:59 INFO - Downloaded 10833377 bytes. 22:39:59 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'] 22:39:59 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 22:39:59 INFO - Return code: 0 22:39:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:39:59 INFO - https://queue.taskcluster.net/v1/task/EtyFhpBfQlaK5wofT7rF7Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 22:39:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EtyFhpBfQlaK5wofT7rF7Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 22:39:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EtyFhpBfQlaK5wofT7rF7Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 22:39:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EtyFhpBfQlaK5wofT7rF7Q/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 22:39:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EtyFhpBfQlaK5wofT7rF7Q/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 22:40:02 INFO - Downloaded 55403377 bytes. 22:40:02 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/EtyFhpBfQlaK5wofT7rF7Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 22:40:02 INFO - mkdir: /builds/slave/test/properties 22:40:02 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 22:40:02 INFO - Writing to file /builds/slave/test/properties/build_url 22:40:02 INFO - Contents: 22:40:02 INFO - build_url:https://queue.taskcluster.net/v1/task/EtyFhpBfQlaK5wofT7rF7Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 22:40:05 INFO - Running post-action listener: _resource_record_post_action 22:40:05 INFO - Running post-action listener: set_extra_try_arguments 22:40:05 INFO - ##### 22:40:05 INFO - ##### Finished download-and-extract step (success) 22:40:05 INFO - ##### 22:40:05 INFO - ##### 22:40:05 INFO - ##### Running populate-webroot step. 22:40:05 INFO - ##### 22:40:05 INFO - Running pre-action listener: _resource_record_pre_action 22:40:05 INFO - Running main action method: populate_webroot 22:40:05 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:40:05 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:40:05 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:40:05 INFO - '--tppagecycles', 22:40:05 INFO - '7'], 22:40:05 INFO - 'tests': ['tsvgm']}}, 22:40:05 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 22:40:05 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:40:05 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 22:40:05 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 22:40:05 INFO - 'tests': ['dromaeo_css', 'kraken']}, 22:40:05 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 22:40:05 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:40:05 INFO - 'talos_options': ['--disable-e10s'], 22:40:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:40:05 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:40:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:40:05 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:40:05 INFO - 'talos_options': ['--disable-e10s'], 22:40:05 INFO - 'tests': ['damp', 'tps']}, 22:40:05 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:40:05 INFO - 'tests': ['damp', 'tps']}, 22:40:05 INFO - 'g3': {'talos_options': ['--disable-e10s'], 22:40:05 INFO - 'tests': ['dromaeo_dom']}, 22:40:05 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:40:05 INFO - 'other': {'talos_options': ['--disable-e10s'], 22:40:05 INFO - 'tests': ['a11yr', 22:40:05 INFO - 'ts_paint', 22:40:05 INFO - 'tpaint', 22:40:05 INFO - 'sessionrestore', 22:40:05 INFO - 'sessionrestore_no_auto_restore', 22:40:05 INFO - 'tabpaint']}, 22:40:05 INFO - 'other-e10s': {'tests': ['a11yr', 22:40:05 INFO - 'ts_paint', 22:40:05 INFO - 'tpaint', 22:40:05 INFO - 'sessionrestore', 22:40:05 INFO - 'sessionrestore_no_auto_restore', 22:40:05 INFO - 'tabpaint']}, 22:40:05 INFO - 'other-e10s_l64': {'tests': ['a11yr', 22:40:05 INFO - 'ts_paint', 22:40:05 INFO - 'tpaint', 22:40:05 INFO - 'sessionrestore', 22:40:05 INFO - 'sessionrestore_no_auto_restore', 22:40:05 INFO - 'tabpaint']}, 22:40:05 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 22:40:05 INFO - 'ts_paint', 22:40:05 INFO - 'tpaint', 22:40:05 INFO - 'sessionrestore', 22:40:05 INFO - 'sessionrestore_no_auto_restore', 22:40:05 INFO - 'tabpaint']}, 22:40:05 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 22:40:05 INFO - 'tests': ['a11yr', 22:40:05 INFO - 'ts_paint', 22:40:05 INFO - 'tpaint', 22:40:05 INFO - 'sessionrestore', 22:40:05 INFO - 'sessionrestore_no_auto_restore', 22:40:05 INFO - 'tabpaint']}, 22:40:05 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 22:40:05 INFO - 'tests': ['a11yr', 22:40:05 INFO - 'ts_paint', 22:40:05 INFO - 'tpaint', 22:40:05 INFO - 'sessionrestore', 22:40:05 INFO - 'sessionrestore_no_auto_restore', 22:40:05 INFO - 'tabpaint']}, 22:40:05 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 22:40:05 INFO - 'tests': ['tsvgx', 22:40:05 INFO - 'tsvgr_opacity', 22:40:05 INFO - 'tart', 22:40:05 INFO - 'tscrollx', 22:40:05 INFO - 'cart']}, 22:40:05 INFO - 'svgr-e10s': {'tests': ['tsvgx', 22:40:05 INFO - 'tsvgr_opacity', 22:40:05 INFO - 'tart', 22:40:05 INFO - 'tscrollx', 22:40:05 INFO - 'cart']}, 22:40:05 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:40:05 INFO - 'talos_options': ['--disable-e10s'], 22:40:05 INFO - 'tests': ['tp5o']}, 22:40:05 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:40:05 INFO - 'tests': ['tp5o']}, 22:40:05 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:40:05 INFO - 'talos_options': ['--disable-e10s', 22:40:05 INFO - '--xperf_path', 22:40:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:40:05 INFO - 'tests': ['tp5n']}, 22:40:05 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:40:05 INFO - 'talos_options': ['--xperf_path', 22:40:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:40:05 INFO - 'tests': ['tp5n']}}, 22:40:05 INFO - 'talos.zip': {'path': '', 22:40:05 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:40:05 INFO - Running post-action listener: _resource_record_post_action 22:40:05 INFO - ##### 22:40:05 INFO - ##### Finished populate-webroot step (success) 22:40:05 INFO - ##### 22:40:05 INFO - ##### 22:40:05 INFO - ##### Running create-virtualenv step. 22:40:05 INFO - ##### 22:40:05 INFO - Running pre-action listener: _resource_record_pre_action 22:40:05 INFO - Running main action method: create_virtualenv 22:40:05 INFO - Creating virtualenv /builds/slave/test/build/venv 22:40:05 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 22:40:05 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 22:40:05 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:40:05 INFO - Using real prefix '/usr' 22:40:05 INFO - New python executable in /builds/slave/test/build/venv/bin/python 22:40:05 INFO - Installing distribute.............................................................................................................................................................................................done. 22:40:07 INFO - Installing pip.................done. 22:40:07 INFO - Return code: 0 22:40:07 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22:40: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')]} 22:40:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:40:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:40: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')]} 22:40:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:40:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:40:07 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 0x7f27f9182f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf5e020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xff02e0>, '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 0xf5c140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf5c5d0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1465617770.572704-728091675', '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 22:40:07 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 22:40:07 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 22:40:07 INFO - Using env: {'DISPLAY': ':0', 22:40:07 INFO - 'HOME': '/home/cltbld', 22:40:07 INFO - 'LANG': 'en_US.UTF-8', 22:40:07 INFO - 'LANGUAGE': 'en_US:en', 22:40:07 INFO - 'LOGNAME': 'cltbld', 22:40:07 INFO - 'MAIL': '/var/mail/cltbld', 22:40:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:40:07 INFO - 'MOZ_NO_REMOTE': '1', 22:40:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:40:07 INFO - 'NO_EM_RESTART': '1', 22:40:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:40:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:40:07 INFO - 'PWD': '/builds/slave/test', 22:40:07 INFO - 'SHELL': '/bin/bash', 22:40:07 INFO - 'SHLVL': '1', 22:40:07 INFO - 'TERM': 'linux', 22:40:07 INFO - 'TMOUT': '86400', 22:40:07 INFO - 'USER': 'cltbld', 22:40:07 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1465617770.572704-728091675', 22:40:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:40:07 INFO - '_': '/tools/buildbot/bin/python'} 22:40:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:40:08 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 22:40:08 INFO - Cleaning up... 22:40:08 INFO - Return code: 0 22:40:08 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 22:40: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')]} 22:40:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:40:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:40: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')]} 22:40:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:40:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:40:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f27f9182f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf5e020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xff02e0>, '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 0xf5c140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf5c5d0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1465617770.572704-728091675', '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 22:40:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 22:40:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 22:40:08 INFO - Using env: {'DISPLAY': ':0', 22:40:08 INFO - 'HOME': '/home/cltbld', 22:40:08 INFO - 'LANG': 'en_US.UTF-8', 22:40:08 INFO - 'LANGUAGE': 'en_US:en', 22:40:08 INFO - 'LOGNAME': 'cltbld', 22:40:08 INFO - 'MAIL': '/var/mail/cltbld', 22:40:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:40:08 INFO - 'MOZ_NO_REMOTE': '1', 22:40:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:40:08 INFO - 'NO_EM_RESTART': '1', 22:40:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:40:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:40:08 INFO - 'PWD': '/builds/slave/test', 22:40:08 INFO - 'SHELL': '/bin/bash', 22:40:08 INFO - 'SHLVL': '1', 22:40:08 INFO - 'TERM': 'linux', 22:40:08 INFO - 'TMOUT': '86400', 22:40:08 INFO - 'USER': 'cltbld', 22:40:08 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1465617770.572704-728091675', 22:40:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:40:08 INFO - '_': '/tools/buildbot/bin/python'} 22:40:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:40:08 INFO - Downloading/unpacking psutil>=3.1.1 22:40:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:40:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:40:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:40:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:40:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:40:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:40:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:40:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:40:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:40:10 INFO - Installing collected packages: psutil 22:40:10 INFO - Running setup.py install for psutil 22:40:10 INFO - building 'psutil._psutil_linux' extension 22:40:10 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 22:40:10 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 22:40:10 INFO - building 'psutil._psutil_posix' extension 22:40:10 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 22:40:10 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 22:40:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:40:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:40:10 INFO - Successfully installed psutil 22:40:10 INFO - Cleaning up... 22:40:10 INFO - Return code: 0 22:40:10 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 22:40:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:40:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:40:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:40:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:40:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:40:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:40:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f27f9182f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf5e020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xff02e0>, '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 0xf5c140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf5c5d0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1465617770.572704-728091675', '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 22:40:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 22:40:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 22:40:10 INFO - Using env: {'DISPLAY': ':0', 22:40:10 INFO - 'HOME': '/home/cltbld', 22:40:10 INFO - 'LANG': 'en_US.UTF-8', 22:40:10 INFO - 'LANGUAGE': 'en_US:en', 22:40:10 INFO - 'LOGNAME': 'cltbld', 22:40:10 INFO - 'MAIL': '/var/mail/cltbld', 22:40:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:40:10 INFO - 'MOZ_NO_REMOTE': '1', 22:40:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:40:10 INFO - 'NO_EM_RESTART': '1', 22:40:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:40:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:40:10 INFO - 'PWD': '/builds/slave/test', 22:40:10 INFO - 'SHELL': '/bin/bash', 22:40:10 INFO - 'SHLVL': '1', 22:40:10 INFO - 'TERM': 'linux', 22:40:10 INFO - 'TMOUT': '86400', 22:40:10 INFO - 'USER': 'cltbld', 22:40:10 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1465617770.572704-728091675', 22:40:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:40:10 INFO - '_': '/tools/buildbot/bin/python'} 22:40:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:40:10 INFO - Downloading/unpacking mozsystemmonitor==0.3 22:40:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:40:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:40:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:40:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:40:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:40:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:40:12 INFO - Downloading mozsystemmonitor-0.3.tar.gz 22:40:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:40:12 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 22:40:12 INFO - Installing collected packages: mozsystemmonitor 22:40:12 INFO - Running setup.py install for mozsystemmonitor 22:40:13 INFO - Successfully installed mozsystemmonitor 22:40:13 INFO - Cleaning up... 22:40:13 INFO - Return code: 0 22:40:13 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 22:40:13 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')]} 22:40:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:40:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:40:13 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')]} 22:40:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:40:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:40:13 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 0x7f27f9182f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf5e020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xff02e0>, '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 0xf5c140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf5c5d0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1465617770.572704-728091675', '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 22:40:13 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 22:40:13 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 22:40:13 INFO - Using env: {'DISPLAY': ':0', 22:40:13 INFO - 'HOME': '/home/cltbld', 22:40:13 INFO - 'LANG': 'en_US.UTF-8', 22:40:13 INFO - 'LANGUAGE': 'en_US:en', 22:40:13 INFO - 'LOGNAME': 'cltbld', 22:40:13 INFO - 'MAIL': '/var/mail/cltbld', 22:40:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:40:13 INFO - 'MOZ_NO_REMOTE': '1', 22:40:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:40:13 INFO - 'NO_EM_RESTART': '1', 22:40:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:40:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:40:13 INFO - 'PWD': '/builds/slave/test', 22:40:13 INFO - 'SHELL': '/bin/bash', 22:40:13 INFO - 'SHLVL': '1', 22:40:13 INFO - 'TERM': 'linux', 22:40:13 INFO - 'TMOUT': '86400', 22:40:13 INFO - 'USER': 'cltbld', 22:40:13 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1465617770.572704-728091675', 22:40:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:40:13 INFO - '_': '/tools/buildbot/bin/python'} 22:40:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:40:13 INFO - Downloading/unpacking jsonschema==2.5.1 22:40:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:40:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:40:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:40:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:40:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:40:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:40:15 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:40:15 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 22:40:15 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 22:40:15 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 22:40:15 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 22:40:15 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 22:40:15 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 22:40:15 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 22:40:15 INFO - Downloading functools32-3.2.3-2.tar.gz 22:40:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 22:40:15 INFO - warning: no files found matching '*.txt' 22:40:15 INFO - no previously-included directories found matching 'build' 22:40:15 INFO - no previously-included directories found matching 'dist' 22:40:15 INFO - no previously-included directories found matching '.git*' 22:40:15 INFO - Installing collected packages: jsonschema, functools32 22:40:15 INFO - Running setup.py install for functools32 22:40:15 INFO - warning: no files found matching '*.txt' 22:40:15 INFO - no previously-included directories found matching 'build' 22:40:15 INFO - no previously-included directories found matching 'dist' 22:40:15 INFO - no previously-included directories found matching '.git*' 22:40:15 INFO - Successfully installed jsonschema functools32 22:40:15 INFO - Cleaning up... 22:40:15 INFO - Return code: 0 22:40:15 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22:40:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:40:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:40:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:40:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:40:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:40:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:40:15 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 0x7f27f9182f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf5e020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xff02e0>, '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 0xf5c140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf5c5d0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1465617770.572704-728091675', '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 22:40:15 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 22:40:15 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 22:40:15 INFO - Using env: {'DISPLAY': ':0', 22:40:15 INFO - 'HOME': '/home/cltbld', 22:40:15 INFO - 'LANG': 'en_US.UTF-8', 22:40:15 INFO - 'LANGUAGE': 'en_US:en', 22:40:15 INFO - 'LOGNAME': 'cltbld', 22:40:15 INFO - 'MAIL': '/var/mail/cltbld', 22:40:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:40:15 INFO - 'MOZ_NO_REMOTE': '1', 22:40:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:40:15 INFO - 'NO_EM_RESTART': '1', 22:40:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:40:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:40:15 INFO - 'PWD': '/builds/slave/test', 22:40:15 INFO - 'SHELL': '/bin/bash', 22:40:15 INFO - 'SHLVL': '1', 22:40:15 INFO - 'TERM': 'linux', 22:40:15 INFO - 'TMOUT': '86400', 22:40:15 INFO - 'USER': 'cltbld', 22:40:15 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1465617770.572704-728091675', 22:40:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:40:15 INFO - '_': '/tools/buildbot/bin/python'} 22:40:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:40:15 INFO - Downloading/unpacking blobuploader==1.2.4 22:40:15 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 22:40:15 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 22:40:15 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 22:40:15 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 22:40:15 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 22:40:15 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 22:40:17 INFO - Downloading blobuploader-1.2.4.tar.gz 22:40:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:40:17 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:40:17 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 22:40:17 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 22:40:17 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 22:40:17 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 22:40:17 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 22:40:17 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 22:40:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:40:18 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:40:18 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 22:40:18 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 22:40:18 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 22:40:18 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 22:40:18 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 22:40:18 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 22:40:18 INFO - Downloading docopt-0.6.1.tar.gz 22:40:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:40:18 INFO - Installing collected packages: blobuploader, requests, docopt 22:40:18 INFO - Running setup.py install for blobuploader 22:40:18 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:40:18 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:40:18 INFO - Running setup.py install for requests 22:40:18 INFO - Running setup.py install for docopt 22:40:19 INFO - Successfully installed blobuploader requests docopt 22:40:19 INFO - Cleaning up... 22:40:19 INFO - Return code: 0 22:40:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:40: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')]} 22:40:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:40:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:40: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')]} 22:40:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:40:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:40:19 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 0x7f27f9182f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf5e020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xff02e0>, '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 0xf5c140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf5c5d0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1465617770.572704-728091675', '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 22:40:19 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 22:40:19 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 22:40:19 INFO - Using env: {'DISPLAY': ':0', 22:40:19 INFO - 'HOME': '/home/cltbld', 22:40:19 INFO - 'LANG': 'en_US.UTF-8', 22:40:19 INFO - 'LANGUAGE': 'en_US:en', 22:40:19 INFO - 'LOGNAME': 'cltbld', 22:40:19 INFO - 'MAIL': '/var/mail/cltbld', 22:40:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:40:19 INFO - 'MOZ_NO_REMOTE': '1', 22:40:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:40:19 INFO - 'NO_EM_RESTART': '1', 22:40:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:40:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:40:19 INFO - 'PWD': '/builds/slave/test', 22:40:19 INFO - 'SHELL': '/bin/bash', 22:40:19 INFO - 'SHLVL': '1', 22:40:19 INFO - 'TERM': 'linux', 22:40:19 INFO - 'TMOUT': '86400', 22:40:19 INFO - 'USER': 'cltbld', 22:40:19 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1465617770.572704-728091675', 22:40:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:40:19 INFO - '_': '/tools/buildbot/bin/python'} 22:40:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:40:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:40:19 INFO - Running setup.py (path:/tmp/pip-2XGK36-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:40:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:40:19 INFO - Running setup.py (path:/tmp/pip-dZ5PyZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:40:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:40:19 INFO - Running setup.py (path:/tmp/pip-oOJKyk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:40:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:40:19 INFO - Running setup.py (path:/tmp/pip-BFZDYN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:40:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:40:19 INFO - Running setup.py (path:/tmp/pip-00aVW8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:40:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:40:19 INFO - Running setup.py (path:/tmp/pip-dtO8dG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:40:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:40:19 INFO - Running setup.py (path:/tmp/pip-wSp7vh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:40:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:40:19 INFO - Running setup.py (path:/tmp/pip-ipUWsa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:40:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:40:19 INFO - Running setup.py (path:/tmp/pip-vomWjC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:40:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:40:19 INFO - Running setup.py (path:/tmp/pip-XVT0_U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:40:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:40:20 INFO - Running setup.py (path:/tmp/pip-yxvQyk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:40:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:40:20 INFO - Running setup.py (path:/tmp/pip-oj9cck-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:40:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:40:20 INFO - Running setup.py (path:/tmp/pip-qBdNda-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:40:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:40:20 INFO - Running setup.py (path:/tmp/pip-XynTW3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:40:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:40:20 INFO - Running setup.py (path:/tmp/pip-zLndWF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:40:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:40:20 INFO - Running setup.py (path:/tmp/pip-hM92ho-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:40:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:40:20 INFO - Running setup.py (path:/tmp/pip-ZGdpSB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:40:20 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:40:20 INFO - Running setup.py install for manifestparser 22:40:20 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:40:20 INFO - Running setup.py install for mozcrash 22:40:20 INFO - Running setup.py install for mozdebug 22:40:20 INFO - Running setup.py install for mozdevice 22:40:21 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 22:40:21 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:40:21 INFO - Running setup.py install for mozfile 22:40:21 INFO - Running setup.py install for mozhttpd 22:40:21 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:40:21 INFO - Running setup.py install for mozinfo 22:40:21 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:40:21 INFO - Running setup.py install for mozInstall 22:40:21 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:40:21 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:40:21 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:40:21 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:40:21 INFO - Running setup.py install for mozleak 22:40:21 INFO - Running setup.py install for mozlog 22:40:21 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:40:21 INFO - Running setup.py install for moznetwork 22:40:21 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:40:21 INFO - Running setup.py install for mozprocess 22:40:21 INFO - Running setup.py install for mozprofile 22:40:21 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:40:21 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:40:21 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:40:21 INFO - Running setup.py install for mozrunner 22:40:22 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:40:22 INFO - Running setup.py install for mozscreenshot 22:40:22 INFO - Running setup.py install for moztest 22:40:22 INFO - Running setup.py install for mozversion 22:40:22 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:40:22 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:40:22 INFO - Cleaning up... 22:40:22 INFO - Return code: 0 22:40:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:40:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:40:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:40:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:40:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:40:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:40:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:40:22 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 0x7f27f9182f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf5e020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xff02e0>, '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 0xf5c140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf5c5d0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1465617770.572704-728091675', '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 22:40:22 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 22:40:22 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 22:40:22 INFO - Using env: {'DISPLAY': ':0', 22:40:22 INFO - 'HOME': '/home/cltbld', 22:40:22 INFO - 'LANG': 'en_US.UTF-8', 22:40:22 INFO - 'LANGUAGE': 'en_US:en', 22:40:22 INFO - 'LOGNAME': 'cltbld', 22:40:22 INFO - 'MAIL': '/var/mail/cltbld', 22:40:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:40:22 INFO - 'MOZ_NO_REMOTE': '1', 22:40:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:40:22 INFO - 'NO_EM_RESTART': '1', 22:40:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:40:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:40:22 INFO - 'PWD': '/builds/slave/test', 22:40:22 INFO - 'SHELL': '/bin/bash', 22:40:22 INFO - 'SHLVL': '1', 22:40:22 INFO - 'TERM': 'linux', 22:40:22 INFO - 'TMOUT': '86400', 22:40:22 INFO - 'USER': 'cltbld', 22:40:22 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1465617770.572704-728091675', 22:40:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:40:22 INFO - '_': '/tools/buildbot/bin/python'} 22:40:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:40:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:40:22 INFO - Running setup.py (path:/tmp/pip-jeb5t5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:40:22 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)) 22:40:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:40:22 INFO - Running setup.py (path:/tmp/pip-Jh_uQ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:40:22 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)) 22:40:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:40:22 INFO - Running setup.py (path:/tmp/pip-Ld9wgA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:40:22 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)) 22:40:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:40:22 INFO - Running setup.py (path:/tmp/pip-_qUSx_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:40:22 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)) 22:40:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:40:22 INFO - Running setup.py (path:/tmp/pip-uManRY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:40:22 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)) 22:40:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:40:22 INFO - Running setup.py (path:/tmp/pip-fTNSgL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:40:23 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)) 22:40:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:40:23 INFO - Running setup.py (path:/tmp/pip-3BNAUX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:40:23 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)) 22:40:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:40:23 INFO - Running setup.py (path:/tmp/pip-feq0hY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:40:23 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)) 22:40:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:40:23 INFO - Running setup.py (path:/tmp/pip-P4VZ5W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:40:23 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)) 22:40:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:40:23 INFO - Running setup.py (path:/tmp/pip-Xy0iYR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:40:23 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)) 22:40:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:40:23 INFO - Running setup.py (path:/tmp/pip-QJgXJR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:40:23 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)) 22:40:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:40:23 INFO - Running setup.py (path:/tmp/pip-LiHv2a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:40:23 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)) 22:40:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:40:23 INFO - Running setup.py (path:/tmp/pip-XsgaEV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:40:23 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)) 22:40:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:40:23 INFO - Running setup.py (path:/tmp/pip-O9bIze-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:40:23 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)) 22:40:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:40:23 INFO - Running setup.py (path:/tmp/pip-BED2Vs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:40:23 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)) 22:40:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:40:23 INFO - Running setup.py (path:/tmp/pip-Y_BODM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:40:23 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)) 22:40:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:40:23 INFO - Running setup.py (path:/tmp/pip-qpM02e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:40:23 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)) 22:40:23 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)) 22:40:23 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)) 22:40:23 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)) 22:40:23 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)) 22:40:23 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)) 22:40:23 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:40: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 22:40: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 22:40: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 22:40: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 22:40: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 22:40: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 22:40:25 INFO - Downloading blessings-1.6.tar.gz 22:40:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:40:25 INFO - Installing collected packages: blessings 22:40:25 INFO - Running setup.py install for blessings 22:40:25 INFO - Successfully installed blessings 22:40:25 INFO - Cleaning up... 22:40:26 INFO - Return code: 0 22:40:26 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:40:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:40:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:40:26 INFO - Reading from file tmpfile_stdout 22:40:26 INFO - Current package versions: 22:40:26 INFO - argparse == 1.2.1 22:40:26 INFO - blessings == 1.6 22:40:26 INFO - blobuploader == 1.2.4 22:40:26 INFO - docopt == 0.6.1 22:40:26 INFO - functools32 == 3.2.3-2 22:40:26 INFO - jsonschema == 2.5.1 22:40:26 INFO - manifestparser == 1.1 22:40:26 INFO - mozInstall == 1.12 22:40:26 INFO - mozcrash == 0.17 22:40:26 INFO - mozdebug == 0.1 22:40:26 INFO - mozdevice == 0.48 22:40:26 INFO - mozfile == 1.2 22:40:26 INFO - mozhttpd == 0.7 22:40:26 INFO - mozinfo == 0.9 22:40:26 INFO - mozleak == 0.1 22:40:26 INFO - mozlog == 3.2 22:40:26 INFO - moznetwork == 0.27 22:40:26 INFO - mozprocess == 0.22 22:40:26 INFO - mozprofile == 0.28 22:40:26 INFO - mozrunner == 6.11 22:40:26 INFO - mozscreenshot == 0.1 22:40:26 INFO - mozsystemmonitor == 0.3 22:40:26 INFO - moztest == 0.7 22:40:26 INFO - mozversion == 1.4 22:40:26 INFO - psutil == 3.1.1 22:40:26 INFO - requests == 1.2.3 22:40:26 INFO - wsgiref == 0.1.2 22:40:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:40:26 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')]} 22:40:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:40:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:40:26 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')]} 22:40:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:40:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:40:26 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 0x7f27f9182f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf5e020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xff02e0>, '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 0xf5c140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf5c5d0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1465617770.572704-728091675', '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 22:40:26 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 22:40:26 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 22:40:26 INFO - Using env: {'DISPLAY': ':0', 22:40:26 INFO - 'HOME': '/home/cltbld', 22:40:26 INFO - 'LANG': 'en_US.UTF-8', 22:40:26 INFO - 'LANGUAGE': 'en_US:en', 22:40:26 INFO - 'LOGNAME': 'cltbld', 22:40:26 INFO - 'MAIL': '/var/mail/cltbld', 22:40:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:40:26 INFO - 'MOZ_NO_REMOTE': '1', 22:40:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:40:26 INFO - 'NO_EM_RESTART': '1', 22:40:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:40:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:40:26 INFO - 'PWD': '/builds/slave/test', 22:40:26 INFO - 'SHELL': '/bin/bash', 22:40:26 INFO - 'SHLVL': '1', 22:40:26 INFO - 'TERM': 'linux', 22:40:26 INFO - 'TMOUT': '86400', 22:40:26 INFO - 'USER': 'cltbld', 22:40:26 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1465617770.572704-728091675', 22:40:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:40:26 INFO - '_': '/tools/buildbot/bin/python'} 22:40:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:40:26 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)) 22:40:26 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)) 22:40:26 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)) 22:40:26 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)) 22:40:26 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)) 22:40:26 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)) 22:40:26 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)) 22:40:26 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)) 22:40:26 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)) 22:40:26 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)) 22:40:26 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)) 22:40:26 INFO - Cleaning up... 22:40:26 INFO - Return code: 0 22:40:26 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 22:40:26 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')]} 22:40:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:40:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:40:26 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')]} 22:40:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:40:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:40:26 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 0x7f27f9182f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf5e020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xff02e0>, '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 0xf5c140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf5c5d0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1465617770.572704-728091675', '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 22:40:26 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 22:40:26 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 22:40:26 INFO - Using env: {'DISPLAY': ':0', 22:40:26 INFO - 'HOME': '/home/cltbld', 22:40:26 INFO - 'LANG': 'en_US.UTF-8', 22:40:26 INFO - 'LANGUAGE': 'en_US:en', 22:40:26 INFO - 'LOGNAME': 'cltbld', 22:40:26 INFO - 'MAIL': '/var/mail/cltbld', 22:40:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:40:26 INFO - 'MOZ_NO_REMOTE': '1', 22:40:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:40:26 INFO - 'NO_EM_RESTART': '1', 22:40:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:40:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:40:26 INFO - 'PWD': '/builds/slave/test', 22:40:26 INFO - 'SHELL': '/bin/bash', 22:40:26 INFO - 'SHLVL': '1', 22:40:26 INFO - 'TERM': 'linux', 22:40:26 INFO - 'TMOUT': '86400', 22:40:26 INFO - 'USER': 'cltbld', 22:40:26 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1465617770.572704-728091675', 22:40:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:40:26 INFO - '_': '/tools/buildbot/bin/python'} 22:40:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:40:26 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 22:40:26 INFO - Cleaning up... 22:40:26 INFO - Return code: 0 22:40:26 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 22:40:26 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')]} 22:40:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:40:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:40:26 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')]} 22:40:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:40:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:40:26 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 0x7f27f9182f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf5e020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xff02e0>, '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 0xf5c140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf5c5d0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1465617770.572704-728091675', '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 22:40:26 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 22:40:26 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 22:40:26 INFO - Using env: {'DISPLAY': ':0', 22:40:26 INFO - 'HOME': '/home/cltbld', 22:40:26 INFO - 'LANG': 'en_US.UTF-8', 22:40:26 INFO - 'LANGUAGE': 'en_US:en', 22:40:26 INFO - 'LOGNAME': 'cltbld', 22:40:26 INFO - 'MAIL': '/var/mail/cltbld', 22:40:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:40:26 INFO - 'MOZ_NO_REMOTE': '1', 22:40:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:40:26 INFO - 'NO_EM_RESTART': '1', 22:40:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:40:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:40:26 INFO - 'PWD': '/builds/slave/test', 22:40:26 INFO - 'SHELL': '/bin/bash', 22:40:26 INFO - 'SHLVL': '1', 22:40:26 INFO - 'TERM': 'linux', 22:40:26 INFO - 'TMOUT': '86400', 22:40:26 INFO - 'USER': 'cltbld', 22:40:26 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1465617770.572704-728091675', 22:40:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:40:26 INFO - '_': '/tools/buildbot/bin/python'} 22:40:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:40:26 INFO - Downloading/unpacking flake8 22:40: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 22:40: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 22:40: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 22:40: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 22:40: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 22:40: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 22:40:28 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 22:40:28 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 22:40:28 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 22:40:28 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 22:40:28 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 22:40:28 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 22:40:28 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 22:40:28 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 22:40:28 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 22:40:28 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 22:40:28 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 22:40:28 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 22:40:28 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 22:40:28 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 22:40:28 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 22:40:28 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 22:40:29 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 22:40:29 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 22:40:29 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 22:40:29 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 22:40:29 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 22:40:29 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 22:40:29 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 22:40:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 22:40:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:40:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:40:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:40:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:40:29 INFO - no previously-included directories found matching 'docs/_build' 22:40:29 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 22:40:29 INFO - Running setup.py install for pep8 22:40:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:40:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:40:29 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:40:29 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:40:29 INFO - no previously-included directories found matching 'docs/_build' 22:40:29 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 22:40:29 INFO - Successfully installed flake8 mccabe pyflakes pep8 22:40:29 INFO - Cleaning up... 22:40:29 INFO - Return code: 0 22:40:29 INFO - Running post-action listener: _resource_record_post_action 22:40:29 INFO - Running post-action listener: _start_resource_monitoring 22:40:29 INFO - Starting resource monitoring. 22:40:29 INFO - ##### 22:40:29 INFO - ##### Finished create-virtualenv step (success) 22:40:29 INFO - ##### 22:40:29 INFO - ##### 22:40:29 INFO - ##### Running install step. 22:40:29 INFO - ##### 22:40:29 INFO - Running pre-action listener: _resource_record_pre_action 22:40:29 INFO - Running main action method: install 22:40:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:40:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:40:29 INFO - Reading from file tmpfile_stdout 22:40:29 INFO - Detecting whether we're running mozinstall >=1.0... 22:40:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:40:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:40:30 INFO - Reading from file tmpfile_stdout 22:40:30 INFO - Output received: 22:40:30 INFO - Usage: mozinstall [options] installer 22:40:30 INFO - Options: 22:40:30 INFO - -h, --help show this help message and exit 22:40:30 INFO - -d DEST, --destination=DEST 22:40:30 INFO - Directory to install application into. [default: 22:40:30 INFO - "/builds/slave/test"] 22:40:30 INFO - --app=APP Application being installed. [default: firefox] 22:40:30 INFO - mkdir: /builds/slave/test/build/application 22:40:30 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'] 22:40:30 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 22:40:46 INFO - Reading from file tmpfile_stdout 22:40:46 INFO - Output received: 22:40:46 INFO - /builds/slave/test/build/application/firefox/firefox 22:40:46 INFO - Running post-action listener: _resource_record_post_action 22:40:46 INFO - ##### 22:40:46 INFO - ##### Finished install step (success) 22:40:46 INFO - ##### 22:40:46 INFO - ##### 22:40:46 INFO - ##### Running run-tests step. 22:40:46 INFO - ##### 22:40:46 INFO - Running pre-action listener: _resource_record_pre_action 22:40:46 INFO - Running main action method: run_tests 22:40:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:40:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:40:46 INFO - Python 2.7.3 22:40:46 INFO - Return code: 0 22:40:46 INFO - grabbing minidump binary from tooltool 22:40:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:40:46 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 0xff02e0>, '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 0xf5c140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf5c5d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:40:46 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 22:40:46 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 22:40:46 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 22:40:46 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:40:46 INFO - Return code: 0 22:40:46 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 22:40:46 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:40:46 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:40:46 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 22:40:46 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:40:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 22:40:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 22:40:47 INFO - Return code: 0 22:40:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EtyFhpBfQlaK5wofT7rF7Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-042', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 22:40:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/EtyFhpBfQlaK5wofT7rF7Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-042 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 22:40:47 INFO - Using env: {'DISPLAY': ':0', 22:40:47 INFO - 'HOME': '/home/cltbld', 22:40:47 INFO - 'LANG': 'en_US.UTF-8', 22:40:47 INFO - 'LANGUAGE': 'en_US:en', 22:40:47 INFO - 'LOGNAME': 'cltbld', 22:40:47 INFO - 'MAIL': '/var/mail/cltbld', 22:40:47 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:40:47 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 22:40:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:40:47 INFO - 'MOZ_NO_REMOTE': '1', 22:40:47 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:40:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:40:47 INFO - 'NO_EM_RESTART': '1', 22:40:47 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:40:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:40:47 INFO - 'PWD': '/builds/slave/test', 22:40:47 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:40:47 INFO - 'SHELL': '/bin/bash', 22:40:47 INFO - 'SHLVL': '1', 22:40:47 INFO - 'TERM': 'linux', 22:40:47 INFO - 'TMOUT': '86400', 22:40:47 INFO - 'USER': 'cltbld', 22:40:47 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1465617770.572704-728091675', 22:40:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:40:47 INFO - '_': '/tools/buildbot/bin/python'} 22:40:47 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EtyFhpBfQlaK5wofT7rF7Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-042', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 22:40:47 INFO - mozversion application_buildid: 20160610220925 22:40:47 INFO - mozversion application_changeset: 2719065dd5a6045af640e32222b5d4359ae87000 22:40:47 INFO - mozversion application_display_name: Nightly 22:40:47 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:40:47 INFO - mozversion application_name: Firefox 22:40:47 INFO - mozversion application_remotingname: firefox 22:40:47 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 22:40:47 INFO - mozversion application_vendor: Mozilla 22:40:47 INFO - mozversion application_version: 50.0a1 22:40:47 INFO - mozversion platform_buildid: 20160610220925 22:40:47 INFO - mozversion platform_changeset: 2719065dd5a6045af640e32222b5d4359ae87000 22:40:47 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 22:40:47 INFO - mozversion platform_version: 50.0a1 22:40:47 INFO - using testdate: 1465623647 22:40:47 INFO - actual date: 1465623647 22:40:47 INFO - starting webserver on 'localhost:41421' 22:40:47 INFO - SUITE-START | Running 2 tests 22:40:47 INFO - TEST-START | dromaeo_css 22:40:47 INFO - operating with platform_type : linux_ 22:40:47 INFO - Initialising browser for dromaeo_css test... 22:40:47 INFO - TEST-INFO | started process 2350 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpk_pbAD/profile http://localhost:41421/getInfo.html) 22:40:52 INFO - PROCESS | 2350 | __metrics Screen width/height:1600/1200 22:40:52 INFO - PROCESS | 2350 | colorDepth:24 22:40:52 INFO - PROCESS | 2350 | Browser inner width/height: 1024/697 22:40:52 INFO - PROCESS | 2350 | __metrics 22:40:53 ERROR - PROCESS | 2350 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 22:40:53 INFO - TEST-INFO | 2350: exit 0 22:40:53 INFO - Browser initialized. 22:40:53 INFO - Running cycle 1/1 for dromaeo_css test... 22:40:53 INFO - TEST-INFO | started process 2556 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpk_pbAD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:41:06 INFO - PROCESS | 2556 | RSS: Main: 186224640 22:41:06 INFO - PROCESS | 2556 | 22:41:55 INFO - PROCESS | 2556 | 1465623715646 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] 22:44:06 INFO - PROCESS | 2556 | Cycle 1(1): loaded http://localhost:41421/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41421/tests/dromaeo/cssquery-ext.html) 22:44:07 INFO - PROCESS | 2556 | RSS: Main: 189501440 22:44:07 INFO - PROCESS | 2556 | 22:47:10 INFO - PROCESS | 2556 | Cycle 1(1): loaded http://localhost:41421/tests/dromaeo/cssquery-ext.html (next: http://localhost:41421/tests/dromaeo/cssquery-jquery.html) 22:47:10 INFO - PROCESS | 2556 | RSS: Main: 188911616 22:47:10 INFO - PROCESS | 2556 | 22:50:12 INFO - PROCESS | 2556 | Cycle 1(1): loaded http://localhost:41421/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41421/tests/dromaeo/cssquery-mootools.html) 22:50:13 INFO - PROCESS | 2556 | RSS: Main: 189603840 22:50:13 INFO - PROCESS | 2556 | 22:53:15 INFO - PROCESS | 2556 | Cycle 1(1): loaded http://localhost:41421/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41421/tests/dromaeo/cssquery-prototype.html) 22:53:15 INFO - PROCESS | 2556 | RSS: Main: 187199488 22:53:15 INFO - PROCESS | 2556 | 22:56:18 INFO - PROCESS | 2556 | Cycle 1(1): loaded http://localhost:41421/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41421/tests/dromaeo/cssquery-yui.html) 22:56:19 INFO - PROCESS | 2556 | RSS: Main: 189251584 22:56:19 INFO - PROCESS | 2556 | 22:59:22 INFO - PROCESS | 2556 | Cycle 1(1): loaded http://localhost:41421/tests/dromaeo/cssquery-yui.html (next: http://localhost:41421/tests/dromaeo/cssquery-dojo.html) 22:59:22 INFO - PROCESS | 2556 | RSS: Main: 190251008 22:59:22 INFO - PROCESS | 2556 | 22:59:22 INFO - PROCESS | 2556 | __start_tp_report 22:59:22 INFO - PROCESS | 2556 | _x_x_mozilla_page_load 22:59:22 INFO - PROCESS | 2556 | _x_x_mozilla_page_load_details 22:59:22 INFO - PROCESS | 2556 | |i|pagename|runs| 22:59:22 INFO - PROCESS | 2556 | |0;dojo.html;2599.480103979204;2641.6169655399963;2669.7196794336596;2676.4379480309135;2680.981227133689;4737.052589482105;4744.6915950463235;4790.6407019473545;4859.562639362457;4897.755112244391;4657.720536767796;4811.2302031674935;4811.3504676868615;4845.854624361275;4911.287863259825;4298.871033868981;4327.718698284617;4334.241507736149;4443.933340999887;4518.751468669222;113.59973748799666;4375.934360984572;4429.291313389858;4436.112777444508;4441.666874984373;4354.716943398669;4355.716878402894;4359.498657654347;4362.760048197348;4377.474703035656;4381.211381951248;4382.8904277393;4392.670549708752;4393.231184542692;4441.400410944513;4296.957030429687;4309.202797482476;4363.083752411997;4363.083752411997;4404.0531285773395;4744.715317080986;4792.472827988919;4797.496262892381;4803.831865884712;4805.663603547753;5122.154844450662;5126.2054381570915;5126.794928202868;5132.127538318495;5151.845444636667;5031.32077169581;5113.360829896263;5160.8967820643375;5200.92198617021;5202.401723801773;4823.9035219295765;4844.66087373884;4851.733154676492;4858.44127925286;4896.387951506062;5295.4969277918535;5295.655782374133;5315.973420132875;5330.600204984564;5331.600129990189;4939.6542242042715;4945.332380128709;4967.528084831935;5008.949910500921;5012.598992080698;5067.569256613156;5091.490850914953;5101.132807422747;5109.591232701375;5142.537171654569;4947.431045429749;5039.899202015939;5051.898962020739;5063.772130254074;5067.910399264176;4873.512648735169;4986.700797952134;5012.448630650625;5041.092603331363;5069.923951140736;4291.785410729451;4311.913761724811;4321.481422229353;4325.480942286946;4361.520232774392;3702.9814850926114;3776.9112395977695;3790.450384694204;3799.1831756172555;3865.690744740414;4427.579379958899;4445.110977804452;4476.552344765562;4480.843170489017;4482.618977386894;5085.821996230115;5139.948600514022;5152.4847515248175;5158.458361872024;5198.16829307309;4345.000649850552;4393.978030109829;4459.286514157784;4500.302453119772;4524.366588677588;4507.909841803145;4536.206163921301;4562.315652652129;4586.678932474695;4590.793414296365;4778.187708089633;4809.591184749265;4817.084753896748;4832.130216561053;4858.101251268386;5054.140796064751;5109.3613298337705;5121.8463446096675;5129.615278854027;5167.483251674953;4853.854384368475;4866.878328041686;4876.219804831352;4906.288588154626;4924;5082.466341034138;5083.364579427572;5087.058894104603;5106.336176297206;5116.539511443988;5059.139946209227;5093.2105523643895;5128.692278463304;5131.589472842089;5219.739013049409;4989.077020751172;4996.325496057985;5020.949790502048;5024.874378140429;5056.317397151338;4985.925211121908;4997.450280469073;4998.875028124326;5016.072026675077;5019.498050194951;4774.069056533943;4827.565519103157;4905.632077594123;4945.18404463274;4965.776540055634;5023.799048038038;5057.949420505748;5067.037262920034;5111.05445492585;5116.616253780907;4940.258961155855;4975.776090075883;4979.427365852974;5003.699778013331;5020.297158397901 22:59:22 INFO - PROCESS | 2556 | |1;ext.html;577.8237637520556;588.2117961931011;598.3806760003397;606.8118883146225;610.8869859076074;33112.5033124503;33807.32385352295;36200.27599448009;36283.63716362836;36389.45415818765;36515.26969460609;36740;37098.62901370992;37211;37398.62601373986;7477.06536682916;7661.885071723928;7665.655045522964;7729.8067548311465;7738.458307918448;7603.619819009055;7664.118626357985;7693.7307194248215;7712.768616941501;7719.614019299012;7700.576468294242;7741.690332386698;7743.922560774405;7744.728934487294;7752.573608451533;7649.617519124049;7661.61691915402;7676.808079797994;7678.654460549289;7683.807904802369;7557.395408367317;7614.923850761477;7643.197464266227;7652.923470765277;7666.080070391533;34591.82704086489;34673.65326346729;34895.651043489495;35074.82462587671;35127.82436087803;2298.850574712655;2709.5935609658513;2897.753690936273;2945.734883860463;2959.289770455097;27287.590686139723;27370;27585.172444826687;27642.447151056866;28683.28291792722;3434.5706786651667;3461.359648465042;3467.6358982306997;3539.7345199109914;3552.6447355264527;228264;228275;229591;229957;230655.846720767;27674.723252767617;28175.577366339523;28217;31196.376072478422;31269.530957035662;33002.504962425584;33438.66561334404;33441.49837752436;33569;33660.158496037795;13424.932875335757;13483.865161348458;13581.45674173022;13613.047086704033;13622.659433514242;10272.280940334254;10347.586096556053;10370.896291036994;10385;10454.42500662471;7835.373170146375;7859.4891332063235;7872.685092596346;7910.248526389983;7911.129775724666;3095.2261934516373;3113.7820352575104;3131.85906634202;3138.8430578471443;3167.2873603439502;919.1451949686722;949.2738055387634;977.6627063663025;987.2003677021636;1010.4897027001317;26100.8694956524;27043.459130817275;27199.456010879672;27821;27889.442211155663;917.1791246834047;924.2236521322121;980.3382716666364;1007.3653598233067;1046.837740150278;14273.928630356782;14346.928265358607;14632.122072675673;14670.067100799932;14711.411543538139;377040;377665;380315;380785;382542;46767.532324677;47671.76164119157;47688.28467572989;47777.761111194915;48001.27998080032;1150.2178518607261;1173.0439691651277;1181.4388165621433;1187.186777057701;1187.8633957094871;26313.868430657723;26605.334866628487;27007.1897843065;27051.729482704923;27202.72797272002;40622;40660.59339406568;40760;40856.79571602123;41018;331855;332699;333212;334187;334747;24337.269881903572;24423.877880610482;24574.139905103235;24599.50800984006;24898.626520601843;40557.39163912485;40653.796731016155;40773.38839917344;41019;41037.58962410457;34975.300493990486;35614.28771424505;35632;35765.46351804673;35935;35485.82257088698;35488.822555887054;35528.64471355357;35758.4636230462;35806.82096589501;34047.14882127967;34157.829210853786;34728.65271347254;34797;35333.82333088421;31052.689473105882;32123.67876321207;32294.35411291714;32328.35343293074;32415.837920810245;24601.84241552228;24645.262115337944;24726.134585290147;24936.805420524142;25060.248192554252 22:59:22 INFO - PROCESS | 2556 | |2;jquery.html;375.55309182073324;379.0845109061615;380.7582185312326;385.323756806804;391.45978549601546;15613.843861561381;16143.273552690127;17070.23183956722;17097.059661718602;17101.401450949204;11760.235584686989;15484.380624774996;16292.918535407307;16298.348066077373;16846.663066738656;4589.839355622562;4758.571728544431;4764.380630518028;4797.568218860302;4804.879878003043;3433.6223015468404;5202.635815492917;5452.154915988028;5473.808416705416;5492.231087647732;5442.482964118402;5465.571962867503;5518.530924871371;5525.226468294442;5543.556515478752;5922.289325280973;6054.424829641177;6064.605800622945;6094.969525152346;6103.542234332443;5210.739463026872;5391.56867450603;5402.594805389612;5407.351117865842;5431.972840135813;12362.960111581579;12429.627111186588;12531.93734031324;12650.304233267167;13498.932505337509;1937.2154277517627;1944.4166749974952;1946.2701486942397;1994.1425187169511;2027.5133967847758;8745.868811967826;9162.587683554257;9252.814943701089;9415.764605884839;9764.121229089345;1696.8557672597844;1766.726157445598;1798.5323815807853;1825.1513046433472;1828.542864283929;65791.342086579;66983;67158;67281.66359168173;67631.66184169048;9795.167410770022;9919.702408927744;9941.552630131662;10081.143102836195;10240.64157754475;13685.86314136846;13801.240931748649;13807.723845523033;13821.447142114404;13866.376013079436;6897.827554311182;6902.6203558803745;6947.548409353376;7012.684429200698;7195.89206161908;6227.252729672468;6277.027060805583;6409.070684750685;6420.390062944013;6466.094746735461;4173.123644034787;4226.936595951063;4233.1956928183545;4303.139372125587;4346.434963454731;1746.6768647800197;1775.4318618042362;1832.5510249988572;1845.372573325076;1903.9920966365878;770.8150043989402;891.2558014058334;900.0999000999001;925.7546750111226;938.3994243684048;14841.703165936837;15314.463993760164;16081.356745730274;16471.752923706154;16652;834.9874751878726;860.6729442811692;865.4158443051041;923.3259720404143;941.0166376136954;8753.311709213336;9158.725238242863;9197.49413782235;9447.338686291894;9449.527523623929;383265;389850;392495;394119;395261;72100;75055;77091.61454192693;77800.22199778043;78802;858.4891989266501;880.6402145882508;881.9514926679094;904.1636486250193;904.2630256341192;14282.785758213427;14708.41166353334;15477.993930394488;15953.521394358188;16187.190640468165;36600.81699591485;36646.26707465889;37269.813650931574;38347.42478862875;38765.2246955065;48979.26531101965;49704.50295497143;49800.25299620581;49856.50143498664;49976;7753.612319384121;7809.3362064225175;7874.606269686607;7921.643526041226;8089.959550202211;11120.666380008613;12248.87751122513;12373.505059797508;12396.380180991095;12643.620691379274;7074;10212.744681382728;10607.727072751319;10676.519556620126;10686;10303.124234439856;10427.478626068514;10509.584385075033;10694.73263168427;10782.730431738955;10210.438425886647;10466.267361284941;10753.139748820233;10937.617183398543;10944.23390362667;7782.260685234894;7808.297253247235;7916.6041697916025;8135.471194372347;8136.105028446747;7852.057753069668;9517.666881659108;10737.946310268399;10767.084797792275;10881.619143330263 22:59:22 INFO - PROCESS | 2556 | |3;mootools.html;1349.952751653692;1397.9180792087104;1447.7828325751136;1618.54680689407;1624.8456396642323;6858.691358888849;7413.184549699528;7550.660220290087;8081.111077781439;8135.837283254339;7479.065116860393;7752.147263800977;7770.611469426534;7807.375409967203;7853.450258481908;2202.614542455072;2245.786650268222;2246.2811900191946;2246.4833088389682;2246.84272100953;2168.1327469012363;2170.750363708178;2194.5501172259646;2200.482886521666;2201.0095457044313;2180.8364372672036;2184.137265780016;2194.9012294446707;2195.648696208607;2226.866388016716;2105.3368189020484;2110.145391116585;2112.1445814445174;2115.428834214761;2125.0437303213616;2011.8994050297572;2043.9693404598943;2099.876566037163;2135.1886283212434;2152.903119359617;7892.408069394818;7927.048754149481;7971.800704982364;7972.760817175494;7975.122736498981;4709.529047095298;4767.856964291077;4780.760961951889;4804.351412559295;4831.9275210871865;2852.657681078284;2880.1791489425623;2968.807027543203;2988.3126880817317;3066.9846650766826;909.4861403307176;919.1589695428742;947.1381043250609;982.2534873496123;984.414273507262;10502.422366769824;10528;10563.102136318423;10574.62988795396;10606.15150787943;4273.914521709548;4339.088791353788;4428.31361139024;4437.29003359461;4447.466304043535;8921;8963.103689631114;9012.27901767857;9018.86471702925;9022.233110185576;4697.81208751653;4718.150732868048;4751.524847515221;4756.357891684647;4758.833440829554;3829.157585331223;4126.154138401621;4252.255855225323;4287.121140166259;4329.264025115738;3776.8866933992026;3809.961900381016;3853.6339047790416;3900.7269491135917;3989.9800500997308;1243.776120298355;1247.5839921688766;1253.078986944595;1257.346179986402;1270.294986282622;687.1479365586637;775.4261846233859;788.6017561131591;793.2305663506389;839.2824135364176;4887.511248875155;4974.27872958419;5007.899842003139;5059.06407314648;5063.8987220255385;421.2838175102338;427.4485913172035;438.24184161400956;440.51983338160915;442.15327647554574;3426.2804810989473;3494.7029502492064;3497.5977762557122;3511.964880351215;3558.3061303046175;9578.616855325849;9822.410655360702;9917.702468925943;9937.354071985297;9944.502774861228;9676.951615241878;9697.369670971364;9715.271354648288;9727.367721098106;9794.118529332252;7293.562386256842;7317.451191160684;7330.193678695339;7356.264373562708;7466.70133194677;4954.65317427791;4977.726225057657;5025.497450254945;5035.244713293036;5082.466341034138;8619.267362274277;8958.910410895807;9011.549422528717;9017.2786177107;9055.18503334703;9234.630614775602;9261.768455788659;9272.397294175857;9285.72142835716;9287.535623218948;6125.877482450237;6650.168728908887;6654.73381064752;6795;6837.897431538431;7572.091349038151;7610.847783044419;7631.656575454229;7666.655000525101;7681.500702454323;6685.76599819004;6892.069570608104;6987.6855541499735;6997.790066298019;7085.008098866266;6846.281140480178;6849.178098627997;6900.309969003059;6904.067950826775;6952.582845029315;6287.088372186099;6344.30212676596;6458.644774537445;6461.256955449995;6464.385883341075;4516.367708520876;4519.231730605739;4564.726116433025;4590.311453282035;4612.377329060534;4509.729416235036;4523.547645235451;4542.3413605027745;4570.748608826547;4665.930011049769 22:59:22 INFO - PROCESS | 2556 | |4;prototype.html;292.6722071280167;305.96022517072777;308.65893188027223;310.9486934655782;311.6680735017205;4874.585660218877;4945.876353091175;5050.570701490373;5092.694438333698;5112.36095488064;5024.497550244973;5055.9747201263945;5057.822976195834;5064.924026139611;5073.949260507394;3952.4861767970197;3969.325214713506;3976.8069579126145;3987.3620220764683;3988.6410223079915;3887.747296425723;3943.2704949584418;3956.8417263309575;3974.344233201533;3975.2248311579256;3897.395903634927;3902.8829135125993;3903.4535165076913;3913.4716813230134;3915.39311406731;3922.7254092213557;3931.862384816532;3934.547527034399;3938.8030598470104;3945.7237993340477;3468.8612455502002;3494.1264683829045;3500.632433594487;3516.5428494295834;3520.137566296248;4684.5549672781035;4920.581750551208;4926.45808961014;4926.802927882881;4979.601631869442;4420.977895110504;4456.910861782746;4465.486469056035;4469.324003498688;4470.307102399133;5272.420033796279;5279.732864112585;5287.4976877196605;5289.68261904287;5293.814716484904;3663.6519530644546;3706.6478684524927;3710.647488488616;3754.4743735877;3770.604086570898;5453.263809385722;5467.617266791326;5471.37079235889;5473.425290344536;5491.807786727445;3794.2221844521805;3794.392897136445;3807.676347510437;3807.800542829;3832.271868345061;3813.874164094334;3853.2678791029616;3878;3880.9029774255305;3921.215756848642;4317.84887528935;4387.605115539617;4390.517043125254;4393.494748103945;4398.670099742532;5212.374515058217;5218.739063046908;5235.397929238186;5239.318888544465;5250.7637156328055;1235.8393408856791;1311.4360824845216;1334.426196735413;1337.5318638476456;1344.9798253026213;832.5629044751432;843.401185158532;849.4011721736161;851.3997631669658;859.4886042804521;4133.705793284696;4211.115665710236;4219.649712092101;4233.682473814476;4238.851640192578;4794.9280760788615;4805.591524720368;4819.445763737215;4821.927671084936;4836;4235.724677895927;4251.553586873396;4254.723442976258;4256.106217694319;4264.957350426518;2479.6280557916098;2569;2579.2649095007832;2584.883680234394;2635.3279913621905;4590.632749380042;4605.825514493783;4613.63090952723;4639.744814035261;4646.790894409692;4835.927461088087;4872.561469467694;4873.951260487421;4945.318591678846;4952.727599982036;4301.5698430156735;4507.414036175276;4562.9771851141195;4579.152856721517;4579.839705610288;4752.5485078917445;4756.764320769233;4838.564529192389;4870.659053866196;4875.000624871964;4664.440267167962;4691.788869500949;4714.010057887745;4721.693089949143;4757.881052973565;4556.635469162526;4628.745419001987;5107.489251074863;5125.308083408692;5141.25451809493;3761.1725420407465;3816.7137464690813;3827.215420838777;3845.4616353709944;3852.5184351956004;5133.535902766618;5493.09363954943;5507.862303442446;5513.558915286848;5542.196381524737;5121.257417674342;5220.060389129993;5224.555912747459;5244.767479642204;5289.233061206027;5208.869778255574;5253.947460525345;5255.502181878146;5277.815276465305;5323.361196656426;5004.924926126184;5193.169092945111;5204.34945631796;5276;5282.445343238905;5377.919331210113;5386.353637563518;5400.2439658447065;5403.433004428829;5426.8371948841595;5222.42553319127;5272.130098533699;5273.472652734696;5287.339082614673;5302.2046692996355 22:59:22 INFO - PROCESS | 2556 | |5;yui.html;636.0560561552293;676.4284179868013;681.9931800681992;733.7028503456102;742.9561466140075;11618.767624647513;13725.725485490284;14193.077449965745;14233.217173055491;14249.715005699905;14547.927260363684;14657.56027319182;14679.266036698149;14795;14819.110853348806;625.2340882419023;777.9572123533203;792.5640897506391;801.0547553886412;803.8553060449117;781.5662307419379;782.6126067596548;785.7996210966196;787.2875048081495;788.6411682684394;827.5407149032285;828.3869936247194;829.3365307753803;829.5188790501495;830.9750707478755;819.2299238715648;820.6553247635977;821.0229826506438;821.9095899451086;822.4407402966011;592.6947621974687;594.940505949406;597.375742349246;597.4085655201363;600.1058422949817;13687.315634218348;13702.65743356424;13758;13846.861531384659;13851.099678520864;13009.60971170857;13224.603261902063;13346.733065338736;13516.12145210558;13552.728945421135;10155.238357123246;10309.84535231972;10346.12057975073;10352.327098738559;10370.79258414835;3310.3710295043866;3333.3499967506345;3347.297067615804;3387.6781705737917;3414.6243913169533;50362.49637503651;52058.479415205744;52526.21210681843;59769.402305976815;63196;10243.7439064024;10530.15758739299;10553.947230263799;10709.357438553712;10718.35689858611;16904.32382704678;16971.490855274362;16974.575635608962;17105.657886842444;17118;7132.500724949204;7197.4961752677855;7265.237150099163;7268.309510596485;7324.4872858900435;3995.780232087263;4039.636432721069;4048.0891799344913;4054.1688953764406;4121.155163191538;2872.4973129702216;2966.821990680566;2971.405718856194;2972.405518896186;2972.5986991755835;523.0872128136426;524.1508755815603;531.5853634165358;533.8291746641038;543.7009644695402;468.9366935463737;550.3038656100036;606.805822136912;607.3838824930493;641.7112299465166;7030.226675065739;7344.081989751281;7442.218567050381;7452.515586486861;7533.397328213729;535.8579976306282;615.2831950777295;636.3032479435011;636.5575924732359;646.6249575246346;3668.486411902336;3749.1376983293994;3835.712321575837;3881.4954055973108;3888.494495715539;93944.53027734818;94984;95151;95917.5204123975;96915.51542242244;48038.51961480411;49043;49607.75196123996;51086.48913510892;51917.48082519202;66936;71374.28625713676;71520.28479715137;72245.63877180581;72387;7394.223606521237;7434.3309102181065;7618.162002179866;7670;7735.806604834924;42189;43764.78117609519;44234.77882610566;44975.550244497135;44996;37287.627123728416;51013;63435.36564634479;63783;64055;9772.364796288219;9993.500324983575;10197.74505637365;10234.130098941674;10546.103581195684;10618.8938110621;10628.946855265674;10885.020348168702;11109.388983605655;12011.339376334035;9111.225545828414;9250.21373183287;9357.251419886257;10345.327553708985;10451.58193672275;10024.949875250577;10203.795924081625;10403.167746580406;10769.9461502692;10871.184661150604;9782.461964592016;10319.329243599143;10375.014373634493;10379.169666426516;10668.519916603927;7887.132415434412;8155.225253600898;8177.918220817715;8462.365322600706;8630.093840146945;7848.84302313962;7866.449348545547;7931.60341982887;8007.1592482788465;8028.397870159644 22:59:22 INFO - PROCESS | 2556 | __end_tp_report 22:59:22 INFO - PROCESS | 2556 | __start_cc_report 22:59:22 INFO - PROCESS | 2556 | _x_x_mozilla_cycle_collect,407 22:59:22 INFO - PROCESS | 2556 | __end_cc_report 22:59:22 INFO - PROCESS | 2556 | __startTimestamp1465624762336__endTimestamp 22:59:22 INFO - PROCESS | 2556 | 22:59:22 INFO - PROCESS | 2556 | ------- Summary: start ------- 22:59:22 INFO - PROCESS | 2556 | Number of tests: 6 22:59:22 INFO - PROCESS | 2556 | 22:59:22 INFO - PROCESS | 2556 | [#0] dojo.html Cycles:165 Average:4708.64 Median:4876.22 stddev:617.81 (12.7%) stddev-sans-first:597.13 22:59:22 INFO - PROCESS | 2556 | Values: 2599.5 2641.6 2669.7 2676.4 2681.0 4737.1 4744.7 4790.6 4859.6 4897.8 4657.7 4811.2 4811.4 4845.9 4911.3 4298.9 4327.7 4334.2 4443.9 4518.8 113.6 4375.9 4429.3 4436.1 4441.7 4354.7 4355.7 4359.5 4362.8 4377.5 4381.2 4382.9 4392.7 4393.2 4441.4 4297.0 4309.2 4363.1 4363.1 4404.1 4744.7 4792.5 4797.5 4803.8 4805.7 5122.2 5126.2 5126.8 5132.1 5151.8 5031.3 5113.4 5160.9 5200.9 5202.4 4823.9 4844.7 4851.7 4858.4 4896.4 5295.5 5295.7 5316.0 5330.6 5331.6 4939.7 4945.3 4967.5 5008.9 5012.6 5067.6 5091.5 5101.1 5109.6 5142.5 4947.4 5039.9 5051.9 5063.8 5067.9 4873.5 4986.7 5012.4 5041.1 5069.9 4291.8 4311.9 4321.5 4325.5 4361.5 3703.0 3776.9 3790.5 3799.2 3865.7 4427.6 4445.1 4476.6 4480.8 4482.6 5085.8 5139.9 5152.5 5158.5 5198.2 4345.0 4394.0 4459.3 4500.3 4524.4 4507.9 4536.2 4562.3 4586.7 4590.8 4778.2 4809.6 4817.1 4832.1 4858.1 5054.1 5109.4 5121.8 5129.6 5167.5 4853.9 4866.9 4876.2 4906.3 4924.0 5082.5 5083.4 5087.1 5106.3 5116.5 5059.1 5093.2 5128.7 5131.6 5219.7 4989.1 4996.3 5020.9 5024.9 5056.3 4985.9 4997.5 4998.9 5016.1 5019.5 4774.1 4827.6 4905.6 4945.2 4965.8 5023.8 5057.9 5067.0 5111.1 5116.6 4940.3 4975.8 4979.4 5003.7 5020.3 22:59:22 INFO - PROCESS | 2556 | 22:59:22 INFO - PROCESS | 2556 | [#1] ext.html Cycles:180 Average:44667.82 Median:19070.64 stddev:84651.32 (443.9%) stddev-sans-first:84824.06 22:59:22 INFO - PROCESS | 2556 | Values: 577.8 588.2 598.4 606.8 610.9 33112.5 33807.3 36200.3 36283.6 36389.5 36515.3 36740.0 37098.6 37211.0 37398.6 7477.1 7661.9 7665.7 7729.8 7738.5 7603.6 7664.1 7693.7 7712.8 7719.6 7700.6 7741.7 7743.9 7744.7 7752.6 7649.6 7661.6 7676.8 7678.7 7683.8 7557.4 7614.9 7643.2 7652.9 7666.1 34591.8 34673.7 34895.7 35074.8 35127.8 2298.9 2709.6 2897.8 2945.7 2959.3 27287.6 27370.0 27585.2 27642.4 28683.3 3434.6 3461.4 3467.6 3539.7 3552.6 228264.0 228275.0 229591.0 229957.0 230655.8 27674.7 28175.6 28217.0 31196.4 31269.5 33002.5 33438.7 33441.5 33569.0 33660.2 13424.9 13483.9 13581.5 13613.0 13622.7 10272.3 10347.6 10370.9 10385.0 10454.4 7835.4 7859.5 7872.7 7910.2 7911.1 3095.2 3113.8 3131.9 3138.8 3167.3 919.1 949.3 977.7 987.2 1010.5 26100.9 27043.5 27199.5 27821.0 27889.4 917.2 924.2 980.3 1007.4 1046.8 14273.9 14346.9 14632.1 14670.1 14711.4 377040.0 377665.0 380315.0 380785.0 382542.0 46767.5 47671.8 47688.3 47777.8 48001.3 1150.2 1173.0 1181.4 1187.2 1187.9 26313.9 26605.3 27007.2 27051.7 27202.7 40622.0 40660.6 40760.0 40856.8 41018.0 331855.0 332699.0 333212.0 334187.0 334747.0 24337.3 24423.9 24574.1 24599.5 24898.6 40557.4 40653.8 40773.4 41019.0 41037.6 34975.3 35614.3 35632.0 35765.5 35935.0 35485.8 35488.8 35528.6 35758.5 35806.8 34047.1 34157.8 34728.7 34797.0 35333.8 31052.7 32123.7 32294.4 32328.4 32415.8 24601.8 24645.3 24726.1 24936.8 25060.2 22:59:22 INFO - PROCESS | 2556 | 22:59:22 INFO - PROCESS | 2556 | [#2] jquery.html Cycles:180 Average:23925.54 Median:4674.21 stddev:64523.49 (1380.4%) stddev-sans-first:64680.26 22:59:22 INFO - PROCESS | 2556 | Values: 375.6 379.1 380.8 385.3 391.5 15613.8 16143.3 17070.2 17097.1 17101.4 11760.2 15484.4 16292.9 16298.3 16846.7 4589.8 4758.6 4764.4 4797.6 4804.9 3433.6 5202.6 5452.2 5473.8 5492.2 5442.5 5465.6 5518.5 5525.2 5543.6 5922.3 6054.4 6064.6 6095.0 6103.5 5210.7 5391.6 5402.6 5407.4 5432.0 12363.0 12429.6 12531.9 12650.3 13498.9 1937.2 1944.4 1946.3 1994.1 2027.5 8745.9 9162.6 9252.8 9415.8 9764.1 1696.9 1766.7 1798.5 1825.2 1828.5 65791.3 66983.0 67158.0 67281.7 67631.7 9795.2 9919.7 9941.6 10081.1 10240.6 13685.9 13801.2 13807.7 13821.4 13866.4 6897.8 6902.6 6947.5 7012.7 7195.9 6227.3 6277.0 6409.1 6420.4 6466.1 4173.1 4226.9 4233.2 4303.1 4346.4 1746.7 1775.4 1832.6 1845.4 1904.0 770.8 891.3 900.1 925.8 938.4 14841.7 15314.5 16081.4 16471.8 16652.0 835.0 860.7 865.4 923.3 941.0 8753.3 9158.7 9197.5 9447.3 9449.5 383265.0 389850.0 392495.0 394119.0 395261.0 72100.0 75055.0 77091.6 77800.2 78802.0 858.5 880.6 882.0 904.2 904.3 14282.8 14708.4 15478.0 15953.5 16187.2 36600.8 36646.3 37269.8 38347.4 38765.2 48979.3 49704.5 49800.3 49856.5 49976.0 7753.6 7809.3 7874.6 7921.6 8090.0 11120.7 12248.9 12373.5 12396.4 12643.6 7074.0 10212.7 10607.7 10676.5 10686.0 10303.1 10427.5 10509.6 10694.7 10782.7 10210.4 10466.3 10753.1 10937.6 10944.2 7782.3 7808.3 7916.6 8135.5 8136.1 7852.1 9517.7 10737.9 10767.1 10881.6 22:59:22 INFO - PROCESS | 2556 | 22:59:22 INFO - PROCESS | 2556 | [#3] mootools.html Cycles:180 Average:5157.15 Median:4921.08 stddev:2914.17 (59.2%) stddev-sans-first:2908.30 22:59:22 INFO - PROCESS | 2556 | Values: 1350.0 1397.9 1447.8 1618.5 1624.8 6858.7 7413.2 7550.7 8081.1 8135.8 7479.1 7752.1 7770.6 7807.4 7853.5 2202.6 2245.8 2246.3 2246.5 2246.8 2168.1 2170.8 2194.6 2200.5 2201.0 2180.8 2184.1 2194.9 2195.6 2226.9 2105.3 2110.1 2112.1 2115.4 2125.0 2011.9 2044.0 2099.9 2135.2 2152.9 7892.4 7927.0 7971.8 7972.8 7975.1 4709.5 4767.9 4780.8 4804.4 4831.9 2852.7 2880.2 2968.8 2988.3 3067.0 909.5 919.2 947.1 982.3 984.4 10502.4 10528.0 10563.1 10574.6 10606.2 4273.9 4339.1 4428.3 4437.3 4447.5 8921.0 8963.1 9012.3 9018.9 9022.2 4697.8 4718.2 4751.5 4756.4 4758.8 3829.2 4126.2 4252.3 4287.1 4329.3 3776.9 3810.0 3853.6 3900.7 3990.0 1243.8 1247.6 1253.1 1257.3 1270.3 687.1 775.4 788.6 793.2 839.3 4887.5 4974.3 5007.9 5059.1 5063.9 421.3 427.4 438.2 440.5 442.2 3426.3 3494.7 3497.6 3512.0 3558.3 9578.6 9822.4 9917.7 9937.4 9944.5 9677.0 9697.4 9715.3 9727.4 9794.1 7293.6 7317.5 7330.2 7356.3 7466.7 4954.7 4977.7 5025.5 5035.2 5082.5 8619.3 8958.9 9011.5 9017.3 9055.2 9234.6 9261.8 9272.4 9285.7 9287.5 6125.9 6650.2 6654.7 6795.0 6837.9 7572.1 7610.8 7631.7 7666.7 7681.5 6685.8 6892.1 6987.7 6997.8 7085.0 6846.3 6849.2 6900.3 6904.1 6952.6 6287.1 6344.3 6458.6 6461.3 6464.4 4516.4 4519.2 4564.7 4590.3 4612.4 4509.7 4523.5 4542.3 4570.7 4665.9 22:59:22 INFO - PROCESS | 2556 | 22:59:22 INFO - PROCESS | 2556 | [#4] prototype.html Cycles:180 Average:4245.01 Median:4643.27 stddev:1231.16 (26.5%) stddev-sans-first:1198.34 22:59:22 INFO - PROCESS | 2556 | Values: 292.7 306.0 308.7 310.9 311.7 4874.6 4945.9 5050.6 5092.7 5112.4 5024.5 5056.0 5057.8 5064.9 5073.9 3952.5 3969.3 3976.8 3987.4 3988.6 3887.7 3943.3 3956.8 3974.3 3975.2 3897.4 3902.9 3903.5 3913.5 3915.4 3922.7 3931.9 3934.5 3938.8 3945.7 3468.9 3494.1 3500.6 3516.5 3520.1 4684.6 4920.6 4926.5 4926.8 4979.6 4421.0 4456.9 4465.5 4469.3 4470.3 5272.4 5279.7 5287.5 5289.7 5293.8 3663.7 3706.6 3710.6 3754.5 3770.6 5453.3 5467.6 5471.4 5473.4 5491.8 3794.2 3794.4 3807.7 3807.8 3832.3 3813.9 3853.3 3878.0 3880.9 3921.2 4317.8 4387.6 4390.5 4393.5 4398.7 5212.4 5218.7 5235.4 5239.3 5250.8 1235.8 1311.4 1334.4 1337.5 1345.0 832.6 843.4 849.4 851.4 859.5 4133.7 4211.1 4219.6 4233.7 4238.9 4794.9 4805.6 4819.4 4821.9 4836.0 4235.7 4251.6 4254.7 4256.1 4265.0 2479.6 2569.0 2579.3 2584.9 2635.3 4590.6 4605.8 4613.6 4639.7 4646.8 4835.9 4872.6 4874.0 4945.3 4952.7 4301.6 4507.4 4563.0 4579.2 4579.8 4752.5 4756.8 4838.6 4870.7 4875.0 4664.4 4691.8 4714.0 4721.7 4757.9 4556.6 4628.7 5107.5 5125.3 5141.3 3761.2 3816.7 3827.2 3845.5 3852.5 5133.5 5493.1 5507.9 5513.6 5542.2 5121.3 5220.1 5224.6 5244.8 5289.2 5208.9 5253.9 5255.5 5277.8 5323.4 5004.9 5193.2 5204.3 5276.0 5282.4 5377.9 5386.4 5400.2 5403.4 5426.8 5222.4 5272.1 5273.5 5287.3 5302.2 22:59:22 INFO - PROCESS | 2556 | 22:59:22 INFO - PROCESS | 2556 | [#5] yui.html Cycles:180 Average:15983.93 Median:26525.18 stddev:22349.14 (84.3%) stddev-sans-first:22382.13 22:59:22 INFO - PROCESS | 2556 | Values: 636.1 676.4 682.0 733.7 743.0 11618.8 13725.7 14193.1 14233.2 14249.7 14547.9 14657.6 14679.3 14795.0 14819.1 625.2 778.0 792.6 801.1 803.9 781.6 782.6 785.8 787.3 788.6 827.5 828.4 829.3 829.5 831.0 819.2 820.7 821.0 821.9 822.4 592.7 594.9 597.4 597.4 600.1 13687.3 13702.7 13758.0 13846.9 13851.1 13009.6 13224.6 13346.7 13516.1 13552.7 10155.2 10309.8 10346.1 10352.3 10370.8 3310.4 3333.3 3347.3 3387.7 3414.6 50362.5 52058.5 52526.2 59769.4 63196.0 10243.7 10530.2 10553.9 10709.4 10718.4 16904.3 16971.5 16974.6 17105.7 17118.0 7132.5 7197.5 7265.2 7268.3 7324.5 3995.8 4039.6 4048.1 4054.2 4121.2 2872.5 2966.8 2971.4 2972.4 2972.6 523.1 524.2 531.6 533.8 543.7 468.9 550.3 606.8 607.4 641.7 7030.2 7344.1 7442.2 7452.5 7533.4 535.9 615.3 636.3 636.6 646.6 3668.5 3749.1 3835.7 3881.5 3888.5 93944.5 94984.0 95151.0 95917.5 96915.5 48038.5 49043.0 49607.8 51086.5 51917.5 66936.0 71374.3 71520.3 72245.6 72387.0 7394.2 7434.3 7618.2 7670.0 7735.8 42189.0 43764.8 44234.8 44975.6 44996.0 37287.6 51013.0 63435.4 63783.0 64055.0 9772.4 9993.5 10197.7 10234.1 10546.1 10618.9 10628.9 10885.0 11109.4 12011.3 9111.2 9250.2 9357.3 10345.3 10451.6 10024.9 10203.8 10403.2 10769.9 10871.2 9782.5 10319.3 10375.0 10379.2 10668.5 7887.1 8155.2 8177.9 8462.4 8630.1 7848.8 7866.4 7931.6 8007.2 8028.4 22:59:22 INFO - PROCESS | 2556 | -------- Summary: end -------- 22:59:22 INFO - PROCESS | 2556 | 22:59:23 INFO - TEST-INFO | 2556: exit 0 22:59:23 INFO - TEST-OK | dromaeo_css | took 1115895ms 22:59:23 INFO - TEST-START | kraken 22:59:23 INFO - operating with platform_type : linux_ 22:59:23 INFO - Initialising browser for kraken test... 22:59:23 INFO - TEST-INFO | started process 2886 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzUyUHD/profile http://localhost:41421/getInfo.html) 22:59:28 INFO - PROCESS | 2886 | __metrics Screen width/height:1600/1200 22:59:28 INFO - PROCESS | 2886 | colorDepth:24 22:59:28 INFO - PROCESS | 2886 | Browser inner width/height: 1024/697 22:59:28 INFO - PROCESS | 2886 | __metrics 22:59:28 ERROR - PROCESS | 2886 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 22:59:29 INFO - TEST-INFO | 2886: exit 0 22:59:29 INFO - Browser initialized. 22:59:29 INFO - Running cycle 1/1 for kraken test... 22:59:29 INFO - TEST-INFO | started process 3013 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzUyUHD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:59:42 INFO - PROCESS | 3013 | RSS: Main: 185753600 22:59:42 INFO - PROCESS | 3013 | 22:59:44 INFO - PROCESS | 3013 | Cycle 1(1): loaded http://localhost:41421/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41421/tests/kraken/driver.html?testName=audio-beat-detection) 22:59:45 INFO - PROCESS | 3013 | RSS: Main: 190935040 22:59:45 INFO - PROCESS | 3013 | 22:59:48 INFO - PROCESS | 3013 | Cycle 1(1): loaded http://localhost:41421/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41421/tests/kraken/driver.html?testName=audio-dft) 22:59:49 INFO - PROCESS | 3013 | RSS: Main: 190222336 22:59:49 INFO - PROCESS | 3013 | 22:59:52 INFO - PROCESS | 3013 | Cycle 1(1): loaded http://localhost:41421/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41421/tests/kraken/driver.html?testName=audio-fft) 22:59:52 INFO - PROCESS | 3013 | RSS: Main: 185700352 22:59:52 INFO - PROCESS | 3013 | 22:59:54 INFO - PROCESS | 3013 | Cycle 1(1): loaded http://localhost:41421/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41421/tests/kraken/driver.html?testName=audio-oscillator) 22:59:55 INFO - PROCESS | 3013 | RSS: Main: 186523648 22:59:55 INFO - PROCESS | 3013 | 22:59:57 INFO - PROCESS | 3013 | Cycle 1(1): loaded http://localhost:41421/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41421/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:59:58 INFO - PROCESS | 3013 | RSS: Main: 186744832 22:59:58 INFO - PROCESS | 3013 | 23:00:01 INFO - PROCESS | 3013 | Cycle 1(1): loaded http://localhost:41421/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41421/tests/kraken/driver.html?testName=imaging-darkroom) 23:00:02 INFO - PROCESS | 3013 | RSS: Main: 187174912 23:00:02 INFO - PROCESS | 3013 | 23:00:05 INFO - PROCESS | 3013 | Cycle 1(1): loaded http://localhost:41421/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41421/tests/kraken/driver.html?testName=imaging-desaturate) 23:00:06 INFO - PROCESS | 3013 | RSS: Main: 183595008 23:00:06 INFO - PROCESS | 3013 | 23:00:09 INFO - PROCESS | 3013 | Cycle 1(1): loaded http://localhost:41421/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41421/tests/kraken/driver.html?testName=json-parse-financial) 23:00:10 INFO - PROCESS | 3013 | RSS: Main: 185876480 23:00:10 INFO - PROCESS | 3013 | 23:00:11 INFO - PROCESS | 3013 | Cycle 1(1): loaded http://localhost:41421/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41421/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:00:12 INFO - PROCESS | 3013 | RSS: Main: 186380288 23:00:12 INFO - PROCESS | 3013 | 23:00:14 INFO - PROCESS | 3013 | Cycle 1(1): loaded http://localhost:41421/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41421/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:00:14 INFO - PROCESS | 3013 | RSS: Main: 186712064 23:00:14 INFO - PROCESS | 3013 | 23:00:17 INFO - PROCESS | 3013 | Cycle 1(1): loaded http://localhost:41421/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41421/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:00:17 INFO - PROCESS | 3013 | RSS: Main: 186974208 23:00:17 INFO - PROCESS | 3013 | 23:00:20 INFO - PROCESS | 3013 | Cycle 1(1): loaded http://localhost:41421/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41421/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:00:21 INFO - PROCESS | 3013 | RSS: Main: 186847232 23:00:21 INFO - PROCESS | 3013 | 23:00:24 INFO - PROCESS | 3013 | Cycle 1(1): loaded http://localhost:41421/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41421/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:00:24 INFO - PROCESS | 3013 | RSS: Main: 186511360 23:00:24 INFO - PROCESS | 3013 | 23:00:26 INFO - PROCESS | 3013 | Cycle 1(1): loaded http://localhost:41421/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41421/tests/kraken/driver.html?testName=ai-astar) 23:00:26 INFO - PROCESS | 3013 | RSS: Main: 187731968 23:00:26 INFO - PROCESS | 3013 | 23:00:26 INFO - PROCESS | 3013 | __start_tp_report 23:00:26 INFO - PROCESS | 3013 | _x_x_mozilla_page_load 23:00:26 INFO - PROCESS | 3013 | _x_x_mozilla_page_load_details 23:00:26 INFO - PROCESS | 3013 | |i|pagename|runs| 23:00:26 INFO - PROCESS | 3013 | |0;ai-astar;114;111;115;116;117;116;114;115;114;115 23:00:26 INFO - PROCESS | 3013 | |1;audio-beat-detection;160;132;166;175;140;161;157;132;202;151 23:00:26 INFO - PROCESS | 3013 | |2;audio-dft;165;179;165;167;163;164;165;165;163;162 23:00:26 INFO - PROCESS | 3013 | |3;audio-fft;78;76;75;173;77;77;77;76;161;78 23:00:26 INFO - PROCESS | 3013 | |4;audio-oscillator;87;86;148;88;88;87;131;86;86;140 23:00:26 INFO - PROCESS | 3013 | |5;imaging-gaussian-blur;117;117;123;117;117;119;119;119;119;118 23:00:26 INFO - PROCESS | 3013 | |6;imaging-darkroom;148;149;148;147;148;149;148;148;149;149 23:00:26 INFO - PROCESS | 3013 | |7;imaging-desaturate;95;96;95;96;96;95;96;96;95;95 23:00:26 INFO - PROCESS | 3013 | |8;json-parse-financial;64;64;63;64;64;64;63;64;63;64 23:00:26 INFO - PROCESS | 3013 | |9;json-stringify-tinderbox;65;67;70;65;66;66;66;67;65;67 23:00:26 INFO - PROCESS | 3013 | |10;stanford-crypto-aes;85;85;85;86;88;91;85;84;122;90 23:00:26 INFO - PROCESS | 3013 | |11;stanford-crypto-ccm;139;130;131;132;133;135;137;134;138;139 23:00:26 INFO - PROCESS | 3013 | |12;stanford-crypto-pbkdf2;173;171;175;171;172;170;174;173;165;171 23:00:26 INFO - PROCESS | 3013 | |13;stanford-crypto-sha256-iterative;68;68;67;72;71;68;67;67;69;67 23:00:26 INFO - PROCESS | 3013 | __end_tp_report 23:00:26 INFO - PROCESS | 3013 | __start_cc_report 23:00:26 INFO - PROCESS | 3013 | _x_x_mozilla_cycle_collect,969 23:00:26 INFO - PROCESS | 3013 | __end_cc_report 23:00:26 INFO - PROCESS | 3013 | __startTimestamp1465624826846__endTimestamp 23:00:26 INFO - PROCESS | 3013 | 23:00:26 INFO - PROCESS | 3013 | ------- Summary: start ------- 23:00:26 INFO - PROCESS | 3013 | Number of tests: 14 23:00:26 INFO - PROCESS | 3013 | 23:00:26 INFO - PROCESS | 3013 | [#0] ai-astar Cycles:10 Average:114.70 Median:115.00 stddev:1.64 (1.4%) stddev-sans-first:1.72 23:00:26 INFO - PROCESS | 3013 | Values: 114.0 111.0 115.0 116.0 117.0 116.0 114.0 115.0 114.0 115.0 23:00:26 INFO - PROCESS | 3013 | 23:00:26 INFO - PROCESS | 3013 | [#1] audio-beat-detection Cycles:10 Average:157.60 Median:160.50 stddev:21.15 (13.2%) stddev-sans-first:22.42 23:00:26 INFO - PROCESS | 3013 | Values: 160.0 132.0 166.0 175.0 140.0 161.0 157.0 132.0 202.0 151.0 23:00:26 INFO - PROCESS | 3013 | 23:00:26 INFO - PROCESS | 3013 | [#2] audio-dft Cycles:10 Average:165.80 Median:165.00 stddev:4.85 (2.9%) stddev-sans-first:5.13 23:00:26 INFO - PROCESS | 3013 | Values: 165.0 179.0 165.0 167.0 163.0 164.0 165.0 165.0 163.0 162.0 23:00:26 INFO - PROCESS | 3013 | 23:00:26 INFO - PROCESS | 3013 | [#3] audio-fft Cycles:10 Average:94.80 Median:77.00 stddev:38.17 (49.6%) stddev-sans-first:40.00 23:00:26 INFO - PROCESS | 3013 | Values: 78.0 76.0 75.0 173.0 77.0 77.0 77.0 76.0 161.0 78.0 23:00:26 INFO - PROCESS | 3013 | 23:00:26 INFO - PROCESS | 3013 | [#4] audio-oscillator Cycles:10 Average:102.70 Median:86.50 stddev:25.83 (29.9%) stddev-sans-first:26.77 23:00:26 INFO - PROCESS | 3013 | Values: 87.0 86.0 148.0 88.0 88.0 87.0 131.0 86.0 86.0 140.0 23:00:26 INFO - PROCESS | 3013 | 23:00:26 INFO - PROCESS | 3013 | [#5] imaging-gaussian-blur Cycles:10 Average:118.50 Median:119.00 stddev:1.84 (1.5%) stddev-sans-first:1.87 23:00:26 INFO - PROCESS | 3013 | Values: 117.0 117.0 123.0 117.0 117.0 119.0 119.0 119.0 119.0 118.0 23:00:26 INFO - PROCESS | 3013 | 23:00:26 INFO - PROCESS | 3013 | [#6] imaging-darkroom Cycles:10 Average:148.30 Median:148.50 stddev:0.67 (0.5%) stddev-sans-first:0.71 23:00:26 INFO - PROCESS | 3013 | Values: 148.0 149.0 148.0 147.0 148.0 149.0 148.0 148.0 149.0 149.0 23:00:26 INFO - PROCESS | 3013 | 23:00:26 INFO - PROCESS | 3013 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 23:00:26 INFO - PROCESS | 3013 | Values: 95.0 96.0 95.0 96.0 96.0 95.0 96.0 96.0 95.0 95.0 23:00:26 INFO - PROCESS | 3013 | 23:00:26 INFO - PROCESS | 3013 | [#8] json-parse-financial Cycles:10 Average:63.70 Median:64.00 stddev:0.48 (0.8%) stddev-sans-first:0.50 23:00:26 INFO - PROCESS | 3013 | Values: 64.0 64.0 63.0 64.0 64.0 64.0 63.0 64.0 63.0 64.0 23:00:26 INFO - PROCESS | 3013 | 23:00:26 INFO - PROCESS | 3013 | [#9] json-stringify-tinderbox Cycles:10 Average:66.40 Median:66.50 stddev:1.51 (2.3%) stddev-sans-first:1.51 23:00:26 INFO - PROCESS | 3013 | Values: 65.0 67.0 70.0 65.0 66.0 66.0 66.0 67.0 65.0 67.0 23:00:26 INFO - PROCESS | 3013 | 23:00:26 INFO - PROCESS | 3013 | [#10] stanford-crypto-aes Cycles:10 Average:90.10 Median:85.50 stddev:11.45 (13.4%) stddev-sans-first:12.00 23:00:26 INFO - PROCESS | 3013 | Values: 85.0 85.0 85.0 86.0 88.0 91.0 85.0 84.0 122.0 90.0 23:00:26 INFO - PROCESS | 3013 | 23:00:26 INFO - PROCESS | 3013 | [#11] stanford-crypto-ccm Cycles:10 Average:134.80 Median:136.00 stddev:3.33 (2.4%) stddev-sans-first:3.16 23:00:26 INFO - PROCESS | 3013 | Values: 139.0 130.0 131.0 132.0 133.0 135.0 137.0 134.0 138.0 139.0 23:00:26 INFO - PROCESS | 3013 | 23:00:26 INFO - PROCESS | 3013 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.50 Median:172.50 stddev:2.76 (1.6%) stddev-sans-first:2.87 23:00:26 INFO - PROCESS | 3013 | Values: 173.0 171.0 175.0 171.0 172.0 170.0 174.0 173.0 165.0 171.0 23:00:26 INFO - PROCESS | 3013 | 23:00:26 INFO - PROCESS | 3013 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.40 Median:68.00 stddev:1.78 (2.6%) stddev-sans-first:1.88 23:00:26 INFO - PROCESS | 3013 | Values: 68.0 68.0 67.0 72.0 71.0 68.0 67.0 67.0 69.0 67.0 23:00:26 INFO - PROCESS | 3013 | -------- Summary: end -------- 23:00:26 INFO - PROCESS | 3013 | 23:00:27 INFO - TEST-INFO | 3013: exit 0 23:00:28 INFO - TEST-OK | kraken | took 64941ms 23:00:28 INFO - SUITE-END | took 1180s 23:00:28 INFO - Completed test suite (00:19:41) 23:00:28 INFO - javascript benchmark 23:00:28 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6231.717473451248, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2599.480103979204, 2641.6169655399963, 2669.7196794336596, 2676.4379480309135, 2680.981227133689, 4737.052589482105, 4744.6915950463235, 4790.6407019473545, 4859.562639362457, 4897.755112244391, 4657.720536767796, 4811.2302031674935, 4811.3504676868615, 4845.854624361275, 4911.287863259825, 4298.871033868981, 4327.718698284617, 4334.241507736149, 4443.933340999887, 4518.751468669222, 113.59973748799666, 4375.934360984572, 4429.291313389858, 4436.112777444508, 4441.666874984373, 4354.716943398669, 4355.716878402894, 4359.498657654347, 4362.760048197348, 4377.474703035656, 4381.211381951248, 4382.8904277393, 4392.670549708752, 4393.231184542692, 4441.400410944513, 4296.957030429687, 4309.202797482476, 4363.083752411997, 4363.083752411997, 4404.0531285773395, 4744.715317080986, 4792.472827988919, 4797.496262892381, 4803.831865884712, 4805.663603547753, 5122.154844450662, 5126.2054381570915, 5126.794928202868, 5132.127538318495, 5151.845444636667, 5031.32077169581, 5113.360829896263, 5160.8967820643375, 5200.92198617021, 5202.401723801773, 4823.9035219295765, 4844.66087373884, 4851.733154676492, 4858.44127925286, 4896.387951506062, 5295.4969277918535, 5295.655782374133, 5315.973420132875, 5330.600204984564, 5331.600129990189, 4939.6542242042715, 4945.332380128709, 4967.528084831935, 5008.949910500921, 5012.598992080698, 5067.569256613156, 5091.490850914953, 5101.132807422747, 5109.591232701375, 5142.537171654569, 4947.431045429749, 5039.899202015939, 5051.898962020739, 5063.772130254074, 5067.910399264176, 4873.512648735169, 4986.700797952134, 5012.448630650625, 5041.092603331363, 5069.923951140736, 4291.785410729451, 4311.913761724811, 4321.481422229353, 4325.480942286946, 4361.520232774392, 3702.9814850926114, 3776.9112395977695, 3790.450384694204, 3799.1831756172555, 3865.690744740414, 4427.579379958899, 4445.110977804452, 4476.552344765562, 4480.843170489017, 4482.618977386894, 5085.821996230115, 5139.948600514022, 5152.4847515248175, 5158.458361872024, 5198.16829307309, 4345.000649850552, 4393.978030109829, 4459.286514157784, 4500.302453119772, 4524.366588677588, 4507.909841803145, 4536.206163921301, 4562.315652652129, 4586.678932474695, 4590.793414296365, 4778.187708089633, 4809.591184749265, 4817.084753896748, 4832.130216561053, 4858.101251268386, 5054.140796064751, 5109.3613298337705, 5121.8463446096675, 5129.615278854027, 5167.483251674953, 4853.854384368475, 4866.878328041686, 4876.219804831352, 4906.288588154626, 4924.0, 5082.466341034138, 5083.364579427572, 5087.058894104603, 5106.336176297206, 5116.539511443988, 5059.139946209227, 5093.2105523643895, 5128.692278463304, 5131.589472842089, 5219.739013049409, 4989.077020751172, 4996.325496057985, 5020.949790502048, 5024.874378140429, 5056.317397151338, 4985.925211121908, 4997.450280469073, 4998.875028124326, 5016.072026675077, 5019.498050194951, 4774.069056533943, 4827.565519103157, 4905.632077594123, 4945.18404463274, 4965.776540055634, 5023.799048038038, 5057.949420505748, 5067.037262920034, 5111.05445492585, 5116.616253780907, 4940.258961155855, 4975.776090075883, 4979.427365852974, 5003.699778013331, 5020.297158397901], "value": 4671.3051893470265, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [577.8237637520556, 588.2117961931011, 598.3806760003397, 606.8118883146225, 610.8869859076074, 33112.5033124503, 33807.32385352295, 36200.27599448009, 36283.63716362836, 36389.45415818765, 36515.26969460609, 36740.0, 37098.62901370992, 37211.0, 37398.62601373986, 7477.06536682916, 7661.885071723928, 7665.655045522964, 7729.8067548311465, 7738.458307918448, 7603.619819009055, 7664.118626357985, 7693.7307194248215, 7712.768616941501, 7719.614019299012, 7700.576468294242, 7741.690332386698, 7743.922560774405, 7744.728934487294, 7752.573608451533, 7649.617519124049, 7661.61691915402, 7676.808079797994, 7678.654460549289, 7683.807904802369, 7557.395408367317, 7614.923850761477, 7643.197464266227, 7652.923470765277, 7666.080070391533, 34591.82704086489, 34673.65326346729, 34895.651043489495, 35074.82462587671, 35127.82436087803, 2298.850574712655, 2709.5935609658513, 2897.753690936273, 2945.734883860463, 2959.289770455097, 27287.590686139723, 27370.0, 27585.172444826687, 27642.447151056866, 28683.28291792722, 3434.5706786651667, 3461.359648465042, 3467.6358982306997, 3539.7345199109914, 3552.6447355264527, 228264.0, 228275.0, 229591.0, 229957.0, 230655.846720767, 27674.723252767617, 28175.577366339523, 28217.0, 31196.376072478422, 31269.530957035662, 33002.504962425584, 33438.66561334404, 33441.49837752436, 33569.0, 33660.158496037795, 13424.932875335757, 13483.865161348458, 13581.45674173022, 13613.047086704033, 13622.659433514242, 10272.280940334254, 10347.586096556053, 10370.896291036994, 10385.0, 10454.42500662471, 7835.373170146375, 7859.4891332063235, 7872.685092596346, 7910.248526389983, 7911.129775724666, 3095.2261934516373, 3113.7820352575104, 3131.85906634202, 3138.8430578471443, 3167.2873603439502, 919.1451949686722, 949.2738055387634, 977.6627063663025, 987.2003677021636, 1010.4897027001317, 26100.8694956524, 27043.459130817275, 27199.456010879672, 27821.0, 27889.442211155663, 917.1791246834047, 924.2236521322121, 980.3382716666364, 1007.3653598233067, 1046.837740150278, 14273.928630356782, 14346.928265358607, 14632.122072675673, 14670.067100799932, 14711.411543538139, 377040.0, 377665.0, 380315.0, 380785.0, 382542.0, 46767.532324677, 47671.76164119157, 47688.28467572989, 47777.761111194915, 48001.27998080032, 1150.2178518607261, 1173.0439691651277, 1181.4388165621433, 1187.186777057701, 1187.8633957094871, 26313.868430657723, 26605.334866628487, 27007.1897843065, 27051.729482704923, 27202.72797272002, 40622.0, 40660.59339406568, 40760.0, 40856.79571602123, 41018.0, 331855.0, 332699.0, 333212.0, 334187.0, 334747.0, 24337.269881903572, 24423.877880610482, 24574.139905103235, 24599.50800984006, 24898.626520601843, 40557.39163912485, 40653.796731016155, 40773.38839917344, 41019.0, 41037.58962410457, 34975.300493990486, 35614.28771424505, 35632.0, 35765.46351804673, 35935.0, 35485.82257088698, 35488.822555887054, 35528.64471355357, 35758.4636230462, 35806.82096589501, 34047.14882127967, 34157.829210853786, 34728.65271347254, 34797.0, 35333.82333088421, 31052.689473105882, 32123.67876321207, 32294.35411291714, 32328.35343293074, 32415.837920810245, 24601.84241552228, 24645.262115337944, 24726.134585290147, 24936.805420524142, 25060.248192554252], "value": 15830.418547385532, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [375.55309182073324, 379.0845109061615, 380.7582185312326, 385.323756806804, 391.45978549601546, 15613.843861561381, 16143.273552690127, 17070.23183956722, 17097.059661718602, 17101.401450949204, 11760.235584686989, 15484.380624774996, 16292.918535407307, 16298.348066077373, 16846.663066738656, 4589.839355622562, 4758.571728544431, 4764.380630518028, 4797.568218860302, 4804.879878003043, 3433.6223015468404, 5202.635815492917, 5452.154915988028, 5473.808416705416, 5492.231087647732, 5442.482964118402, 5465.571962867503, 5518.530924871371, 5525.226468294442, 5543.556515478752, 5922.289325280973, 6054.424829641177, 6064.605800622945, 6094.969525152346, 6103.542234332443, 5210.739463026872, 5391.56867450603, 5402.594805389612, 5407.351117865842, 5431.972840135813, 12362.960111581579, 12429.627111186588, 12531.93734031324, 12650.304233267167, 13498.932505337509, 1937.2154277517627, 1944.4166749974952, 1946.2701486942397, 1994.1425187169511, 2027.5133967847758, 8745.868811967826, 9162.587683554257, 9252.814943701089, 9415.764605884839, 9764.121229089345, 1696.8557672597844, 1766.726157445598, 1798.5323815807853, 1825.1513046433472, 1828.542864283929, 65791.342086579, 66983.0, 67158.0, 67281.66359168173, 67631.66184169048, 9795.167410770022, 9919.702408927744, 9941.552630131662, 10081.143102836195, 10240.64157754475, 13685.86314136846, 13801.240931748649, 13807.723845523033, 13821.447142114404, 13866.376013079436, 6897.827554311182, 6902.6203558803745, 6947.548409353376, 7012.684429200698, 7195.89206161908, 6227.252729672468, 6277.027060805583, 6409.070684750685, 6420.390062944013, 6466.094746735461, 4173.123644034787, 4226.936595951063, 4233.1956928183545, 4303.139372125587, 4346.434963454731, 1746.6768647800197, 1775.4318618042362, 1832.5510249988572, 1845.372573325076, 1903.9920966365878, 770.8150043989402, 891.2558014058334, 900.0999000999001, 925.7546750111226, 938.3994243684048, 14841.703165936837, 15314.463993760164, 16081.356745730274, 16471.752923706154, 16652.0, 834.9874751878726, 860.6729442811692, 865.4158443051041, 923.3259720404143, 941.0166376136954, 8753.311709213336, 9158.725238242863, 9197.49413782235, 9447.338686291894, 9449.527523623929, 383265.0, 389850.0, 392495.0, 394119.0, 395261.0, 72100.0, 75055.0, 77091.61454192693, 77800.22199778043, 78802.0, 858.4891989266501, 880.6402145882508, 881.9514926679094, 904.1636486250193, 904.2630256341192, 14282.785758213427, 14708.41166353334, 15477.993930394488, 15953.521394358188, 16187.190640468165, 36600.81699591485, 36646.26707465889, 37269.813650931574, 38347.42478862875, 38765.2246955065, 48979.26531101965, 49704.50295497143, 49800.25299620581, 49856.50143498664, 49976.0, 7753.612319384121, 7809.3362064225175, 7874.606269686607, 7921.643526041226, 8089.959550202211, 11120.666380008613, 12248.87751122513, 12373.505059797508, 12396.380180991095, 12643.620691379274, 7074.0, 10212.744681382728, 10607.727072751319, 10676.519556620126, 10686.0, 10303.124234439856, 10427.478626068514, 10509.584385075033, 10694.73263168427, 10782.730431738955, 10210.438425886647, 10466.267361284941, 10753.139748820233, 10937.617183398543, 10944.23390362667, 7782.260685234894, 7808.297253247235, 7916.6041697916025, 8135.471194372347, 8136.105028446747, 7852.057753069668, 9517.666881659108, 10737.946310268399, 10767.084797792275, 10881.619143330263], "value": 8044.694515430317, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1349.952751653692, 1397.9180792087104, 1447.7828325751136, 1618.54680689407, 1624.8456396642323, 6858.691358888849, 7413.184549699528, 7550.660220290087, 8081.111077781439, 8135.837283254339, 7479.065116860393, 7752.147263800977, 7770.611469426534, 7807.375409967203, 7853.450258481908, 2202.614542455072, 2245.786650268222, 2246.2811900191946, 2246.4833088389682, 2246.84272100953, 2168.1327469012363, 2170.750363708178, 2194.5501172259646, 2200.482886521666, 2201.0095457044313, 2180.8364372672036, 2184.137265780016, 2194.9012294446707, 2195.648696208607, 2226.866388016716, 2105.3368189020484, 2110.145391116585, 2112.1445814445174, 2115.428834214761, 2125.0437303213616, 2011.8994050297572, 2043.9693404598943, 2099.876566037163, 2135.1886283212434, 2152.903119359617, 7892.408069394818, 7927.048754149481, 7971.800704982364, 7972.760817175494, 7975.122736498981, 4709.529047095298, 4767.856964291077, 4780.760961951889, 4804.351412559295, 4831.9275210871865, 2852.657681078284, 2880.1791489425623, 2968.807027543203, 2988.3126880817317, 3066.9846650766826, 909.4861403307176, 919.1589695428742, 947.1381043250609, 982.2534873496123, 984.414273507262, 10502.422366769824, 10528.0, 10563.102136318423, 10574.62988795396, 10606.15150787943, 4273.914521709548, 4339.088791353788, 4428.31361139024, 4437.29003359461, 4447.466304043535, 8921.0, 8963.103689631114, 9012.27901767857, 9018.86471702925, 9022.233110185576, 4697.81208751653, 4718.150732868048, 4751.524847515221, 4756.357891684647, 4758.833440829554, 3829.157585331223, 4126.154138401621, 4252.255855225323, 4287.121140166259, 4329.264025115738, 3776.8866933992026, 3809.961900381016, 3853.6339047790416, 3900.7269491135917, 3989.9800500997308, 1243.776120298355, 1247.5839921688766, 1253.078986944595, 1257.346179986402, 1270.294986282622, 687.1479365586637, 775.4261846233859, 788.6017561131591, 793.2305663506389, 839.2824135364176, 4887.511248875155, 4974.27872958419, 5007.899842003139, 5059.06407314648, 5063.8987220255385, 421.2838175102338, 427.4485913172035, 438.24184161400956, 440.51983338160915, 442.15327647554574, 3426.2804810989473, 3494.7029502492064, 3497.5977762557122, 3511.964880351215, 3558.3061303046175, 9578.616855325849, 9822.410655360702, 9917.702468925943, 9937.354071985297, 9944.502774861228, 9676.951615241878, 9697.369670971364, 9715.271354648288, 9727.367721098106, 9794.118529332252, 7293.562386256842, 7317.451191160684, 7330.193678695339, 7356.264373562708, 7466.70133194677, 4954.65317427791, 4977.726225057657, 5025.497450254945, 5035.244713293036, 5082.466341034138, 8619.267362274277, 8958.910410895807, 9011.549422528717, 9017.2786177107, 9055.18503334703, 9234.630614775602, 9261.768455788659, 9272.397294175857, 9285.72142835716, 9287.535623218948, 6125.877482450237, 6650.168728908887, 6654.73381064752, 6795.0, 6837.897431538431, 7572.091349038151, 7610.847783044419, 7631.656575454229, 7666.655000525101, 7681.500702454323, 6685.76599819004, 6892.069570608104, 6987.6855541499735, 6997.790066298019, 7085.008098866266, 6846.281140480178, 6849.178098627997, 6900.309969003059, 6904.067950826775, 6952.582845029315, 6287.088372186099, 6344.30212676596, 6458.644774537445, 6461.256955449995, 6464.385883341075, 4516.367708520876, 4519.231730605739, 4564.726116433025, 4590.311453282035, 4612.377329060534, 4509.729416235036, 4523.547645235451, 4542.3413605027745, 4570.748608826547, 4665.930011049769], "value": 4081.3959948689935, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [292.6722071280167, 305.96022517072777, 308.65893188027223, 310.9486934655782, 311.6680735017205, 4874.585660218877, 4945.876353091175, 5050.570701490373, 5092.694438333698, 5112.36095488064, 5024.497550244973, 5055.9747201263945, 5057.822976195834, 5064.924026139611, 5073.949260507394, 3952.4861767970197, 3969.325214713506, 3976.8069579126145, 3987.3620220764683, 3988.6410223079915, 3887.747296425723, 3943.2704949584418, 3956.8417263309575, 3974.344233201533, 3975.2248311579256, 3897.395903634927, 3902.8829135125993, 3903.4535165076913, 3913.4716813230134, 3915.39311406731, 3922.7254092213557, 3931.862384816532, 3934.547527034399, 3938.8030598470104, 3945.7237993340477, 3468.8612455502002, 3494.1264683829045, 3500.632433594487, 3516.5428494295834, 3520.137566296248, 4684.5549672781035, 4920.581750551208, 4926.45808961014, 4926.802927882881, 4979.601631869442, 4420.977895110504, 4456.910861782746, 4465.486469056035, 4469.324003498688, 4470.307102399133, 5272.420033796279, 5279.732864112585, 5287.4976877196605, 5289.68261904287, 5293.814716484904, 3663.6519530644546, 3706.6478684524927, 3710.647488488616, 3754.4743735877, 3770.604086570898, 5453.263809385722, 5467.617266791326, 5471.37079235889, 5473.425290344536, 5491.807786727445, 3794.2221844521805, 3794.392897136445, 3807.676347510437, 3807.800542829, 3832.271868345061, 3813.874164094334, 3853.2678791029616, 3878.0, 3880.9029774255305, 3921.215756848642, 4317.84887528935, 4387.605115539617, 4390.517043125254, 4393.494748103945, 4398.670099742532, 5212.374515058217, 5218.739063046908, 5235.397929238186, 5239.318888544465, 5250.7637156328055, 1235.8393408856791, 1311.4360824845216, 1334.426196735413, 1337.5318638476456, 1344.9798253026213, 832.5629044751432, 843.401185158532, 849.4011721736161, 851.3997631669658, 859.4886042804521, 4133.705793284696, 4211.115665710236, 4219.649712092101, 4233.682473814476, 4238.851640192578, 4794.9280760788615, 4805.591524720368, 4819.445763737215, 4821.927671084936, 4836.0, 4235.724677895927, 4251.553586873396, 4254.723442976258, 4256.106217694319, 4264.957350426518, 2479.6280557916098, 2569.0, 2579.2649095007832, 2584.883680234394, 2635.3279913621905, 4590.632749380042, 4605.825514493783, 4613.63090952723, 4639.744814035261, 4646.790894409692, 4835.927461088087, 4872.561469467694, 4873.951260487421, 4945.318591678846, 4952.727599982036, 4301.5698430156735, 4507.414036175276, 4562.9771851141195, 4579.152856721517, 4579.839705610288, 4752.5485078917445, 4756.764320769233, 4838.564529192389, 4870.659053866196, 4875.000624871964, 4664.440267167962, 4691.788869500949, 4714.010057887745, 4721.693089949143, 4757.881052973565, 4556.635469162526, 4628.745419001987, 5107.489251074863, 5125.308083408692, 5141.25451809493, 3761.1725420407465, 3816.7137464690813, 3827.215420838777, 3845.4616353709944, 3852.5184351956004, 5133.535902766618, 5493.09363954943, 5507.862303442446, 5513.558915286848, 5542.196381524737, 5121.257417674342, 5220.060389129993, 5224.555912747459, 5244.767479642204, 5289.233061206027, 5208.869778255574, 5253.947460525345, 5255.502181878146, 5277.815276465305, 5323.361196656426, 5004.924926126184, 5193.169092945111, 5204.34945631796, 5276.0, 5282.445343238905, 5377.919331210113, 5386.353637563518, 5400.2439658447065, 5403.433004428829, 5426.8371948841595, 5222.42553319127, 5272.130098533699, 5273.472652734696, 5287.339082614673, 5302.2046692996355], "value": 3852.9638504767777, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [636.0560561552293, 676.4284179868013, 681.9931800681992, 733.7028503456102, 742.9561466140075, 11618.767624647513, 13725.725485490284, 14193.077449965745, 14233.217173055491, 14249.715005699905, 14547.927260363684, 14657.56027319182, 14679.266036698149, 14795.0, 14819.110853348806, 625.2340882419023, 777.9572123533203, 792.5640897506391, 801.0547553886412, 803.8553060449117, 781.5662307419379, 782.6126067596548, 785.7996210966196, 787.2875048081495, 788.6411682684394, 827.5407149032285, 828.3869936247194, 829.3365307753803, 829.5188790501495, 830.9750707478755, 819.2299238715648, 820.6553247635977, 821.0229826506438, 821.9095899451086, 822.4407402966011, 592.6947621974687, 594.940505949406, 597.375742349246, 597.4085655201363, 600.1058422949817, 13687.315634218348, 13702.65743356424, 13758.0, 13846.861531384659, 13851.099678520864, 13009.60971170857, 13224.603261902063, 13346.733065338736, 13516.12145210558, 13552.728945421135, 10155.238357123246, 10309.84535231972, 10346.12057975073, 10352.327098738559, 10370.79258414835, 3310.3710295043866, 3333.3499967506345, 3347.297067615804, 3387.6781705737917, 3414.6243913169533, 50362.49637503651, 52058.479415205744, 52526.21210681843, 59769.402305976815, 63196.0, 10243.7439064024, 10530.15758739299, 10553.947230263799, 10709.357438553712, 10718.35689858611, 16904.32382704678, 16971.490855274362, 16974.575635608962, 17105.657886842444, 17118.0, 7132.500724949204, 7197.4961752677855, 7265.237150099163, 7268.309510596485, 7324.4872858900435, 3995.780232087263, 4039.636432721069, 4048.0891799344913, 4054.1688953764406, 4121.155163191538, 2872.4973129702216, 2966.821990680566, 2971.405718856194, 2972.405518896186, 2972.5986991755835, 523.0872128136426, 524.1508755815603, 531.5853634165358, 533.8291746641038, 543.7009644695402, 468.9366935463737, 550.3038656100036, 606.805822136912, 607.3838824930493, 641.7112299465166, 7030.226675065739, 7344.081989751281, 7442.218567050381, 7452.515586486861, 7533.397328213729, 535.8579976306282, 615.2831950777295, 636.3032479435011, 636.5575924732359, 646.6249575246346, 3668.486411902336, 3749.1376983293994, 3835.712321575837, 3881.4954055973108, 3888.494495715539, 93944.53027734818, 94984.0, 95151.0, 95917.5204123975, 96915.51542242244, 48038.51961480411, 49043.0, 49607.75196123996, 51086.48913510892, 51917.48082519202, 66936.0, 71374.28625713676, 71520.28479715137, 72245.63877180581, 72387.0, 7394.223606521237, 7434.3309102181065, 7618.162002179866, 7670.0, 7735.806604834924, 42189.0, 43764.78117609519, 44234.77882610566, 44975.550244497135, 44996.0, 37287.627123728416, 51013.0, 63435.36564634479, 63783.0, 64055.0, 9772.364796288219, 9993.500324983575, 10197.74505637365, 10234.130098941674, 10546.103581195684, 10618.8938110621, 10628.946855265674, 10885.020348168702, 11109.388983605655, 12011.339376334035, 9111.225545828414, 9250.21373183287, 9357.251419886257, 10345.327553708985, 10451.58193672275, 10024.949875250577, 10203.795924081625, 10403.167746580406, 10769.9461502692, 10871.184661150604, 9782.461964592016, 10319.329243599143, 10375.014373634493, 10379.169666426516, 10668.519916603927, 7887.132415434412, 8155.225253600898, 8177.918220817715, 8462.365322600706, 8630.093840146945, 7848.84302313962, 7866.449348545547, 7931.60341982887, 8007.1592482788465, 8028.397870159644], "value": 6259.763624711219, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1592.8000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 111.0, 115.0, 116.0, 117.0, 116.0, 114.0, 115.0, 114.0, 115.0], "value": 114.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 132.0, 166.0, 175.0, 140.0, 161.0, 157.0, 132.0, 202.0, 151.0], "value": 157.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 179.0, 165.0, 167.0, 163.0, 164.0, 165.0, 165.0, 163.0, 162.0], "value": 165.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 76.0, 75.0, 173.0, 77.0, 77.0, 77.0, 76.0, 161.0, 78.0], "value": 94.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 148.0, 88.0, 88.0, 87.0, 131.0, 86.0, 86.0, 140.0], "value": 102.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 123.0, 117.0, 117.0, 119.0, 119.0, 119.0, 119.0, 118.0], "value": 118.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 149.0, 148.0, 147.0, 148.0, 149.0, 148.0, 148.0, 149.0, 149.0], "value": 148.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 96.0, 96.0, 95.0, 96.0, 96.0, 95.0, 95.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 63.0, 64.0, 64.0, 64.0, 63.0, 64.0, 63.0, 64.0], "value": 63.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 67.0, 70.0, 65.0, 66.0, 66.0, 66.0, 67.0, 65.0, 67.0], "value": 66.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 85.0, 86.0, 88.0, 91.0, 85.0, 84.0, 122.0, 90.0], "value": 90.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 130.0, 131.0, 132.0, 133.0, 135.0, 137.0, 134.0, 138.0, 139.0], "value": 134.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 171.0, 175.0, 171.0, 172.0, 170.0, 174.0, 173.0, 165.0, 171.0], "value": 171.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 67.0, 72.0, 71.0, 68.0, 67.0, 67.0, 69.0, 67.0], "value": 68.4, "unit": "score"}]}]} 23:00:28 INFO - Return code: 0 23:00:28 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 23:00:28 ERROR - # TBPL SUCCESS # 23:00:28 INFO - Running post-action listener: _resource_record_post_action 23:00:28 INFO - ##### 23:00:28 INFO - ##### Finished run-tests step (success) 23:00:28 INFO - ##### 23:00:28 INFO - Running post-run listener: _resource_record_post_run 23:00:28 INFO - Total resource usage - Wall time: 1198s; CPU: 14.0%; Read bytes: 12288; Write bytes: 534982656; Read time: 184; Write time: 444100 23:00:28 INFO - TinderboxPrint: CPU usage
13.5% 23:00:28 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 184 23:00:28 INFO - TinderboxPrint: I/O write bytes / time
534,982,656 / 444,100 23:00:28 INFO - TinderboxPrint: CPU idle
8,262.8 (86.4%) 23:00:28 INFO - TinderboxPrint: CPU user
1,236.3 (12.9%) 23:00:28 INFO - TinderboxPrint: Swap in / out
0 / 0 23:00:28 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 146534400; Read time: 0; Write time: 178892 23:00:28 INFO - run-tests - Wall time: 1183s; CPU: 14.0%; Read bytes: 12288; Write bytes: 296226816; Read time: 184; Write time: 195332 23:00:29 INFO - Running post-run listener: _upload_blobber_files 23:00:29 INFO - Blob upload gear active. 23:00:29 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 23:00:29 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 23:00:29 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'] 23:00:29 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 23:00:29 INFO - (blobuploader) - INFO - Open directory for files ... 23:00:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 23:00:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:00:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:00:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 23:00:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:00:30 INFO - (blobuploader) - INFO - Done attempting. 23:00:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 23:00:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:00:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:00:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 23:00:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:00:31 INFO - (blobuploader) - INFO - Done attempting. 23:00:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 23:00:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:00:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:00:36 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 23:00:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:00:36 INFO - (blobuploader) - INFO - Done attempting. 23:00:36 INFO - (blobuploader) - INFO - Iteration through files over. 23:00:36 INFO - Return code: 0 23:00:36 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 23:00:36 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 23:00:36 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a39099286944f484a9e5f5862527f61c4d8a7b61aa0fd57c244b388bfd06560262d48c9326b8067ceabfbd3e916a6e87ebbd7eb4e63e47fa2db471b574f4e207", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/db2cce8b70fc48a0d63d39d9562d9a137d7b209356a83ef689c2910b0f0afa5bdfe0659f7aeabbf85485f8382e3370a16ac783afd7f55ed980b2c6fc30343441", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5957fc35572761803d17719dd34030b6cd1e8f5776f79bb910042467e0ee2c5e3f991d799bbe0b8e0cf7ed6e2b4139e53096a52ca23d32446aba0e6ae0dc6a1f"} 23:00:36 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 23:00:36 INFO - Writing to file /builds/slave/test/properties/blobber_files 23:00:36 INFO - Contents: 23:00:36 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a39099286944f484a9e5f5862527f61c4d8a7b61aa0fd57c244b388bfd06560262d48c9326b8067ceabfbd3e916a6e87ebbd7eb4e63e47fa2db471b574f4e207", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/db2cce8b70fc48a0d63d39d9562d9a137d7b209356a83ef689c2910b0f0afa5bdfe0659f7aeabbf85485f8382e3370a16ac783afd7f55ed980b2c6fc30343441", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5957fc35572761803d17719dd34030b6cd1e8f5776f79bb910042467e0ee2c5e3f991d799bbe0b8e0cf7ed6e2b4139e53096a52ca23d32446aba0e6ae0dc6a1f"} 23:00:36 INFO - Running post-run listener: copy_logs_to_upload_dir 23:00:36 INFO - Copying logs to upload dir... 23:00:36 INFO - mkdir: /builds/slave/test/build/upload/logs 23:00:36 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1254.862855 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2016-06-10 23:00:36.017371) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-10 23:00:36.020935) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1465617770.572704-728091675 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a39099286944f484a9e5f5862527f61c4d8a7b61aa0fd57c244b388bfd06560262d48c9326b8067ceabfbd3e916a6e87ebbd7eb4e63e47fa2db471b574f4e207", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/db2cce8b70fc48a0d63d39d9562d9a137d7b209356a83ef689c2910b0f0afa5bdfe0659f7aeabbf85485f8382e3370a16ac783afd7f55ed980b2c6fc30343441", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5957fc35572761803d17719dd34030b6cd1e8f5776f79bb910042467e0ee2c5e3f991d799bbe0b8e0cf7ed6e2b4139e53096a52ca23d32446aba0e6ae0dc6a1f"} build_url:https://queue.taskcluster.net/v1/task/EtyFhpBfQlaK5wofT7rF7Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011281 build_url: 'https://queue.taskcluster.net/v1/task/EtyFhpBfQlaK5wofT7rF7Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a39099286944f484a9e5f5862527f61c4d8a7b61aa0fd57c244b388bfd06560262d48c9326b8067ceabfbd3e916a6e87ebbd7eb4e63e47fa2db471b574f4e207", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/db2cce8b70fc48a0d63d39d9562d9a137d7b209356a83ef689c2910b0f0afa5bdfe0659f7aeabbf85485f8382e3370a16ac783afd7f55ed980b2c6fc30343441", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5957fc35572761803d17719dd34030b6cd1e8f5776f79bb910042467e0ee2c5e3f991d799bbe0b8e0cf7ed6e2b4139e53096a52ca23d32446aba0e6ae0dc6a1f"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-10 23:00:36.047394) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 23:00:36.047743) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1465617770.572704-728091675 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004466 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-10 23:00:36.129491) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-10 23:00:36.129806) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-10 23:00:36.130097) ========= ========= Total master_lag: 0.17 =========