builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-052 starttime: 1465193319.22 results: success (0) buildid: 20160605222532 builduid: d91ea748e74840eba03f006164e6976d revision: 824355c9efe23d83f7e67a4b2c9e0e837f7c7771 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-05 23:08:39.216112) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-05 23:08:39.216540) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-05 23:08:39.216879) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-05 23:08:39.247985) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-05 23:08:39.248341) ========= 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=826874ccc97bd7bf541b4875000001d5-1465180425.410960-1540520960 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-05 23:08:40-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 219M=0s 2016-06-05 23:08:40 (219 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.130262 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-05 23:08:39.403590) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-05 23:08:39.403934) ========= 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=826874ccc97bd7bf541b4875000001d5-1465180425.410960-1540520960 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022433 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-05 23:08:39.466484) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-05 23:08:39.466872) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 824355c9efe23d83f7e67a4b2c9e0e837f7c7771 --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 824355c9efe23d83f7e67a4b2c9e0e837f7c7771 --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=826874ccc97bd7bf541b4875000001d5-1465180425.410960-1540520960 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-05 23:08:40,314 truncating revision to first 12 chars 2016-06-05 23:08:40,314 Setting DEBUG logging. 2016-06-05 23:08:40,314 attempt 1/10 2016-06-05 23:08:40,314 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/824355c9efe2?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-05 23:08:41,297 unpacking tar archive at: fx-team-824355c9efe2/testing/mozharness/ program finished with exit code 0 elapsedTime=1.306998 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-05 23:08:40.788072) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-05 23:08:40.788426) ========= script_repo_revision: 824355c9efe23d83f7e67a4b2c9e0e837f7c7771 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-05 23:08:40.788912) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-05 23:08:40.789219) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-05 23:08:40.800237) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2016-06-05 23:08:40.800543) ========= /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=826874ccc97bd7bf541b4875000001d5-1465180425.410960-1540520960 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 23:08:41 INFO - MultiFileLogger online at 20160605 23:08:41 in /builds/slave/test 23:08:41 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 23:08:41 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 23:08:41 INFO - {'append_to_log': False, 23:08:41 INFO - 'base_work_dir': '/builds/slave/test', 23:08:41 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 23:08:41 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 23:08:41 INFO - 'branch': 'Fx-Team-Non-PGO', 23:08:41 INFO - 'buildbot_json_path': 'buildprops.json', 23:08:41 INFO - 'config_files': ('talos/linux_config.py',), 23:08:41 INFO - 'default_actions': ('clobber', 23:08:41 INFO - 'read-buildbot-config', 23:08:41 INFO - 'download-and-extract', 23:08:41 INFO - 'populate-webroot', 23:08:41 INFO - 'create-virtualenv', 23:08:41 INFO - 'install', 23:08:41 INFO - 'run-tests'), 23:08:41 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 23:08:41 INFO - 'download_minidump_stackwalk': True, 23:08:41 INFO - 'download_symbols': 'ondemand', 23:08:41 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 23:08:41 INFO - 'tooltool.py': '/tools/tooltool.py', 23:08:41 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 23:08:41 INFO - '/tools/misc-python/virtualenv.py')}, 23:08:41 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 23:08:41 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 23:08:41 INFO - 'installer_path': 'installer.exe', 23:08:41 INFO - 'log_level': 'info', 23:08:41 INFO - 'log_name': 'talos', 23:08:41 INFO - 'log_to_console': True, 23:08:41 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 23:08:41 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 23:08:41 INFO - 'opt_config_files': (), 23:08:41 INFO - 'pip_index': False, 23:08:41 INFO - 'sps_profile': False, 23:08:41 INFO - 'sps_profile_interval': 0, 23:08:41 INFO - 'suite': 'dromaeojs-e10s', 23:08:41 INFO - 'system_bits': '32', 23:08:41 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 23:08:41 INFO - 'title': 'talos-linux64-ix-052', 23:08:41 INFO - 'tooltool_cache': '/builds/tooltool_cache', 23:08:41 INFO - 'use_talos_json': True, 23:08:41 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 23:08:41 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 23:08:41 INFO - 'work_dir': 'build'} 23:08:41 INFO - ##### 23:08:41 INFO - ##### Running clobber step. 23:08:41 INFO - ##### 23:08:41 INFO - Running pre-action listener: _resource_record_pre_action 23:08:41 INFO - Running main action method: clobber 23:08:41 INFO - rmtree: /builds/slave/test/build 23:08:41 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 23:08:42 INFO - Running post-action listener: _resource_record_post_action 23:08:42 INFO - ##### 23:08:42 INFO - ##### Finished clobber step (success) 23:08:42 INFO - ##### 23:08:42 INFO - ##### 23:08:42 INFO - ##### Running read-buildbot-config step. 23:08:42 INFO - ##### 23:08:42 INFO - Running pre-action listener: _resource_record_pre_action 23:08:42 INFO - Running main action method: read_buildbot_config 23:08:42 INFO - Using buildbot properties: 23:08:42 INFO - { 23:08:42 INFO - "project": "", 23:08:42 INFO - "product": "firefox", 23:08:42 INFO - "script_repo_revision": "production", 23:08:42 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 23:08:42 INFO - "repository": "", 23:08:42 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 23:08:42 INFO - "buildid": "20160605222532", 23:08:42 INFO - "pgo_build": "False", 23:08:42 INFO - "basedir": "/builds/slave/test", 23:08:42 INFO - "buildnumber": 1557, 23:08:42 INFO - "slavename": "talos-linux64-ix-052", 23:08:42 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 23:08:42 INFO - "platform": "ubuntu64_hw", 23:08:42 INFO - "scheduler": "tests-fx-team-linux64-talos", 23:08:42 INFO - "branch": "fx-team", 23:08:42 INFO - "repo_path": "integration/fx-team", 23:08:42 INFO - "revision": "824355c9efe23d83f7e67a4b2c9e0e837f7c7771", 23:08:42 INFO - "stage_platform": "linux64", 23:08:42 INFO - "builduid": "d91ea748e74840eba03f006164e6976d", 23:08:42 INFO - "slavebuilddir": "test" 23:08:42 INFO - } 23:08:42 INFO - Found installer url https://queue.taskcluster.net/v1/task/R6Ysy68PTkG3ZqIWUMsjFw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 23:08:42 INFO - Running post-action listener: _resource_record_post_action 23:08:42 INFO - ##### 23:08:42 INFO - ##### Finished read-buildbot-config step (success) 23:08:42 INFO - ##### 23:08:42 INFO - ##### 23:08:42 INFO - ##### Running download-and-extract step. 23:08:42 INFO - ##### 23:08:42 INFO - Running pre-action listener: _resource_record_pre_action 23:08:42 INFO - Running main action method: download_and_extract 23:08:42 INFO - mkdir: /builds/slave/test/build/tests 23:08: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')]} 23:08:42 INFO - https://queue.taskcluster.net/v1/task/R6Ysy68PTkG3ZqIWUMsjFw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 23:08:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R6Ysy68PTkG3ZqIWUMsjFw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 23:08:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R6Ysy68PTkG3ZqIWUMsjFw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 23:08:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R6Ysy68PTkG3ZqIWUMsjFw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 23:08:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R6Ysy68PTkG3ZqIWUMsjFw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 23:08:49 INFO - Downloaded 1361 bytes. 23:08:49 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 23:08:49 INFO - Using the following test package requirements: 23:08:49 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 23:08:49 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 23:08:49 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 23:08:49 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 23:08:49 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 23:08:49 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 23:08:49 INFO - u'jsshell-linux-x86_64.zip'], 23:08:49 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 23:08:49 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 23:08:49 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 23:08:49 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 23:08:49 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 23:08:49 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 23:08:49 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 23:08:49 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 23:08:49 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 23:08:49 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 23:08:49 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 23:08:49 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 23:08:49 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')]} 23:08:49 INFO - https://queue.taskcluster.net/v1/task/R6Ysy68PTkG3ZqIWUMsjFw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:08:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R6Ysy68PTkG3ZqIWUMsjFw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 23:08:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R6Ysy68PTkG3ZqIWUMsjFw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 23:08:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R6Ysy68PTkG3ZqIWUMsjFw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 23:08:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R6Ysy68PTkG3ZqIWUMsjFw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 23:08:54 INFO - Downloaded 22868152 bytes. 23:08:54 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 23:08:54 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 23:08:55 INFO - Return code: 0 23:08:55 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 23:08:55 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')]} 23:08:55 INFO - https://queue.taskcluster.net/v1/task/R6Ysy68PTkG3ZqIWUMsjFw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:08:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R6Ysy68PTkG3ZqIWUMsjFw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 23:08:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R6Ysy68PTkG3ZqIWUMsjFw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 23:08:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R6Ysy68PTkG3ZqIWUMsjFw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 23:08:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R6Ysy68PTkG3ZqIWUMsjFw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 23:08:59 INFO - Downloaded 22868152 bytes. 23:08:59 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 23:08:59 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 23:09:00 INFO - Return code: 0 23:09:00 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')]} 23:09:00 INFO - https://queue.taskcluster.net/v1/task/R6Ysy68PTkG3ZqIWUMsjFw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 23:09:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R6Ysy68PTkG3ZqIWUMsjFw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 23:09:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R6Ysy68PTkG3ZqIWUMsjFw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 23:09:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R6Ysy68PTkG3ZqIWUMsjFw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 23:09:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R6Ysy68PTkG3ZqIWUMsjFw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 23:09:01 INFO - Downloaded 10833369 bytes. 23:09:01 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 23:09:01 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 23:09:02 INFO - Return code: 0 23:09:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:09:02 INFO - https://queue.taskcluster.net/v1/task/R6Ysy68PTkG3ZqIWUMsjFw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 23:09:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R6Ysy68PTkG3ZqIWUMsjFw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 23:09:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R6Ysy68PTkG3ZqIWUMsjFw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 23:09:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R6Ysy68PTkG3ZqIWUMsjFw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 23:09:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R6Ysy68PTkG3ZqIWUMsjFw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 23:09:03 INFO - Downloaded 55183220 bytes. 23:09:03 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/R6Ysy68PTkG3ZqIWUMsjFw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 23:09:03 INFO - mkdir: /builds/slave/test/properties 23:09:03 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 23:09:03 INFO - Writing to file /builds/slave/test/properties/build_url 23:09:03 INFO - Contents: 23:09:03 INFO - build_url:https://queue.taskcluster.net/v1/task/R6Ysy68PTkG3ZqIWUMsjFw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 23:09:04 INFO - Running post-action listener: _resource_record_post_action 23:09:04 INFO - Running post-action listener: set_extra_try_arguments 23:09:04 INFO - ##### 23:09:04 INFO - ##### Finished download-and-extract step (success) 23:09:04 INFO - ##### 23:09:04 INFO - ##### 23:09:04 INFO - ##### Running populate-webroot step. 23:09:04 INFO - ##### 23:09:04 INFO - Running pre-action listener: _resource_record_pre_action 23:09:04 INFO - Running main action method: populate_webroot 23:09:04 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 23:09:04 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 23:09:04 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 23:09:04 INFO - '--tppagecycles', 23:09:04 INFO - '7'], 23:09:04 INFO - 'tests': ['tsvgm']}}, 23:09:04 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 23:09:04 INFO - 'tests': ['tresize', 'tcanvasmark']}, 23:09:04 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 23:09:04 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 23:09:04 INFO - 'tests': ['dromaeo_css', 'kraken']}, 23:09:04 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 23:09:04 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:09:04 INFO - 'talos_options': ['--disable-e10s'], 23:09:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:09:04 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:09:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:09:04 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:09:04 INFO - 'talos_options': ['--disable-e10s'], 23:09:04 INFO - 'tests': ['damp', 'tps']}, 23:09:04 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:09:04 INFO - 'tests': ['damp', 'tps']}, 23:09:04 INFO - 'g3': {'talos_options': ['--disable-e10s'], 23:09:04 INFO - 'tests': ['dromaeo_dom']}, 23:09:04 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 23:09:04 INFO - 'other': {'talos_options': ['--disable-e10s'], 23:09:04 INFO - 'tests': ['a11yr', 23:09:04 INFO - 'ts_paint', 23:09:04 INFO - 'tpaint', 23:09:04 INFO - 'sessionrestore', 23:09:04 INFO - 'sessionrestore_no_auto_restore', 23:09:04 INFO - 'tabpaint']}, 23:09:04 INFO - 'other-e10s': {'tests': ['a11yr', 23:09:04 INFO - 'ts_paint', 23:09:04 INFO - 'tpaint', 23:09:04 INFO - 'sessionrestore', 23:09:04 INFO - 'sessionrestore_no_auto_restore', 23:09:04 INFO - 'tabpaint']}, 23:09:04 INFO - 'other-e10s_l64': {'tests': ['a11yr', 23:09:04 INFO - 'ts_paint', 23:09:04 INFO - 'tpaint', 23:09:04 INFO - 'sessionrestore', 23:09:04 INFO - 'sessionrestore_no_auto_restore', 23:09:04 INFO - 'tabpaint']}, 23:09:04 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 23:09:04 INFO - 'ts_paint', 23:09:04 INFO - 'tpaint', 23:09:04 INFO - 'sessionrestore', 23:09:04 INFO - 'sessionrestore_no_auto_restore', 23:09:04 INFO - 'tabpaint']}, 23:09:04 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 23:09:04 INFO - 'tests': ['a11yr', 23:09:04 INFO - 'ts_paint', 23:09:04 INFO - 'tpaint', 23:09:04 INFO - 'sessionrestore', 23:09:04 INFO - 'sessionrestore_no_auto_restore', 23:09:04 INFO - 'tabpaint']}, 23:09:04 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 23:09:04 INFO - 'tests': ['a11yr', 23:09:04 INFO - 'ts_paint', 23:09:04 INFO - 'tpaint', 23:09:04 INFO - 'sessionrestore', 23:09:04 INFO - 'sessionrestore_no_auto_restore', 23:09:04 INFO - 'tabpaint']}, 23:09:04 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 23:09:04 INFO - 'tests': ['tsvgx', 23:09:04 INFO - 'tsvgr_opacity', 23:09:04 INFO - 'tart', 23:09:04 INFO - 'tscrollx', 23:09:04 INFO - 'cart']}, 23:09:04 INFO - 'svgr-e10s': {'tests': ['tsvgx', 23:09:04 INFO - 'tsvgr_opacity', 23:09:04 INFO - 'tart', 23:09:04 INFO - 'tscrollx', 23:09:04 INFO - 'cart']}, 23:09:04 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:09:04 INFO - 'talos_options': ['--disable-e10s'], 23:09:04 INFO - 'tests': ['tp5o']}, 23:09:04 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:09:04 INFO - 'tests': ['tp5o']}, 23:09:04 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:09:04 INFO - 'talos_options': ['--disable-e10s', 23:09:04 INFO - '--xperf_path', 23:09:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:09:04 INFO - 'tests': ['tp5n']}, 23:09:04 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:09:04 INFO - 'talos_options': ['--xperf_path', 23:09:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:09:04 INFO - 'tests': ['tp5n']}}, 23:09:04 INFO - 'talos.zip': {'path': '', 23:09:04 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 23:09:04 INFO - Running post-action listener: _resource_record_post_action 23:09:04 INFO - ##### 23:09:04 INFO - ##### Finished populate-webroot step (success) 23:09:04 INFO - ##### 23:09:04 INFO - ##### 23:09:04 INFO - ##### Running create-virtualenv step. 23:09:04 INFO - ##### 23:09:04 INFO - Running pre-action listener: _resource_record_pre_action 23:09:04 INFO - Running main action method: create_virtualenv 23:09:04 INFO - Creating virtualenv /builds/slave/test/build/venv 23:09:04 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 23:09:04 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 23:09:04 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 23:09:04 INFO - Using real prefix '/usr' 23:09:04 INFO - New python executable in /builds/slave/test/build/venv/bin/python 23:09:05 INFO - Installing distribute.............................................................................................................................................................................................done. 23:09:07 INFO - Installing pip.................done. 23:09:07 INFO - Return code: 0 23:09:07 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 23:09: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')]} 23:09:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:09:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:09: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')]} 23:09:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:09:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:09: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 0x7f5945cb9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e78350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f071c0>, '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 0x1f080c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f08550>, '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': '826874ccc97bd7bf541b4875000001d5-1465180425.410960-1540520960', '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 23:09: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 23:09: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 23:09:07 INFO - Using env: {'DISPLAY': ':0', 23:09:07 INFO - 'HOME': '/home/cltbld', 23:09:07 INFO - 'LANG': 'en_US.UTF-8', 23:09:07 INFO - 'LANGUAGE': 'en_US:en', 23:09:07 INFO - 'LOGNAME': 'cltbld', 23:09:07 INFO - 'MAIL': '/var/mail/cltbld', 23:09:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:09:07 INFO - 'MOZ_NO_REMOTE': '1', 23:09:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:09:07 INFO - 'NO_EM_RESTART': '1', 23:09:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:09:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:09:07 INFO - 'PWD': '/builds/slave/test', 23:09:07 INFO - 'SHELL': '/bin/bash', 23:09:07 INFO - 'SHLVL': '1', 23:09:07 INFO - 'TERM': 'linux', 23:09:07 INFO - 'TMOUT': '86400', 23:09:07 INFO - 'USER': 'cltbld', 23:09:07 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1465180425.410960-1540520960', 23:09:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:09:07 INFO - '_': '/tools/buildbot/bin/python'} 23:09:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:09:07 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 23:09:07 INFO - Cleaning up... 23:09:07 INFO - Return code: 0 23:09:07 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 23:09: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')]} 23:09:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:09:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:09: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')]} 23:09:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:09:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:09: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', '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 0x7f5945cb9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e78350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f071c0>, '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 0x1f080c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f08550>, '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': '826874ccc97bd7bf541b4875000001d5-1465180425.410960-1540520960', '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 23:09: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', 'psutil>=3.1.1'] in /builds/slave/test/build 23:09: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 psutil>=3.1.1 23:09:07 INFO - Using env: {'DISPLAY': ':0', 23:09:07 INFO - 'HOME': '/home/cltbld', 23:09:07 INFO - 'LANG': 'en_US.UTF-8', 23:09:07 INFO - 'LANGUAGE': 'en_US:en', 23:09:07 INFO - 'LOGNAME': 'cltbld', 23:09:07 INFO - 'MAIL': '/var/mail/cltbld', 23:09:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:09:07 INFO - 'MOZ_NO_REMOTE': '1', 23:09:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:09:07 INFO - 'NO_EM_RESTART': '1', 23:09:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:09:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:09:07 INFO - 'PWD': '/builds/slave/test', 23:09:07 INFO - 'SHELL': '/bin/bash', 23:09:07 INFO - 'SHLVL': '1', 23:09:07 INFO - 'TERM': 'linux', 23:09:07 INFO - 'TMOUT': '86400', 23:09:07 INFO - 'USER': 'cltbld', 23:09:07 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1465180425.410960-1540520960', 23:09:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:09:07 INFO - '_': '/tools/buildbot/bin/python'} 23:09:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:09:07 INFO - Downloading/unpacking psutil>=3.1.1 23:09:07 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 23:09:07 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 23:09:07 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 23:09:07 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 23:09:07 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 23:09:07 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 23:09:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 23:09:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:09:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:09:09 INFO - Installing collected packages: psutil 23:09:09 INFO - Running setup.py install for psutil 23:09:09 INFO - building 'psutil._psutil_linux' extension 23:09:09 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 23:09:09 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 23:09:09 INFO - building 'psutil._psutil_posix' extension 23:09:09 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 23:09:09 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 23:09:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:09:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:09:09 INFO - Successfully installed psutil 23:09:09 INFO - Cleaning up... 23:09:10 INFO - Return code: 0 23:09:10 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 23:09: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')]} 23:09:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:09:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:09: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')]} 23:09:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:09:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:09: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 0x7f5945cb9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e78350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f071c0>, '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 0x1f080c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f08550>, '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': '826874ccc97bd7bf541b4875000001d5-1465180425.410960-1540520960', '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 23:09: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 23:09: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 23:09:10 INFO - Using env: {'DISPLAY': ':0', 23:09:10 INFO - 'HOME': '/home/cltbld', 23:09:10 INFO - 'LANG': 'en_US.UTF-8', 23:09:10 INFO - 'LANGUAGE': 'en_US:en', 23:09:10 INFO - 'LOGNAME': 'cltbld', 23:09:10 INFO - 'MAIL': '/var/mail/cltbld', 23:09:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:09:10 INFO - 'MOZ_NO_REMOTE': '1', 23:09:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:09:10 INFO - 'NO_EM_RESTART': '1', 23:09:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:09:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:09:10 INFO - 'PWD': '/builds/slave/test', 23:09:10 INFO - 'SHELL': '/bin/bash', 23:09:10 INFO - 'SHLVL': '1', 23:09:10 INFO - 'TERM': 'linux', 23:09:10 INFO - 'TMOUT': '86400', 23:09:10 INFO - 'USER': 'cltbld', 23:09:10 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1465180425.410960-1540520960', 23:09:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:09:10 INFO - '_': '/tools/buildbot/bin/python'} 23:09:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:09:10 INFO - Downloading/unpacking mozsystemmonitor==0.3 23:09: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 23:09: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 23:09: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 23:09: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 23:09: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 23:09: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 23:09:12 INFO - Downloading mozsystemmonitor-0.3.tar.gz 23:09:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 23:09:12 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 23:09:12 INFO - Installing collected packages: mozsystemmonitor 23:09:12 INFO - Running setup.py install for mozsystemmonitor 23:09:12 INFO - Successfully installed mozsystemmonitor 23:09:12 INFO - Cleaning up... 23:09:12 INFO - Return code: 0 23:09:12 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 23:09:12 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')]} 23:09:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:09:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:09:12 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')]} 23:09:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:09:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:09:12 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 0x7f5945cb9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e78350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f071c0>, '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 0x1f080c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f08550>, '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': '826874ccc97bd7bf541b4875000001d5-1465180425.410960-1540520960', '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 23:09:12 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 23:09:12 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 23:09:12 INFO - Using env: {'DISPLAY': ':0', 23:09:12 INFO - 'HOME': '/home/cltbld', 23:09:12 INFO - 'LANG': 'en_US.UTF-8', 23:09:12 INFO - 'LANGUAGE': 'en_US:en', 23:09:12 INFO - 'LOGNAME': 'cltbld', 23:09:12 INFO - 'MAIL': '/var/mail/cltbld', 23:09:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:09:12 INFO - 'MOZ_NO_REMOTE': '1', 23:09:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:09:12 INFO - 'NO_EM_RESTART': '1', 23:09:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:09:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:09:12 INFO - 'PWD': '/builds/slave/test', 23:09:12 INFO - 'SHELL': '/bin/bash', 23:09:12 INFO - 'SHLVL': '1', 23:09:12 INFO - 'TERM': 'linux', 23:09:12 INFO - 'TMOUT': '86400', 23:09:12 INFO - 'USER': 'cltbld', 23:09:12 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1465180425.410960-1540520960', 23:09:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:09:12 INFO - '_': '/tools/buildbot/bin/python'} 23:09:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:09:12 INFO - Downloading/unpacking jsonschema==2.5.1 23:09:12 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 23:09:12 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 23:09:12 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 23:09:12 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 23:09:12 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 23:09:12 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 23:09:14 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 23:09:14 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 23:09:14 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 23:09:14 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 23:09:14 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 23:09:14 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 23:09:14 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 23:09:14 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 23:09:14 INFO - Downloading functools32-3.2.3-2.tar.gz 23:09:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 23:09:14 INFO - warning: no files found matching '*.txt' 23:09:14 INFO - no previously-included directories found matching 'build' 23:09:14 INFO - no previously-included directories found matching 'dist' 23:09:14 INFO - no previously-included directories found matching '.git*' 23:09:14 INFO - Installing collected packages: jsonschema, functools32 23:09:14 INFO - Running setup.py install for functools32 23:09:14 INFO - warning: no files found matching '*.txt' 23:09:14 INFO - no previously-included directories found matching 'build' 23:09:14 INFO - no previously-included directories found matching 'dist' 23:09:14 INFO - no previously-included directories found matching '.git*' 23:09:14 INFO - Successfully installed jsonschema functools32 23:09:14 INFO - Cleaning up... 23:09:14 INFO - Return code: 0 23:09:14 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 23:09:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:09:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:09:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:09:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:09:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:09:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:09:14 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 0x7f5945cb9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e78350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f071c0>, '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 0x1f080c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f08550>, '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': '826874ccc97bd7bf541b4875000001d5-1465180425.410960-1540520960', '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 23:09:14 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 23:09:14 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 23:09:14 INFO - Using env: {'DISPLAY': ':0', 23:09:14 INFO - 'HOME': '/home/cltbld', 23:09:14 INFO - 'LANG': 'en_US.UTF-8', 23:09:14 INFO - 'LANGUAGE': 'en_US:en', 23:09:14 INFO - 'LOGNAME': 'cltbld', 23:09:14 INFO - 'MAIL': '/var/mail/cltbld', 23:09:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:09:14 INFO - 'MOZ_NO_REMOTE': '1', 23:09:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:09:14 INFO - 'NO_EM_RESTART': '1', 23:09:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:09:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:09:14 INFO - 'PWD': '/builds/slave/test', 23:09:14 INFO - 'SHELL': '/bin/bash', 23:09:14 INFO - 'SHLVL': '1', 23:09:14 INFO - 'TERM': 'linux', 23:09:14 INFO - 'TMOUT': '86400', 23:09:14 INFO - 'USER': 'cltbld', 23:09:14 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1465180425.410960-1540520960', 23:09:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:09:14 INFO - '_': '/tools/buildbot/bin/python'} 23:09:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:09:15 INFO - Downloading/unpacking blobuploader==1.2.4 23:09: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 23:09: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 23:09: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 23:09: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 23:09: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 23:09: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 23:09:16 INFO - Downloading blobuploader-1.2.4.tar.gz 23:09:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 23:09:17 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 23:09: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 23:09: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 23:09: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 23:09: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 23:09: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 23:09: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 23:09:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 23:09:17 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 23:09: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 23:09: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 23:09: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 23:09: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 23:09: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 23:09: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 23:09:17 INFO - Downloading docopt-0.6.1.tar.gz 23:09:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 23:09:17 INFO - Installing collected packages: blobuploader, requests, docopt 23:09:17 INFO - Running setup.py install for blobuploader 23:09:17 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 23:09:17 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 23:09:17 INFO - Running setup.py install for requests 23:09:18 INFO - Running setup.py install for docopt 23:09:18 INFO - Successfully installed blobuploader requests docopt 23:09:18 INFO - Cleaning up... 23:09:18 INFO - Return code: 0 23:09:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:09:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:09:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:09:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:09:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:09:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:09:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:09:18 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 0x7f5945cb9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e78350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f071c0>, '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 0x1f080c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f08550>, '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': '826874ccc97bd7bf541b4875000001d5-1465180425.410960-1540520960', '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 23:09:18 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 23:09:18 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 23:09:18 INFO - Using env: {'DISPLAY': ':0', 23:09:18 INFO - 'HOME': '/home/cltbld', 23:09:18 INFO - 'LANG': 'en_US.UTF-8', 23:09:18 INFO - 'LANGUAGE': 'en_US:en', 23:09:18 INFO - 'LOGNAME': 'cltbld', 23:09:18 INFO - 'MAIL': '/var/mail/cltbld', 23:09:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:09:18 INFO - 'MOZ_NO_REMOTE': '1', 23:09:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:09:18 INFO - 'NO_EM_RESTART': '1', 23:09:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:09:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:09:18 INFO - 'PWD': '/builds/slave/test', 23:09:18 INFO - 'SHELL': '/bin/bash', 23:09:18 INFO - 'SHLVL': '1', 23:09:18 INFO - 'TERM': 'linux', 23:09:18 INFO - 'TMOUT': '86400', 23:09:18 INFO - 'USER': 'cltbld', 23:09:18 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1465180425.410960-1540520960', 23:09:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:09:18 INFO - '_': '/tools/buildbot/bin/python'} 23:09:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:09:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:09:18 INFO - Running setup.py (path:/tmp/pip-2oUSlC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:09:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:09:18 INFO - Running setup.py (path:/tmp/pip-9rK8xu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:09:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:09:18 INFO - Running setup.py (path:/tmp/pip-CiVY0Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:09:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:09:18 INFO - Running setup.py (path:/tmp/pip-NddoJh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:09:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:09:18 INFO - Running setup.py (path:/tmp/pip-lEIK0S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:09:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:09:18 INFO - Running setup.py (path:/tmp/pip-2XOvqP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:09:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:09:19 INFO - Running setup.py (path:/tmp/pip-gLADGR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:09:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:09:19 INFO - Running setup.py (path:/tmp/pip-TJjaoO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:09:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:09:19 INFO - Running setup.py (path:/tmp/pip-8FlzKr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:09:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:09:19 INFO - Running setup.py (path:/tmp/pip-J4qHpR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:09:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:09:19 INFO - Running setup.py (path:/tmp/pip-z4OMIp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:09:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:09:19 INFO - Running setup.py (path:/tmp/pip-X5_SjT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:09:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:09:19 INFO - Running setup.py (path:/tmp/pip-j24fKS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:09:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:09:19 INFO - Running setup.py (path:/tmp/pip-6boOkY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:09:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:09:19 INFO - Running setup.py (path:/tmp/pip-r5v7Vc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:09:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:09:19 INFO - Running setup.py (path:/tmp/pip-eyf2Jr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:09:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:09:19 INFO - Running setup.py (path:/tmp/pip-b5CPp2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:09:19 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 23:09:19 INFO - Running setup.py install for manifestparser 23:09:19 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 23:09:19 INFO - Running setup.py install for mozcrash 23:09:20 INFO - Running setup.py install for mozdebug 23:09:20 INFO - Running setup.py install for mozdevice 23:09:20 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 23:09:20 INFO - Installing dm script to /builds/slave/test/build/venv/bin 23:09:20 INFO - Running setup.py install for mozfile 23:09:20 INFO - Running setup.py install for mozhttpd 23:09:20 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 23:09:20 INFO - Running setup.py install for mozinfo 23:09:20 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 23:09:20 INFO - Running setup.py install for mozInstall 23:09:20 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 23:09:20 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 23:09:20 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 23:09:20 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 23:09:20 INFO - Running setup.py install for mozleak 23:09:20 INFO - Running setup.py install for mozlog 23:09:20 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 23:09:20 INFO - Running setup.py install for moznetwork 23:09:21 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 23:09:21 INFO - Running setup.py install for mozprocess 23:09:21 INFO - Running setup.py install for mozprofile 23:09:21 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 23:09:21 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 23:09:21 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 23:09:21 INFO - Running setup.py install for mozrunner 23:09:21 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 23:09:21 INFO - Running setup.py install for mozscreenshot 23:09:21 INFO - Running setup.py install for moztest 23:09:21 INFO - Running setup.py install for mozversion 23:09:21 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 23:09:21 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 23:09:21 INFO - Cleaning up... 23:09:21 INFO - Return code: 0 23:09:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:09:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:09:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:09:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:09:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:09:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:09:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:09:21 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 0x7f5945cb9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e78350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f071c0>, '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 0x1f080c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f08550>, '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': '826874ccc97bd7bf541b4875000001d5-1465180425.410960-1540520960', '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 23:09:21 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 23:09:21 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 23:09:21 INFO - Using env: {'DISPLAY': ':0', 23:09:21 INFO - 'HOME': '/home/cltbld', 23:09:21 INFO - 'LANG': 'en_US.UTF-8', 23:09:21 INFO - 'LANGUAGE': 'en_US:en', 23:09:21 INFO - 'LOGNAME': 'cltbld', 23:09:21 INFO - 'MAIL': '/var/mail/cltbld', 23:09:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:09:21 INFO - 'MOZ_NO_REMOTE': '1', 23:09:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:09:21 INFO - 'NO_EM_RESTART': '1', 23:09:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:09:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:09:21 INFO - 'PWD': '/builds/slave/test', 23:09:21 INFO - 'SHELL': '/bin/bash', 23:09:21 INFO - 'SHLVL': '1', 23:09:21 INFO - 'TERM': 'linux', 23:09:21 INFO - 'TMOUT': '86400', 23:09:21 INFO - 'USER': 'cltbld', 23:09:21 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1465180425.410960-1540520960', 23:09:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:09:21 INFO - '_': '/tools/buildbot/bin/python'} 23:09:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:09:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:09:21 INFO - Running setup.py (path:/tmp/pip-qLBaOL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:09:21 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)) 23:09:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:09:21 INFO - Running setup.py (path:/tmp/pip-jW0YmD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:09: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)) 23:09:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:09:22 INFO - Running setup.py (path:/tmp/pip-OHzxQV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:09: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)) 23:09:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:09:22 INFO - Running setup.py (path:/tmp/pip-W_SQlm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:09: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)) 23:09:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:09:22 INFO - Running setup.py (path:/tmp/pip-r3ULgY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:09: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)) 23:09:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:09:22 INFO - Running setup.py (path:/tmp/pip-aizuCv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:09:22 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)) 23:09:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:09:22 INFO - Running setup.py (path:/tmp/pip-UkQtCj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:09:22 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)) 23:09:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:09:22 INFO - Running setup.py (path:/tmp/pip-h03Xxp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:09:22 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)) 23:09:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:09:22 INFO - Running setup.py (path:/tmp/pip-fszp0K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:09:22 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)) 23:09:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:09:22 INFO - Running setup.py (path:/tmp/pip-o_Xs0C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:09:22 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)) 23:09:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:09:22 INFO - Running setup.py (path:/tmp/pip-abz_l_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:09:22 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)) 23:09:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:09:22 INFO - Running setup.py (path:/tmp/pip-hjNcJN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:09:22 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)) 23:09:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:09:22 INFO - Running setup.py (path:/tmp/pip-Bq0DSO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:09:22 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)) 23:09:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:09:22 INFO - Running setup.py (path:/tmp/pip-Fjj00o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:09:22 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)) 23:09:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:09:22 INFO - Running setup.py (path:/tmp/pip-P7gupk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:09:22 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)) 23:09:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:09:22 INFO - Running setup.py (path:/tmp/pip-QsbBUB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:09: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)) 23:09:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:09:23 INFO - Running setup.py (path:/tmp/pip-rFVxxK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:09: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)) 23:09: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)) 23:09: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)) 23:09: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)) 23:09: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)) 23:09: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)) 23:09:23 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:09: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 23:09: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 23:09: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 23:09: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 23:09: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 23:09: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 23:09:25 INFO - Downloading blessings-1.6.tar.gz 23:09:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 23:09:25 INFO - Installing collected packages: blessings 23:09:25 INFO - Running setup.py install for blessings 23:09:25 INFO - Successfully installed blessings 23:09:25 INFO - Cleaning up... 23:09:25 INFO - Return code: 0 23:09:25 INFO - Done creating virtualenv /builds/slave/test/build/venv. 23:09:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:09:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:09:25 INFO - Reading from file tmpfile_stdout 23:09:25 INFO - Current package versions: 23:09:25 INFO - argparse == 1.2.1 23:09:25 INFO - blessings == 1.6 23:09:25 INFO - blobuploader == 1.2.4 23:09:25 INFO - docopt == 0.6.1 23:09:25 INFO - functools32 == 3.2.3-2 23:09:25 INFO - jsonschema == 2.5.1 23:09:25 INFO - manifestparser == 1.1 23:09:25 INFO - mozInstall == 1.12 23:09:25 INFO - mozcrash == 0.17 23:09:25 INFO - mozdebug == 0.1 23:09:25 INFO - mozdevice == 0.48 23:09:25 INFO - mozfile == 1.2 23:09:25 INFO - mozhttpd == 0.7 23:09:25 INFO - mozinfo == 0.9 23:09:25 INFO - mozleak == 0.1 23:09:25 INFO - mozlog == 3.2 23:09:25 INFO - moznetwork == 0.27 23:09:25 INFO - mozprocess == 0.22 23:09:25 INFO - mozprofile == 0.28 23:09:25 INFO - mozrunner == 6.11 23:09:25 INFO - mozscreenshot == 0.1 23:09:25 INFO - mozsystemmonitor == 0.3 23:09:25 INFO - moztest == 0.7 23:09:25 INFO - mozversion == 1.4 23:09:25 INFO - psutil == 3.1.1 23:09:25 INFO - requests == 1.2.3 23:09:25 INFO - wsgiref == 0.1.2 23:09:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:09:25 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')]} 23:09:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:09:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:09:25 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')]} 23:09:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:09:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:09:25 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 0x7f5945cb9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e78350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f071c0>, '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 0x1f080c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f08550>, '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': '826874ccc97bd7bf541b4875000001d5-1465180425.410960-1540520960', '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 23:09:25 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 23:09:25 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 23:09:25 INFO - Using env: {'DISPLAY': ':0', 23:09:25 INFO - 'HOME': '/home/cltbld', 23:09:25 INFO - 'LANG': 'en_US.UTF-8', 23:09:25 INFO - 'LANGUAGE': 'en_US:en', 23:09:25 INFO - 'LOGNAME': 'cltbld', 23:09:25 INFO - 'MAIL': '/var/mail/cltbld', 23:09:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:09:25 INFO - 'MOZ_NO_REMOTE': '1', 23:09:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:09:25 INFO - 'NO_EM_RESTART': '1', 23:09:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:09:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:09:25 INFO - 'PWD': '/builds/slave/test', 23:09:25 INFO - 'SHELL': '/bin/bash', 23:09:25 INFO - 'SHLVL': '1', 23:09:25 INFO - 'TERM': 'linux', 23:09:25 INFO - 'TMOUT': '86400', 23:09:25 INFO - 'USER': 'cltbld', 23:09:25 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1465180425.410960-1540520960', 23:09:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:09:25 INFO - '_': '/tools/buildbot/bin/python'} 23:09:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:09:25 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)) 23:09:25 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)) 23:09:25 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)) 23:09:25 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)) 23:09:25 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)) 23:09:25 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)) 23:09:25 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)) 23:09:25 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)) 23:09:25 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)) 23:09:25 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)) 23:09:25 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)) 23:09:25 INFO - Cleaning up... 23:09:25 INFO - Return code: 0 23:09:25 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 23:09:25 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')]} 23:09:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:09:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:09:25 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')]} 23:09:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:09:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:09:25 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 0x7f5945cb9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e78350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f071c0>, '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 0x1f080c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f08550>, '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': '826874ccc97bd7bf541b4875000001d5-1465180425.410960-1540520960', '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 23:09:25 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 23:09:25 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 23:09:25 INFO - Using env: {'DISPLAY': ':0', 23:09:25 INFO - 'HOME': '/home/cltbld', 23:09:25 INFO - 'LANG': 'en_US.UTF-8', 23:09:25 INFO - 'LANGUAGE': 'en_US:en', 23:09:25 INFO - 'LOGNAME': 'cltbld', 23:09:25 INFO - 'MAIL': '/var/mail/cltbld', 23:09:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:09:25 INFO - 'MOZ_NO_REMOTE': '1', 23:09:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:09:25 INFO - 'NO_EM_RESTART': '1', 23:09:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:09:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:09:25 INFO - 'PWD': '/builds/slave/test', 23:09:25 INFO - 'SHELL': '/bin/bash', 23:09:25 INFO - 'SHLVL': '1', 23:09:25 INFO - 'TERM': 'linux', 23:09:25 INFO - 'TMOUT': '86400', 23:09:25 INFO - 'USER': 'cltbld', 23:09:25 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1465180425.410960-1540520960', 23:09:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:09:25 INFO - '_': '/tools/buildbot/bin/python'} 23:09:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:09:25 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 23:09:25 INFO - Cleaning up... 23:09:25 INFO - Return code: 0 23:09:25 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 23:09:25 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')]} 23:09:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:09:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:09:25 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')]} 23:09:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:09:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:09:25 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 0x7f5945cb9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e78350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f071c0>, '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 0x1f080c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f08550>, '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': '826874ccc97bd7bf541b4875000001d5-1465180425.410960-1540520960', '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 23:09:25 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 23:09:25 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 23:09:25 INFO - Using env: {'DISPLAY': ':0', 23:09:25 INFO - 'HOME': '/home/cltbld', 23:09:25 INFO - 'LANG': 'en_US.UTF-8', 23:09:25 INFO - 'LANGUAGE': 'en_US:en', 23:09:25 INFO - 'LOGNAME': 'cltbld', 23:09:25 INFO - 'MAIL': '/var/mail/cltbld', 23:09:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:09:25 INFO - 'MOZ_NO_REMOTE': '1', 23:09:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:09:25 INFO - 'NO_EM_RESTART': '1', 23:09:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:09:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:09:25 INFO - 'PWD': '/builds/slave/test', 23:09:25 INFO - 'SHELL': '/bin/bash', 23:09:25 INFO - 'SHLVL': '1', 23:09:25 INFO - 'TERM': 'linux', 23:09:25 INFO - 'TMOUT': '86400', 23:09:25 INFO - 'USER': 'cltbld', 23:09:25 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1465180425.410960-1540520960', 23:09:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:09:25 INFO - '_': '/tools/buildbot/bin/python'} 23:09:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:09:26 INFO - Downloading/unpacking flake8 23:09: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 23:09: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 23:09: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 23:09: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 23:09: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 23:09: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 23:09:27 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 23:09:28 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 23:09: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 23:09: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 23:09: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 23:09: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 23:09: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 23:09: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 23:09:28 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 23:09:28 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 23:09: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 23:09: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 23:09: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 23:09: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 23:09: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 23:09: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 23:09:28 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 23:09: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 23:09: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 23:09: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 23:09: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 23:09: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 23:09: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 23:09:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 23:09:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:09:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:09:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:09:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:09:28 INFO - no previously-included directories found matching 'docs/_build' 23:09:28 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 23:09:28 INFO - Running setup.py install for pep8 23:09:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:09:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:09:28 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:09:28 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:09:28 INFO - no previously-included directories found matching 'docs/_build' 23:09:28 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 23:09:28 INFO - Successfully installed flake8 mccabe pyflakes pep8 23:09:28 INFO - Cleaning up... 23:09:28 INFO - Return code: 0 23:09:28 INFO - Running post-action listener: _resource_record_post_action 23:09:28 INFO - Running post-action listener: _start_resource_monitoring 23:09:29 INFO - Starting resource monitoring. 23:09:29 INFO - ##### 23:09:29 INFO - ##### Finished create-virtualenv step (success) 23:09:29 INFO - ##### 23:09:29 INFO - ##### 23:09:29 INFO - ##### Running install step. 23:09:29 INFO - ##### 23:09:29 INFO - Running pre-action listener: _resource_record_pre_action 23:09:29 INFO - Running main action method: install 23:09:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:09:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:09:29 INFO - Reading from file tmpfile_stdout 23:09:29 INFO - Detecting whether we're running mozinstall >=1.0... 23:09:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 23:09:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 23:09:29 INFO - Reading from file tmpfile_stdout 23:09:29 INFO - Output received: 23:09:29 INFO - Usage: mozinstall [options] installer 23:09:29 INFO - Options: 23:09:29 INFO - -h, --help show this help message and exit 23:09:29 INFO - -d DEST, --destination=DEST 23:09:29 INFO - Directory to install application into. [default: 23:09:29 INFO - "/builds/slave/test"] 23:09:29 INFO - --app=APP Application being installed. [default: firefox] 23:09:29 INFO - mkdir: /builds/slave/test/build/application 23:09:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 23:09:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 23:09:45 INFO - Reading from file tmpfile_stdout 23:09:45 INFO - Output received: 23:09:45 INFO - /builds/slave/test/build/application/firefox/firefox 23:09:45 INFO - Running post-action listener: _resource_record_post_action 23:09:45 INFO - ##### 23:09:45 INFO - ##### Finished install step (success) 23:09:45 INFO - ##### 23:09:45 INFO - ##### 23:09:45 INFO - ##### Running run-tests step. 23:09:45 INFO - ##### 23:09:45 INFO - Running pre-action listener: _resource_record_pre_action 23:09:45 INFO - Running main action method: run_tests 23:09:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 23:09:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 23:09:45 INFO - Python 2.7.3 23:09:45 INFO - Return code: 0 23:09:45 INFO - grabbing minidump binary from tooltool 23:09:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:09:45 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 0x1f071c0>, '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 0x1f080c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f08550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 23:09:45 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 23:09:45 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 23:09:45 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 23:09:45 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 23:09:45 INFO - Return code: 0 23:09:45 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 23:09:45 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 23:09:45 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 23:09:45 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 23:09:45 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 23:09:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 23:09:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 23:09:46 INFO - Return code: 0 23:09:46 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/R6Ysy68PTkG3ZqIWUMsjFw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-052', '--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 23:09:46 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/R6Ysy68PTkG3ZqIWUMsjFw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-052 --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 23:09:46 INFO - Using env: {'DISPLAY': ':0', 23:09:46 INFO - 'HOME': '/home/cltbld', 23:09:46 INFO - 'LANG': 'en_US.UTF-8', 23:09:46 INFO - 'LANGUAGE': 'en_US:en', 23:09:46 INFO - 'LOGNAME': 'cltbld', 23:09:46 INFO - 'MAIL': '/var/mail/cltbld', 23:09:46 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 23:09:46 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 23:09:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:09:46 INFO - 'MOZ_NO_REMOTE': '1', 23:09:46 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 23:09:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:09:46 INFO - 'NO_EM_RESTART': '1', 23:09:46 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:09:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:09:46 INFO - 'PWD': '/builds/slave/test', 23:09:46 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 23:09:46 INFO - 'SHELL': '/bin/bash', 23:09:46 INFO - 'SHLVL': '1', 23:09:46 INFO - 'TERM': 'linux', 23:09:46 INFO - 'TMOUT': '86400', 23:09:46 INFO - 'USER': 'cltbld', 23:09:46 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1465180425.410960-1540520960', 23:09:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:09:46 INFO - '_': '/tools/buildbot/bin/python'} 23:09:46 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/R6Ysy68PTkG3ZqIWUMsjFw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-052', '--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 23:09:46 INFO - mozversion application_buildid: 20160605222532 23:09:46 INFO - mozversion application_changeset: 824355c9efe23d83f7e67a4b2c9e0e837f7c7771 23:09:46 INFO - mozversion application_display_name: Nightly 23:09:46 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 23:09:46 INFO - mozversion application_name: Firefox 23:09:46 INFO - mozversion application_remotingname: firefox 23:09:46 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 23:09:46 INFO - mozversion application_vendor: Mozilla 23:09:46 INFO - mozversion application_version: 49.0a1 23:09:46 INFO - mozversion platform_buildid: 20160605222532 23:09:46 INFO - mozversion platform_changeset: 824355c9efe23d83f7e67a4b2c9e0e837f7c7771 23:09:46 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 23:09:46 INFO - mozversion platform_version: 49.0a1 23:09:46 INFO - using testdate: 1465193386 23:09:46 INFO - actual date: 1465193386 23:09:46 INFO - starting webserver on 'localhost:46563' 23:09:46 INFO - SUITE-START | Running 2 tests 23:09:46 INFO - TEST-START | dromaeo_css 23:09:46 INFO - operating with platform_type : linux_ 23:09:46 INFO - Initialising browser for dromaeo_css test... 23:09:46 INFO - TEST-INFO | started process 30634 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEfzYtb/profile http://localhost:46563/getInfo.html) 23:09:50 INFO - PROCESS | 30634 | __metrics Screen width/height:1600/1200 23:09:50 INFO - PROCESS | 30634 | colorDepth:24 23:09:50 INFO - PROCESS | 30634 | Browser inner width/height: 1024/697 23:09:50 INFO - PROCESS | 30634 | __metrics 23:09:51 ERROR - PROCESS | 30634 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2938: TypeError: this.tabs is undefined 23:09:52 INFO - TEST-INFO | 30634: exit 0 23:09:52 INFO - Browser initialized. 23:09:52 INFO - Running cycle 1/1 for dromaeo_css test... 23:09:52 INFO - TEST-INFO | started process 30752 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEfzYtb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:10:04 INFO - PROCESS | 30752 | RSS: Main: 167833600 23:10:04 INFO - PROCESS | 30752 | 23:10:54 INFO - PROCESS | 30752 | 1465193454249 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] 23:13:06 INFO - PROCESS | 30752 | Cycle 1(1): loaded http://localhost:46563/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46563/tests/dromaeo/cssquery-ext.html) 23:13:07 INFO - PROCESS | 30752 | RSS: Main: 171180032 23:13:07 INFO - PROCESS | 30752 | 23:16:09 INFO - PROCESS | 30752 | Cycle 1(1): loaded http://localhost:46563/tests/dromaeo/cssquery-ext.html (next: http://localhost:46563/tests/dromaeo/cssquery-jquery.html) 23:16:10 INFO - PROCESS | 30752 | RSS: Main: 169734144 23:16:10 INFO - PROCESS | 30752 | 23:19:12 INFO - PROCESS | 30752 | Cycle 1(1): loaded http://localhost:46563/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46563/tests/dromaeo/cssquery-mootools.html) 23:19:12 INFO - PROCESS | 30752 | RSS: Main: 171311104 23:19:12 INFO - PROCESS | 30752 | 23:22:14 INFO - PROCESS | 30752 | Cycle 1(1): loaded http://localhost:46563/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46563/tests/dromaeo/cssquery-prototype.html) 23:22:15 INFO - PROCESS | 30752 | RSS: Main: 168267776 23:22:15 INFO - PROCESS | 30752 | 23:25:17 INFO - PROCESS | 30752 | Cycle 1(1): loaded http://localhost:46563/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46563/tests/dromaeo/cssquery-yui.html) 23:25:18 INFO - PROCESS | 30752 | RSS: Main: 170196992 23:25:18 INFO - PROCESS | 30752 | 23:28:21 INFO - PROCESS | 30752 | Cycle 1(1): loaded http://localhost:46563/tests/dromaeo/cssquery-yui.html (next: http://localhost:46563/tests/dromaeo/cssquery-dojo.html) 23:28:21 INFO - PROCESS | 30752 | RSS: Main: 171577344 23:28:21 INFO - PROCESS | 30752 | 23:28:21 INFO - PROCESS | 30752 | __start_tp_report 23:28:21 INFO - PROCESS | 30752 | _x_x_mozilla_page_load 23:28:21 INFO - PROCESS | 30752 | _x_x_mozilla_page_load_details 23:28:21 INFO - PROCESS | 30752 | |i|pagename|runs| 23:28:21 INFO - PROCESS | 30752 | |0;dojo.html;2690.4619076184763;2724.4823483538125;2726.3593055631923;2736.822106563072;2742.2595899107228;4701.2242979908315;4730.5742483176555;4758.833440829568;4841.419029716439;4880.951190488094;4659.394278743767;4679.906401871961;4718.457377401592;4773.3317335572965;4781.617470602352;4358.324459708742;4385.934210986838;4454.665900057493;4490.416245888046;4515.2324104902245;4425.9114817703785;4433.933490997638;4446.466424029121;4507.278835386339;4512.413386259782;4391.538888416702;4468.173387923229;4501.617362524189;4506.77466126694;4529.4791099023705;4402.801873915681;4410.140022695576;4412.514623391425;4440.267355886275;4457.732536047815;4361.258586040381;4383.057642606855;4385.276429389147;4438.378626992224;4442.155990361821;4640.83757068501;4673.065386922629;4694.718316900963;4717.599004084657;4741.359916411275;5136.203888397305;5152.149895267276;5160.974195129038;5168.173092305213;5191.273221748958;5098.796048158069;5174.120399532051;5174.818881339135;5182.378114626231;5217.34783152106;4740.834070807539;4841.394825646794;4854;4867.294242334912;4880.463149053601;5336.866578335573;5355.758990845421;5363.410024897258;5367.651102678314;5374.381946076173;5158.74206289684;5159.922601160985;5164.380274367025;5169.147090730063;5173.1722924331925;5003.149464591028;5148.4079330876675;5168.741562921914;5199.818006369759;5216.295800067019;5124.820631277962;5137.2037334213255;5142.51146141116;5144.408393034849;5206;4980.551750342486;5132.050570644443;5133.204353325241;5144;5155.690658560498;4207.200631879933;4271.530131685512;4275.978620106942;4296.656267498593;4325.134973005349;3742.569604495518;3752.399616061417;3797.867074652374;3798.1264309209037;3822.694184465236;4469.7988590513505;4479.372887795711;4486.371907932892;4499.617532509707;4508.368828364031;5046;5096.184610462308;5128.948710512922;5145.922811157836;5183.429822719498;4425.35832304314;4466.3747075409465;4467.084247729208;4484.641228701696;4516.88707782308;4513.368128462018;4647.604953578983;4682.204025315705;4682.274247491644;4735.2423612222565;4869.366982292279;4902.2156454967035;4935.728534930613;4941.654084214214;4949.653524253412;5275.446078161738;5292.338457692788;5293.523582877559;5294.582622831856;5350.250964865;4778.546038126373;4844.515548445127;4937.679050861682;4944.505549445171;4948.505149485023;5124.333836601218;5165.147750621106;5186.299849520266;5195.428502864757;5238.476152384731;5244.868878278074;5260.658057226268;5265.973670131625;5274.683518988873;5276.920846187387;4900.019996000743;4922.581580565692;4946.307516947702;5091.261767043684;5107.9233811493605;4936.062148191976;4956.925646115384;4970.627202959865;4975.253711943237;5009.624278179078;4824.324594556695;4868.878278042936;4870.634702397405;4884.902301954012;4893.975530122327;4926.827561035347;5047.369078865142;5060.772265247999;5073.59411247092;5100.056489549445;4807.423109226916;4881.975590122169;4899.828506002273;4900.264960255848;4972.552470277692 23:28:21 INFO - PROCESS | 30752 | |1;ext.html;538.9155523165218;580.4833698008772;599.7511032921337;605.1497645807641;628.8962321217;39216.21567568647;39855.40216896742;39923;40041;40104.79947600261;39847.60152398483;40423;40599.39100913489;40617.59382406175;40627.390589141185;7519.887201691992;7604.049493813273;7636.809079773022;7646.235376462337;7658.195889431585;7687.154413014564;7854.567998760066;7865.567393793339;7883;7883.054033515986;7840.372770178401;7844.450888437812;7852.489588176779;7895.644695988694;7906.841863162734;7772.106207786092;7817.648205830695;7832.216778322179;7860.0960889497865;7879.921200788005;7629.198934111894;7690.923090769133;7755.728549500796;7766.922330776676;7788.727394541163;37405.43891841624;37491.25017499662;37647.62352376468;37739.05652358713;37806;2943.5290353543332;3065.938681226385;3118.8752449901976;3122.859471323773;3244.772865899388;29624.40751184986;30210.69789302101;30377.696223037707;30604;30681.232969175726;3303.3888730584918;3305.1076209423322;3315.245375688209;3322.401967645823;3327.8169700666454;254991;255377;256831;257021;257334;55087.173692394645;55753.44246557564;55798.442015580134;55849.72075139598;55986;34107.31785364279;34936.475952860725;34973.47539786905;36703;36782.816085919396;14976.326065327086;15016;15137.243137843065;15140.772888406682;15284.235788210544;10826.891731082746;10874.510647020903;10886.945565272123;10957.287776294515;11016.17378696601;18845.434636960912;19010.334638287593;19013.239470421304;19045.904770476336;19180.904095479713;6884.862302753917;6997.615131167733;7088.92911070893;7130.3939165170505;7222.96388518054;821.2936874288107;966.1015255812163;979.7648564344506;987.1954357199004;1076.5586109694987;26790.464190716077;27070.458590828468;27471.45057098847;27488.17535473939;27767.86116069407;947.1948843482984;968.1335204991493;1006.2101250518308;1021.8671572695501;1092.0662833277593;14179.22014289224;14412.855871441152;14476.493322733864;14546;14548.563543093724;384437;385322;387029;387520;387984;49883.25175122376;50669.49330506721;51416.48583514117;51452;51515.48484515182;1194.3610168559953;1194.8207768834745;1228.3735294999615;1231.950721971129;1234.01895493085;26772.062977795682;27348.45303093967;27403.93944067634;27808.44383112286;28156.155315340573;42292;42707.572924271604;42767.3584896233;42772.786136069124;42807.14385712206;331602;333169;334061;334350;334591;25352.239432817045;26459.338516537242;26461.735382646697;26520.734792652598;26540.601890972037;42803.715888523395;42930.78534607307;43165.3525197116;44284.33573496465;44564.88587785331;36524.452133218554;37648.2470350586;37917.81041094887;37976.62023379731;38062.42906356351;35932.4610130843;36461.63538364582;36846.63153368432;36887.81556092203;37318.62681373151;31109.222269443446;36009.279814404086;36602.45096323611;37123.81438092792;37273.6272637281;31160.376792464478;33667.42482941318;33726.3254734899;33972;34156.31687366189;24431.51136977215;24499.142530011362;24750.25749227526;25105.24684259475;25261.115860944778 23:28:21 INFO - PROCESS | 30752 | |2;jquery.html;356.303426800605;364.8230608155045;367.18668150047637;367.83631284078564;379.8423654183514;15435.536933891986;16559.33762649494;17471.91264043678;17519.211635476404;17583.29666813329;15362.539123826275;15471.45849895254;15969.361225550992;16062.75905861413;16162.83837161628;4970;5124.92312615311;5147.716875571842;5150.793968241266;5159.071367153911;3742.981285093571;5073.112205364065;5662.631928924607;5943.821685349447;5956.195913551658;5967.104934259874;5969.462748352647;5971.790987315445;5987.55093367997;6003.039513677791;5710.229119068935;5906.852328691795;5921.703914804286;5934.881302373971;5938.020226662596;4445.866624001285;5123.820666276662;5135.666181698178;5152.098382782998;5162.6128040397125;11340.206185567014;11946.462409191521;11947.581834635746;11999;12019.21875078117;1667.8082020567547;1697.1683874901332;1716.519374575121;1783.5006198264507;1784.5895444047812;8775.692850750193;9114.954425227897;9168.312376571717;11074.224804263706;12538.68653283666;1480.5262316058866;1492.2911616981955;1664.9750253746204;1716.5767460278275;1723.750056241838;65351.673241633485;68822.3117768821;69471.65264173698;69484.65257673679;69831.99999999949;9642.42145471274;9651.276154288316;9816.312858100007;10023.649172278936;10070.676676696672;13940.58178254654;13944.790828137586;14031.78952315716;14045.438182472586;14077.296135193199;7110.25342339047;7160.820979475555;7195.568265904062;7233;7234.914762785625;6598.7030583623855;6640.701168447432;6697.430718388894;6709.664516774142;6835.316468353224;4209.957900421018;4289.6139347458875;4306.354046892929;4345.67407444443;4378.671599630041;1563.1168389859693;1598.5843680643115;1723.147042214112;1753.7194048952106;1763.6825371433008;856.8029353248787;875.0680525240598;877.6138499060393;879.0418443896184;917.8898532176181;15531.844681553266;15974.840251597569;15987.600309992344;16354.509364719077;16374.508764737076;834.5326617094447;836.477201748907;844.3751623798468;862.6894318045498;873.1835733589114;8939.508327041945;9059;9233.215176710055;9243.722688319362;9421.104995025462;366379;367257;371739;374868;385523;48065.27902081471;53532;66560.66719666467;71266;74646.50706985939;878.0473186592618;883.5273128876149;900.9684661036832;903.3766700976305;907.8138981508774;14714.969952103678;14728.484503042342;14830.258487075818;14945.775813363025;15148.242587870784;32907.20288775481;33161;33751.4937275946;34173;34573;45419.7729011366;46623;46859.06281874275;47004;47053;7493.925060749323;7677.577733224726;7815.413843961612;7881.605919704107;7939.2060793920145;11541.596044138414;11765;11821.527138914347;11866.152123490472;12028.63914082579;9983.251256155672;9995.100440960348;10013.2490063247;10190.592376304865;10391.168706503311;9930.652427165014;10001.799964000826;10068.647597334058;10088.949555252177;10273.9486302568;9995.650152244636;10098.54556544972;10112.270401079077;10209.897901021192;10318.896811031793;6652.567583107082;7076.71693132269;7245;7738.071431428039;7795.259450352208;10118.139958103644;10119.595216191565;10139.543720532447;10280.537375817956;10285.897141028494 23:28:21 INFO - PROCESS | 30752 | |3;mootools.html;1440.8847292216624;1441.070509521359;1560.859522642962;1760.4630587670756;1764.6029643330253;6745.190577130751;7375.483716139873;7402.444816638754;7931.682732690692;7978.7207447739265;7450.441216908726;7765.417593680469;7780.299773020427;7812.921870781304;7814.92185078149;2087.9582408351826;2143.421276255418;2146.9033893474752;2147.5812216617765;2150.666646669769;2089.4462967313675;2132.744070711517;2134.79719426655;2134.957300853982;2148.4199266198116;2101.7898210179014;2102.8843413612244;2113.9218998310894;2119.79861913118;2131.637621604331;2114.143771772435;2119.8304135669264;2122.0875023739786;2129.6805479178092;2129.765725770164;2062.95874082519;2065.555905480314;2073.626747185506;2087.6137914485867;2102.390306811023;7732.613369331567;7783.299503044696;7793.766187014398;7801.0638723352995;7802.843943121163;4357.150355680644;4437.378766972626;4452.977735111336;4459.974205932621;4460.0633866887665;2804.9719502804915;2864.2266588021116;2881.207667891326;2883.480973424783;2920.1385591250632;856.3063918226256;858.0775666158904;878.2403221213668;886.5434301334818;889.1108891108892;10372.325798823127;10379.221558383151;10398.220133489944;10404.479776011169;10407.323523970994;4078.1843631273864;4122.464079669624;4179.226843034048;4208.473940757405;4214.515330737005;8929.910700893039;8940.105989401009;8940.597673104727;8954.149355811187;8959.641614335484;4390.648748100144;4437.334399839985;4452.30989196675;4464.553544645574;4479.440069991251;3634.527511423498;3933.056066544009;3971.344728119828;4011.0574015106426;4069.04377471294;3547.5033495310677;3569.696575791087;3611.9277614448088;3642.0530662028063;3657.908552286214;1145.2899202494507;1180.952761889532;1185.3302883870758;1196.7367179220557;1205.4816428935467;808.6118663041773;898.510311880027;906.5059542549326;914.5244472874201;927.0312523413049;5148.6910785353;5236.581073514109;5311.150215965427;5325.786968521294;5342.385625653022;386.0580184350177;875.4047247871381;892.6518657723493;916.4867674102524;971.4122955611895;3674.2651469706166;3778.962210377861;3847.0959324558708;3861.961380386216;3862.6716729078344;9185.081491850762;9390.389624674373;9446.244300455946;9479.383840050512;9484.525773711424;9553.761155971017;9677.37097088687;9694.127528522467;9749.610015599439;9772.120509154069;7039.225685174627;7389.371903388164;7395.630218489054;7562.130355009244;7563.659635316424;5438.564914806727;5669.914951275651;5754.9424505754405;5763.971180144073;5926.644401335933;8537.615807288563;8607.612657430305;8747.825043499222;8903.554822258991;8925;8789.384743067923;8905.109489051043;8916.687915922912;8989;9029.548522573714;5941.732622031933;6420.550561460653;6421.293657697743;6471.352864713491;6588.40704336612;6739.494537909774;6830.931690683228;6888.655567221719;6905.067815844997;6907.654617269217;5988.910166347596;6278.246610406781;6360.936390636034;6436.292007879223;6437.356264373712;6314.336994615683;6386.648734319657;6439.710213040518;6464.773732919513;6555.246146693001;5891.293044834647;5955.880882382415;5995.580309378476;6000.369961154016;6008.24896887889;4286.528481867054;4359.869203923888;4387.8244870204835;4454.563156239204;4740.3837501124635;4570.588647021784;4577.862664120082;4606.6314694825005;4635.629149668086;4779.354787103835 23:28:21 INFO - PROCESS | 30752 | |4;prototype.html;282.82182225198125;285.940590113629;286.9383082637233;287.5959277215513;292.0712135409399;4945.653804233705;4992.62555308352;4993.875153121174;5008.699478031312;5019.222020586811;4873.342098816667;4930.309756634074;4952.876178095549;4959.504049595039;4978.178600530908;3640.526731524898;3728.552573691161;3810.12367155553;3832.559255685604;3833.5783063862955;3817.6373244541724;3824.388097904336;3832.865849695261;3837.9808100959594;3850.614938506155;3824.923501529968;3827.4450204720297;3827.5981021992707;3828.8277027533827;3830.1382189007527;3555.7510974231814;3789.7157713171346;3813.866514672001;3823.3500304947947;3835.137094153807;3263.640999490054;3273.8035717857006;3274.705276525124;3288.490284005983;3292.785968912037;4711.717296962193;4715;4720.693154944952;4723.905521889543;4724.244120940633;4319.200947824631;4321.7406955582455;4331.722141968127;4336.956630433687;4342;5030.6730062546185;5128.948710512885;5138.84583462493;5155.175171972504;5160.019596276696;3612.584552776412;3616.27674465108;3624.746267761258;3625.1299688074937;3636.9454458182886;5373.973130134364;5403.432639572828;5432.777625034375;5433.293671822637;5442.265294185314;3578.6779189872514;3649.3613617617343;3656.652618001339;3657.6890964267805;3675.2833197526224;3686.1337585667347;3707.9803054159784;3715.498407714924;3716.6283371663158;3717.8141092945243;4241.257779888507;4272.145570885836;4275.444192254987;4299.871003869889;4300.505441874162;5090.220317017217;5112.36095488064;5184.766685499161;5191.650170955579;5194.701324668833;1281.6283277849507;1285.6657269110099;1301.7201301720177;1302.9609111726663;1303.7327347893658;795.0618270440935;797.6729540888324;802.6989878795451;827.6317038917745;828.3125006244923;4412.713173643703;4517.186906356822;4526.479454862667;4543.454785425704;4551.112533056023;5342.465753424626;5352.652077614943;5356.598255130881;5363.310557174477;5383.300170977748;4419.18245124653;4496.482904466028;4533.863984080483;4562.520935301812;4570.268756998864;2792.3019245188702;2863.5704644303523;2864.6392963342664;2869.7130286971137;2871.4637668847067;4968.056069346812;4985.950140498621;5006.274090256892;5009.298698182258;5042.142835717937;5173.793048278102;5425.070461950502;5446.264754258124;5453.445767956114;5487.052096505763;5041.193409054534;5052.671576347526;5054.241863720325;5058.696478211319;5067.746612669352;5355.4376790436445;5361.24942508057;5363.27595774581;5365.704886231295;5388;4930.408350997904;5218.399884013387;5249.343832020997;5250.317458730341;5259.921101183409;5041.495850414929;5045.697258164522;5046.798128074983;5049.394072711299;5054.494550544916;3713.702903767638;3716.6956486978247;3719.8512059517316;3727.1986522897705;3728.757630753992;5163.4578369270685;5329.173978033411;5335.905174998414;5357.946420535744;5392.325959255093;5216.217567364925;5239.29269548606;5243;5247.685138891678;5265.60507961912;5183.896322073462;5207.947920520746;5212.270282160424;5253.973730131325;5264.684118952875;4950.183219768842;5005.599552035901;5084.186530155157;5089.720065396439;5105.566026887756;4959.70241785494;5019.899602007867;5170.870728231674;5187.559057480156;5218.373795144607;4971.676841005323;5036;5036.445990941067;5041.546260836542;5046.697198167974 23:28:21 INFO - PROCESS | 30752 | |5;yui.html;616.2481772237869;642.3448082955385;660.5277226782853;666.8266250774797;680.4250408404899;12183;12374.505019799197;12657.746845063093;12686.809697854527;12930.159539629918;12076.335801530913;12135.968442682382;12228.694282642939;12398.690032749186;12528.123031387784;638.1098367776948;785.9646315915797;799.9760007199778;812.3907069697726;813.536284317939;807.9192080791933;809.4697972827807;812.2811311988874;814.5479259011246;816.1308206759782;857.438377862501;858.4205661178711;860.2601762484289;861.8621020636699;865.5888452984844;844.3540691371106;849.1720572441882;849.7833052571555;850.7787975126449;851.7742798158492;615.3815415507431;617.5985609353955;617.8115674719209;618.6195489773756;619.1177571959939;12691.175073620278;12706.745865082647;12710.936445317715;12723.491060357575;12751.234925904475;13648.522301719393;13709.383077761524;13809.723805523934;13813.930930345385;14041.64895877601;10577.259591828575;10703.678889633324;10727.195460340428;10736.24846260762;10765.90961092708;3301.603807543086;3312.3540909522653;3356.2616224430585;3378.729701623864;3467.7745946513646;61964;62103;66336;66595.3340466594;66758.33241667521;9374.109459601326;9521.809563808685;9650.758731031781;9660.37207581505;9673.806523869483;17007.574810629834;17471.213795379237;17547.64904701899;17616.735748963776;17686.170212765897;6179.907301390483;6241.7191226394925;6296;6364.331745166784;6523.18460192476;3751.2309976454762;3759.567649720317;3815.751976121543;3819.560750513671;3828.272628200633;2966.718161774628;3014.7437467815043;3028.727414532703;3032.5147976324124;3069.3400918802563;530.8699368654627;531;538.2249560632677;540.767469987909;548.832606055149;475.25622400942416;507.652258203132;579.6319337220895;599.9580029397988;613.2855223664382;7980.241877021674;8092.150324215991;8145.226203510657;8168.142345053684;8379.95810020946;489.40048440660615;610.3106719878346;616.7532986805224;619.9969000154971;622.4771192198484;3434.3303055904357;3718.1819999600043;3729.4219395993664;3731.1231860512758;3782.791946442972;68334;82122;83687.5815620918;85018;92625;74694.6265268681;75703.62148189223;76348;76735.61632191803;77206.22793772102;68916.310836892;68924.31075689179;69427.3057269431;70007;70400;8466.322694184573;8894.33292503052;9021.188093071654;9025.774355641162;9029.909700902906;41585.58414415938;43006.35490467708;43194.13611727685;43389.566104338555;43662;57596.71201643965;59573.7021314908;60728.39271607404;60977.08534372077;61121;11403.543858245908;11456.255343402652;11569.132315076235;11648.503050397114;11723.706907327385;11161.776764464828;11476.713082173012;11614.419279035845;11819.822702659296;11891.76216475683;12324.81512777327;12344.75310493803;12503.062270329943;12528.248305101723;13101.148425352321;11752.11859110553;11802.586909458129;11934.820977685515;12384.318862462651;12387.938060309642;11765.176437649283;11898.702532436759;11965.282083075042;12029.21810082377;12178.756424871275;9765.41810423771;9974.15219706304;9997.450140242356;10200.489975501047;10298.485075746332;9918.652847150315;10261.17910567138;10291.53688084053;10356.792864142826;10458.947705261426 23:28:21 INFO - PROCESS | 30752 | __end_tp_report 23:28:21 INFO - PROCESS | 30752 | __start_cc_report 23:28:21 INFO - PROCESS | 30752 | _x_x_mozilla_cycle_collect,387 23:28:21 INFO - PROCESS | 30752 | __end_cc_report 23:28:21 INFO - PROCESS | 30752 | __startTimestamp1465194501433__endTimestamp 23:28:21 INFO - PROCESS | 30752 | 23:28:21 INFO - PROCESS | 30752 | ------- Summary: start ------- 23:28:21 INFO - PROCESS | 30752 | Number of tests: 6 23:28:21 INFO - PROCESS | 30752 | 23:28:21 INFO - PROCESS | 30752 | [#0] dojo.html Cycles:165 Average:4768.20 Median:4881.98 stddev:508.18 (10.4%) stddev-sans-first:482.89 23:28:21 INFO - PROCESS | 30752 | Values: 2690.5 2724.5 2726.4 2736.8 2742.3 4701.2 4730.6 4758.8 4841.4 4881.0 4659.4 4679.9 4718.5 4773.3 4781.6 4358.3 4385.9 4454.7 4490.4 4515.2 4425.9 4433.9 4446.5 4507.3 4512.4 4391.5 4468.2 4501.6 4506.8 4529.5 4402.8 4410.1 4412.5 4440.3 4457.7 4361.3 4383.1 4385.3 4438.4 4442.2 4640.8 4673.1 4694.7 4717.6 4741.4 5136.2 5152.1 5161.0 5168.2 5191.3 5098.8 5174.1 5174.8 5182.4 5217.3 4740.8 4841.4 4854.0 4867.3 4880.5 5336.9 5355.8 5363.4 5367.7 5374.4 5158.7 5159.9 5164.4 5169.1 5173.2 5003.1 5148.4 5168.7 5199.8 5216.3 5124.8 5137.2 5142.5 5144.4 5206.0 4980.6 5132.1 5133.2 5144.0 5155.7 4207.2 4271.5 4276.0 4296.7 4325.1 3742.6 3752.4 3797.9 3798.1 3822.7 4469.8 4479.4 4486.4 4499.6 4508.4 5046.0 5096.2 5128.9 5145.9 5183.4 4425.4 4466.4 4467.1 4484.6 4516.9 4513.4 4647.6 4682.2 4682.3 4735.2 4869.4 4902.2 4935.7 4941.7 4949.7 5275.4 5292.3 5293.5 5294.6 5350.3 4778.5 4844.5 4937.7 4944.5 4948.5 5124.3 5165.1 5186.3 5195.4 5238.5 5244.9 5260.7 5266.0 5274.7 5276.9 4900.0 4922.6 4946.3 5091.3 5107.9 4936.1 4956.9 4970.6 4975.3 5009.6 4824.3 4868.9 4870.6 4884.9 4894.0 4926.8 5047.4 5060.8 5073.6 5100.1 4807.4 4882.0 4899.8 4900.3 4972.6 23:28:21 INFO - PROCESS | 30752 | 23:28:21 INFO - PROCESS | 30752 | [#1] ext.html Cycles:180 Average:47713.08 Median:36867.22 stddev:86818.31 (235.5%) stddev-sans-first:86989.61 23:28:21 INFO - PROCESS | 30752 | Values: 538.9 580.5 599.8 605.1 628.9 39216.2 39855.4 39923.0 40041.0 40104.8 39847.6 40423.0 40599.4 40617.6 40627.4 7519.9 7604.0 7636.8 7646.2 7658.2 7687.2 7854.6 7865.6 7883.0 7883.1 7840.4 7844.5 7852.5 7895.6 7906.8 7772.1 7817.6 7832.2 7860.1 7879.9 7629.2 7690.9 7755.7 7766.9 7788.7 37405.4 37491.3 37647.6 37739.1 37806.0 2943.5 3065.9 3118.9 3122.9 3244.8 29624.4 30210.7 30377.7 30604.0 30681.2 3303.4 3305.1 3315.2 3322.4 3327.8 254991.0 255377.0 256831.0 257021.0 257334.0 55087.2 55753.4 55798.4 55849.7 55986.0 34107.3 34936.5 34973.5 36703.0 36782.8 14976.3 15016.0 15137.2 15140.8 15284.2 10826.9 10874.5 10886.9 10957.3 11016.2 18845.4 19010.3 19013.2 19045.9 19180.9 6884.9 6997.6 7088.9 7130.4 7223.0 821.3 966.1 979.8 987.2 1076.6 26790.5 27070.5 27471.5 27488.2 27767.9 947.2 968.1 1006.2 1021.9 1092.1 14179.2 14412.9 14476.5 14546.0 14548.6 384437.0 385322.0 387029.0 387520.0 387984.0 49883.3 50669.5 51416.5 51452.0 51515.5 1194.4 1194.8 1228.4 1232.0 1234.0 26772.1 27348.5 27403.9 27808.4 28156.2 42292.0 42707.6 42767.4 42772.8 42807.1 331602.0 333169.0 334061.0 334350.0 334591.0 25352.2 26459.3 26461.7 26520.7 26540.6 42803.7 42930.8 43165.4 44284.3 44564.9 36524.5 37648.2 37917.8 37976.6 38062.4 35932.5 36461.6 36846.6 36887.8 37318.6 31109.2 36009.3 36602.5 37123.8 37273.6 31160.4 33667.4 33726.3 33972.0 34156.3 24431.5 24499.1 24750.3 25105.2 25261.1 23:28:21 INFO - PROCESS | 30752 | 23:28:21 INFO - PROCESS | 30752 | [#2] jquery.html Cycles:180 Average:22899.10 Median:4412.27 stddev:61421.46 (1392.1%) stddev-sans-first:61570.44 23:28:21 INFO - PROCESS | 30752 | Values: 356.3 364.8 367.2 367.8 379.8 15435.5 16559.3 17471.9 17519.2 17583.3 15362.5 15471.5 15969.4 16062.8 16162.8 4970.0 5124.9 5147.7 5150.8 5159.1 3743.0 5073.1 5662.6 5943.8 5956.2 5967.1 5969.5 5971.8 5987.6 6003.0 5710.2 5906.9 5921.7 5934.9 5938.0 4445.9 5123.8 5135.7 5152.1 5162.6 11340.2 11946.5 11947.6 11999.0 12019.2 1667.8 1697.2 1716.5 1783.5 1784.6 8775.7 9115.0 9168.3 11074.2 12538.7 1480.5 1492.3 1665.0 1716.6 1723.8 65351.7 68822.3 69471.7 69484.7 69832.0 9642.4 9651.3 9816.3 10023.6 10070.7 13940.6 13944.8 14031.8 14045.4 14077.3 7110.3 7160.8 7195.6 7233.0 7234.9 6598.7 6640.7 6697.4 6709.7 6835.3 4210.0 4289.6 4306.4 4345.7 4378.7 1563.1 1598.6 1723.1 1753.7 1763.7 856.8 875.1 877.6 879.0 917.9 15531.8 15974.8 15987.6 16354.5 16374.5 834.5 836.5 844.4 862.7 873.2 8939.5 9059.0 9233.2 9243.7 9421.1 366379.0 367257.0 371739.0 374868.0 385523.0 48065.3 53532.0 66560.7 71266.0 74646.5 878.0 883.5 901.0 903.4 907.8 14715.0 14728.5 14830.3 14945.8 15148.2 32907.2 33161.0 33751.5 34173.0 34573.0 45419.8 46623.0 46859.1 47004.0 47053.0 7493.9 7677.6 7815.4 7881.6 7939.2 11541.6 11765.0 11821.5 11866.2 12028.6 9983.3 9995.1 10013.2 10190.6 10391.2 9930.7 10001.8 10068.6 10088.9 10273.9 9995.7 10098.5 10112.3 10209.9 10318.9 6652.6 7076.7 7245.0 7738.1 7795.3 10118.1 10119.6 10139.5 10280.5 10285.9 23:28:21 INFO - PROCESS | 30752 | 23:28:21 INFO - PROCESS | 30752 | [#3] mootools.html Cycles:180 Average:5045.56 Median:5390.48 stddev:2814.64 (52.2%) stddev-sans-first:2809.50 23:28:21 INFO - PROCESS | 30752 | Values: 1440.9 1441.1 1560.9 1760.5 1764.6 6745.2 7375.5 7402.4 7931.7 7978.7 7450.4 7765.4 7780.3 7812.9 7814.9 2088.0 2143.4 2146.9 2147.6 2150.7 2089.4 2132.7 2134.8 2135.0 2148.4 2101.8 2102.9 2113.9 2119.8 2131.6 2114.1 2119.8 2122.1 2129.7 2129.8 2063.0 2065.6 2073.6 2087.6 2102.4 7732.6 7783.3 7793.8 7801.1 7802.8 4357.2 4437.4 4453.0 4460.0 4460.1 2805.0 2864.2 2881.2 2883.5 2920.1 856.3 858.1 878.2 886.5 889.1 10372.3 10379.2 10398.2 10404.5 10407.3 4078.2 4122.5 4179.2 4208.5 4214.5 8929.9 8940.1 8940.6 8954.1 8959.6 4390.6 4437.3 4452.3 4464.6 4479.4 3634.5 3933.1 3971.3 4011.1 4069.0 3547.5 3569.7 3611.9 3642.1 3657.9 1145.3 1181.0 1185.3 1196.7 1205.5 808.6 898.5 906.5 914.5 927.0 5148.7 5236.6 5311.2 5325.8 5342.4 386.1 875.4 892.7 916.5 971.4 3674.3 3779.0 3847.1 3862.0 3862.7 9185.1 9390.4 9446.2 9479.4 9484.5 9553.8 9677.4 9694.1 9749.6 9772.1 7039.2 7389.4 7395.6 7562.1 7563.7 5438.6 5669.9 5754.9 5764.0 5926.6 8537.6 8607.6 8747.8 8903.6 8925.0 8789.4 8905.1 8916.7 8989.0 9029.5 5941.7 6420.6 6421.3 6471.4 6588.4 6739.5 6830.9 6888.7 6905.1 6907.7 5988.9 6278.2 6360.9 6436.3 6437.4 6314.3 6386.6 6439.7 6464.8 6555.2 5891.3 5955.9 5995.6 6000.4 6008.2 4286.5 4359.9 4387.8 4454.6 4740.4 4570.6 4577.9 4606.6 4635.6 4779.4 23:28:21 INFO - PROCESS | 30752 | 23:28:21 INFO - PROCESS | 30752 | [#4] prototype.html Cycles:180 Average:4271.40 Median:4956.19 stddev:1264.94 (25.5%) stddev-sans-first:1232.55 23:28:21 INFO - PROCESS | 30752 | Values: 282.8 285.9 286.9 287.6 292.1 4945.7 4992.6 4993.9 5008.7 5019.2 4873.3 4930.3 4952.9 4959.5 4978.2 3640.5 3728.6 3810.1 3832.6 3833.6 3817.6 3824.4 3832.9 3838.0 3850.6 3824.9 3827.4 3827.6 3828.8 3830.1 3555.8 3789.7 3813.9 3823.4 3835.1 3263.6 3273.8 3274.7 3288.5 3292.8 4711.7 4715.0 4720.7 4723.9 4724.2 4319.2 4321.7 4331.7 4337.0 4342.0 5030.7 5128.9 5138.8 5155.2 5160.0 3612.6 3616.3 3624.7 3625.1 3636.9 5374.0 5403.4 5432.8 5433.3 5442.3 3578.7 3649.4 3656.7 3657.7 3675.3 3686.1 3708.0 3715.5 3716.6 3717.8 4241.3 4272.1 4275.4 4299.9 4300.5 5090.2 5112.4 5184.8 5191.7 5194.7 1281.6 1285.7 1301.7 1303.0 1303.7 795.1 797.7 802.7 827.6 828.3 4412.7 4517.2 4526.5 4543.5 4551.1 5342.5 5352.7 5356.6 5363.3 5383.3 4419.2 4496.5 4533.9 4562.5 4570.3 2792.3 2863.6 2864.6 2869.7 2871.5 4968.1 4986.0 5006.3 5009.3 5042.1 5173.8 5425.1 5446.3 5453.4 5487.1 5041.2 5052.7 5054.2 5058.7 5067.7 5355.4 5361.2 5363.3 5365.7 5388.0 4930.4 5218.4 5249.3 5250.3 5259.9 5041.5 5045.7 5046.8 5049.4 5054.5 3713.7 3716.7 3719.9 3727.2 3728.8 5163.5 5329.2 5335.9 5357.9 5392.3 5216.2 5239.3 5243.0 5247.7 5265.6 5183.9 5207.9 5212.3 5254.0 5264.7 4950.2 5005.6 5084.2 5089.7 5105.6 4959.7 5019.9 5170.9 5187.6 5218.4 4971.7 5036.0 5036.4 5041.5 5046.7 23:28:21 INFO - PROCESS | 30752 | 23:28:21 INFO - PROCESS | 30752 | [#5] yui.html Cycles:180 Average:16898.91 Median:534.61 stddev:23143.34 (4329.0%) stddev-sans-first:23175.97 23:28:21 INFO - PROCESS | 30752 | Values: 616.2 642.3 660.5 666.8 680.4 12183.0 12374.5 12657.7 12686.8 12930.2 12076.3 12136.0 12228.7 12398.7 12528.1 638.1 786.0 800.0 812.4 813.5 807.9 809.5 812.3 814.5 816.1 857.4 858.4 860.3 861.9 865.6 844.4 849.2 849.8 850.8 851.8 615.4 617.6 617.8 618.6 619.1 12691.2 12706.7 12710.9 12723.5 12751.2 13648.5 13709.4 13809.7 13813.9 14041.6 10577.3 10703.7 10727.2 10736.2 10765.9 3301.6 3312.4 3356.3 3378.7 3467.8 61964.0 62103.0 66336.0 66595.3 66758.3 9374.1 9521.8 9650.8 9660.4 9673.8 17007.6 17471.2 17547.6 17616.7 17686.2 6179.9 6241.7 6296.0 6364.3 6523.2 3751.2 3759.6 3815.8 3819.6 3828.3 2966.7 3014.7 3028.7 3032.5 3069.3 530.9 531.0 538.2 540.8 548.8 475.3 507.7 579.6 600.0 613.3 7980.2 8092.2 8145.2 8168.1 8380.0 489.4 610.3 616.8 620.0 622.5 3434.3 3718.2 3729.4 3731.1 3782.8 68334.0 82122.0 83687.6 85018.0 92625.0 74694.6 75703.6 76348.0 76735.6 77206.2 68916.3 68924.3 69427.3 70007.0 70400.0 8466.3 8894.3 9021.2 9025.8 9029.9 41585.6 43006.4 43194.1 43389.6 43662.0 57596.7 59573.7 60728.4 60977.1 61121.0 11403.5 11456.3 11569.1 11648.5 11723.7 11161.8 11476.7 11614.4 11819.8 11891.8 12324.8 12344.8 12503.1 12528.2 13101.1 11752.1 11802.6 11934.8 12384.3 12387.9 11765.2 11898.7 11965.3 12029.2 12178.8 9765.4 9974.2 9997.5 10200.5 10298.5 9918.7 10261.2 10291.5 10356.8 10458.9 23:28:21 INFO - PROCESS | 30752 | -------- Summary: end -------- 23:28:21 INFO - PROCESS | 30752 | 23:28:22 INFO - TEST-INFO | 30752: exit 0 23:28:22 INFO - TEST-OK | dromaeo_css | took 1115861ms 23:28:22 INFO - TEST-START | kraken 23:28:22 INFO - operating with platform_type : linux_ 23:28:22 INFO - Initialising browser for kraken test... 23:28:22 INFO - TEST-INFO | started process 30988 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpakQpMz/profile http://localhost:46563/getInfo.html) 23:28:27 INFO - PROCESS | 30988 | __metrics Screen width/height:1600/1200 23:28:27 INFO - PROCESS | 30988 | colorDepth:24 23:28:27 INFO - PROCESS | 30988 | Browser inner width/height: 1024/697 23:28:27 INFO - PROCESS | 30988 | __metrics 23:28:27 ERROR - PROCESS | 30988 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2938: TypeError: this.tabs is undefined 23:28:28 INFO - TEST-INFO | 30988: exit 0 23:28:28 INFO - Browser initialized. 23:28:28 INFO - Running cycle 1/1 for kraken test... 23:28:28 INFO - TEST-INFO | started process 31108 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpakQpMz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:28:40 INFO - PROCESS | 31108 | RSS: Main: 168783872 23:28:40 INFO - PROCESS | 31108 | 23:28:43 INFO - PROCESS | 31108 | Cycle 1(1): loaded http://localhost:46563/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46563/tests/kraken/driver.html?testName=audio-beat-detection) 23:28:44 INFO - PROCESS | 31108 | RSS: Main: 172904448 23:28:44 INFO - PROCESS | 31108 | 23:28:46 INFO - PROCESS | 31108 | Cycle 1(1): loaded http://localhost:46563/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46563/tests/kraken/driver.html?testName=audio-dft) 23:28:47 INFO - PROCESS | 31108 | RSS: Main: 172969984 23:28:47 INFO - PROCESS | 31108 | 23:28:50 INFO - PROCESS | 31108 | Cycle 1(1): loaded http://localhost:46563/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46563/tests/kraken/driver.html?testName=audio-fft) 23:28:51 INFO - PROCESS | 31108 | RSS: Main: 168017920 23:28:51 INFO - PROCESS | 31108 | 23:28:53 INFO - PROCESS | 31108 | Cycle 1(1): loaded http://localhost:46563/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46563/tests/kraken/driver.html?testName=audio-oscillator) 23:28:53 INFO - PROCESS | 31108 | RSS: Main: 168726528 23:28:53 INFO - PROCESS | 31108 | 23:28:56 INFO - PROCESS | 31108 | Cycle 1(1): loaded http://localhost:46563/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46563/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:28:56 INFO - PROCESS | 31108 | RSS: Main: 168771584 23:28:56 INFO - PROCESS | 31108 | 23:29:00 INFO - PROCESS | 31108 | Cycle 1(1): loaded http://localhost:46563/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46563/tests/kraken/driver.html?testName=imaging-darkroom) 23:29:00 INFO - PROCESS | 31108 | RSS: Main: 169480192 23:29:00 INFO - PROCESS | 31108 | 23:29:04 INFO - PROCESS | 31108 | Cycle 1(1): loaded http://localhost:46563/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46563/tests/kraken/driver.html?testName=imaging-desaturate) 23:29:04 INFO - PROCESS | 31108 | RSS: Main: 166395904 23:29:04 INFO - PROCESS | 31108 | 23:29:07 INFO - PROCESS | 31108 | Cycle 1(1): loaded http://localhost:46563/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46563/tests/kraken/driver.html?testName=json-parse-financial) 23:29:08 INFO - PROCESS | 31108 | RSS: Main: 167350272 23:29:08 INFO - PROCESS | 31108 | 23:29:10 INFO - PROCESS | 31108 | Cycle 1(1): loaded http://localhost:46563/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46563/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:29:10 INFO - PROCESS | 31108 | RSS: Main: 167751680 23:29:10 INFO - PROCESS | 31108 | 23:29:12 INFO - PROCESS | 31108 | Cycle 1(1): loaded http://localhost:46563/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46563/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:29:13 INFO - PROCESS | 31108 | RSS: Main: 168312832 23:29:13 INFO - PROCESS | 31108 | 23:29:15 INFO - PROCESS | 31108 | Cycle 1(1): loaded http://localhost:46563/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46563/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:29:16 INFO - PROCESS | 31108 | RSS: Main: 169213952 23:29:16 INFO - PROCESS | 31108 | 23:29:19 INFO - PROCESS | 31108 | Cycle 1(1): loaded http://localhost:46563/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46563/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:29:19 INFO - PROCESS | 31108 | RSS: Main: 169332736 23:29:19 INFO - PROCESS | 31108 | 23:29:22 INFO - PROCESS | 31108 | Cycle 1(1): loaded http://localhost:46563/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46563/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:29:23 INFO - PROCESS | 31108 | RSS: Main: 168779776 23:29:23 INFO - PROCESS | 31108 | 23:29:24 INFO - PROCESS | 31108 | Cycle 1(1): loaded http://localhost:46563/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46563/tests/kraken/driver.html?testName=ai-astar) 23:29:25 INFO - PROCESS | 31108 | RSS: Main: 169422848 23:29:25 INFO - PROCESS | 31108 | 23:29:25 INFO - PROCESS | 31108 | __start_tp_report 23:29:25 INFO - PROCESS | 31108 | _x_x_mozilla_page_load 23:29:25 INFO - PROCESS | 31108 | _x_x_mozilla_page_load_details 23:29:25 INFO - PROCESS | 31108 | |i|pagename|runs| 23:29:25 INFO - PROCESS | 31108 | |0;ai-astar;112;107;114;115;113;114;115;115;113;113 23:29:25 INFO - PROCESS | 31108 | |1;audio-beat-detection;156;131;167;181;132;162;157;131;194;131 23:29:25 INFO - PROCESS | 31108 | |2;audio-dft;163;165;168;173;162;162;162;164;162;162 23:29:25 INFO - PROCESS | 31108 | |3;audio-fft;77;75;76;160;75;77;77;76;161;76 23:29:25 INFO - PROCESS | 31108 | |4;audio-oscillator;86;86;147;88;89;87;131;87;87;135 23:29:25 INFO - PROCESS | 31108 | |5;imaging-gaussian-blur;118;118;121;117;117;118;117;117;117;118 23:29:25 INFO - PROCESS | 31108 | |6;imaging-darkroom;148;149;147;148;148;149;148;148;147;150 23:29:25 INFO - PROCESS | 31108 | |7;imaging-desaturate;95;95;95;95;95;97;96;95;96;95 23:29:25 INFO - PROCESS | 31108 | |8;json-parse-financial;65;65;63;65;65;65;66;64;63;66 23:29:25 INFO - PROCESS | 31108 | |9;json-stringify-tinderbox;64;65;67;64;65;66;70;65;65;64 23:29:25 INFO - PROCESS | 31108 | |10;stanford-crypto-aes;96;84;84;83;84;85;84;84;108;85 23:29:25 INFO - PROCESS | 31108 | |11;stanford-crypto-ccm;138;134;140;136;133;143;139;141;152;135 23:29:25 INFO - PROCESS | 31108 | |12;stanford-crypto-pbkdf2;166;166;172;165;169;168;166;169;168;167 23:29:25 INFO - PROCESS | 31108 | |13;stanford-crypto-sha256-iterative;70;68;67;68;68;65;68;66;67;68 23:29:25 INFO - PROCESS | 31108 | __end_tp_report 23:29:25 INFO - PROCESS | 31108 | __start_cc_report 23:29:25 INFO - PROCESS | 31108 | _x_x_mozilla_cycle_collect,957 23:29:25 INFO - PROCESS | 31108 | __end_cc_report 23:29:25 INFO - PROCESS | 31108 | __startTimestamp1465194565153__endTimestamp 23:29:25 INFO - PROCESS | 31108 | 23:29:25 INFO - PROCESS | 31108 | ------- Summary: start ------- 23:29:25 INFO - PROCESS | 31108 | Number of tests: 14 23:29:25 INFO - PROCESS | 31108 | 23:29:25 INFO - PROCESS | 31108 | [#0] ai-astar Cycles:10 Average:113.10 Median:114.00 stddev:2.38 (2.1%) stddev-sans-first:2.49 23:29:25 INFO - PROCESS | 31108 | Values: 112.0 107.0 114.0 115.0 113.0 114.0 115.0 115.0 113.0 113.0 23:29:25 INFO - PROCESS | 31108 | 23:29:25 INFO - PROCESS | 31108 | [#1] audio-beat-detection Cycles:10 Average:154.20 Median:159.50 stddev:22.72 (14.2%) stddev-sans-first:24.09 23:29:25 INFO - PROCESS | 31108 | Values: 156.0 131.0 167.0 181.0 132.0 162.0 157.0 131.0 194.0 131.0 23:29:25 INFO - PROCESS | 31108 | 23:29:25 INFO - PROCESS | 31108 | [#2] audio-dft Cycles:10 Average:164.30 Median:163.50 stddev:3.62 (2.2%) stddev-sans-first:3.81 23:29:25 INFO - PROCESS | 31108 | Values: 163.0 165.0 168.0 173.0 162.0 162.0 162.0 164.0 162.0 162.0 23:29:25 INFO - PROCESS | 31108 | 23:29:25 INFO - PROCESS | 31108 | [#3] audio-fft Cycles:10 Average:93.00 Median:76.00 stddev:35.58 (46.8%) stddev-sans-first:37.27 23:29:25 INFO - PROCESS | 31108 | Values: 77.0 75.0 76.0 160.0 75.0 77.0 77.0 76.0 161.0 76.0 23:29:25 INFO - PROCESS | 31108 | 23:29:25 INFO - PROCESS | 31108 | [#4] audio-oscillator Cycles:10 Average:102.30 Median:87.00 stddev:24.73 (28.4%) stddev-sans-first:25.52 23:29:25 INFO - PROCESS | 31108 | Values: 86.0 86.0 147.0 88.0 89.0 87.0 131.0 87.0 87.0 135.0 23:29:25 INFO - PROCESS | 31108 | 23:29:25 INFO - PROCESS | 31108 | [#5] imaging-gaussian-blur Cycles:10 Average:117.80 Median:118.00 stddev:1.23 (1.0%) stddev-sans-first:1.30 23:29:25 INFO - PROCESS | 31108 | Values: 118.0 118.0 121.0 117.0 117.0 118.0 117.0 117.0 117.0 118.0 23:29:25 INFO - PROCESS | 31108 | 23:29:25 INFO - PROCESS | 31108 | [#6] imaging-darkroom Cycles:10 Average:148.20 Median:148.00 stddev:0.92 (0.6%) stddev-sans-first:0.97 23:29:25 INFO - PROCESS | 31108 | Values: 148.0 149.0 147.0 148.0 148.0 149.0 148.0 148.0 147.0 150.0 23:29:25 INFO - PROCESS | 31108 | 23:29:25 INFO - PROCESS | 31108 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.00 stddev:0.70 (0.7%) stddev-sans-first:0.73 23:29:25 INFO - PROCESS | 31108 | Values: 95.0 95.0 95.0 95.0 95.0 97.0 96.0 95.0 96.0 95.0 23:29:25 INFO - PROCESS | 31108 | 23:29:25 INFO - PROCESS | 31108 | [#8] json-parse-financial Cycles:10 Average:64.70 Median:65.00 stddev:1.06 (1.6%) stddev-sans-first:1.12 23:29:25 INFO - PROCESS | 31108 | Values: 65.0 65.0 63.0 65.0 65.0 65.0 66.0 64.0 63.0 66.0 23:29:25 INFO - PROCESS | 31108 | 23:29:25 INFO - PROCESS | 31108 | [#9] json-stringify-tinderbox Cycles:10 Average:65.50 Median:65.00 stddev:1.84 (2.8%) stddev-sans-first:1.87 23:29:25 INFO - PROCESS | 31108 | Values: 64.0 65.0 67.0 64.0 65.0 66.0 70.0 65.0 65.0 64.0 23:29:25 INFO - PROCESS | 31108 | 23:29:25 INFO - PROCESS | 31108 | [#10] stanford-crypto-aes Cycles:10 Average:87.70 Median:84.00 stddev:8.07 (9.6%) stddev-sans-first:7.98 23:29:25 INFO - PROCESS | 31108 | Values: 96.0 84.0 84.0 83.0 84.0 85.0 84.0 84.0 108.0 85.0 23:29:25 INFO - PROCESS | 31108 | 23:29:25 INFO - PROCESS | 31108 | [#11] stanford-crypto-ccm Cycles:10 Average:139.10 Median:139.50 stddev:5.55 (4.0%) stddev-sans-first:5.87 23:29:25 INFO - PROCESS | 31108 | Values: 138.0 134.0 140.0 136.0 133.0 143.0 139.0 141.0 152.0 135.0 23:29:25 INFO - PROCESS | 31108 | 23:29:25 INFO - PROCESS | 31108 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.60 Median:168.00 stddev:2.07 (1.2%) stddev-sans-first:2.11 23:29:25 INFO - PROCESS | 31108 | Values: 166.0 166.0 172.0 165.0 169.0 168.0 166.0 169.0 168.0 167.0 23:29:25 INFO - PROCESS | 31108 | 23:29:25 INFO - PROCESS | 31108 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.50 Median:68.00 stddev:1.35 (2.0%) stddev-sans-first:1.09 23:29:25 INFO - PROCESS | 31108 | Values: 70.0 68.0 67.0 68.0 68.0 65.0 68.0 66.0 67.0 68.0 23:29:25 INFO - PROCESS | 31108 | -------- Summary: end -------- 23:29:25 INFO - PROCESS | 31108 | 23:29:26 INFO - TEST-INFO | 31108: exit 0 23:29:26 INFO - TEST-OK | kraken | took 64061ms 23:29:26 INFO - SUITE-END | took 1179s 23:29:26 INFO - Completed test suite (00:19:40) 23:29:26 INFO - javascript benchmark 23:29:26 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6373.336216615494, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2690.4619076184763, 2724.4823483538125, 2726.3593055631923, 2736.822106563072, 2742.2595899107228, 4701.2242979908315, 4730.5742483176555, 4758.833440829568, 4841.419029716439, 4880.951190488094, 4659.394278743767, 4679.906401871961, 4718.457377401592, 4773.3317335572965, 4781.617470602352, 4358.324459708742, 4385.934210986838, 4454.665900057493, 4490.416245888046, 4515.2324104902245, 4425.9114817703785, 4433.933490997638, 4446.466424029121, 4507.278835386339, 4512.413386259782, 4391.538888416702, 4468.173387923229, 4501.617362524189, 4506.77466126694, 4529.4791099023705, 4402.801873915681, 4410.140022695576, 4412.514623391425, 4440.267355886275, 4457.732536047815, 4361.258586040381, 4383.057642606855, 4385.276429389147, 4438.378626992224, 4442.155990361821, 4640.83757068501, 4673.065386922629, 4694.718316900963, 4717.599004084657, 4741.359916411275, 5136.203888397305, 5152.149895267276, 5160.974195129038, 5168.173092305213, 5191.273221748958, 5098.796048158069, 5174.120399532051, 5174.818881339135, 5182.378114626231, 5217.34783152106, 4740.834070807539, 4841.394825646794, 4854.0, 4867.294242334912, 4880.463149053601, 5336.866578335573, 5355.758990845421, 5363.410024897258, 5367.651102678314, 5374.381946076173, 5158.74206289684, 5159.922601160985, 5164.380274367025, 5169.147090730063, 5173.1722924331925, 5003.149464591028, 5148.4079330876675, 5168.741562921914, 5199.818006369759, 5216.295800067019, 5124.820631277962, 5137.2037334213255, 5142.51146141116, 5144.408393034849, 5206.0, 4980.551750342486, 5132.050570644443, 5133.204353325241, 5144.0, 5155.690658560498, 4207.200631879933, 4271.530131685512, 4275.978620106942, 4296.656267498593, 4325.134973005349, 3742.569604495518, 3752.399616061417, 3797.867074652374, 3798.1264309209037, 3822.694184465236, 4469.7988590513505, 4479.372887795711, 4486.371907932892, 4499.617532509707, 4508.368828364031, 5046.0, 5096.184610462308, 5128.948710512922, 5145.922811157836, 5183.429822719498, 4425.35832304314, 4466.3747075409465, 4467.084247729208, 4484.641228701696, 4516.88707782308, 4513.368128462018, 4647.604953578983, 4682.204025315705, 4682.274247491644, 4735.2423612222565, 4869.366982292279, 4902.2156454967035, 4935.728534930613, 4941.654084214214, 4949.653524253412, 5275.446078161738, 5292.338457692788, 5293.523582877559, 5294.582622831856, 5350.250964865, 4778.546038126373, 4844.515548445127, 4937.679050861682, 4944.505549445171, 4948.505149485023, 5124.333836601218, 5165.147750621106, 5186.299849520266, 5195.428502864757, 5238.476152384731, 5244.868878278074, 5260.658057226268, 5265.973670131625, 5274.683518988873, 5276.920846187387, 4900.019996000743, 4922.581580565692, 4946.307516947702, 5091.261767043684, 5107.9233811493605, 4936.062148191976, 4956.925646115384, 4970.627202959865, 4975.253711943237, 5009.624278179078, 4824.324594556695, 4868.878278042936, 4870.634702397405, 4884.902301954012, 4893.975530122327, 4926.827561035347, 5047.369078865142, 5060.772265247999, 5073.59411247092, 5100.056489549445, 4807.423109226916, 4881.975590122169, 4899.828506002273, 4900.264960255848, 4972.552470277692], "value": 4735.681080756947, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [538.9155523165218, 580.4833698008772, 599.7511032921337, 605.1497645807641, 628.8962321217, 39216.21567568647, 39855.40216896742, 39923.0, 40041.0, 40104.79947600261, 39847.60152398483, 40423.0, 40599.39100913489, 40617.59382406175, 40627.390589141185, 7519.887201691992, 7604.049493813273, 7636.809079773022, 7646.235376462337, 7658.195889431585, 7687.154413014564, 7854.567998760066, 7865.567393793339, 7883.0, 7883.054033515986, 7840.372770178401, 7844.450888437812, 7852.489588176779, 7895.644695988694, 7906.841863162734, 7772.106207786092, 7817.648205830695, 7832.216778322179, 7860.0960889497865, 7879.921200788005, 7629.198934111894, 7690.923090769133, 7755.728549500796, 7766.922330776676, 7788.727394541163, 37405.43891841624, 37491.25017499662, 37647.62352376468, 37739.05652358713, 37806.0, 2943.5290353543332, 3065.938681226385, 3118.8752449901976, 3122.859471323773, 3244.772865899388, 29624.40751184986, 30210.69789302101, 30377.696223037707, 30604.0, 30681.232969175726, 3303.3888730584918, 3305.1076209423322, 3315.245375688209, 3322.401967645823, 3327.8169700666454, 254991.0, 255377.0, 256831.0, 257021.0, 257334.0, 55087.173692394645, 55753.44246557564, 55798.442015580134, 55849.72075139598, 55986.0, 34107.31785364279, 34936.475952860725, 34973.47539786905, 36703.0, 36782.816085919396, 14976.326065327086, 15016.0, 15137.243137843065, 15140.772888406682, 15284.235788210544, 10826.891731082746, 10874.510647020903, 10886.945565272123, 10957.287776294515, 11016.17378696601, 18845.434636960912, 19010.334638287593, 19013.239470421304, 19045.904770476336, 19180.904095479713, 6884.862302753917, 6997.615131167733, 7088.92911070893, 7130.3939165170505, 7222.96388518054, 821.2936874288107, 966.1015255812163, 979.7648564344506, 987.1954357199004, 1076.5586109694987, 26790.464190716077, 27070.458590828468, 27471.45057098847, 27488.17535473939, 27767.86116069407, 947.1948843482984, 968.1335204991493, 1006.2101250518308, 1021.8671572695501, 1092.0662833277593, 14179.22014289224, 14412.855871441152, 14476.493322733864, 14546.0, 14548.563543093724, 384437.0, 385322.0, 387029.0, 387520.0, 387984.0, 49883.25175122376, 50669.49330506721, 51416.48583514117, 51452.0, 51515.48484515182, 1194.3610168559953, 1194.8207768834745, 1228.3735294999615, 1231.950721971129, 1234.01895493085, 26772.062977795682, 27348.45303093967, 27403.93944067634, 27808.44383112286, 28156.155315340573, 42292.0, 42707.572924271604, 42767.3584896233, 42772.786136069124, 42807.14385712206, 331602.0, 333169.0, 334061.0, 334350.0, 334591.0, 25352.239432817045, 26459.338516537242, 26461.735382646697, 26520.734792652598, 26540.601890972037, 42803.715888523395, 42930.78534607307, 43165.3525197116, 44284.33573496465, 44564.88587785331, 36524.452133218554, 37648.2470350586, 37917.81041094887, 37976.62023379731, 38062.42906356351, 35932.4610130843, 36461.63538364582, 36846.63153368432, 36887.81556092203, 37318.62681373151, 31109.222269443446, 36009.279814404086, 36602.45096323611, 37123.81438092792, 37273.6272637281, 31160.376792464478, 33667.42482941318, 33726.3254734899, 33972.0, 34156.31687366189, 24431.51136977215, 24499.142530011362, 24750.25749227526, 25105.24684259475, 25261.115860944778], "value": 17530.158512261365, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [356.303426800605, 364.8230608155045, 367.18668150047637, 367.83631284078564, 379.8423654183514, 15435.536933891986, 16559.33762649494, 17471.91264043678, 17519.211635476404, 17583.29666813329, 15362.539123826275, 15471.45849895254, 15969.361225550992, 16062.75905861413, 16162.83837161628, 4970.0, 5124.92312615311, 5147.716875571842, 5150.793968241266, 5159.071367153911, 3742.981285093571, 5073.112205364065, 5662.631928924607, 5943.821685349447, 5956.195913551658, 5967.104934259874, 5969.462748352647, 5971.790987315445, 5987.55093367997, 6003.039513677791, 5710.229119068935, 5906.852328691795, 5921.703914804286, 5934.881302373971, 5938.020226662596, 4445.866624001285, 5123.820666276662, 5135.666181698178, 5152.098382782998, 5162.6128040397125, 11340.206185567014, 11946.462409191521, 11947.581834635746, 11999.0, 12019.21875078117, 1667.8082020567547, 1697.1683874901332, 1716.519374575121, 1783.5006198264507, 1784.5895444047812, 8775.692850750193, 9114.954425227897, 9168.312376571717, 11074.224804263706, 12538.68653283666, 1480.5262316058866, 1492.2911616981955, 1664.9750253746204, 1716.5767460278275, 1723.750056241838, 65351.673241633485, 68822.3117768821, 69471.65264173698, 69484.65257673679, 69831.99999999949, 9642.42145471274, 9651.276154288316, 9816.312858100007, 10023.649172278936, 10070.676676696672, 13940.58178254654, 13944.790828137586, 14031.78952315716, 14045.438182472586, 14077.296135193199, 7110.25342339047, 7160.820979475555, 7195.568265904062, 7233.0, 7234.914762785625, 6598.7030583623855, 6640.701168447432, 6697.430718388894, 6709.664516774142, 6835.316468353224, 4209.957900421018, 4289.6139347458875, 4306.354046892929, 4345.67407444443, 4378.671599630041, 1563.1168389859693, 1598.5843680643115, 1723.147042214112, 1753.7194048952106, 1763.6825371433008, 856.8029353248787, 875.0680525240598, 877.6138499060393, 879.0418443896184, 917.8898532176181, 15531.844681553266, 15974.840251597569, 15987.600309992344, 16354.509364719077, 16374.508764737076, 834.5326617094447, 836.477201748907, 844.3751623798468, 862.6894318045498, 873.1835733589114, 8939.508327041945, 9059.0, 9233.215176710055, 9243.722688319362, 9421.104995025462, 366379.0, 367257.0, 371739.0, 374868.0, 385523.0, 48065.27902081471, 53532.0, 66560.66719666467, 71266.0, 74646.50706985939, 878.0473186592618, 883.5273128876149, 900.9684661036832, 903.3766700976305, 907.8138981508774, 14714.969952103678, 14728.484503042342, 14830.258487075818, 14945.775813363025, 15148.242587870784, 32907.20288775481, 33161.0, 33751.4937275946, 34173.0, 34573.0, 45419.7729011366, 46623.0, 46859.06281874275, 47004.0, 47053.0, 7493.925060749323, 7677.577733224726, 7815.413843961612, 7881.605919704107, 7939.2060793920145, 11541.596044138414, 11765.0, 11821.527138914347, 11866.152123490472, 12028.63914082579, 9983.251256155672, 9995.100440960348, 10013.2490063247, 10190.592376304865, 10391.168706503311, 9930.652427165014, 10001.799964000826, 10068.647597334058, 10088.949555252177, 10273.9486302568, 9995.650152244636, 10098.54556544972, 10112.270401079077, 10209.897901021192, 10318.896811031793, 6652.567583107082, 7076.71693132269, 7245.0, 7738.071431428039, 7795.259450352208, 10118.139958103644, 10119.595216191565, 10139.543720532447, 10280.537375817956, 10285.897141028494], "value": 7890.3380915264115, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1440.8847292216624, 1441.070509521359, 1560.859522642962, 1760.4630587670756, 1764.6029643330253, 6745.190577130751, 7375.483716139873, 7402.444816638754, 7931.682732690692, 7978.7207447739265, 7450.441216908726, 7765.417593680469, 7780.299773020427, 7812.921870781304, 7814.92185078149, 2087.9582408351826, 2143.421276255418, 2146.9033893474752, 2147.5812216617765, 2150.666646669769, 2089.4462967313675, 2132.744070711517, 2134.79719426655, 2134.957300853982, 2148.4199266198116, 2101.7898210179014, 2102.8843413612244, 2113.9218998310894, 2119.79861913118, 2131.637621604331, 2114.143771772435, 2119.8304135669264, 2122.0875023739786, 2129.6805479178092, 2129.765725770164, 2062.95874082519, 2065.555905480314, 2073.626747185506, 2087.6137914485867, 2102.390306811023, 7732.613369331567, 7783.299503044696, 7793.766187014398, 7801.0638723352995, 7802.843943121163, 4357.150355680644, 4437.378766972626, 4452.977735111336, 4459.974205932621, 4460.0633866887665, 2804.9719502804915, 2864.2266588021116, 2881.207667891326, 2883.480973424783, 2920.1385591250632, 856.3063918226256, 858.0775666158904, 878.2403221213668, 886.5434301334818, 889.1108891108892, 10372.325798823127, 10379.221558383151, 10398.220133489944, 10404.479776011169, 10407.323523970994, 4078.1843631273864, 4122.464079669624, 4179.226843034048, 4208.473940757405, 4214.515330737005, 8929.910700893039, 8940.105989401009, 8940.597673104727, 8954.149355811187, 8959.641614335484, 4390.648748100144, 4437.334399839985, 4452.30989196675, 4464.553544645574, 4479.440069991251, 3634.527511423498, 3933.056066544009, 3971.344728119828, 4011.0574015106426, 4069.04377471294, 3547.5033495310677, 3569.696575791087, 3611.9277614448088, 3642.0530662028063, 3657.908552286214, 1145.2899202494507, 1180.952761889532, 1185.3302883870758, 1196.7367179220557, 1205.4816428935467, 808.6118663041773, 898.510311880027, 906.5059542549326, 914.5244472874201, 927.0312523413049, 5148.6910785353, 5236.581073514109, 5311.150215965427, 5325.786968521294, 5342.385625653022, 386.0580184350177, 875.4047247871381, 892.6518657723493, 916.4867674102524, 971.4122955611895, 3674.2651469706166, 3778.962210377861, 3847.0959324558708, 3861.961380386216, 3862.6716729078344, 9185.081491850762, 9390.389624674373, 9446.244300455946, 9479.383840050512, 9484.525773711424, 9553.761155971017, 9677.37097088687, 9694.127528522467, 9749.610015599439, 9772.120509154069, 7039.225685174627, 7389.371903388164, 7395.630218489054, 7562.130355009244, 7563.659635316424, 5438.564914806727, 5669.914951275651, 5754.9424505754405, 5763.971180144073, 5926.644401335933, 8537.615807288563, 8607.612657430305, 8747.825043499222, 8903.554822258991, 8925.0, 8789.384743067923, 8905.109489051043, 8916.687915922912, 8989.0, 9029.548522573714, 5941.732622031933, 6420.550561460653, 6421.293657697743, 6471.352864713491, 6588.40704336612, 6739.494537909774, 6830.931690683228, 6888.655567221719, 6905.067815844997, 6907.654617269217, 5988.910166347596, 6278.246610406781, 6360.936390636034, 6436.292007879223, 6437.356264373712, 6314.336994615683, 6386.648734319657, 6439.710213040518, 6464.773732919513, 6555.246146693001, 5891.293044834647, 5955.880882382415, 5995.580309378476, 6000.369961154016, 6008.24896887889, 4286.528481867054, 4359.869203923888, 4387.8244870204835, 4454.563156239204, 4740.3837501124635, 4570.588647021784, 4577.862664120082, 4606.6314694825005, 4635.629149668086, 4779.354787103835], "value": 4074.8103389255602, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [282.82182225198125, 285.940590113629, 286.9383082637233, 287.5959277215513, 292.0712135409399, 4945.653804233705, 4992.62555308352, 4993.875153121174, 5008.699478031312, 5019.222020586811, 4873.342098816667, 4930.309756634074, 4952.876178095549, 4959.504049595039, 4978.178600530908, 3640.526731524898, 3728.552573691161, 3810.12367155553, 3832.559255685604, 3833.5783063862955, 3817.6373244541724, 3824.388097904336, 3832.865849695261, 3837.9808100959594, 3850.614938506155, 3824.923501529968, 3827.4450204720297, 3827.5981021992707, 3828.8277027533827, 3830.1382189007527, 3555.7510974231814, 3789.7157713171346, 3813.866514672001, 3823.3500304947947, 3835.137094153807, 3263.640999490054, 3273.8035717857006, 3274.705276525124, 3288.490284005983, 3292.785968912037, 4711.717296962193, 4715.0, 4720.693154944952, 4723.905521889543, 4724.244120940633, 4319.200947824631, 4321.7406955582455, 4331.722141968127, 4336.956630433687, 4342.0, 5030.6730062546185, 5128.948710512885, 5138.84583462493, 5155.175171972504, 5160.019596276696, 3612.584552776412, 3616.27674465108, 3624.746267761258, 3625.1299688074937, 3636.9454458182886, 5373.973130134364, 5403.432639572828, 5432.777625034375, 5433.293671822637, 5442.265294185314, 3578.6779189872514, 3649.3613617617343, 3656.652618001339, 3657.6890964267805, 3675.2833197526224, 3686.1337585667347, 3707.9803054159784, 3715.498407714924, 3716.6283371663158, 3717.8141092945243, 4241.257779888507, 4272.145570885836, 4275.444192254987, 4299.871003869889, 4300.505441874162, 5090.220317017217, 5112.36095488064, 5184.766685499161, 5191.650170955579, 5194.701324668833, 1281.6283277849507, 1285.6657269110099, 1301.7201301720177, 1302.9609111726663, 1303.7327347893658, 795.0618270440935, 797.6729540888324, 802.6989878795451, 827.6317038917745, 828.3125006244923, 4412.713173643703, 4517.186906356822, 4526.479454862667, 4543.454785425704, 4551.112533056023, 5342.465753424626, 5352.652077614943, 5356.598255130881, 5363.310557174477, 5383.300170977748, 4419.18245124653, 4496.482904466028, 4533.863984080483, 4562.520935301812, 4570.268756998864, 2792.3019245188702, 2863.5704644303523, 2864.6392963342664, 2869.7130286971137, 2871.4637668847067, 4968.056069346812, 4985.950140498621, 5006.274090256892, 5009.298698182258, 5042.142835717937, 5173.793048278102, 5425.070461950502, 5446.264754258124, 5453.445767956114, 5487.052096505763, 5041.193409054534, 5052.671576347526, 5054.241863720325, 5058.696478211319, 5067.746612669352, 5355.4376790436445, 5361.24942508057, 5363.27595774581, 5365.704886231295, 5388.0, 4930.408350997904, 5218.399884013387, 5249.343832020997, 5250.317458730341, 5259.921101183409, 5041.495850414929, 5045.697258164522, 5046.798128074983, 5049.394072711299, 5054.494550544916, 3713.702903767638, 3716.6956486978247, 3719.8512059517316, 3727.1986522897705, 3728.757630753992, 5163.4578369270685, 5329.173978033411, 5335.905174998414, 5357.946420535744, 5392.325959255093, 5216.217567364925, 5239.29269548606, 5243.0, 5247.685138891678, 5265.60507961912, 5183.896322073462, 5207.947920520746, 5212.270282160424, 5253.973730131325, 5264.684118952875, 4950.183219768842, 5005.599552035901, 5084.186530155157, 5089.720065396439, 5105.566026887756, 4959.70241785494, 5019.899602007867, 5170.870728231674, 5187.559057480156, 5218.373795144607, 4971.676841005323, 5036.0, 5036.445990941067, 5041.546260836542, 5046.697198167974], "value": 3859.6209191090325, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [616.2481772237869, 642.3448082955385, 660.5277226782853, 666.8266250774797, 680.4250408404899, 12183.0, 12374.505019799197, 12657.746845063093, 12686.809697854527, 12930.159539629918, 12076.335801530913, 12135.968442682382, 12228.694282642939, 12398.690032749186, 12528.123031387784, 638.1098367776948, 785.9646315915797, 799.9760007199778, 812.3907069697726, 813.536284317939, 807.9192080791933, 809.4697972827807, 812.2811311988874, 814.5479259011246, 816.1308206759782, 857.438377862501, 858.4205661178711, 860.2601762484289, 861.8621020636699, 865.5888452984844, 844.3540691371106, 849.1720572441882, 849.7833052571555, 850.7787975126449, 851.7742798158492, 615.3815415507431, 617.5985609353955, 617.8115674719209, 618.6195489773756, 619.1177571959939, 12691.175073620278, 12706.745865082647, 12710.936445317715, 12723.491060357575, 12751.234925904475, 13648.522301719393, 13709.383077761524, 13809.723805523934, 13813.930930345385, 14041.64895877601, 10577.259591828575, 10703.678889633324, 10727.195460340428, 10736.24846260762, 10765.90961092708, 3301.603807543086, 3312.3540909522653, 3356.2616224430585, 3378.729701623864, 3467.7745946513646, 61964.0, 62103.0, 66336.0, 66595.3340466594, 66758.33241667521, 9374.109459601326, 9521.809563808685, 9650.758731031781, 9660.37207581505, 9673.806523869483, 17007.574810629834, 17471.213795379237, 17547.64904701899, 17616.735748963776, 17686.170212765897, 6179.907301390483, 6241.7191226394925, 6296.0, 6364.331745166784, 6523.18460192476, 3751.2309976454762, 3759.567649720317, 3815.751976121543, 3819.560750513671, 3828.272628200633, 2966.718161774628, 3014.7437467815043, 3028.727414532703, 3032.5147976324124, 3069.3400918802563, 530.8699368654627, 531.0, 538.2249560632677, 540.767469987909, 548.832606055149, 475.25622400942416, 507.652258203132, 579.6319337220895, 599.9580029397988, 613.2855223664382, 7980.241877021674, 8092.150324215991, 8145.226203510657, 8168.142345053684, 8379.95810020946, 489.40048440660615, 610.3106719878346, 616.7532986805224, 619.9969000154971, 622.4771192198484, 3434.3303055904357, 3718.1819999600043, 3729.4219395993664, 3731.1231860512758, 3782.791946442972, 68334.0, 82122.0, 83687.5815620918, 85018.0, 92625.0, 74694.6265268681, 75703.62148189223, 76348.0, 76735.61632191803, 77206.22793772102, 68916.310836892, 68924.31075689179, 69427.3057269431, 70007.0, 70400.0, 8466.322694184573, 8894.33292503052, 9021.188093071654, 9025.774355641162, 9029.909700902906, 41585.58414415938, 43006.35490467708, 43194.13611727685, 43389.566104338555, 43662.0, 57596.71201643965, 59573.7021314908, 60728.39271607404, 60977.08534372077, 61121.0, 11403.543858245908, 11456.255343402652, 11569.132315076235, 11648.503050397114, 11723.706907327385, 11161.776764464828, 11476.713082173012, 11614.419279035845, 11819.822702659296, 11891.76216475683, 12324.81512777327, 12344.75310493803, 12503.062270329943, 12528.248305101723, 13101.148425352321, 11752.11859110553, 11802.586909458129, 11934.820977685515, 12384.318862462651, 12387.938060309642, 11765.176437649283, 11898.702532436759, 11965.282083075042, 12029.21810082377, 12178.756424871275, 9765.41810423771, 9974.15219706304, 9997.450140242356, 10200.489975501047, 10298.485075746332, 9918.652847150315, 10261.17910567138, 10291.53688084053, 10356.792864142826, 10458.947705261426], "value": 6504.838265207654, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1580.3999999999996, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 107.0, 114.0, 115.0, 113.0, 114.0, 115.0, 115.0, 113.0, 113.0], "value": 113.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 131.0, 167.0, 181.0, 132.0, 162.0, 157.0, 131.0, 194.0, 131.0], "value": 154.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 165.0, 168.0, 173.0, 162.0, 162.0, 162.0, 164.0, 162.0, 162.0], "value": 164.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 75.0, 76.0, 160.0, 75.0, 77.0, 77.0, 76.0, 161.0, 76.0], "value": 93.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 147.0, 88.0, 89.0, 87.0, 131.0, 87.0, 87.0, 135.0], "value": 102.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 121.0, 117.0, 117.0, 118.0, 117.0, 117.0, 117.0, 118.0], "value": 117.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 149.0, 147.0, 148.0, 148.0, 149.0, 148.0, 148.0, 147.0, 150.0], "value": 148.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 97.0, 96.0, 95.0, 96.0, 95.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 63.0, 65.0, 65.0, 65.0, 66.0, 64.0, 63.0, 66.0], "value": 64.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 67.0, 64.0, 65.0, 66.0, 70.0, 65.0, 65.0, 64.0], "value": 65.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 84.0, 84.0, 83.0, 84.0, 85.0, 84.0, 84.0, 108.0, 85.0], "value": 87.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 134.0, 140.0, 136.0, 133.0, 143.0, 139.0, 141.0, 152.0, 135.0], "value": 139.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 166.0, 172.0, 165.0, 169.0, 168.0, 166.0, 169.0, 168.0, 167.0], "value": 167.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 68.0, 67.0, 68.0, 68.0, 65.0, 68.0, 66.0, 67.0, 68.0], "value": 67.5, "unit": "score"}]}]} 23:29:26 INFO - Return code: 0 23:29:26 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 23:29:26 ERROR - # TBPL SUCCESS # 23:29:26 INFO - Running post-action listener: _resource_record_post_action 23:29:26 INFO - ##### 23:29:26 INFO - ##### Finished run-tests step (success) 23:29:26 INFO - ##### 23:29:26 INFO - Running post-run listener: _resource_record_post_run 23:29:27 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 0; Write bytes: 523980800; Read time: 0; Write time: 596940 23:29:27 INFO - TinderboxPrint: CPU usage
13.4% 23:29:27 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 23:29:27 INFO - TinderboxPrint: I/O write bytes / time
523,980,800 / 596,940 23:29:27 INFO - TinderboxPrint: CPU idle
8,267.5 (86.5%) 23:29:27 INFO - TinderboxPrint: CPU user
1,228.1 (12.9%) 23:29:27 INFO - TinderboxPrint: Swap in / out
0 / 0 23:29:27 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 237436928; Read time: 0; Write time: 312000 23:29:27 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 0; Write bytes: 286482432; Read time: 0; Write time: 284924 23:29:27 INFO - Running post-run listener: _upload_blobber_files 23:29:27 INFO - Blob upload gear active. 23:29:27 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 23:29:27 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:29:27 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:29:27 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:29:28 INFO - (blobuploader) - INFO - Open directory for files ... 23:29:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 23:29:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:29:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:29:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 23:29:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:29:29 INFO - (blobuploader) - INFO - Done attempting. 23:29:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 23:29:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:29:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:29:34 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 23:29:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:29:34 INFO - (blobuploader) - INFO - Done attempting. 23:29:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 23:29:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:29:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:29:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 23:29:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:29:35 INFO - (blobuploader) - INFO - Done attempting. 23:29:35 INFO - (blobuploader) - INFO - Iteration through files over. 23:29:35 INFO - Return code: 0 23:29:35 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 23:29:35 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 23:29:35 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0109b5a89f7cff2630ab14b186ec50dade39367449c0503be5769a1264ced8731b895d230b197691b372dcc993529cc488d9e686bf206253f9c48fb0bf497ba6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8426d4582cd44259ad35fd4a8d2dcb4d76b9780a88bbf273d8ef8a2b2d1d0d2149746b91fc8ce73060aea3ab61eb4d63b63a85837d1a69f3e29ee06021b07c8a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f9520d2f1167bf90473db3d9fc9fd9db32a22badfc05207250ba654ae328c7b7c8144417935360c303a6f9899a6a4ed57c8e29c082675f17e02762f3db7cc5d9"} 23:29:35 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 23:29:35 INFO - Writing to file /builds/slave/test/properties/blobber_files 23:29:35 INFO - Contents: 23:29:35 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0109b5a89f7cff2630ab14b186ec50dade39367449c0503be5769a1264ced8731b895d230b197691b372dcc993529cc488d9e686bf206253f9c48fb0bf497ba6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8426d4582cd44259ad35fd4a8d2dcb4d76b9780a88bbf273d8ef8a2b2d1d0d2149746b91fc8ce73060aea3ab61eb4d63b63a85837d1a69f3e29ee06021b07c8a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f9520d2f1167bf90473db3d9fc9fd9db32a22badfc05207250ba654ae328c7b7c8144417935360c303a6f9899a6a4ed57c8e29c082675f17e02762f3db7cc5d9"} 23:29:35 INFO - Running post-run listener: copy_logs_to_upload_dir 23:29:35 INFO - Copying logs to upload dir... 23:29:35 INFO - mkdir: /builds/slave/test/build/upload/logs 23:29:35 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1253.674592 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2016-06-05 23:29:34.485065) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-05 23:29:34.488147) ========= 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=826874ccc97bd7bf541b4875000001d5-1465180425.410960-1540520960 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/0109b5a89f7cff2630ab14b186ec50dade39367449c0503be5769a1264ced8731b895d230b197691b372dcc993529cc488d9e686bf206253f9c48fb0bf497ba6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8426d4582cd44259ad35fd4a8d2dcb4d76b9780a88bbf273d8ef8a2b2d1d0d2149746b91fc8ce73060aea3ab61eb4d63b63a85837d1a69f3e29ee06021b07c8a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f9520d2f1167bf90473db3d9fc9fd9db32a22badfc05207250ba654ae328c7b7c8144417935360c303a6f9899a6a4ed57c8e29c082675f17e02762f3db7cc5d9"} build_url:https://queue.taskcluster.net/v1/task/R6Ysy68PTkG3ZqIWUMsjFw/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011313 build_url: 'https://queue.taskcluster.net/v1/task/R6Ysy68PTkG3ZqIWUMsjFw/artifacts/public/build/firefox-49.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/0109b5a89f7cff2630ab14b186ec50dade39367449c0503be5769a1264ced8731b895d230b197691b372dcc993529cc488d9e686bf206253f9c48fb0bf497ba6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8426d4582cd44259ad35fd4a8d2dcb4d76b9780a88bbf273d8ef8a2b2d1d0d2149746b91fc8ce73060aea3ab61eb4d63b63a85837d1a69f3e29ee06021b07c8a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f9520d2f1167bf90473db3d9fc9fd9db32a22badfc05207250ba654ae328c7b7c8144417935360c303a6f9899a6a4ed57c8e29c082675f17e02762f3db7cc5d9"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-05 23:29:34.517622) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-05 23:29:34.517997) ========= 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=826874ccc97bd7bf541b4875000001d5-1465180425.410960-1540520960 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004501 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-05 23:29:34.603590) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-05 23:29:34.603955) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-05 23:29:34.604268) ========= ========= Total master_lag: 0.19 =========