builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-043 starttime: 1467122460.53 results: success (0) buildid: 20160628062322 builduid: 6cc9b03a7e534f37a2fd7d6b98419215 revision: 9676dc9d8b43a5de17ebd0baedfbfd42826dc312 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-28 07:01:00.532759) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-28 07:01:00.533285) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-28 07:01:00.533631) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-28 07:01:00.566537) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 07:01:00.566868) ========= 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=d2a8c569965ab8367867b893000001a1-1467122374.804559-1305311035 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-28 07:01:00-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 228M=0s 2016-06-28 07:01:00 (228 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.120196 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 07:01:00.740117) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 07:01:00.740525) ========= 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=d2a8c569965ab8367867b893000001a1-1467122374.804559-1305311035 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013958 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 07:01:00.790767) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-28 07:01:00.791156) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 9676dc9d8b43a5de17ebd0baedfbfd42826dc312 --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 9676dc9d8b43a5de17ebd0baedfbfd42826dc312 --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=d2a8c569965ab8367867b893000001a1-1467122374.804559-1305311035 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-28 07:01:00,859 truncating revision to first 12 chars 2016-06-28 07:01:00,859 Setting DEBUG logging. 2016-06-28 07:01:00,859 attempt 1/10 2016-06-28 07:01:00,860 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/9676dc9d8b43?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-28 07:01:01,971 unpacking tar archive at: fx-team-9676dc9d8b43/testing/mozharness/ program finished with exit code 0 elapsedTime=1.503967 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-28 07:01:02.312391) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-28 07:01:02.312787) ========= script_repo_revision: 9676dc9d8b43a5de17ebd0baedfbfd42826dc312 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-28 07:01:02.313247) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-28 07:01:02.313577) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-28 07:01:02.324643) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-06-28 07:01:02.324969) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=d2a8c569965ab8367867b893000001a1-1467122374.804559-1305311035 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:01:02 INFO - MultiFileLogger online at 20160628 07:01:02 in /builds/slave/test 07:01:02 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 07:01:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:01:02 INFO - {'append_to_log': False, 07:01:02 INFO - 'base_work_dir': '/builds/slave/test', 07:01:02 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 07:01:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:01:02 INFO - 'branch': 'Fx-Team-Non-PGO', 07:01:02 INFO - 'buildbot_json_path': 'buildprops.json', 07:01:02 INFO - 'config_files': ('talos/linux_config.py',), 07:01:02 INFO - 'default_actions': ('clobber', 07:01:02 INFO - 'read-buildbot-config', 07:01:02 INFO - 'download-and-extract', 07:01:02 INFO - 'populate-webroot', 07:01:02 INFO - 'create-virtualenv', 07:01:02 INFO - 'install', 07:01:02 INFO - 'run-tests'), 07:01:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:01:02 INFO - 'download_minidump_stackwalk': True, 07:01:02 INFO - 'download_symbols': 'ondemand', 07:01:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:01:02 INFO - 'tooltool.py': '/tools/tooltool.py', 07:01:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:01:02 INFO - '/tools/misc-python/virtualenv.py')}, 07:01:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:01:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:01:02 INFO - 'installer_path': 'installer.exe', 07:01:02 INFO - 'log_level': 'info', 07:01:02 INFO - 'log_name': 'talos', 07:01:02 INFO - 'log_to_console': True, 07:01:02 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:01:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:01:02 INFO - 'opt_config_files': (), 07:01:02 INFO - 'pip_index': False, 07:01:02 INFO - 'sps_profile': False, 07:01:02 INFO - 'sps_profile_interval': 0, 07:01:02 INFO - 'suite': 'dromaeojs', 07:01:02 INFO - 'system_bits': '32', 07:01:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:01:02 INFO - 'title': 'talos-linux64-ix-043', 07:01:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:01:02 INFO - 'use_talos_json': True, 07:01:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:01:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:01:02 INFO - 'work_dir': 'build'} 07:01:02 INFO - ##### 07:01:02 INFO - ##### Running clobber step. 07:01:02 INFO - ##### 07:01:02 INFO - Running pre-action listener: _resource_record_pre_action 07:01:02 INFO - Running main action method: clobber 07:01:02 INFO - rmtree: /builds/slave/test/build 07:01:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:01:03 INFO - Running post-action listener: _resource_record_post_action 07:01:03 INFO - ##### 07:01:03 INFO - ##### Finished clobber step (success) 07:01:03 INFO - ##### 07:01:03 INFO - ##### 07:01:03 INFO - ##### Running read-buildbot-config step. 07:01:03 INFO - ##### 07:01:03 INFO - Running pre-action listener: _resource_record_pre_action 07:01:03 INFO - Running main action method: read_buildbot_config 07:01:03 INFO - Using buildbot properties: 07:01:03 INFO - { 07:01:03 INFO - "project": "", 07:01:03 INFO - "product": "firefox", 07:01:03 INFO - "script_repo_revision": "production", 07:01:03 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 07:01:03 INFO - "repository": "", 07:01:03 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 07:01:03 INFO - "buildid": "20160628062322", 07:01:03 INFO - "pgo_build": "False", 07:01:03 INFO - "basedir": "/builds/slave/test", 07:01:03 INFO - "buildnumber": 1891, 07:01:03 INFO - "slavename": "talos-linux64-ix-043", 07:01:03 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 07:01:03 INFO - "platform": "ubuntu64_hw", 07:01:03 INFO - "scheduler": "tests-fx-team-linux64-talos", 07:01:03 INFO - "branch": "fx-team", 07:01:03 INFO - "repo_path": "integration/fx-team", 07:01:03 INFO - "revision": "9676dc9d8b43a5de17ebd0baedfbfd42826dc312", 07:01:03 INFO - "stage_platform": "linux64", 07:01:03 INFO - "builduid": "6cc9b03a7e534f37a2fd7d6b98419215", 07:01:03 INFO - "slavebuilddir": "test" 07:01:03 INFO - } 07:01:03 INFO - Found installer url https://queue.taskcluster.net/v1/task/NtsGEXtBSv2NMlHQzSzEVQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 07:01:03 INFO - Running post-action listener: _resource_record_post_action 07:01:03 INFO - ##### 07:01:03 INFO - ##### Finished read-buildbot-config step (success) 07:01:03 INFO - ##### 07:01:03 INFO - ##### 07:01:03 INFO - ##### Running download-and-extract step. 07:01:03 INFO - ##### 07:01:03 INFO - Running pre-action listener: _resource_record_pre_action 07:01:03 INFO - Running main action method: download_and_extract 07:01:03 INFO - mkdir: /builds/slave/test/build/tests 07:01:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:01:03 INFO - https://queue.taskcluster.net/v1/task/NtsGEXtBSv2NMlHQzSzEVQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 07:01:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NtsGEXtBSv2NMlHQzSzEVQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:01:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NtsGEXtBSv2NMlHQzSzEVQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:01:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NtsGEXtBSv2NMlHQzSzEVQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:01:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NtsGEXtBSv2NMlHQzSzEVQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 07:01:04 INFO - Downloaded 1361 bytes. 07:01:04 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:01:04 INFO - Using the following test package requirements: 07:01:04 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 07:01:04 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:01:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:01:04 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:01:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:01:04 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:01:04 INFO - u'jsshell-linux-x86_64.zip'], 07:01:04 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:01:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:01:04 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 07:01:04 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:01:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:01:04 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:01:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:01:04 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:01:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:01:04 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:01:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:01:04 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:01:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:01:04 INFO - https://queue.taskcluster.net/v1/task/NtsGEXtBSv2NMlHQzSzEVQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:01:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NtsGEXtBSv2NMlHQzSzEVQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:01:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NtsGEXtBSv2NMlHQzSzEVQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:01:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NtsGEXtBSv2NMlHQzSzEVQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:01:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NtsGEXtBSv2NMlHQzSzEVQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:01:05 INFO - Downloaded 22713365 bytes. 07:01:05 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:01:05 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 07:01:07 INFO - Return code: 0 07:01:07 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 07:01: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')]} 07:01:07 INFO - https://queue.taskcluster.net/v1/task/NtsGEXtBSv2NMlHQzSzEVQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:01:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NtsGEXtBSv2NMlHQzSzEVQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:01:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NtsGEXtBSv2NMlHQzSzEVQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:01:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NtsGEXtBSv2NMlHQzSzEVQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:01:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NtsGEXtBSv2NMlHQzSzEVQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:01:08 INFO - Downloaded 22713365 bytes. 07:01:08 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:01:08 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 07:01:10 INFO - Return code: 0 07:01: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')]} 07:01:10 INFO - https://queue.taskcluster.net/v1/task/NtsGEXtBSv2NMlHQzSzEVQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:01:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NtsGEXtBSv2NMlHQzSzEVQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 07:01:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NtsGEXtBSv2NMlHQzSzEVQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 07:01:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NtsGEXtBSv2NMlHQzSzEVQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 07:01:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NtsGEXtBSv2NMlHQzSzEVQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 07:01:11 INFO - Downloaded 14405245 bytes. 07:01:11 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:01:11 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 07:01:12 INFO - Return code: 0 07:01: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')]} 07:01:12 INFO - https://queue.taskcluster.net/v1/task/NtsGEXtBSv2NMlHQzSzEVQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:01:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NtsGEXtBSv2NMlHQzSzEVQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:01:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NtsGEXtBSv2NMlHQzSzEVQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:01:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NtsGEXtBSv2NMlHQzSzEVQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:01:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NtsGEXtBSv2NMlHQzSzEVQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 07:01:40 INFO - Downloaded 56400725 bytes. 07:01:40 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NtsGEXtBSv2NMlHQzSzEVQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:01:40 INFO - mkdir: /builds/slave/test/properties 07:01:40 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:01:40 INFO - Writing to file /builds/slave/test/properties/build_url 07:01:40 INFO - Contents: 07:01:40 INFO - build_url:https://queue.taskcluster.net/v1/task/NtsGEXtBSv2NMlHQzSzEVQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:01:40 INFO - Running post-action listener: _resource_record_post_action 07:01:40 INFO - Running post-action listener: set_extra_try_arguments 07:01:40 INFO - ##### 07:01:40 INFO - ##### Finished download-and-extract step (success) 07:01:40 INFO - ##### 07:01:40 INFO - ##### 07:01:40 INFO - ##### Running populate-webroot step. 07:01:40 INFO - ##### 07:01:40 INFO - Running pre-action listener: _resource_record_pre_action 07:01:40 INFO - Running main action method: populate_webroot 07:01:40 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:01:40 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:01:40 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:01:40 INFO - '--tppagecycles', 07:01:40 INFO - '7'], 07:01:40 INFO - 'tests': ['tsvgm']}}, 07:01:40 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:01:40 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:01:40 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:01:40 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:01:40 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:01:40 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:01:40 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:01:40 INFO - 'talos_options': ['--disable-e10s'], 07:01:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:01:40 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:01:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:01:40 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:01:40 INFO - 'talos_options': ['--disable-e10s'], 07:01:40 INFO - 'tests': ['damp', 'tps']}, 07:01:40 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:01:40 INFO - 'tests': ['damp', 'tps']}, 07:01:40 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:01:40 INFO - 'tests': ['dromaeo_dom']}, 07:01:40 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:01:40 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:01:40 INFO - 'tests': ['basic_compositor_video']}, 07:01:40 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:01:40 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:01:40 INFO - 'tests': ['a11yr', 07:01:40 INFO - 'ts_paint', 07:01:40 INFO - 'tpaint', 07:01:40 INFO - 'sessionrestore', 07:01:40 INFO - 'sessionrestore_no_auto_restore', 07:01:40 INFO - 'tabpaint']}, 07:01:40 INFO - 'other-e10s': {'tests': ['a11yr', 07:01:40 INFO - 'ts_paint', 07:01:40 INFO - 'tpaint', 07:01:40 INFO - 'sessionrestore', 07:01:40 INFO - 'sessionrestore_no_auto_restore', 07:01:40 INFO - 'tabpaint']}, 07:01:40 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:01:40 INFO - 'ts_paint', 07:01:40 INFO - 'tpaint', 07:01:40 INFO - 'sessionrestore', 07:01:40 INFO - 'sessionrestore_no_auto_restore', 07:01:40 INFO - 'tabpaint']}, 07:01:40 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:01:40 INFO - 'ts_paint', 07:01:40 INFO - 'tpaint', 07:01:40 INFO - 'sessionrestore', 07:01:40 INFO - 'sessionrestore_no_auto_restore', 07:01:40 INFO - 'tabpaint']}, 07:01:40 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:01:40 INFO - 'tests': ['a11yr', 07:01:40 INFO - 'ts_paint', 07:01:40 INFO - 'tpaint', 07:01:40 INFO - 'sessionrestore', 07:01:40 INFO - 'sessionrestore_no_auto_restore', 07:01:40 INFO - 'tabpaint']}, 07:01:40 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:01:40 INFO - 'tests': ['a11yr', 07:01:40 INFO - 'ts_paint', 07:01:40 INFO - 'tpaint', 07:01:40 INFO - 'sessionrestore', 07:01:40 INFO - 'sessionrestore_no_auto_restore', 07:01:40 INFO - 'tabpaint']}, 07:01:40 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:01:40 INFO - 'tests': ['tsvgx', 07:01:40 INFO - 'tsvgr_opacity', 07:01:40 INFO - 'tart', 07:01:40 INFO - 'tscrollx', 07:01:40 INFO - 'cart']}, 07:01:40 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:01:40 INFO - 'tsvgr_opacity', 07:01:40 INFO - 'tart', 07:01:40 INFO - 'tscrollx', 07:01:40 INFO - 'cart']}, 07:01:40 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:01:40 INFO - 'talos_options': ['--disable-e10s'], 07:01:40 INFO - 'tests': ['tp5o']}, 07:01:40 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:01:40 INFO - 'tests': ['tp5o']}, 07:01:40 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:01:40 INFO - 'talos_options': ['--disable-e10s', 07:01:40 INFO - '--xperf_path', 07:01:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:01:40 INFO - 'tests': ['tp5n']}, 07:01:40 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:01:40 INFO - 'talos_options': ['--xperf_path', 07:01:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:01:40 INFO - 'tests': ['tp5n']}}, 07:01:40 INFO - 'talos.zip': {'path': '', 07:01:40 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:01:40 INFO - Running post-action listener: _resource_record_post_action 07:01:40 INFO - ##### 07:01:40 INFO - ##### Finished populate-webroot step (success) 07:01:40 INFO - ##### 07:01:40 INFO - ##### 07:01:40 INFO - ##### Running create-virtualenv step. 07:01:40 INFO - ##### 07:01:40 INFO - Running pre-action listener: _resource_record_pre_action 07:01:40 INFO - Running main action method: create_virtualenv 07:01:40 INFO - Creating virtualenv /builds/slave/test/build/venv 07:01:40 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 07:01:40 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:01:40 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:01:40 INFO - Using real prefix '/usr' 07:01:40 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:01:41 INFO - Installing distribute.............................................................................................................................................................................................done. 07:01:43 INFO - Installing pip.................done. 07:01:43 INFO - Return code: 0 07:01:43 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:01:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:01:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:01:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:01:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:01:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:01:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:01:43 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 0x7f9c5c17ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16037d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1692520>, '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 0x1693420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16938b0>, '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': 'd2a8c569965ab8367867b893000001a1-1467122374.804559-1305311035', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:01:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 07:01:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 07:01:43 INFO - Using env: {'DISPLAY': ':0', 07:01:43 INFO - 'HOME': '/home/cltbld', 07:01:43 INFO - 'LANG': 'en_US.UTF-8', 07:01:43 INFO - 'LANGUAGE': 'en_US:en', 07:01:43 INFO - 'LOGNAME': 'cltbld', 07:01:43 INFO - 'MAIL': '/var/mail/cltbld', 07:01:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:01:43 INFO - 'MOZ_NO_REMOTE': '1', 07:01:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:01:43 INFO - 'NO_EM_RESTART': '1', 07:01:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:01:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:01:43 INFO - 'PWD': '/builds/slave/test', 07:01:43 INFO - 'SHELL': '/bin/bash', 07:01:43 INFO - 'SHLVL': '1', 07:01:43 INFO - 'TERM': 'linux', 07:01:43 INFO - 'TMOUT': '86400', 07:01:43 INFO - 'USER': 'cltbld', 07:01:43 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1467122374.804559-1305311035', 07:01:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:01:43 INFO - '_': '/tools/buildbot/bin/python'} 07:01:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:01:43 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 07:01:43 INFO - Cleaning up... 07:01:43 INFO - Return code: 0 07:01:43 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:01:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:01:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:01:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:01:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:01:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:01:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:01:43 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 0x7f9c5c17ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16037d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1692520>, '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 0x1693420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16938b0>, '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': 'd2a8c569965ab8367867b893000001a1-1467122374.804559-1305311035', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:01:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 07:01:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 07:01:43 INFO - Using env: {'DISPLAY': ':0', 07:01:43 INFO - 'HOME': '/home/cltbld', 07:01:43 INFO - 'LANG': 'en_US.UTF-8', 07:01:43 INFO - 'LANGUAGE': 'en_US:en', 07:01:43 INFO - 'LOGNAME': 'cltbld', 07:01:43 INFO - 'MAIL': '/var/mail/cltbld', 07:01:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:01:43 INFO - 'MOZ_NO_REMOTE': '1', 07:01:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:01:43 INFO - 'NO_EM_RESTART': '1', 07:01:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:01:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:01:43 INFO - 'PWD': '/builds/slave/test', 07:01:43 INFO - 'SHELL': '/bin/bash', 07:01:43 INFO - 'SHLVL': '1', 07:01:43 INFO - 'TERM': 'linux', 07:01:43 INFO - 'TMOUT': '86400', 07:01:43 INFO - 'USER': 'cltbld', 07:01:43 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1467122374.804559-1305311035', 07:01:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:01:43 INFO - '_': '/tools/buildbot/bin/python'} 07:01:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:01:44 INFO - Downloading/unpacking psutil>=3.1.1 07:01:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:01:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:01:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:01:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:01:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:01:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:01:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:01:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:01:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:01:46 INFO - Installing collected packages: psutil 07:01:46 INFO - Running setup.py install for psutil 07:01:46 INFO - building 'psutil._psutil_linux' extension 07:01:46 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 07:01:47 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 07:01:47 INFO - building 'psutil._psutil_posix' extension 07:01:47 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 07:01:47 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 07:01:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:01:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:01:47 INFO - Successfully installed psutil 07:01:47 INFO - Cleaning up... 07:01:47 INFO - Return code: 0 07:01:47 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:01:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:01:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:01:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:01:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:01:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:01:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:01:47 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 0x7f9c5c17ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16037d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1692520>, '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 0x1693420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16938b0>, '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': 'd2a8c569965ab8367867b893000001a1-1467122374.804559-1305311035', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:01:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 07:01:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 07:01:47 INFO - Using env: {'DISPLAY': ':0', 07:01:47 INFO - 'HOME': '/home/cltbld', 07:01:47 INFO - 'LANG': 'en_US.UTF-8', 07:01:47 INFO - 'LANGUAGE': 'en_US:en', 07:01:47 INFO - 'LOGNAME': 'cltbld', 07:01:47 INFO - 'MAIL': '/var/mail/cltbld', 07:01:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:01:47 INFO - 'MOZ_NO_REMOTE': '1', 07:01:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:01:47 INFO - 'NO_EM_RESTART': '1', 07:01:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:01:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:01:47 INFO - 'PWD': '/builds/slave/test', 07:01:47 INFO - 'SHELL': '/bin/bash', 07:01:47 INFO - 'SHLVL': '1', 07:01:47 INFO - 'TERM': 'linux', 07:01:47 INFO - 'TMOUT': '86400', 07:01:47 INFO - 'USER': 'cltbld', 07:01:47 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1467122374.804559-1305311035', 07:01:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:01:47 INFO - '_': '/tools/buildbot/bin/python'} 07:01:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:01:47 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:01:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:01:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:01:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:01:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:01:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:01:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:01:49 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:01:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:01:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:01:49 INFO - Installing collected packages: mozsystemmonitor 07:01:49 INFO - Running setup.py install for mozsystemmonitor 07:01:49 INFO - Successfully installed mozsystemmonitor 07:01:49 INFO - Cleaning up... 07:01:49 INFO - Return code: 0 07:01:49 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:01: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')]} 07:01:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:01:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:01: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')]} 07:01:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:01:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:01:49 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 0x7f9c5c17ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16037d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1692520>, '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 0x1693420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16938b0>, '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': 'd2a8c569965ab8367867b893000001a1-1467122374.804559-1305311035', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:01:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 07:01:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 07:01:49 INFO - Using env: {'DISPLAY': ':0', 07:01:49 INFO - 'HOME': '/home/cltbld', 07:01:49 INFO - 'LANG': 'en_US.UTF-8', 07:01:49 INFO - 'LANGUAGE': 'en_US:en', 07:01:49 INFO - 'LOGNAME': 'cltbld', 07:01:49 INFO - 'MAIL': '/var/mail/cltbld', 07:01:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:01:49 INFO - 'MOZ_NO_REMOTE': '1', 07:01:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:01:49 INFO - 'NO_EM_RESTART': '1', 07:01:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:01:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:01:49 INFO - 'PWD': '/builds/slave/test', 07:01:49 INFO - 'SHELL': '/bin/bash', 07:01:49 INFO - 'SHLVL': '1', 07:01:49 INFO - 'TERM': 'linux', 07:01:49 INFO - 'TMOUT': '86400', 07:01:49 INFO - 'USER': 'cltbld', 07:01:49 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1467122374.804559-1305311035', 07:01:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:01:49 INFO - '_': '/tools/buildbot/bin/python'} 07:01:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:01:49 INFO - Downloading/unpacking jsonschema==2.5.1 07:01:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:01:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:01:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:01:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:01:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:01:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:01:51 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:01:51 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:01:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:01:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:01:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:01:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:01:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:01:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:01:52 INFO - Downloading functools32-3.2.3-2.tar.gz 07:01:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:01:52 INFO - warning: no files found matching '*.txt' 07:01:52 INFO - no previously-included directories found matching 'build' 07:01:52 INFO - no previously-included directories found matching 'dist' 07:01:52 INFO - no previously-included directories found matching '.git*' 07:01:52 INFO - Installing collected packages: jsonschema, functools32 07:01:52 INFO - Running setup.py install for functools32 07:01:52 INFO - warning: no files found matching '*.txt' 07:01:52 INFO - no previously-included directories found matching 'build' 07:01:52 INFO - no previously-included directories found matching 'dist' 07:01:52 INFO - no previously-included directories found matching '.git*' 07:01:52 INFO - Successfully installed jsonschema functools32 07:01:52 INFO - Cleaning up... 07:01:52 INFO - Return code: 0 07:01:52 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:01:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:01:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:01:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:01:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:01:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:01:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:01:52 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 0x7f9c5c17ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16037d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1692520>, '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 0x1693420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16938b0>, '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': 'd2a8c569965ab8367867b893000001a1-1467122374.804559-1305311035', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:01:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:01:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:01:52 INFO - Using env: {'DISPLAY': ':0', 07:01:52 INFO - 'HOME': '/home/cltbld', 07:01:52 INFO - 'LANG': 'en_US.UTF-8', 07:01:52 INFO - 'LANGUAGE': 'en_US:en', 07:01:52 INFO - 'LOGNAME': 'cltbld', 07:01:52 INFO - 'MAIL': '/var/mail/cltbld', 07:01:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:01:52 INFO - 'MOZ_NO_REMOTE': '1', 07:01:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:01:52 INFO - 'NO_EM_RESTART': '1', 07:01:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:01:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:01:52 INFO - 'PWD': '/builds/slave/test', 07:01:52 INFO - 'SHELL': '/bin/bash', 07:01:52 INFO - 'SHLVL': '1', 07:01:52 INFO - 'TERM': 'linux', 07:01:52 INFO - 'TMOUT': '86400', 07:01:52 INFO - 'USER': 'cltbld', 07:01:52 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1467122374.804559-1305311035', 07:01:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:01:52 INFO - '_': '/tools/buildbot/bin/python'} 07:01:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:01:52 INFO - Downloading/unpacking blobuploader==1.2.4 07:01:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:01:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:01:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:01:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:01:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:01:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:01:54 INFO - Downloading blobuploader-1.2.4.tar.gz 07:01:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:01:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:01:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:01:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:01:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:01:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:01:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:01:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:01:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:01:54 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:01:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:01:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:01:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:01:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:01:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:01:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:01:55 INFO - Downloading docopt-0.6.1.tar.gz 07:01:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:01:55 INFO - Installing collected packages: blobuploader, requests, docopt 07:01:55 INFO - Running setup.py install for blobuploader 07:01:55 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:01:55 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:01:55 INFO - Running setup.py install for requests 07:01:55 INFO - Running setup.py install for docopt 07:01:55 INFO - Successfully installed blobuploader requests docopt 07:01:55 INFO - Cleaning up... 07:01:55 INFO - Return code: 0 07:01:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:01: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')]} 07:01:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:01:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:01: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')]} 07:01:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:01:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:01:55 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 0x7f9c5c17ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16037d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1692520>, '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 0x1693420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16938b0>, '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': 'd2a8c569965ab8367867b893000001a1-1467122374.804559-1305311035', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:01:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:01:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:01:55 INFO - Using env: {'DISPLAY': ':0', 07:01:55 INFO - 'HOME': '/home/cltbld', 07:01:55 INFO - 'LANG': 'en_US.UTF-8', 07:01:55 INFO - 'LANGUAGE': 'en_US:en', 07:01:55 INFO - 'LOGNAME': 'cltbld', 07:01:55 INFO - 'MAIL': '/var/mail/cltbld', 07:01:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:01:55 INFO - 'MOZ_NO_REMOTE': '1', 07:01:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:01:55 INFO - 'NO_EM_RESTART': '1', 07:01:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:01:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:01:55 INFO - 'PWD': '/builds/slave/test', 07:01:55 INFO - 'SHELL': '/bin/bash', 07:01:55 INFO - 'SHLVL': '1', 07:01:55 INFO - 'TERM': 'linux', 07:01:55 INFO - 'TMOUT': '86400', 07:01:55 INFO - 'USER': 'cltbld', 07:01:55 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1467122374.804559-1305311035', 07:01:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:01:55 INFO - '_': '/tools/buildbot/bin/python'} 07:01:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:01:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:01:55 INFO - Running setup.py (path:/tmp/pip-b4K7Qh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:01:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:01:56 INFO - Running setup.py (path:/tmp/pip-pakK2L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:01:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:01:56 INFO - Running setup.py (path:/tmp/pip-FDUniT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:01:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:01:56 INFO - Running setup.py (path:/tmp/pip-o3RBwO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:01:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:01:56 INFO - Running setup.py (path:/tmp/pip-j4DM0B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:01:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:01:56 INFO - Running setup.py (path:/tmp/pip-ad1V4J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:01:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:01:56 INFO - Running setup.py (path:/tmp/pip-P5Cx5P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:01:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:01:56 INFO - Running setup.py (path:/tmp/pip-PmOpAI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:01:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:01:56 INFO - Running setup.py (path:/tmp/pip-JaxdZ4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:01:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:01:56 INFO - Running setup.py (path:/tmp/pip-Arjp_Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:01:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:01:56 INFO - Running setup.py (path:/tmp/pip-iGAmR9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:01:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:01:56 INFO - Running setup.py (path:/tmp/pip-CxocW0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:01:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:01:56 INFO - Running setup.py (path:/tmp/pip-rIuStO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:01:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:01:56 INFO - Running setup.py (path:/tmp/pip-XKLaav-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:01:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:01:56 INFO - Running setup.py (path:/tmp/pip-f6q8b9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:01:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:01:57 INFO - Running setup.py (path:/tmp/pip-EOkRPt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:01:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:01:57 INFO - Running setup.py (path:/tmp/pip-ZZKBmJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:01:57 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:01:57 INFO - Running setup.py install for manifestparser 07:01:57 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:01:57 INFO - Running setup.py install for mozcrash 07:01:57 INFO - Running setup.py install for mozdebug 07:01:57 INFO - Running setup.py install for mozdevice 07:01:57 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:01:57 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:01:57 INFO - Running setup.py install for mozfile 07:01:57 INFO - Running setup.py install for mozhttpd 07:01:57 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:01:57 INFO - Running setup.py install for mozinfo 07:01:57 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:01:57 INFO - Running setup.py install for mozInstall 07:01:57 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:01:57 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:01:57 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:01:57 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:01:57 INFO - Running setup.py install for mozleak 07:01:58 INFO - Running setup.py install for mozlog 07:01:58 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:01:58 INFO - Running setup.py install for moznetwork 07:01:58 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:01:58 INFO - Running setup.py install for mozprocess 07:01:58 INFO - Running setup.py install for mozprofile 07:01:58 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:01:58 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:01:58 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:01:58 INFO - Running setup.py install for mozrunner 07:01:58 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:01:58 INFO - Running setup.py install for mozscreenshot 07:01:58 INFO - Running setup.py install for moztest 07:01:58 INFO - Running setup.py install for mozversion 07:01:58 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:01:58 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:01:58 INFO - Cleaning up... 07:01:58 INFO - Return code: 0 07:01:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:01:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:01:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:01:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:01:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:01:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:01:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:01:58 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 0x7f9c5c17ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16037d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1692520>, '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 0x1693420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16938b0>, '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': 'd2a8c569965ab8367867b893000001a1-1467122374.804559-1305311035', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:01:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:01:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:01:58 INFO - Using env: {'DISPLAY': ':0', 07:01:58 INFO - 'HOME': '/home/cltbld', 07:01:58 INFO - 'LANG': 'en_US.UTF-8', 07:01:58 INFO - 'LANGUAGE': 'en_US:en', 07:01:58 INFO - 'LOGNAME': 'cltbld', 07:01:58 INFO - 'MAIL': '/var/mail/cltbld', 07:01:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:01:58 INFO - 'MOZ_NO_REMOTE': '1', 07:01:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:01:58 INFO - 'NO_EM_RESTART': '1', 07:01:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:01:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:01:58 INFO - 'PWD': '/builds/slave/test', 07:01:58 INFO - 'SHELL': '/bin/bash', 07:01:58 INFO - 'SHLVL': '1', 07:01:58 INFO - 'TERM': 'linux', 07:01:58 INFO - 'TMOUT': '86400', 07:01:58 INFO - 'USER': 'cltbld', 07:01:58 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1467122374.804559-1305311035', 07:01:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:01:58 INFO - '_': '/tools/buildbot/bin/python'} 07:01:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:01:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:01:59 INFO - Running setup.py (path:/tmp/pip-u_269t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:01:59 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 07:01:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:01:59 INFO - Running setup.py (path:/tmp/pip-Q18ppr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:01:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:01:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:01:59 INFO - Running setup.py (path:/tmp/pip-SFoqwJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:01:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:01:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:01:59 INFO - Running setup.py (path:/tmp/pip-DU2rye-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:01:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:01:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:01:59 INFO - Running setup.py (path:/tmp/pip-SW2VwE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:01:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 07:01:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:01:59 INFO - Running setup.py (path:/tmp/pip-_TBfGS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:01:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 07:01:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:01:59 INFO - Running setup.py (path:/tmp/pip-M1SwCT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:01:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 07:01:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:01:59 INFO - Running setup.py (path:/tmp/pip-jvAXxt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:01:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 07:01:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:01:59 INFO - Running setup.py (path:/tmp/pip-w6wl9x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:01:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 07:01:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:01:59 INFO - Running setup.py (path:/tmp/pip-RJFodo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:01:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:01:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:01:59 INFO - Running setup.py (path:/tmp/pip-rKYeik-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:01:59 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 07:01:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:01:59 INFO - Running setup.py (path:/tmp/pip-mMUlDZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:02:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 07:02:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:02:00 INFO - Running setup.py (path:/tmp/pip-bAmszH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:02:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 07:02:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:02:00 INFO - Running setup.py (path:/tmp/pip-5Y0U7j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:02:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 07:02:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:02:00 INFO - Running setup.py (path:/tmp/pip-rnQ8HC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:02:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 07:02:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:02:00 INFO - Running setup.py (path:/tmp/pip-uj9_vn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:02:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 07:02:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:02:00 INFO - Running setup.py (path:/tmp/pip-mriO4y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:02:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 07:02:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:02:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:02:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:02:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:02:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:02:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:02:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:02:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:02:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:02:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:02:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:02:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:02:02 INFO - Downloading blessings-1.6.tar.gz 07:02:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:02:02 INFO - Installing collected packages: blessings 07:02:02 INFO - Running setup.py install for blessings 07:02:02 INFO - Successfully installed blessings 07:02:02 INFO - Cleaning up... 07:02:02 INFO - Return code: 0 07:02:02 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:02:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:02:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:02:02 INFO - Reading from file tmpfile_stdout 07:02:02 INFO - Current package versions: 07:02:02 INFO - argparse == 1.2.1 07:02:02 INFO - blessings == 1.6 07:02:02 INFO - blobuploader == 1.2.4 07:02:02 INFO - docopt == 0.6.1 07:02:02 INFO - functools32 == 3.2.3-2 07:02:02 INFO - jsonschema == 2.5.1 07:02:02 INFO - manifestparser == 1.1 07:02:02 INFO - mozInstall == 1.12 07:02:02 INFO - mozcrash == 0.17 07:02:02 INFO - mozdebug == 0.1 07:02:02 INFO - mozdevice == 0.48 07:02:02 INFO - mozfile == 1.2 07:02:02 INFO - mozhttpd == 0.7 07:02:02 INFO - mozinfo == 0.9 07:02:02 INFO - mozleak == 0.1 07:02:02 INFO - mozlog == 3.2 07:02:02 INFO - moznetwork == 0.27 07:02:02 INFO - mozprocess == 0.22 07:02:02 INFO - mozprofile == 0.28 07:02:02 INFO - mozrunner == 6.11 07:02:02 INFO - mozscreenshot == 0.1 07:02:02 INFO - mozsystemmonitor == 0.3 07:02:02 INFO - moztest == 0.7 07:02:02 INFO - mozversion == 1.4 07:02:02 INFO - psutil == 3.1.1 07:02:02 INFO - requests == 1.2.3 07:02:02 INFO - wsgiref == 0.1.2 07:02:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:02: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')]} 07:02:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:02:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:02: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')]} 07:02:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:02:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:02:02 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 0x7f9c5c17ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16037d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1692520>, '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 0x1693420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16938b0>, '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': 'd2a8c569965ab8367867b893000001a1-1467122374.804559-1305311035', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:02:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 07:02:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:02:02 INFO - Using env: {'DISPLAY': ':0', 07:02:02 INFO - 'HOME': '/home/cltbld', 07:02:02 INFO - 'LANG': 'en_US.UTF-8', 07:02:02 INFO - 'LANGUAGE': 'en_US:en', 07:02:02 INFO - 'LOGNAME': 'cltbld', 07:02:02 INFO - 'MAIL': '/var/mail/cltbld', 07:02:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:02:02 INFO - 'MOZ_NO_REMOTE': '1', 07:02:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:02:02 INFO - 'NO_EM_RESTART': '1', 07:02:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:02:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:02:02 INFO - 'PWD': '/builds/slave/test', 07:02:02 INFO - 'SHELL': '/bin/bash', 07:02:02 INFO - 'SHLVL': '1', 07:02:02 INFO - 'TERM': 'linux', 07:02:02 INFO - 'TMOUT': '86400', 07:02:02 INFO - 'USER': 'cltbld', 07:02:02 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1467122374.804559-1305311035', 07:02:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:02:02 INFO - '_': '/tools/buildbot/bin/python'} 07:02:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:02:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:02:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 07:02:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 07:02:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:02:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 07:02:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 07:02:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 07:02:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 07:02:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 07:02:02 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:02:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:02:02 INFO - Cleaning up... 07:02:02 INFO - Return code: 0 07:02:02 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:02: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')]} 07:02:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:02:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:02: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')]} 07:02:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:02:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:02:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9c5c17ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16037d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1692520>, '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 0x1693420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16938b0>, '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': 'd2a8c569965ab8367867b893000001a1-1467122374.804559-1305311035', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:02:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 07:02:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 07:02:03 INFO - Using env: {'DISPLAY': ':0', 07:02:03 INFO - 'HOME': '/home/cltbld', 07:02:03 INFO - 'LANG': 'en_US.UTF-8', 07:02:03 INFO - 'LANGUAGE': 'en_US:en', 07:02:03 INFO - 'LOGNAME': 'cltbld', 07:02:03 INFO - 'MAIL': '/var/mail/cltbld', 07:02:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:02:03 INFO - 'MOZ_NO_REMOTE': '1', 07:02:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:02:03 INFO - 'NO_EM_RESTART': '1', 07:02:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:02:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:02:03 INFO - 'PWD': '/builds/slave/test', 07:02:03 INFO - 'SHELL': '/bin/bash', 07:02:03 INFO - 'SHLVL': '1', 07:02:03 INFO - 'TERM': 'linux', 07:02:03 INFO - 'TMOUT': '86400', 07:02:03 INFO - 'USER': 'cltbld', 07:02:03 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1467122374.804559-1305311035', 07:02:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:02:03 INFO - '_': '/tools/buildbot/bin/python'} 07:02:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:02:03 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:02:03 INFO - Cleaning up... 07:02:03 INFO - Return code: 0 07:02:03 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 07:02:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:02:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:02:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:02:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:02:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:02:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:02:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9c5c17ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15398a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16037d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1692520>, '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 0x1693420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16938b0>, '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': 'd2a8c569965ab8367867b893000001a1-1467122374.804559-1305311035', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:02:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 07:02:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 07:02:03 INFO - Using env: {'DISPLAY': ':0', 07:02:03 INFO - 'HOME': '/home/cltbld', 07:02:03 INFO - 'LANG': 'en_US.UTF-8', 07:02:03 INFO - 'LANGUAGE': 'en_US:en', 07:02:03 INFO - 'LOGNAME': 'cltbld', 07:02:03 INFO - 'MAIL': '/var/mail/cltbld', 07:02:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:02:03 INFO - 'MOZ_NO_REMOTE': '1', 07:02:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:02:03 INFO - 'NO_EM_RESTART': '1', 07:02:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:02:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:02:03 INFO - 'PWD': '/builds/slave/test', 07:02:03 INFO - 'SHELL': '/bin/bash', 07:02:03 INFO - 'SHLVL': '1', 07:02:03 INFO - 'TERM': 'linux', 07:02:03 INFO - 'TMOUT': '86400', 07:02:03 INFO - 'USER': 'cltbld', 07:02:03 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1467122374.804559-1305311035', 07:02:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:02:03 INFO - '_': '/tools/buildbot/bin/python'} 07:02:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:02:03 INFO - Downloading/unpacking flake8 07:02:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:02:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:02:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:02:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:02:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:02:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:02:05 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 07:02:05 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 07:02:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:02:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:02:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:02:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:02:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:02:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:02:05 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 07:02:05 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 07:02:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:02:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:02:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:02:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:02:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:02:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:02:05 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 07:02:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:02:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:02:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:02:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:02:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:02:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:02:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 07:02:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:02:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:02:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:02:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:02:06 INFO - no previously-included directories found matching 'docs/_build' 07:02:06 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 07:02:06 INFO - Running setup.py install for pep8 07:02:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:02:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:02:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:02:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:02:06 INFO - no previously-included directories found matching 'docs/_build' 07:02:06 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 07:02:06 INFO - Successfully installed flake8 mccabe pyflakes pep8 07:02:06 INFO - Cleaning up... 07:02:06 INFO - Return code: 0 07:02:06 INFO - Running post-action listener: _resource_record_post_action 07:02:06 INFO - Running post-action listener: _start_resource_monitoring 07:02:06 INFO - Starting resource monitoring. 07:02:06 INFO - ##### 07:02:06 INFO - ##### Finished create-virtualenv step (success) 07:02:06 INFO - ##### 07:02:06 INFO - ##### 07:02:06 INFO - ##### Running install step. 07:02:06 INFO - ##### 07:02:06 INFO - Running pre-action listener: _resource_record_pre_action 07:02:06 INFO - Running main action method: install 07:02:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:02:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:02:06 INFO - Reading from file tmpfile_stdout 07:02:06 INFO - Detecting whether we're running mozinstall >=1.0... 07:02:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:02:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:02:06 INFO - Reading from file tmpfile_stdout 07:02:06 INFO - Output received: 07:02:06 INFO - Usage: mozinstall [options] installer 07:02:06 INFO - Options: 07:02:06 INFO - -h, --help show this help message and exit 07:02:06 INFO - -d DEST, --destination=DEST 07:02:06 INFO - Directory to install application into. [default: 07:02:06 INFO - "/builds/slave/test"] 07:02:06 INFO - --app=APP Application being installed. [default: firefox] 07:02:06 INFO - mkdir: /builds/slave/test/build/application 07:02:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 07:02:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 07:02:22 INFO - Reading from file tmpfile_stdout 07:02:22 INFO - Output received: 07:02:22 INFO - /builds/slave/test/build/application/firefox/firefox 07:02:22 INFO - Running post-action listener: _resource_record_post_action 07:02:22 INFO - ##### 07:02:22 INFO - ##### Finished install step (success) 07:02:22 INFO - ##### 07:02:22 INFO - ##### 07:02:22 INFO - ##### Running run-tests step. 07:02:22 INFO - ##### 07:02:22 INFO - Running pre-action listener: _resource_record_pre_action 07:02:22 INFO - Running main action method: run_tests 07:02:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:02:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:02:22 INFO - Python 2.7.3 07:02:22 INFO - Return code: 0 07:02:22 INFO - grabbing minidump binary from tooltool 07:02:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:02:22 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 0x1692520>, '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 0x1693420>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16938b0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:02:22 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 07:02:22 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 07:02:22 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 07:02:22 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:02:22 INFO - Return code: 0 07:02:22 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:02:22 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:02:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:02:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:02:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:02:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 07:02:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 07:02:23 INFO - Return code: 0 07:02:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NtsGEXtBSv2NMlHQzSzEVQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-043', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 07:02:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/NtsGEXtBSv2NMlHQzSzEVQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-043 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 07:02:23 INFO - Using env: {'DISPLAY': ':0', 07:02:23 INFO - 'HOME': '/home/cltbld', 07:02:23 INFO - 'LANG': 'en_US.UTF-8', 07:02:23 INFO - 'LANGUAGE': 'en_US:en', 07:02:23 INFO - 'LOGNAME': 'cltbld', 07:02:23 INFO - 'MAIL': '/var/mail/cltbld', 07:02:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:02:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:02:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:02:23 INFO - 'MOZ_NO_REMOTE': '1', 07:02:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:02:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:02:23 INFO - 'NO_EM_RESTART': '1', 07:02:23 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:02:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:02:23 INFO - 'PWD': '/builds/slave/test', 07:02:23 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:02:23 INFO - 'SHELL': '/bin/bash', 07:02:23 INFO - 'SHLVL': '1', 07:02:23 INFO - 'TERM': 'linux', 07:02:23 INFO - 'TMOUT': '86400', 07:02:23 INFO - 'USER': 'cltbld', 07:02:23 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1467122374.804559-1305311035', 07:02:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:02:23 INFO - '_': '/tools/buildbot/bin/python'} 07:02:23 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NtsGEXtBSv2NMlHQzSzEVQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-043', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 07:02:24 INFO - mozversion application_buildid: 20160628062322 07:02:24 INFO - mozversion application_changeset: 9676dc9d8b43a5de17ebd0baedfbfd42826dc312 07:02:24 INFO - mozversion application_display_name: Nightly 07:02:24 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:02:24 INFO - mozversion application_name: Firefox 07:02:24 INFO - mozversion application_remotingname: firefox 07:02:24 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 07:02:24 INFO - mozversion application_vendor: Mozilla 07:02:24 INFO - mozversion application_version: 50.0a1 07:02:24 INFO - mozversion platform_buildid: 20160628062322 07:02:24 INFO - mozversion platform_changeset: 9676dc9d8b43a5de17ebd0baedfbfd42826dc312 07:02:24 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 07:02:24 INFO - mozversion platform_version: 50.0a1 07:02:24 INFO - using testdate: 1467122544 07:02:24 INFO - actual date: 1467122544 07:02:24 INFO - starting webserver on 'localhost:40220' 07:02:24 INFO - SUITE-START | Running 2 tests 07:02:24 INFO - TEST-START | dromaeo_css 07:02:24 INFO - operating with platform_type : linux_ 07:02:24 INFO - Initialising browser for dromaeo_css test... 07:02:24 INFO - TEST-INFO | started process 3306 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_GYkeC/profile http://localhost:40220/getInfo.html) 07:02:29 INFO - PROCESS | 3306 | __metrics Screen width/height:1600/1200 07:02:29 INFO - PROCESS | 3306 | colorDepth:24 07:02:29 INFO - PROCESS | 3306 | Browser inner width/height: 1024/697 07:02:29 INFO - PROCESS | 3306 | __metrics 07:02:30 INFO - PROCESS | 3306 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:02:31 INFO - TEST-INFO | 3306: exit 0 07:02:31 INFO - Browser initialized. 07:02:31 INFO - Running cycle 1/1 for dromaeo_css test... 07:02:31 INFO - TEST-INFO | started process 3387 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_GYkeC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:02:43 INFO - PROCESS | 3387 | RSS: Main: 175267840 07:02:43 INFO - PROCESS | 3387 | 07:03:36 INFO - PROCESS | 3387 | 1467122616035 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 07:05:47 INFO - PROCESS | 3387 | Cycle 1(1): loaded http://localhost:40220/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40220/tests/dromaeo/cssquery-ext.html) 07:05:49 INFO - PROCESS | 3387 | RSS: Main: 286109696 07:05:49 INFO - PROCESS | 3387 | 07:08:51 INFO - PROCESS | 3387 | Cycle 1(1): loaded http://localhost:40220/tests/dromaeo/cssquery-ext.html (next: http://localhost:40220/tests/dromaeo/cssquery-jquery.html) 07:08:52 INFO - PROCESS | 3387 | RSS: Main: 256528384 07:08:52 INFO - PROCESS | 3387 | 07:11:54 INFO - PROCESS | 3387 | Cycle 1(1): loaded http://localhost:40220/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40220/tests/dromaeo/cssquery-mootools.html) 07:11:55 INFO - PROCESS | 3387 | RSS: Main: 266346496 07:11:55 INFO - PROCESS | 3387 | 07:14:57 INFO - PROCESS | 3387 | Cycle 1(1): loaded http://localhost:40220/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40220/tests/dromaeo/cssquery-prototype.html) 07:14:58 INFO - PROCESS | 3387 | RSS: Main: 255668224 07:14:58 INFO - PROCESS | 3387 | 07:18:01 INFO - PROCESS | 3387 | Cycle 1(1): loaded http://localhost:40220/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40220/tests/dromaeo/cssquery-yui.html) 07:18:02 INFO - PROCESS | 3387 | RSS: Main: 236249088 07:18:02 INFO - PROCESS | 3387 | 07:21:04 INFO - PROCESS | 3387 | Cycle 1(1): loaded http://localhost:40220/tests/dromaeo/cssquery-yui.html (next: http://localhost:40220/tests/dromaeo/cssquery-dojo.html) 07:21:04 INFO - PROCESS | 3387 | RSS: Main: 284831744 07:21:04 INFO - PROCESS | 3387 | 07:21:04 INFO - PROCESS | 3387 | __start_tp_report 07:21:04 INFO - PROCESS | 3387 | _x_x_mozilla_page_load 07:21:04 INFO - PROCESS | 3387 | _x_x_mozilla_page_load_details 07:21:04 INFO - PROCESS | 3387 | |i|pagename|runs| 07:21:04 INFO - PROCESS | 3387 | |0;dojo.html;2629.513539995101;2640.5511063119266;2679.9866000669995;2682.436688295459;2693.461307738453;4714.811407543702;4752.928706069408;4785.1625965456;4854.490278520753;4887.8533643990695;4792.185328494147;4816.349792777974;4859.3439885615435;4868.123737727207;4954.554090131887;4399.604035636792;4415.271480205763;4463.4643842738915;4512.706674066191;4604.1252162089095;4492.168948744493;4527.932081018787;4559.886002849922;4569.47451043131;4585.472670642869;4373.278409062533;4419.182451246497;4433.290673492225;4475.597196252353;4488.23699971004;4385.736855788631;4396.274614688573;4398.868033958955;4436.534163912775;4477.082198149372;4371.628411585019;4422.933655995163;4442.289233722621;4444.644428445717;4480.686351955364;4682.08699303636;4844.491328410537;4896.902061958741;4906.607471402279;4907.730074845882;5118.61610379223;5148.459411761749;5163.7159956202395;5182.585393168575;5240.711760853152;5197.350331208599;5242.239875218072;5252.816151434681;5269.710165940872;5276;4719.221328480831;4834.854954351375;4880.926786098176;4890.804367825247;4894.706317620954;5378.058839703036;5420.891582168335;5425.131978883439;5448.564114870801;5475.780968761205;5164.354455693038;5170.224466330081;5209.869753256199;5211.765470553834;5219.973900130551;4970.751462426864;5079.339685840817;5165.767540460613;5247.580193584504;5257.263983042377;5132.794688212504;5138.845834624967;5139.614528910347;5157.638965272395;5164.612654050961;5102.132637451642;5118.846434606968;5119.846404607868;5125.820596279113;5176.8964620707375;4289.356596510548;4340.565943405634;4342.044750154961;4355.499117601453;4417.801198946056;3787.147891724395;3795.886123416302;3833.9041523962123;3864.6715029222833;3878.553966293856;4438.689291749611;4447.510773814878;4449.844255451044;4485.035717320791;4488.955110448854;5039.168537191395;5183.403908550565;5185.118529849935;5192.4547922468355;5238.057149713089;4449.065696203834;4494.640428765691;4499.730016199039;4506.932396014063;4513.616342610849;4740.288956656529;4741.2651039089;4742.715437073718;4746.169420351424;4781.856544303677;4758.976205118952;4831.758412079453;4904.166291730343;4967.577755890789;4992.825251116194;5192.532672059533;5203.505666961632;5211.843644690665;5221.164613661796;5273.050850846885;4868.123737727243;4912.214045752662;4914.434839993446;4914.64662012537;4964.106460837084;4988.850334489971;5100.617453690914;5116.2069879168785;5151.871203219799;5156.639035267495;5210.140326846028;5216;5230.163173892159;5235.476452354734;5274.683518988873;5081.568066714371;5090.669106508065;5092.618053645917;5095.694258344512;5140.974295128501;4927.1377508935075;5038.823641172541;5066.746662666926;5081.695098294114;5103.7192954387865;5025.723585202702;5032.773525191302;5090.41460232078;5092.516210959953;5095.617828662939;5135.87160320995;5138.306328645585;5139.511746384088;5140.43455219933;5186.533212010937;4785.138675038526;4827.686200396963;4936.284238785428;5015.899682006412;5059.924101138412 07:21:04 INFO - PROCESS | 3387 | |1;ext.html;541.9625924961884;572.8367415286643;584.7836300568788;585.6603170161306;590.2179612014082;26880.462390752175;39362;39771.20457590854;39829.4025589616;39849.80075099628;39137.21725565487;39472.40791388132;39529.802350988204;39589.8020509897;39603.40594891079;7590.468667193299;7899.328557072641;8047.114817370085;8050.033995920468;10123.746906327327;10117.696469105938;10269.127124194452;10271.486425678724;10274.897251027505;10281.228907831905;10257.281990260684;10306.072453479186;10306.175505959543;10307.484625768719;10322;7727.304542591166;7889.487183333123;7898.881516777195;10110.090091891765;10250.897491025105;9905;10020.59917603295;10344.275900686955;10346.637867674595;10359;38178.61821381778;38632.80683596592;38647.42028869569;38684.613153868384;38690.22619547593;3088.799228050192;3115.3302040061267;3353.815540145291;3772.7170462215167;3800.923981520354;29666;29883.551746723817;29982.850085749433;30091.849540752155;30596.694033059608;3150.4329220740256;3198.9680103198903;3199.9600129957626;3235.660255673144;3252.7397808175288;254528;254841;255314;255636;257279;32390;55625.16562251569;56232.43767562272;56309.43690563042;56343;32714.34571308608;34756.65243347534;34782.82608586941;34825.303493930485;34832.47751283733;12665.303408312448;12830.615081547381;12839.550615728405;12851.678708032374;12851.807222891664;10218.744531386626;10332.328398654063;10526.947365263279;10566.049055585034;10568.365898046142;7814.21857814214;7883.6058197089915;8010;8090.231428014329;8139;3189.8245596492416;3239.4492936200904;3243.61076670801;3260.755443341759;3270.8691652334114;934.6681927915628;941.1341565759518;957.7844984878346;969.5540051576354;1025.2823023883163;23127.421814454774;24292.392690182533;24302.392440189138;24317;24331.39171520726;971.0774763974252;981.7349315684868;1000.9199264058858;1024.416082832793;1039.0907955538903;13162.946964242838;13399.53101641438;13714.17714937107;13862.376193071335;13907.09603875765;404057;404501;405561;407338;407374;49622;49807.750961245685;50005.24992125121;50015;50184.74907625438;1100.3507930320989;1183.378949987559;1189.3042570096245;1207.4868181023205;1207.6135636596205;27726.44547109087;29028;29292.853535732185;29299.414011720073;29861;40679.38980915229;40686.38970415505;41206.793966029974;41232.58767412287;41259.587404125574;296027;298500;299007;299626;299862;22320.66519002184;22780.772192277866;22808.20171293997;22815.31554053381;22867.656985144902;41155;41271.1745765077;41710.374344384254;42442;42820.35769463398;34931.65068349284;35856.05583385773;36718.8164059178;36820;36967.44548831823;35173.64826351704;35299.29401412009;35721.82139089288;35910.461343079354;36098;34842.82578587091;34972.82513587517;36819.07952301214;36999.63000369962;37059.81470092632;30820.537691935086;32508.837455813515;33273.667263328025;33295;33320.1669958253;23567;23948.64077038811;24093.377194721;24158.516829662956;24423.633645494978 07:21:04 INFO - PROCESS | 3387 | |2;jquery.html;376.08048321853073;376.4917361561891;377.81487071335056;387.3550538353641;390.4514157608559;15922.68154636908;16451.670966580677;17248.31006759731;17293.740593891085;17853.553661158476;11800.291982481058;15660;16462.094584797862;16480;17272.395466158687;3536.770109942858;4672.065586882629;4888.41339039314;4888.9511104889025;4891.926621100686;3654.5979942206336;5240.973795131038;5497.752601132958;5507.256520369759;5582.637128586629;5261.421243663213;5517.613767036309;5544.0575102232715;5552.583556233279;5569.554435645159;3472.5138480612736;5413.864653383657;5549.0289199389945;5552.167174923753;5554.611177217596;5155.097857874857;5478.506934375925;5483;5485.259489968883;5486.177073439016;12317.692057698629;12347;12513.562025329069;12541.874581254253;12587.181833180814;1883.8398736107447;1946.581484980736;1948.3667807962327;1991.4822146241936;2050.589882023586;8821.823563528758;9257.398269112486;9300.162985331353;9742;9746.853797193047;1770.7673823850491;1793.7847458305087;1810.6107186954869;1843.6312737452429;1845.3541260558832;60206.69896650489;65868;67267;74187.25812741912;74362.62818685926;15117.70880191946;15667.216639167997;16099.517014489584;16191.514254572146;16314.75527867083;28841.56737648937;29062.854685726437;29067.273318166794;29218.7078129216;29291;8448.83102337962;8745.606447709868;8792.076831932683;8849.407106720852;8933.776655583662;7202.135743710788;7212.567245965259;7341;7414.962925185339;7415.592142432218;8124.4684078847185;8359.578871591844;8505.489670619783;8558.44370115953;8597.355198360148;2604.3749500119834;3391.338688955679;3411.607665118543;3429.9657003430148;3430.9313813723584;695.9898439250263;734.4124700239787;787.142344067999;843.9957800210959;937.6483818568037;16583.419580314872;16606.335746570243;16722.916385418237;16751.6649667006;17201.483955481355;867.9305655547668;870.3602851903846;875.5228400521731;877.5743764274322;922.8523436250168;9211.493367864832;9262.44425334482;9509.476978766234;9520.666776662783;9628.9037109628;359669;360709;370236;386534;390480;49668.25497617538;75076.62461687656;79081;79437;80875;851.0893344121854;888.8177923525661;892.1747383670079;899.1952202778476;900.3787386703154;14270.785938211142;14748.483803066842;14860.108393496424;14887.181205033827;15223.238838058274;34979.47530786989;35511.289774203855;36318.45522317114;36827.26345473022;36880.81559592185;48200.75899620479;52200.47799521956;52418.213726793365;52612.47387526076;52701.20948185703;4698.459677137173;4799.112164249625;6790.626515541692;6954.165500140016;7645.1972542882195;10669.626563070255;11628.069754419796;12141.08941829384;12452.31512266834;12550;10199.133073688523;10309.690709278733;10599.258051936291;10637.202209834448;10714.410707410856;9994.10053095225;10206.897931020594;10478.37129772216;10822.945885270523;10871.565137394731;10305.381677099398;10382.494538292056;10412.271141020055;10456.738581535523;10571.682849514527;7175.2499227556955;7254.455915806441;7350.96324518374;7404.481686281909;7445.590492522963;9563.234941204826;10530.631427899987;10631.94684026575;10710.250282480463;10862.891371086187 07:21:04 INFO - PROCESS | 3387 | |3;mootools.html;1170.8360829483868;1315.0860152194223;1362.4345896452971;1413.985860141399;1705.5480297721106;6728.428083612893;7487.475876688627;7734.845303093949;7768.1843406442285;7939.92060079399;7668.271514206155;7812.570308633023;7815.648295826687;7820.100688420834;7823.335016523588;1832.1663643042384;2125.4155107345528;2180.5965896309194;2208.8785116818567;2227.1536816009893;2233.062113912161;2256.627656436686;2257.6726374675663;2260.8304377171694;2262.490939538607;2196.6595177747395;2207.4481379655085;2230.654248591471;2233.4416395901026;2234.0393630738777;1825.3976187857975;1884.4252502986583;1886.56608979934;2160.0387827416807;2200.207925146954;2173.4457713283014;2210.812080973119;2212.61279276126;2214.0590249144047;2214.9557008859892;7795.727149549739;7812.140664526897;7848.7645370638975;7855.214478552156;7857.764267071997;4532;4666.043461090469;4670.883227919295;4673.906521869578;4677.64917631179;2830.1933948824485;2921.21127295629;2957.497225471675;2962.3630919352227;3033.4994725870206;1006.8842083160457;1019.8062368150028;1048.2609760119099;1052.9262951593391;1060.363781730963;10868.945655271753;10879.83680244797;10887.618933337295;10893.945530272298;10937.234393592451;4207.579242075768;4268.146370725805;4272.08150247692;4353.412289340962;4391.407160033418;9280.860787088199;9308.115729005734;9342.766430839283;9352.392094513834;9353.672621458216;4728.05438912219;4732.952670473252;4743.928841067387;4747.454042785055;4751.073540659608;3736.887893363149;4065;4186.58134186585;4197.412362269285;4244.91510169801;3616.710663146942;3696.2237930034457;3732.9734323060834;3752.9249415011545;3796.7911764852647;1193.612076075279;1201.6335017819474;1209.2804781155373;1209.8064309710403;1212.8180772883961;836.1471299274828;844.160060739568;863.5034854958424;883.4875772052194;895.1048951048951;5442.591805614595;5500.50495455411;5528.336599607992;5621.634593751475;5712.571557133231;880.854658981261;898.4564338575068;899.8290324838259;909.9954500227589;917.8110207155981;3996.6827533147416;4010.939835902464;4061.7969101544804;4141.4616099907425;4154.750714957112;9623.278254130968;9755.951220243853;9819.558119884623;9857.112859842506;9878.654247101316;9791.314607977516;9810.166135878388;9815.509224538744;9816.65641702537;9830.066143716336;7023.578585284899;7137.785866423912;7316.926830731731;7318.048653675095;7383.630818459055;5447.891042179055;5492.725363731877;5497.175423686479;5514.61397702157;5628.240187574625;8877.511736854534;8952;8962.462252264884;8999;9050.637974480947;8605.182507661762;8972.730818075468;8978.685745998859;9281.350305478552;9307.627694892128;6610.6694665267505;7103.218645949045;7268.96365518169;7289.671964761493;7457.477976541807;7599.848003039798;7609.923900760921;7667.88498172539;7681.385489160742;7681.423893208143;6589.374009469093;6641.203055633355;6735.393814556714;6830.556013859282;6832.043513907957;6748.358905903931;6776.085228494288;6798;6843.452523797984;6851.246362899978;5951.107333899777;6087.878242435215;6128.816135515942;6136.754529818757;6147.569670123048;4672.906541869212;4680.92978605328;4729.929051064306;4782.928256076231;4841.975790121168;4697.177993850994;4722.173619616485;4943.209086546135;4946.060248552907;4958.305837182726 07:21:04 INFO - PROCESS | 3387 | |4;prototype.html;308.36476857673193;314.410480349345;315.241843366703;317.2259686365267;317.774380190065;4879.048585525824;4929.658412254177;4944.703317800934;4954.232094025428;4962.454130045701;4777.426708794949;4779.426468823737;4816.63875209359;4859.805607775694;4865.562099411052;3632.7638703484254;3753.3431649461236;3754.5494540655022;3823.1780167264033;3846.288436639217;3826.1773718650484;3846.8653597124107;3856.652901238888;3862.9806850965706;3863.343231650612;3644.3257997270457;3806.4861243732157;3832.2718683450194;3836.9808150959207;3847.4228865670234;3682.55809302884;3767.6797472214757;3794.165283637595;3805.06775839921;3806.276807406584;3336.616289126733;3353.161709572607;3359.378514974713;3362.0586235853757;3371.9325613487595;4759.690620109682;4778.116048531033;4782.689125206885;4793.514010656672;4796.280557916306;4262.552431994627;4392.363107349448;4397.47230332359;4398.33900490202;4407.449068866392;5058.924116138261;5073.949260507385;5091.159958606825;5097.643164978453;5103.260027296058;3724.9813750931344;3729.4219395993664;3744.2511497700298;3745.1011757178353;3774.2262836118803;5083.135866902636;5257.500537448898;5274.7626356814035;5365.892682146336;5371.442281738291;3772.7359084863797;3782.527184101987;3789.03379638196;3802.144517483544;3819.1597848473293;3849.268638958589;3849.942250866239;3868.458415821787;3897.3179693553516;3907;4325.329573916048;4343.2182207203;4344.283193273074;4357.346398040256;4383.780810959439;4806.49531799163;5047.662369472093;5059.797608095635;5062.544371006627;5077.669951453144;1288.845338559379;1312.7440149171011;1315.1320128715001;1317.1899281941728;1322.8214191084273;835.5362773660677;840.6259214649544;860.4364141487335;864.312871267344;864.5331520978726;4438.134563760036;4449.199144154083;4451.3323001550025;4465.173942820588;4468.352088947085;5196.142636464941;5210.244514545369;5223.895522089613;5231.790728370823;5233.39815921174;4258.67980925914;4428.446444194476;4457.665675074318;4468.731876087445;4583.656225783079;2799.1805326537915;2809.578563215493;2811.831290122599;2819.6898341182455;2827.4203788223363;4956.132676781621;4965.478624744422;4975.258659469157;4983.377077865267;5013;5105.412877519133;5423.294971653739;5428.4842939920645;5432.6468779529205;5444.237806707064;4939.3084968104495;4939.827106051271;4964.379452568429;4970.6023518117745;4976.203807390945;5290.365156181283;5295.576353891603;5322.54758345545;5330;5346.304980352529;4917.827876024322;5180.19706945409;5200.427952925251;5206.323177986837;5210.609204309768;4968.130577149057;4996.325496058131;5000.974995125001;5001.874953126201;5036.917062831509;3736.458213559073;3766;3780.5652349979005;3787.1100291432044;3791.7914514701956;5144.228365745168;5271.71005594696;5294.576433885203;5298;5388.649737767033;5100.617453691062;5126.667066562646;5134.510991812333;5136.512031357015;5154.201098829687;5007.949920500894;5085.338905942203;5116.897662046813;5138.563222126161;5143.2285157225215;4759.762011899322;4881.9023619528125;5028.094942910311;5029.1953287473825;5045.747712614281;4945.2582112683385;5164.870878228075;5199.792008319625;5206.375234971828;5212.713300768342;5063.569596584184;5073.974630126826;5096.566791822736;5097.745112744422;5107 07:21:04 INFO - PROCESS | 3387 | |5;yui.html;647.7182425644845;666.2671061831983;684.0594182998377;697.2748341724605;710.037898647333;12208.877911220885;13458.663533411669;13514.864851351484;13535.52625658102;13537.187768733882;12463.252204867715;12575.622731318052;12579.622611321674;12583.874161258385;12599.118061735659;615.9507239420835;744.9962750186241;764.7285213749122;774.601080443572;779.1118125337092;775.1318523253935;778.7624774443792;781.1407451803;781.613101514751;781.6560713286165;836.6444261189001;838.2623291503469;838.5471845203583;838.6938767349934;838.8657814749611;644.1368566121397;795.0697683710073;824.5629816197365;826.4421515477029;829.4069740135802;565.8528782516576;568.4656422962402;568.7696482924422;568.8407245971134;574.0270241939913;12816;12854.55009074678;12859.485620575166;12862.292573908431;12864.29246391448;12516.436760345716;13091.47634094635;13105.410256538478;13367.131136476195;13452.32738363078;11452.141089418326;11510.42447877611;11540.884591154148;11577.652670419817;11825.290482570987;4135.069609337905;4159.126583417486;4201.810918508674;4219.409282700424;4291.678124140702;58122;58170;58613.41386586122;59539.70230148865;59569.7021514894;10417.218708596885;10421.68734937953;10429.530671119817;10472.947635261928;10535.736606584744;18381.724274135897;18389.632207356044;18390.540236493925;18464.538386540175;18494.722579161324;6543.411093001652;6611.636360000246;6647.6676166192465;6664.633445160563;6722.563033402813;3619.529461170031;3622.094476380905;3673.265346930571;3743.0455233915177;3744.213715119801;2671.0784779251126;2764.4747497975322;2764.7097054809356;2765.889364425441;2771.2517620242825;483.6976889444097;495.72734995752194;507.55335304931424;510.5303121128571;511.7927239467947;507.92635067914944;538.8087229033715;542.8018773147772;547.9068558345091;560.3052215253139;6925.411340036153;6945.131858517685;7193.136823581099;7373.156710822294;7478.2521747824785;404.52872403649417;455.58086560364546;458.37431905448824;477.7730577975434;508.09305389879626;3400.5018933252118;3410.300888317889;3447.87932422369;3464.2032332563654;3515.3848076586496;51993;52607;53717.46282537203;62579.6871015642;94356;78785;79674.80487792687;81439.18560814434;82390;84953.57523212468;73125;73548.26451735522;73635.63182184055;73811.26188738045;74748;6516.446102081376;6532.020196970492;6620.271770105381;6653.767118150841;6655.500837437115;41810.58189418067;42879.79481163733;43133.784331078146;43198.136037279706;43369.56630433655;58697.413025869195;63338.683306583174;63920.680396597716;64398;64651.67674161787;8637.309015278637;8693.913060869563;8928.285737141143;8937.73186804397;9228.40015398997;10331.535080921227;10357.533910974174;10406.935967647996;10496.317739346918;10727.785444291227;9879.407235565888;9976;10008.64969726056;10231.539580718736;10392.42841643717;10164.440955747505;10311.896881031094;11183.608573699881;11243.831342530033;11309.151813614177;10549.789004220027;10696.62561810333;10823.188260880623;11409.17921683024;12317.07621928341;9609.663661771805;10075.496225188564;10167.237457190593;10227.7443063924;10363.730903508675;9624.326297159132;10034.397936123856;10347.223958203014;10377.9481102594;10488 07:21:04 INFO - PROCESS | 3387 | __end_tp_report 07:21:04 INFO - PROCESS | 3387 | __start_cc_report 07:21:04 INFO - PROCESS | 3387 | _x_x_mozilla_cycle_collect,1063 07:21:04 INFO - PROCESS | 3387 | __end_cc_report 07:21:04 INFO - PROCESS | 3387 | __startTimestamp1467123664975__endTimestamp 07:21:04 INFO - PROCESS | 3387 | 07:21:04 INFO - PROCESS | 3387 | ------- Summary: start ------- 07:21:04 INFO - PROCESS | 3387 | Number of tests: 6 07:21:04 INFO - PROCESS | 3387 | 07:21:04 INFO - PROCESS | 3387 | [#0] dojo.html Cycles:165 Average:4802.82 Median:4914.65 stddev:517.62 (10.5%) stddev-sans-first:490.33 07:21:04 INFO - PROCESS | 3387 | Values: 2629.5 2640.6 2680.0 2682.4 2693.5 4714.8 4752.9 4785.2 4854.5 4887.9 4792.2 4816.3 4859.3 4868.1 4954.6 4399.6 4415.3 4463.5 4512.7 4604.1 4492.2 4527.9 4559.9 4569.5 4585.5 4373.3 4419.2 4433.3 4475.6 4488.2 4385.7 4396.3 4398.9 4436.5 4477.1 4371.6 4422.9 4442.3 4444.6 4480.7 4682.1 4844.5 4896.9 4906.6 4907.7 5118.6 5148.5 5163.7 5182.6 5240.7 5197.4 5242.2 5252.8 5269.7 5276.0 4719.2 4834.9 4880.9 4890.8 4894.7 5378.1 5420.9 5425.1 5448.6 5475.8 5164.4 5170.2 5209.9 5211.8 5220.0 4970.8 5079.3 5165.8 5247.6 5257.3 5132.8 5138.8 5139.6 5157.6 5164.6 5102.1 5118.8 5119.8 5125.8 5176.9 4289.4 4340.6 4342.0 4355.5 4417.8 3787.1 3795.9 3833.9 3864.7 3878.6 4438.7 4447.5 4449.8 4485.0 4489.0 5039.2 5183.4 5185.1 5192.5 5238.1 4449.1 4494.6 4499.7 4506.9 4513.6 4740.3 4741.3 4742.7 4746.2 4781.9 4759.0 4831.8 4904.2 4967.6 4992.8 5192.5 5203.5 5211.8 5221.2 5273.1 4868.1 4912.2 4914.4 4914.6 4964.1 4988.9 5100.6 5116.2 5151.9 5156.6 5210.1 5216.0 5230.2 5235.5 5274.7 5081.6 5090.7 5092.6 5095.7 5141.0 4927.1 5038.8 5066.7 5081.7 5103.7 5025.7 5032.8 5090.4 5092.5 5095.6 5135.9 5138.3 5139.5 5140.4 5186.5 4785.1 4827.7 4936.3 5015.9 5059.9 07:21:04 INFO - PROCESS | 3387 | 07:21:04 INFO - PROCESS | 3387 | [#1] ext.html Cycles:180 Average:46403.93 Median:3265.81 stddev:86081.84 (2635.8%) stddev-sans-first:86254.45 07:21:04 INFO - PROCESS | 3387 | Values: 542.0 572.8 584.8 585.7 590.2 26880.5 39362.0 39771.2 39829.4 39849.8 39137.2 39472.4 39529.8 39589.8 39603.4 7590.5 7899.3 8047.1 8050.0 10123.7 10117.7 10269.1 10271.5 10274.9 10281.2 10257.3 10306.1 10306.2 10307.5 10322.0 7727.3 7889.5 7898.9 10110.1 10250.9 9905.0 10020.6 10344.3 10346.6 10359.0 38178.6 38632.8 38647.4 38684.6 38690.2 3088.8 3115.3 3353.8 3772.7 3800.9 29666.0 29883.6 29982.9 30091.8 30596.7 3150.4 3199.0 3200.0 3235.7 3252.7 254528.0 254841.0 255314.0 255636.0 257279.0 32390.0 55625.2 56232.4 56309.4 56343.0 32714.3 34756.7 34782.8 34825.3 34832.5 12665.3 12830.6 12839.6 12851.7 12851.8 10218.7 10332.3 10526.9 10566.0 10568.4 7814.2 7883.6 8010.0 8090.2 8139.0 3189.8 3239.4 3243.6 3260.8 3270.9 934.7 941.1 957.8 969.6 1025.3 23127.4 24292.4 24302.4 24317.0 24331.4 971.1 981.7 1000.9 1024.4 1039.1 13162.9 13399.5 13714.2 13862.4 13907.1 404057.0 404501.0 405561.0 407338.0 407374.0 49622.0 49807.8 50005.2 50015.0 50184.7 1100.4 1183.4 1189.3 1207.5 1207.6 27726.4 29028.0 29292.9 29299.4 29861.0 40679.4 40686.4 41206.8 41232.6 41259.6 296027.0 298500.0 299007.0 299626.0 299862.0 22320.7 22780.8 22808.2 22815.3 22867.7 41155.0 41271.2 41710.4 42442.0 42820.4 34931.7 35856.1 36718.8 36820.0 36967.4 35173.6 35299.3 35721.8 35910.5 36098.0 34842.8 34972.8 36819.1 36999.6 37059.8 30820.5 32508.8 33273.7 33295.0 33320.2 23567.0 23948.6 24093.4 24158.5 24423.6 07:21:04 INFO - PROCESS | 3387 | 07:21:04 INFO - PROCESS | 3387 | [#2] jquery.html Cycles:180 Average:24171.41 Median:197576.03 stddev:61695.00 (31.2%) stddev-sans-first:61842.20 07:21:04 INFO - PROCESS | 3387 | Values: 376.1 376.5 377.8 387.4 390.5 15922.7 16451.7 17248.3 17293.7 17853.6 11800.3 15660.0 16462.1 16480.0 17272.4 3536.8 4672.1 4888.4 4889.0 4891.9 3654.6 5241.0 5497.8 5507.3 5582.6 5261.4 5517.6 5544.1 5552.6 5569.6 3472.5 5413.9 5549.0 5552.2 5554.6 5155.1 5478.5 5483.0 5485.3 5486.2 12317.7 12347.0 12513.6 12541.9 12587.2 1883.8 1946.6 1948.4 1991.5 2050.6 8821.8 9257.4 9300.2 9742.0 9746.9 1770.8 1793.8 1810.6 1843.6 1845.4 60206.7 65868.0 67267.0 74187.3 74362.6 15117.7 15667.2 16099.5 16191.5 16314.8 28841.6 29062.9 29067.3 29218.7 29291.0 8448.8 8745.6 8792.1 8849.4 8933.8 7202.1 7212.6 7341.0 7415.0 7415.6 8124.5 8359.6 8505.5 8558.4 8597.4 2604.4 3391.3 3411.6 3430.0 3430.9 696.0 734.4 787.1 844.0 937.6 16583.4 16606.3 16722.9 16751.7 17201.5 867.9 870.4 875.5 877.6 922.9 9211.5 9262.4 9509.5 9520.7 9628.9 359669.0 360709.0 370236.0 386534.0 390480.0 49668.3 75076.6 79081.0 79437.0 80875.0 851.1 888.8 892.2 899.2 900.4 14270.8 14748.5 14860.1 14887.2 15223.2 34979.5 35511.3 36318.5 36827.3 36880.8 48200.8 52200.5 52418.2 52612.5 52701.2 4698.5 4799.1 6790.6 6954.2 7645.2 10669.6 11628.1 12141.1 12452.3 12550.0 10199.1 10309.7 10599.3 10637.2 10714.4 9994.1 10206.9 10478.4 10822.9 10871.6 10305.4 10382.5 10412.3 10456.7 10571.7 7175.2 7254.5 7351.0 7404.5 7445.6 9563.2 10530.6 10631.9 10710.3 10862.9 07:21:04 INFO - PROCESS | 3387 | 07:21:04 INFO - PROCESS | 3387 | [#3] mootools.html Cycles:180 Average:5221.81 Median:5445.24 stddev:2908.94 (53.4%) stddev-sans-first:2901.16 07:21:04 INFO - PROCESS | 3387 | Values: 1170.8 1315.1 1362.4 1414.0 1705.5 6728.4 7487.5 7734.8 7768.2 7939.9 7668.3 7812.6 7815.6 7820.1 7823.3 1832.2 2125.4 2180.6 2208.9 2227.2 2233.1 2256.6 2257.7 2260.8 2262.5 2196.7 2207.4 2230.7 2233.4 2234.0 1825.4 1884.4 1886.6 2160.0 2200.2 2173.4 2210.8 2212.6 2214.1 2215.0 7795.7 7812.1 7848.8 7855.2 7857.8 4532.0 4666.0 4670.9 4673.9 4677.6 2830.2 2921.2 2957.5 2962.4 3033.5 1006.9 1019.8 1048.3 1052.9 1060.4 10868.9 10879.8 10887.6 10893.9 10937.2 4207.6 4268.1 4272.1 4353.4 4391.4 9280.9 9308.1 9342.8 9352.4 9353.7 4728.1 4733.0 4743.9 4747.5 4751.1 3736.9 4065.0 4186.6 4197.4 4244.9 3616.7 3696.2 3733.0 3752.9 3796.8 1193.6 1201.6 1209.3 1209.8 1212.8 836.1 844.2 863.5 883.5 895.1 5442.6 5500.5 5528.3 5621.6 5712.6 880.9 898.5 899.8 910.0 917.8 3996.7 4010.9 4061.8 4141.5 4154.8 9623.3 9756.0 9819.6 9857.1 9878.7 9791.3 9810.2 9815.5 9816.7 9830.1 7023.6 7137.8 7316.9 7318.0 7383.6 5447.9 5492.7 5497.2 5514.6 5628.2 8877.5 8952.0 8962.5 8999.0 9050.6 8605.2 8972.7 8978.7 9281.4 9307.6 6610.7 7103.2 7269.0 7289.7 7457.5 7599.8 7609.9 7667.9 7681.4 7681.4 6589.4 6641.2 6735.4 6830.6 6832.0 6748.4 6776.1 6798.0 6843.5 6851.2 5951.1 6087.9 6128.8 6136.8 6147.6 4672.9 4680.9 4729.9 4782.9 4842.0 4697.2 4722.2 4943.2 4946.1 4958.3 07:21:04 INFO - PROCESS | 3387 | 07:21:04 INFO - PROCESS | 3387 | [#4] prototype.html Cycles:180 Average:4255.65 Median:4862.68 stddev:1228.97 (25.3%) stddev-sans-first:1196.18 07:21:04 INFO - PROCESS | 3387 | Values: 308.4 314.4 315.2 317.2 317.8 4879.0 4929.7 4944.7 4954.2 4962.5 4777.4 4779.4 4816.6 4859.8 4865.6 3632.8 3753.3 3754.5 3823.2 3846.3 3826.2 3846.9 3856.7 3863.0 3863.3 3644.3 3806.5 3832.3 3837.0 3847.4 3682.6 3767.7 3794.2 3805.1 3806.3 3336.6 3353.2 3359.4 3362.1 3371.9 4759.7 4778.1 4782.7 4793.5 4796.3 4262.6 4392.4 4397.5 4398.3 4407.4 5058.9 5073.9 5091.2 5097.6 5103.3 3725.0 3729.4 3744.3 3745.1 3774.2 5083.1 5257.5 5274.8 5365.9 5371.4 3772.7 3782.5 3789.0 3802.1 3819.2 3849.3 3849.9 3868.5 3897.3 3907.0 4325.3 4343.2 4344.3 4357.3 4383.8 4806.5 5047.7 5059.8 5062.5 5077.7 1288.8 1312.7 1315.1 1317.2 1322.8 835.5 840.6 860.4 864.3 864.5 4438.1 4449.2 4451.3 4465.2 4468.4 5196.1 5210.2 5223.9 5231.8 5233.4 4258.7 4428.4 4457.7 4468.7 4583.7 2799.2 2809.6 2811.8 2819.7 2827.4 4956.1 4965.5 4975.3 4983.4 5013.0 5105.4 5423.3 5428.5 5432.6 5444.2 4939.3 4939.8 4964.4 4970.6 4976.2 5290.4 5295.6 5322.5 5330.0 5346.3 4917.8 5180.2 5200.4 5206.3 5210.6 4968.1 4996.3 5001.0 5001.9 5036.9 3736.5 3766.0 3780.6 3787.1 3791.8 5144.2 5271.7 5294.6 5298.0 5388.6 5100.6 5126.7 5134.5 5136.5 5154.2 5007.9 5085.3 5116.9 5138.6 5143.2 4759.8 4881.9 5028.1 5029.2 5045.7 4945.3 5164.9 5199.8 5206.4 5212.7 5063.6 5074.0 5096.6 5097.7 5107.0 07:21:04 INFO - PROCESS | 3387 | 07:21:04 INFO - PROCESS | 3387 | [#5] yui.html Cycles:180 Average:16313.36 Median:489.71 stddev:22543.08 (4603.3%) stddev-sans-first:22575.63 07:21:04 INFO - PROCESS | 3387 | Values: 647.7 666.3 684.1 697.3 710.0 12208.9 13458.7 13514.9 13535.5 13537.2 12463.3 12575.6 12579.6 12583.9 12599.1 616.0 745.0 764.7 774.6 779.1 775.1 778.8 781.1 781.6 781.7 836.6 838.3 838.5 838.7 838.9 644.1 795.1 824.6 826.4 829.4 565.9 568.5 568.8 568.8 574.0 12816.0 12854.6 12859.5 12862.3 12864.3 12516.4 13091.5 13105.4 13367.1 13452.3 11452.1 11510.4 11540.9 11577.7 11825.3 4135.1 4159.1 4201.8 4219.4 4291.7 58122.0 58170.0 58613.4 59539.7 59569.7 10417.2 10421.7 10429.5 10472.9 10535.7 18381.7 18389.6 18390.5 18464.5 18494.7 6543.4 6611.6 6647.7 6664.6 6722.6 3619.5 3622.1 3673.3 3743.0 3744.2 2671.1 2764.5 2764.7 2765.9 2771.3 483.7 495.7 507.6 510.5 511.8 507.9 538.8 542.8 547.9 560.3 6925.4 6945.1 7193.1 7373.2 7478.3 404.5 455.6 458.4 477.8 508.1 3400.5 3410.3 3447.9 3464.2 3515.4 51993.0 52607.0 53717.5 62579.7 94356.0 78785.0 79674.8 81439.2 82390.0 84953.6 73125.0 73548.3 73635.6 73811.3 74748.0 6516.4 6532.0 6620.3 6653.8 6655.5 41810.6 42879.8 43133.8 43198.1 43369.6 58697.4 63338.7 63920.7 64398.0 64651.7 8637.3 8693.9 8928.3 8937.7 9228.4 10331.5 10357.5 10406.9 10496.3 10727.8 9879.4 9976.0 10008.6 10231.5 10392.4 10164.4 10311.9 11183.6 11243.8 11309.2 10549.8 10696.6 10823.2 11409.2 12317.1 9609.7 10075.5 10167.2 10227.7 10363.7 9624.3 10034.4 10347.2 10377.9 10488.0 07:21:04 INFO - PROCESS | 3387 | -------- Summary: end -------- 07:21:04 INFO - PROCESS | 3387 | 07:21:05 INFO - TEST-INFO | 3387: exit 0 07:21:05 INFO - TEST-OK | dromaeo_css | took 1121589ms 07:21:05 INFO - TEST-START | kraken 07:21:05 INFO - operating with platform_type : linux_ 07:21:05 INFO - Initialising browser for kraken test... 07:21:05 INFO - TEST-INFO | started process 3567 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpe9mfxJ/profile http://localhost:40220/getInfo.html) 07:21:09 INFO - PROCESS | 3567 | __metrics Screen width/height:1600/1200 07:21:09 INFO - PROCESS | 3567 | colorDepth:24 07:21:09 INFO - PROCESS | 3567 | Browser inner width/height: 1024/697 07:21:09 INFO - PROCESS | 3567 | __metrics 07:21:10 INFO - PROCESS | 3567 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:21:11 INFO - TEST-INFO | 3567: exit 0 07:21:11 INFO - Browser initialized. 07:21:11 INFO - Running cycle 1/1 for kraken test... 07:21:11 INFO - TEST-INFO | started process 3645 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpe9mfxJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:21:23 INFO - PROCESS | 3645 | RSS: Main: 175677440 07:21:23 INFO - PROCESS | 3645 | 07:21:26 INFO - PROCESS | 3645 | Cycle 1(1): loaded http://localhost:40220/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40220/tests/kraken/driver.html?testName=audio-beat-detection) 07:21:27 INFO - PROCESS | 3645 | RSS: Main: 233771008 07:21:27 INFO - PROCESS | 3645 | 07:21:30 INFO - PROCESS | 3645 | Cycle 1(1): loaded http://localhost:40220/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40220/tests/kraken/driver.html?testName=audio-dft) 07:21:30 INFO - PROCESS | 3645 | RSS: Main: 222941184 07:21:30 INFO - PROCESS | 3645 | 07:21:34 INFO - PROCESS | 3645 | Cycle 1(1): loaded http://localhost:40220/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40220/tests/kraken/driver.html?testName=audio-fft) 07:21:34 INFO - PROCESS | 3645 | RSS: Main: 288952320 07:21:34 INFO - PROCESS | 3645 | 07:21:36 INFO - PROCESS | 3645 | Cycle 1(1): loaded http://localhost:40220/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40220/tests/kraken/driver.html?testName=audio-oscillator) 07:21:37 INFO - PROCESS | 3645 | RSS: Main: 198225920 07:21:37 INFO - PROCESS | 3645 | 07:21:39 INFO - PROCESS | 3645 | Cycle 1(1): loaded http://localhost:40220/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40220/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:21:40 INFO - PROCESS | 3645 | RSS: Main: 201818112 07:21:40 INFO - PROCESS | 3645 | 07:21:43 INFO - PROCESS | 3645 | Cycle 1(1): loaded http://localhost:40220/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40220/tests/kraken/driver.html?testName=imaging-darkroom) 07:21:44 INFO - PROCESS | 3645 | RSS: Main: 238403584 07:21:44 INFO - PROCESS | 3645 | 07:21:47 INFO - PROCESS | 3645 | Cycle 1(1): loaded http://localhost:40220/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40220/tests/kraken/driver.html?testName=imaging-desaturate) 07:21:48 INFO - PROCESS | 3645 | RSS: Main: 239210496 07:21:48 INFO - PROCESS | 3645 | 07:21:51 INFO - PROCESS | 3645 | Cycle 1(1): loaded http://localhost:40220/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40220/tests/kraken/driver.html?testName=json-parse-financial) 07:21:51 INFO - PROCESS | 3645 | RSS: Main: 238686208 07:21:51 INFO - PROCESS | 3645 | 07:21:53 INFO - PROCESS | 3645 | Cycle 1(1): loaded http://localhost:40220/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40220/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:21:54 INFO - PROCESS | 3645 | RSS: Main: 225734656 07:21:54 INFO - PROCESS | 3645 | 07:21:55 INFO - PROCESS | 3645 | Cycle 1(1): loaded http://localhost:40220/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40220/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:21:56 INFO - PROCESS | 3645 | RSS: Main: 230797312 07:21:56 INFO - PROCESS | 3645 | 07:21:58 INFO - PROCESS | 3645 | Cycle 1(1): loaded http://localhost:40220/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40220/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:21:59 INFO - PROCESS | 3645 | RSS: Main: 238403584 07:21:59 INFO - PROCESS | 3645 | 07:22:02 INFO - PROCESS | 3645 | Cycle 1(1): loaded http://localhost:40220/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40220/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:22:02 INFO - PROCESS | 3645 | RSS: Main: 240816128 07:22:02 INFO - PROCESS | 3645 | 07:22:05 INFO - PROCESS | 3645 | Cycle 1(1): loaded http://localhost:40220/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40220/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:22:06 INFO - PROCESS | 3645 | RSS: Main: 238460928 07:22:06 INFO - PROCESS | 3645 | 07:22:08 INFO - PROCESS | 3645 | Cycle 1(1): loaded http://localhost:40220/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40220/tests/kraken/driver.html?testName=ai-astar) 07:22:08 INFO - PROCESS | 3645 | RSS: Main: 280682496 07:22:08 INFO - PROCESS | 3645 | 07:22:08 INFO - PROCESS | 3645 | __start_tp_report 07:22:08 INFO - PROCESS | 3645 | _x_x_mozilla_page_load 07:22:08 INFO - PROCESS | 3645 | _x_x_mozilla_page_load_details 07:22:08 INFO - PROCESS | 3645 | |i|pagename|runs| 07:22:08 INFO - PROCESS | 3645 | |0;ai-astar;104;116;113;117;115;114;116;114;114;114 07:22:08 INFO - PROCESS | 3645 | |1;audio-beat-detection;157;131;133;187;131;154;158;132;186;132 07:22:08 INFO - PROCESS | 3645 | |2;audio-dft;163;163;163;161;163;162;163;162;162;161 07:22:08 INFO - PROCESS | 3645 | |3;audio-fft;76;75;75;104;76;76;75;78;98;77 07:22:08 INFO - PROCESS | 3645 | |4;audio-oscillator;86;86;127;86;85;86;116;86;87;136 07:22:08 INFO - PROCESS | 3645 | |5;imaging-gaussian-blur;117;117;116;116;118;117;116;116;117;117 07:22:08 INFO - PROCESS | 3645 | |6;imaging-darkroom;146;146;146;146;146;147;146;146;146;146 07:22:08 INFO - PROCESS | 3645 | |7;imaging-desaturate;96;96;96;95;95;95;95;95;94;94 07:22:08 INFO - PROCESS | 3645 | |8;json-parse-financial;64;63;64;64;64;65;63;63;63;65 07:22:08 INFO - PROCESS | 3645 | |9;json-stringify-tinderbox;64;65;64;64;64;64;65;67;64;65 07:22:08 INFO - PROCESS | 3645 | |10;stanford-crypto-aes;88;82;82;83;83;84;84;85;99;84 07:22:08 INFO - PROCESS | 3645 | |11;stanford-crypto-ccm;135;135;141;131;142;137;127;128;133;131 07:22:08 INFO - PROCESS | 3645 | |12;stanford-crypto-pbkdf2;170;171;168;164;162;166;163;164;164;164 07:22:08 INFO - PROCESS | 3645 | |13;stanford-crypto-sha256-iterative;66;66;66;65;66;66;67;66;65;65 07:22:08 INFO - PROCESS | 3645 | __end_tp_report 07:22:08 INFO - PROCESS | 3645 | __start_cc_report 07:22:08 INFO - PROCESS | 3645 | _x_x_mozilla_cycle_collect,1876 07:22:08 INFO - PROCESS | 3645 | __end_cc_report 07:22:08 INFO - PROCESS | 3645 | __startTimestamp1467123728253__endTimestamp 07:22:08 INFO - PROCESS | 3645 | 07:22:08 INFO - PROCESS | 3645 | ------- Summary: start ------- 07:22:08 INFO - PROCESS | 3645 | Number of tests: 14 07:22:08 INFO - PROCESS | 3645 | 07:22:08 INFO - PROCESS | 3645 | [#0] ai-astar Cycles:10 Average:113.70 Median:114.50 stddev:3.62 (3.2%) stddev-sans-first:1.30 07:22:08 INFO - PROCESS | 3645 | Values: 104.0 116.0 113.0 117.0 115.0 114.0 116.0 114.0 114.0 114.0 07:22:08 INFO - PROCESS | 3645 | 07:22:08 INFO - PROCESS | 3645 | [#1] audio-beat-detection Cycles:10 Average:150.10 Median:155.50 stddev:22.24 (14.3%) stddev-sans-first:23.45 07:22:08 INFO - PROCESS | 3645 | Values: 157.0 131.0 133.0 187.0 131.0 154.0 158.0 132.0 186.0 132.0 07:22:08 INFO - PROCESS | 3645 | 07:22:08 INFO - PROCESS | 3645 | [#2] audio-dft Cycles:10 Average:162.30 Median:163.00 stddev:0.82 (0.5%) stddev-sans-first:0.83 07:22:08 INFO - PROCESS | 3645 | Values: 163.0 163.0 163.0 161.0 163.0 162.0 163.0 162.0 162.0 161.0 07:22:08 INFO - PROCESS | 3645 | 07:22:08 INFO - PROCESS | 3645 | [#3] audio-fft Cycles:10 Average:81.00 Median:76.00 stddev:10.68 (14.0%) stddev-sans-first:11.17 07:22:08 INFO - PROCESS | 3645 | Values: 76.0 75.0 75.0 104.0 76.0 76.0 75.0 78.0 98.0 77.0 07:22:08 INFO - PROCESS | 3645 | 07:22:08 INFO - PROCESS | 3645 | [#4] audio-oscillator Cycles:10 Average:98.10 Median:86.00 stddev:20.05 (23.3%) stddev-sans-first:20.79 07:22:08 INFO - PROCESS | 3645 | Values: 86.0 86.0 127.0 86.0 85.0 86.0 116.0 86.0 87.0 136.0 07:22:08 INFO - PROCESS | 3645 | 07:22:08 INFO - PROCESS | 3645 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.67 (0.6%) stddev-sans-first:0.71 07:22:08 INFO - PROCESS | 3645 | Values: 117.0 117.0 116.0 116.0 118.0 117.0 116.0 116.0 117.0 117.0 07:22:08 INFO - PROCESS | 3645 | 07:22:08 INFO - PROCESS | 3645 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.32 (0.2%) stddev-sans-first:0.33 07:22:08 INFO - PROCESS | 3645 | Values: 146.0 146.0 146.0 146.0 146.0 147.0 146.0 146.0 146.0 146.0 07:22:08 INFO - PROCESS | 3645 | 07:22:08 INFO - PROCESS | 3645 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.74 (0.8%) stddev-sans-first:0.71 07:22:08 INFO - PROCESS | 3645 | Values: 96.0 96.0 96.0 95.0 95.0 95.0 95.0 95.0 94.0 94.0 07:22:08 INFO - PROCESS | 3645 | 07:22:08 INFO - PROCESS | 3645 | [#8] json-parse-financial Cycles:10 Average:63.80 Median:64.00 stddev:0.79 (1.2%) stddev-sans-first:0.83 07:22:08 INFO - PROCESS | 3645 | Values: 64.0 63.0 64.0 64.0 64.0 65.0 63.0 63.0 63.0 65.0 07:22:08 INFO - PROCESS | 3645 | 07:22:08 INFO - PROCESS | 3645 | [#9] json-stringify-tinderbox Cycles:10 Average:64.60 Median:64.50 stddev:0.97 (1.5%) stddev-sans-first:1.00 07:22:08 INFO - PROCESS | 3645 | Values: 64.0 65.0 64.0 64.0 64.0 64.0 65.0 67.0 64.0 65.0 07:22:08 INFO - PROCESS | 3645 | 07:22:08 INFO - PROCESS | 3645 | [#10] stanford-crypto-aes Cycles:10 Average:85.40 Median:84.00 stddev:5.08 (6.0%) stddev-sans-first:5.30 07:22:08 INFO - PROCESS | 3645 | Values: 88.0 82.0 82.0 83.0 83.0 84.0 84.0 85.0 99.0 84.0 07:22:08 INFO - PROCESS | 3645 | 07:22:08 INFO - PROCESS | 3645 | [#11] stanford-crypto-ccm Cycles:10 Average:134.00 Median:135.00 stddev:5.03 (3.7%) stddev-sans-first:5.33 07:22:08 INFO - PROCESS | 3645 | Values: 135.0 135.0 141.0 131.0 142.0 137.0 127.0 128.0 133.0 131.0 07:22:08 INFO - PROCESS | 3645 | 07:22:08 INFO - PROCESS | 3645 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.60 Median:165.00 stddev:3.06 (1.9%) stddev-sans-first:2.80 07:22:08 INFO - PROCESS | 3645 | Values: 170.0 171.0 168.0 164.0 162.0 166.0 163.0 164.0 164.0 164.0 07:22:08 INFO - PROCESS | 3645 | 07:22:08 INFO - PROCESS | 3645 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.80 Median:66.00 stddev:0.63 (1.0%) stddev-sans-first:0.67 07:22:08 INFO - PROCESS | 3645 | Values: 66.0 66.0 66.0 65.0 66.0 66.0 67.0 66.0 65.0 65.0 07:22:08 INFO - PROCESS | 3645 | -------- Summary: end -------- 07:22:08 INFO - PROCESS | 3645 | 07:22:09 INFO - TEST-INFO | 3645: exit 0 07:22:09 INFO - TEST-OK | kraken | took 63559ms 07:22:09 INFO - SUITE-END | took 1185s 07:22:09 INFO - Completed test suite (00:19:45) 07:22:09 INFO - javascript benchmark 07:22:09 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2629.513539995101, 2640.5511063119266, 2679.9866000669995, 2682.436688295459, 2693.461307738453, 4714.811407543702, 4752.928706069408, 4785.1625965456, 4854.490278520753, 4887.8533643990695, 4792.185328494147, 4816.349792777974, 4859.3439885615435, 4868.123737727207, 4954.554090131887, 4399.604035636792, 4415.271480205763, 4463.4643842738915, 4512.706674066191, 4604.1252162089095, 4492.168948744493, 4527.932081018787, 4559.886002849922, 4569.47451043131, 4585.472670642869, 4373.278409062533, 4419.182451246497, 4433.290673492225, 4475.597196252353, 4488.23699971004, 4385.736855788631, 4396.274614688573, 4398.868033958955, 4436.534163912775, 4477.082198149372, 4371.628411585019, 4422.933655995163, 4442.289233722621, 4444.644428445717, 4480.686351955364, 4682.08699303636, 4844.491328410537, 4896.902061958741, 4906.607471402279, 4907.730074845882, 5118.61610379223, 5148.459411761749, 5163.7159956202395, 5182.585393168575, 5240.711760853152, 5197.350331208599, 5242.239875218072, 5252.816151434681, 5269.710165940872, 5276.0, 4719.221328480831, 4834.854954351375, 4880.926786098176, 4890.804367825247, 4894.706317620954, 5378.058839703036, 5420.891582168335, 5425.131978883439, 5448.564114870801, 5475.780968761205, 5164.354455693038, 5170.224466330081, 5209.869753256199, 5211.765470553834, 5219.973900130551, 4970.751462426864, 5079.339685840817, 5165.767540460613, 5247.580193584504, 5257.263983042377, 5132.794688212504, 5138.845834624967, 5139.614528910347, 5157.638965272395, 5164.612654050961, 5102.132637451642, 5118.846434606968, 5119.846404607868, 5125.820596279113, 5176.8964620707375, 4289.356596510548, 4340.565943405634, 4342.044750154961, 4355.499117601453, 4417.801198946056, 3787.147891724395, 3795.886123416302, 3833.9041523962123, 3864.6715029222833, 3878.553966293856, 4438.689291749611, 4447.510773814878, 4449.844255451044, 4485.035717320791, 4488.955110448854, 5039.168537191395, 5183.403908550565, 5185.118529849935, 5192.4547922468355, 5238.057149713089, 4449.065696203834, 4494.640428765691, 4499.730016199039, 4506.932396014063, 4513.616342610849, 4740.288956656529, 4741.2651039089, 4742.715437073718, 4746.169420351424, 4781.856544303677, 4758.976205118952, 4831.758412079453, 4904.166291730343, 4967.577755890789, 4992.825251116194, 5192.532672059533, 5203.505666961632, 5211.843644690665, 5221.164613661796, 5273.050850846885, 4868.123737727243, 4912.214045752662, 4914.434839993446, 4914.64662012537, 4964.106460837084, 4988.850334489971, 5100.617453690914, 5116.2069879168785, 5151.871203219799, 5156.639035267495, 5210.140326846028, 5216.0, 5230.163173892159, 5235.476452354734, 5274.683518988873, 5081.568066714371, 5090.669106508065, 5092.618053645917, 5095.694258344512, 5140.974295128501, 4927.1377508935075, 5038.823641172541, 5066.746662666926, 5081.695098294114, 5103.7192954387865, 5025.723585202702, 5032.773525191302, 5090.41460232078, 5092.516210959953, 5095.617828662939, 5135.87160320995, 5138.306328645585, 5139.511746384088, 5140.43455219933, 5186.533212010937, 4785.138675038526, 4827.686200396963, 4936.284238785428, 5015.899682006412, 5059.924101138412], "value": 4768.694036866106, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [541.9625924961884, 572.8367415286643, 584.7836300568788, 585.6603170161306, 590.2179612014082, 26880.462390752175, 39362.0, 39771.20457590854, 39829.4025589616, 39849.80075099628, 39137.21725565487, 39472.40791388132, 39529.802350988204, 39589.8020509897, 39603.40594891079, 7590.468667193299, 7899.328557072641, 8047.114817370085, 8050.033995920468, 10123.746906327327, 10117.696469105938, 10269.127124194452, 10271.486425678724, 10274.897251027505, 10281.228907831905, 10257.281990260684, 10306.072453479186, 10306.175505959543, 10307.484625768719, 10322.0, 7727.304542591166, 7889.487183333123, 7898.881516777195, 10110.090091891765, 10250.897491025105, 9905.0, 10020.59917603295, 10344.275900686955, 10346.637867674595, 10359.0, 38178.61821381778, 38632.80683596592, 38647.42028869569, 38684.613153868384, 38690.22619547593, 3088.799228050192, 3115.3302040061267, 3353.815540145291, 3772.7170462215167, 3800.923981520354, 29666.0, 29883.551746723817, 29982.850085749433, 30091.849540752155, 30596.694033059608, 3150.4329220740256, 3198.9680103198903, 3199.9600129957626, 3235.660255673144, 3252.7397808175288, 254528.0, 254841.0, 255314.0, 255636.0, 257279.0, 32390.0, 55625.16562251569, 56232.43767562272, 56309.43690563042, 56343.0, 32714.34571308608, 34756.65243347534, 34782.82608586941, 34825.303493930485, 34832.47751283733, 12665.303408312448, 12830.615081547381, 12839.550615728405, 12851.678708032374, 12851.807222891664, 10218.744531386626, 10332.328398654063, 10526.947365263279, 10566.049055585034, 10568.365898046142, 7814.21857814214, 7883.6058197089915, 8010.0, 8090.231428014329, 8139.0, 3189.8245596492416, 3239.4492936200904, 3243.61076670801, 3260.755443341759, 3270.8691652334114, 934.6681927915628, 941.1341565759518, 957.7844984878346, 969.5540051576354, 1025.2823023883163, 23127.421814454774, 24292.392690182533, 24302.392440189138, 24317.0, 24331.39171520726, 971.0774763974252, 981.7349315684868, 1000.9199264058858, 1024.416082832793, 1039.0907955538903, 13162.946964242838, 13399.53101641438, 13714.17714937107, 13862.376193071335, 13907.09603875765, 404057.0, 404501.0, 405561.0, 407338.0, 407374.0, 49622.0, 49807.750961245685, 50005.24992125121, 50015.0, 50184.74907625438, 1100.3507930320989, 1183.378949987559, 1189.3042570096245, 1207.4868181023205, 1207.6135636596205, 27726.44547109087, 29028.0, 29292.853535732185, 29299.414011720073, 29861.0, 40679.38980915229, 40686.38970415505, 41206.793966029974, 41232.58767412287, 41259.587404125574, 296027.0, 298500.0, 299007.0, 299626.0, 299862.0, 22320.66519002184, 22780.772192277866, 22808.20171293997, 22815.31554053381, 22867.656985144902, 41155.0, 41271.1745765077, 41710.374344384254, 42442.0, 42820.35769463398, 34931.65068349284, 35856.05583385773, 36718.8164059178, 36820.0, 36967.44548831823, 35173.64826351704, 35299.29401412009, 35721.82139089288, 35910.461343079354, 36098.0, 34842.82578587091, 34972.82513587517, 36819.07952301214, 36999.63000369962, 37059.81470092632, 30820.537691935086, 32508.837455813515, 33273.667263328025, 33295.0, 33320.1669958253, 23567.0, 23948.64077038811, 24093.377194721, 24158.516829662956, 24423.633645494978], "value": 16783.450791350828, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [376.08048321853073, 376.4917361561891, 377.81487071335056, 387.3550538353641, 390.4514157608559, 15922.68154636908, 16451.670966580677, 17248.31006759731, 17293.740593891085, 17853.553661158476, 11800.291982481058, 15660.0, 16462.094584797862, 16480.0, 17272.395466158687, 3536.770109942858, 4672.065586882629, 4888.41339039314, 4888.9511104889025, 4891.926621100686, 3654.5979942206336, 5240.973795131038, 5497.752601132958, 5507.256520369759, 5582.637128586629, 5261.421243663213, 5517.613767036309, 5544.0575102232715, 5552.583556233279, 5569.554435645159, 3472.5138480612736, 5413.864653383657, 5549.0289199389945, 5552.167174923753, 5554.611177217596, 5155.097857874857, 5478.506934375925, 5483.0, 5485.259489968883, 5486.177073439016, 12317.692057698629, 12347.0, 12513.562025329069, 12541.874581254253, 12587.181833180814, 1883.8398736107447, 1946.581484980736, 1948.3667807962327, 1991.4822146241936, 2050.589882023586, 8821.823563528758, 9257.398269112486, 9300.162985331353, 9742.0, 9746.853797193047, 1770.7673823850491, 1793.7847458305087, 1810.6107186954869, 1843.6312737452429, 1845.3541260558832, 60206.69896650489, 65868.0, 67267.0, 74187.25812741912, 74362.62818685926, 15117.70880191946, 15667.216639167997, 16099.517014489584, 16191.514254572146, 16314.75527867083, 28841.56737648937, 29062.854685726437, 29067.273318166794, 29218.7078129216, 29291.0, 8448.83102337962, 8745.606447709868, 8792.076831932683, 8849.407106720852, 8933.776655583662, 7202.135743710788, 7212.567245965259, 7341.0, 7414.962925185339, 7415.592142432218, 8124.4684078847185, 8359.578871591844, 8505.489670619783, 8558.44370115953, 8597.355198360148, 2604.3749500119834, 3391.338688955679, 3411.607665118543, 3429.9657003430148, 3430.9313813723584, 695.9898439250263, 734.4124700239787, 787.142344067999, 843.9957800210959, 937.6483818568037, 16583.419580314872, 16606.335746570243, 16722.916385418237, 16751.6649667006, 17201.483955481355, 867.9305655547668, 870.3602851903846, 875.5228400521731, 877.5743764274322, 922.8523436250168, 9211.493367864832, 9262.44425334482, 9509.476978766234, 9520.666776662783, 9628.9037109628, 359669.0, 360709.0, 370236.0, 386534.0, 390480.0, 49668.25497617538, 75076.62461687656, 79081.0, 79437.0, 80875.0, 851.0893344121854, 888.8177923525661, 892.1747383670079, 899.1952202778476, 900.3787386703154, 14270.785938211142, 14748.483803066842, 14860.108393496424, 14887.181205033827, 15223.238838058274, 34979.47530786989, 35511.289774203855, 36318.45522317114, 36827.26345473022, 36880.81559592185, 48200.75899620479, 52200.47799521956, 52418.213726793365, 52612.47387526076, 52701.20948185703, 4698.459677137173, 4799.112164249625, 6790.626515541692, 6954.165500140016, 7645.1972542882195, 10669.626563070255, 11628.069754419796, 12141.08941829384, 12452.31512266834, 12550.0, 10199.133073688523, 10309.690709278733, 10599.258051936291, 10637.202209834448, 10714.410707410856, 9994.10053095225, 10206.897931020594, 10478.37129772216, 10822.945885270523, 10871.565137394731, 10305.381677099398, 10382.494538292056, 10412.271141020055, 10456.738581535523, 10571.682849514527, 7175.2499227556955, 7254.455915806441, 7350.96324518374, 7404.481686281909, 7445.590492522963, 9563.234941204826, 10530.631427899987, 10631.94684026575, 10710.250282480463, 10862.891371086187], "value": 8575.655139774044, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1170.8360829483868, 1315.0860152194223, 1362.4345896452971, 1413.985860141399, 1705.5480297721106, 6728.428083612893, 7487.475876688627, 7734.845303093949, 7768.1843406442285, 7939.92060079399, 7668.271514206155, 7812.570308633023, 7815.648295826687, 7820.100688420834, 7823.335016523588, 1832.1663643042384, 2125.4155107345528, 2180.5965896309194, 2208.8785116818567, 2227.1536816009893, 2233.062113912161, 2256.627656436686, 2257.6726374675663, 2260.8304377171694, 2262.490939538607, 2196.6595177747395, 2207.4481379655085, 2230.654248591471, 2233.4416395901026, 2234.0393630738777, 1825.3976187857975, 1884.4252502986583, 1886.56608979934, 2160.0387827416807, 2200.207925146954, 2173.4457713283014, 2210.812080973119, 2212.61279276126, 2214.0590249144047, 2214.9557008859892, 7795.727149549739, 7812.140664526897, 7848.7645370638975, 7855.214478552156, 7857.764267071997, 4532.0, 4666.043461090469, 4670.883227919295, 4673.906521869578, 4677.64917631179, 2830.1933948824485, 2921.21127295629, 2957.497225471675, 2962.3630919352227, 3033.4994725870206, 1006.8842083160457, 1019.8062368150028, 1048.2609760119099, 1052.9262951593391, 1060.363781730963, 10868.945655271753, 10879.83680244797, 10887.618933337295, 10893.945530272298, 10937.234393592451, 4207.579242075768, 4268.146370725805, 4272.08150247692, 4353.412289340962, 4391.407160033418, 9280.860787088199, 9308.115729005734, 9342.766430839283, 9352.392094513834, 9353.672621458216, 4728.05438912219, 4732.952670473252, 4743.928841067387, 4747.454042785055, 4751.073540659608, 3736.887893363149, 4065.0, 4186.58134186585, 4197.412362269285, 4244.91510169801, 3616.710663146942, 3696.2237930034457, 3732.9734323060834, 3752.9249415011545, 3796.7911764852647, 1193.612076075279, 1201.6335017819474, 1209.2804781155373, 1209.8064309710403, 1212.8180772883961, 836.1471299274828, 844.160060739568, 863.5034854958424, 883.4875772052194, 895.1048951048951, 5442.591805614595, 5500.50495455411, 5528.336599607992, 5621.634593751475, 5712.571557133231, 880.854658981261, 898.4564338575068, 899.8290324838259, 909.9954500227589, 917.8110207155981, 3996.6827533147416, 4010.939835902464, 4061.7969101544804, 4141.4616099907425, 4154.750714957112, 9623.278254130968, 9755.951220243853, 9819.558119884623, 9857.112859842506, 9878.654247101316, 9791.314607977516, 9810.166135878388, 9815.509224538744, 9816.65641702537, 9830.066143716336, 7023.578585284899, 7137.785866423912, 7316.926830731731, 7318.048653675095, 7383.630818459055, 5447.891042179055, 5492.725363731877, 5497.175423686479, 5514.61397702157, 5628.240187574625, 8877.511736854534, 8952.0, 8962.462252264884, 8999.0, 9050.637974480947, 8605.182507661762, 8972.730818075468, 8978.685745998859, 9281.350305478552, 9307.627694892128, 6610.6694665267505, 7103.218645949045, 7268.96365518169, 7289.671964761493, 7457.477976541807, 7599.848003039798, 7609.923900760921, 7667.88498172539, 7681.385489160742, 7681.423893208143, 6589.374009469093, 6641.203055633355, 6735.393814556714, 6830.556013859282, 6832.043513907957, 6748.358905903931, 6776.085228494288, 6798.0, 6843.452523797984, 6851.246362899978, 5951.107333899777, 6087.878242435215, 6128.816135515942, 6136.754529818757, 6147.569670123048, 4672.906541869212, 4680.92978605328, 4729.929051064306, 4782.928256076231, 4841.975790121168, 4697.177993850994, 4722.173619616485, 4943.209086546135, 4946.060248552907, 4958.305837182726], "value": 4213.9559395432, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [308.36476857673193, 314.410480349345, 315.241843366703, 317.2259686365267, 317.774380190065, 4879.048585525824, 4929.658412254177, 4944.703317800934, 4954.232094025428, 4962.454130045701, 4777.426708794949, 4779.426468823737, 4816.63875209359, 4859.805607775694, 4865.562099411052, 3632.7638703484254, 3753.3431649461236, 3754.5494540655022, 3823.1780167264033, 3846.288436639217, 3826.1773718650484, 3846.8653597124107, 3856.652901238888, 3862.9806850965706, 3863.343231650612, 3644.3257997270457, 3806.4861243732157, 3832.2718683450194, 3836.9808150959207, 3847.4228865670234, 3682.55809302884, 3767.6797472214757, 3794.165283637595, 3805.06775839921, 3806.276807406584, 3336.616289126733, 3353.161709572607, 3359.378514974713, 3362.0586235853757, 3371.9325613487595, 4759.690620109682, 4778.116048531033, 4782.689125206885, 4793.514010656672, 4796.280557916306, 4262.552431994627, 4392.363107349448, 4397.47230332359, 4398.33900490202, 4407.449068866392, 5058.924116138261, 5073.949260507385, 5091.159958606825, 5097.643164978453, 5103.260027296058, 3724.9813750931344, 3729.4219395993664, 3744.2511497700298, 3745.1011757178353, 3774.2262836118803, 5083.135866902636, 5257.500537448898, 5274.7626356814035, 5365.892682146336, 5371.442281738291, 3772.7359084863797, 3782.527184101987, 3789.03379638196, 3802.144517483544, 3819.1597848473293, 3849.268638958589, 3849.942250866239, 3868.458415821787, 3897.3179693553516, 3907.0, 4325.329573916048, 4343.2182207203, 4344.283193273074, 4357.346398040256, 4383.780810959439, 4806.49531799163, 5047.662369472093, 5059.797608095635, 5062.544371006627, 5077.669951453144, 1288.845338559379, 1312.7440149171011, 1315.1320128715001, 1317.1899281941728, 1322.8214191084273, 835.5362773660677, 840.6259214649544, 860.4364141487335, 864.312871267344, 864.5331520978726, 4438.134563760036, 4449.199144154083, 4451.3323001550025, 4465.173942820588, 4468.352088947085, 5196.142636464941, 5210.244514545369, 5223.895522089613, 5231.790728370823, 5233.39815921174, 4258.67980925914, 4428.446444194476, 4457.665675074318, 4468.731876087445, 4583.656225783079, 2799.1805326537915, 2809.578563215493, 2811.831290122599, 2819.6898341182455, 2827.4203788223363, 4956.132676781621, 4965.478624744422, 4975.258659469157, 4983.377077865267, 5013.0, 5105.412877519133, 5423.294971653739, 5428.4842939920645, 5432.6468779529205, 5444.237806707064, 4939.3084968104495, 4939.827106051271, 4964.379452568429, 4970.6023518117745, 4976.203807390945, 5290.365156181283, 5295.576353891603, 5322.54758345545, 5330.0, 5346.304980352529, 4917.827876024322, 5180.19706945409, 5200.427952925251, 5206.323177986837, 5210.609204309768, 4968.130577149057, 4996.325496058131, 5000.974995125001, 5001.874953126201, 5036.917062831509, 3736.458213559073, 3766.0, 3780.5652349979005, 3787.1100291432044, 3791.7914514701956, 5144.228365745168, 5271.71005594696, 5294.576433885203, 5298.0, 5388.649737767033, 5100.617453691062, 5126.667066562646, 5134.510991812333, 5136.512031357015, 5154.201098829687, 5007.949920500894, 5085.338905942203, 5116.897662046813, 5138.563222126161, 5143.2285157225215, 4759.762011899322, 4881.9023619528125, 5028.094942910311, 5029.1953287473825, 5045.747712614281, 4945.2582112683385, 5164.870878228075, 5199.792008319625, 5206.375234971828, 5212.713300768342, 5063.569596584184, 5073.974630126826, 5096.566791822736, 5097.745112744422, 5107.0], "value": 3866.693849881169, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [647.7182425644845, 666.2671061831983, 684.0594182998377, 697.2748341724605, 710.037898647333, 12208.877911220885, 13458.663533411669, 13514.864851351484, 13535.52625658102, 13537.187768733882, 12463.252204867715, 12575.622731318052, 12579.622611321674, 12583.874161258385, 12599.118061735659, 615.9507239420835, 744.9962750186241, 764.7285213749122, 774.601080443572, 779.1118125337092, 775.1318523253935, 778.7624774443792, 781.1407451803, 781.613101514751, 781.6560713286165, 836.6444261189001, 838.2623291503469, 838.5471845203583, 838.6938767349934, 838.8657814749611, 644.1368566121397, 795.0697683710073, 824.5629816197365, 826.4421515477029, 829.4069740135802, 565.8528782516576, 568.4656422962402, 568.7696482924422, 568.8407245971134, 574.0270241939913, 12816.0, 12854.55009074678, 12859.485620575166, 12862.292573908431, 12864.29246391448, 12516.436760345716, 13091.47634094635, 13105.410256538478, 13367.131136476195, 13452.32738363078, 11452.141089418326, 11510.42447877611, 11540.884591154148, 11577.652670419817, 11825.290482570987, 4135.069609337905, 4159.126583417486, 4201.810918508674, 4219.409282700424, 4291.678124140702, 58122.0, 58170.0, 58613.41386586122, 59539.70230148865, 59569.7021514894, 10417.218708596885, 10421.68734937953, 10429.530671119817, 10472.947635261928, 10535.736606584744, 18381.724274135897, 18389.632207356044, 18390.540236493925, 18464.538386540175, 18494.722579161324, 6543.411093001652, 6611.636360000246, 6647.6676166192465, 6664.633445160563, 6722.563033402813, 3619.529461170031, 3622.094476380905, 3673.265346930571, 3743.0455233915177, 3744.213715119801, 2671.0784779251126, 2764.4747497975322, 2764.7097054809356, 2765.889364425441, 2771.2517620242825, 483.6976889444097, 495.72734995752194, 507.55335304931424, 510.5303121128571, 511.7927239467947, 507.92635067914944, 538.8087229033715, 542.8018773147772, 547.9068558345091, 560.3052215253139, 6925.411340036153, 6945.131858517685, 7193.136823581099, 7373.156710822294, 7478.2521747824785, 404.52872403649417, 455.58086560364546, 458.37431905448824, 477.7730577975434, 508.09305389879626, 3400.5018933252118, 3410.300888317889, 3447.87932422369, 3464.2032332563654, 3515.3848076586496, 51993.0, 52607.0, 53717.46282537203, 62579.6871015642, 94356.0, 78785.0, 79674.80487792687, 81439.18560814434, 82390.0, 84953.57523212468, 73125.0, 73548.26451735522, 73635.63182184055, 73811.26188738045, 74748.0, 6516.446102081376, 6532.020196970492, 6620.271770105381, 6653.767118150841, 6655.500837437115, 41810.58189418067, 42879.79481163733, 43133.784331078146, 43198.136037279706, 43369.56630433655, 58697.413025869195, 63338.683306583174, 63920.680396597716, 64398.0, 64651.67674161787, 8637.309015278637, 8693.913060869563, 8928.285737141143, 8937.73186804397, 9228.40015398997, 10331.535080921227, 10357.533910974174, 10406.935967647996, 10496.317739346918, 10727.785444291227, 9879.407235565888, 9976.0, 10008.64969726056, 10231.539580718736, 10392.42841643717, 10164.440955747505, 10311.896881031094, 11183.608573699881, 11243.831342530033, 11309.151813614177, 10549.789004220027, 10696.62561810333, 10823.188260880623, 11409.17921683024, 12317.07621928341, 9609.663661771805, 10075.496225188564, 10167.237457190593, 10227.7443063924, 10363.730903508675, 9624.326297159132, 10034.397936123856, 10347.223958203014, 10377.9481102594, 10488.0], "value": 6218.085964871453, "unit": "score"}], "name": "dromaeo_css", "value": 6412.787233453772, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 116.0, 113.0, 117.0, 115.0, 114.0, 116.0, 114.0, 114.0, 114.0], "value": 113.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 131.0, 133.0, 187.0, 131.0, 154.0, 158.0, 132.0, 186.0, 132.0], "value": 150.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 163.0, 161.0, 163.0, 162.0, 163.0, 162.0, 162.0, 161.0], "value": 162.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 75.0, 104.0, 76.0, 76.0, 75.0, 78.0, 98.0, 77.0], "value": 81.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 127.0, 86.0, 85.0, 86.0, 116.0, 86.0, 87.0, 136.0], "value": 98.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 116.0, 118.0, 117.0, 116.0, 116.0, 117.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 146.0, 147.0, 146.0, 146.0, 146.0, 146.0], "value": 146.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 94.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 64.0, 64.0, 64.0, 65.0, 63.0, 63.0, 63.0, 65.0], "value": 63.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 64.0, 64.0, 64.0, 64.0, 65.0, 67.0, 64.0, 65.0], "value": 64.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 82.0, 82.0, 83.0, 83.0, 84.0, 84.0, 85.0, 99.0, 84.0], "value": 85.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 135.0, 141.0, 131.0, 142.0, 137.0, 127.0, 128.0, 133.0, 131.0], "value": 134.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 171.0, 168.0, 164.0, 162.0, 166.0, 163.0, 164.0, 164.0, 164.0], "value": 165.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 66.0, 65.0, 66.0, 66.0, 67.0, 66.0, 65.0, 65.0], "value": 65.8, "unit": "score"}], "name": "kraken", "value": 1542.3, "alertThreshold": 2.0}]} 07:22:09 INFO - Return code: 0 07:22:09 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:22:09 INFO - # TBPL SUCCESS # 07:22:09 INFO - Running post-action listener: _resource_record_post_action 07:22:09 INFO - ##### 07:22:09 INFO - ##### Finished run-tests step (success) 07:22:09 INFO - ##### 07:22:09 INFO - Running post-run listener: _resource_record_post_run 07:22:09 INFO - Total resource usage - Wall time: 1203s; CPU: 13.0%; Read bytes: 7827456; Write bytes: 373149696; Read time: 952; Write time: 293668 07:22:09 INFO - TinderboxPrint: CPU usage
13.1% 07:22:09 INFO - TinderboxPrint: I/O read bytes / time
7,827,456 / 952 07:22:09 INFO - TinderboxPrint: I/O write bytes / time
373,149,696 / 293,668 07:22:09 INFO - TinderboxPrint: CPU idle
8,338.9 (86.9%) 07:22:09 INFO - TinderboxPrint: CPU user
1,213.4 (12.6%) 07:22:09 INFO - TinderboxPrint: Swap in / out
0 / 0 07:22:09 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 94945280; Read time: 0; Write time: 81860 07:22:09 INFO - run-tests - Wall time: 1187s; CPU: 13.0%; Read bytes: 6066176; Write bytes: 278204416; Read time: 904; Write time: 211808 07:22:10 INFO - Running post-run listener: _upload_blobber_files 07:22:10 INFO - Blob upload gear active. 07:22:10 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:22:10 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 07:22:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:22:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:22:10 INFO - (blobuploader) - INFO - Open directory for files ... 07:22:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:22:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:22:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:22:14 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:22:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:22:14 INFO - (blobuploader) - INFO - Done attempting. 07:22:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:22:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:22:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:22:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:22:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:22:15 INFO - (blobuploader) - INFO - Done attempting. 07:22:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:22:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:22:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:22:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:22:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:22:15 INFO - (blobuploader) - INFO - Done attempting. 07:22:15 INFO - (blobuploader) - INFO - Iteration through files over. 07:22:15 INFO - Return code: 0 07:22:15 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:22:15 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:22:15 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5b3c9910cebc0db7231e32f7aea5eaaeabc53e275bc51a9ef1d38d6662674ffb211fbf77483d1bdb71490eacfc6a2229cfc1d5e2e271504d2abe6cb8f811f9e1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/565c772a3360f02d0df62669bee5a82e72b8d6f0feb5e8c42f53cefb7ca0179041b620a086b8c71e14a114e80492b969f3cd3e8f853da0124eaa8948e5e91d2b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3b9c72ae5755a0b80526c79e01588018796f1594fab1116b18c7a77162b3733c22ea890bdb0b102087b40c9e4e2cbb7c1a306fc17a4de0753d0d68171ba5c8a2"} 07:22:15 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:22:15 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:22:15 INFO - Contents: 07:22:15 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5b3c9910cebc0db7231e32f7aea5eaaeabc53e275bc51a9ef1d38d6662674ffb211fbf77483d1bdb71490eacfc6a2229cfc1d5e2e271504d2abe6cb8f811f9e1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/565c772a3360f02d0df62669bee5a82e72b8d6f0feb5e8c42f53cefb7ca0179041b620a086b8c71e14a114e80492b969f3cd3e8f853da0124eaa8948e5e91d2b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3b9c72ae5755a0b80526c79e01588018796f1594fab1116b18c7a77162b3733c22ea890bdb0b102087b40c9e4e2cbb7c1a306fc17a4de0753d0d68171ba5c8a2"} 07:22:15 INFO - Running post-run listener: copy_logs_to_upload_dir 07:22:15 INFO - Copying logs to upload dir... 07:22:15 INFO - mkdir: /builds/slave/test/build/upload/logs 07:22:15 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1273.412584 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-06-28 07:22:15.750975) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-28 07:22:15.754947) ========= 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=d2a8c569965ab8367867b893000001a1-1467122374.804559-1305311035 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5b3c9910cebc0db7231e32f7aea5eaaeabc53e275bc51a9ef1d38d6662674ffb211fbf77483d1bdb71490eacfc6a2229cfc1d5e2e271504d2abe6cb8f811f9e1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/565c772a3360f02d0df62669bee5a82e72b8d6f0feb5e8c42f53cefb7ca0179041b620a086b8c71e14a114e80492b969f3cd3e8f853da0124eaa8948e5e91d2b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3b9c72ae5755a0b80526c79e01588018796f1594fab1116b18c7a77162b3733c22ea890bdb0b102087b40c9e4e2cbb7c1a306fc17a4de0753d0d68171ba5c8a2"} build_url:https://queue.taskcluster.net/v1/task/NtsGEXtBSv2NMlHQzSzEVQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011056 build_url: 'https://queue.taskcluster.net/v1/task/NtsGEXtBSv2NMlHQzSzEVQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/5b3c9910cebc0db7231e32f7aea5eaaeabc53e275bc51a9ef1d38d6662674ffb211fbf77483d1bdb71490eacfc6a2229cfc1d5e2e271504d2abe6cb8f811f9e1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/565c772a3360f02d0df62669bee5a82e72b8d6f0feb5e8c42f53cefb7ca0179041b620a086b8c71e14a114e80492b969f3cd3e8f853da0124eaa8948e5e91d2b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3b9c72ae5755a0b80526c79e01588018796f1594fab1116b18c7a77162b3733c22ea890bdb0b102087b40c9e4e2cbb7c1a306fc17a4de0753d0d68171ba5c8a2"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-28 07:22:15.780888) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 07:22:15.781219) ========= 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=d2a8c569965ab8367867b893000001a1-1467122374.804559-1305311035 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004310 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 07:22:15.865719) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-28 07:22:15.866021) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-28 07:22:15.866301) ========= ========= Total master_lag: 0.22 =========