builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-060 starttime: 1466996725.53 results: success (0) buildid: 20160626173008 builduid: 1048c84d6b4745c3b323e55cfdf449ed revision: 110c7ad7d399d16b9c77940f766a26df5d90f881 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-26 20:05:25.535430) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-26 20:05:25.536648) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-26 20:05:25.536990) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-26 20:05:25.585539) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-26 20:05:25.586011) ========= 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=337fe3f4b1febe37b85fccc40000019e-1466994791.249134-1438017817 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-26 20:05:26-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 65.4M=0s 2016-06-26 20:05:26 (65.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.073674 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-26 20:05:25.678690) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-26 20:05:25.679211) ========= 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=337fe3f4b1febe37b85fccc40000019e-1466994791.249134-1438017817 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019197 ========= master_lag: 0.07 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-26 20:05:25.763430) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-06-26 20:05:25.763816) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 110c7ad7d399d16b9c77940f766a26df5d90f881 --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 110c7ad7d399d16b9c77940f766a26df5d90f881 --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=337fe3f4b1febe37b85fccc40000019e-1466994791.249134-1438017817 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-26 20:05:26,288 truncating revision to first 12 chars 2016-06-26 20:05:26,288 Setting DEBUG logging. 2016-06-26 20:05:26,288 attempt 1/10 2016-06-26 20:05:26,288 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/110c7ad7d399?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-26 20:05:27,908 unpacking tar archive at: fx-team-110c7ad7d399/testing/mozharness/ program finished with exit code 0 elapsedTime=1.950966 ========= master_lag: 0.06 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-06-26 20:05:27.774647) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-26 20:05:27.775084) ========= script_repo_revision: 110c7ad7d399d16b9c77940f766a26df5d90f881 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-26 20:05:27.775572) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-26 20:05:27.775890) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-26 20:05:27.786971) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-06-26 20:05:27.787357) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=337fe3f4b1febe37b85fccc40000019e-1466994791.249134-1438017817 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20:05:28 INFO - MultiFileLogger online at 20160626 20:05:28 in /builds/slave/test 20:05:28 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 20:05:28 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:05:28 INFO - {'append_to_log': False, 20:05:28 INFO - 'base_work_dir': '/builds/slave/test', 20:05:28 INFO - 'blob_upload_branch': 'Fx-Team', 20:05:28 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:05:28 INFO - 'branch': 'Fx-Team', 20:05:28 INFO - 'buildbot_json_path': 'buildprops.json', 20:05:28 INFO - 'config_files': ('talos/linux_config.py',), 20:05:28 INFO - 'default_actions': ('clobber', 20:05:28 INFO - 'read-buildbot-config', 20:05:28 INFO - 'download-and-extract', 20:05:28 INFO - 'populate-webroot', 20:05:28 INFO - 'create-virtualenv', 20:05:28 INFO - 'install', 20:05:28 INFO - 'run-tests'), 20:05:28 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:05:28 INFO - 'download_minidump_stackwalk': True, 20:05:28 INFO - 'download_symbols': 'ondemand', 20:05:28 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:05:28 INFO - 'tooltool.py': '/tools/tooltool.py', 20:05:28 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:05:28 INFO - '/tools/misc-python/virtualenv.py')}, 20:05:28 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:05:28 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:05:28 INFO - 'installer_path': 'installer.exe', 20:05:28 INFO - 'log_level': 'info', 20:05:28 INFO - 'log_name': 'talos', 20:05:28 INFO - 'log_to_console': True, 20:05:28 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 20:05:28 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 20:05:28 INFO - 'opt_config_files': (), 20:05:28 INFO - 'pip_index': False, 20:05:28 INFO - 'sps_profile': False, 20:05:28 INFO - 'sps_profile_interval': 0, 20:05:28 INFO - 'suite': 'dromaeojs', 20:05:28 INFO - 'system_bits': '32', 20:05:28 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:05:28 INFO - 'title': 'talos-linux64-ix-060', 20:05:28 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:05:28 INFO - 'use_talos_json': True, 20:05:28 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:05:28 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:05:28 INFO - 'work_dir': 'build'} 20:05:28 INFO - ##### 20:05:28 INFO - ##### Running clobber step. 20:05:28 INFO - ##### 20:05:28 INFO - Running pre-action listener: _resource_record_pre_action 20:05:28 INFO - Running main action method: clobber 20:05:28 INFO - rmtree: /builds/slave/test/build 20:05:28 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:05:28 INFO - Running post-action listener: _resource_record_post_action 20:05:28 INFO - ##### 20:05:28 INFO - ##### Finished clobber step (success) 20:05:28 INFO - ##### 20:05:28 INFO - ##### 20:05:28 INFO - ##### Running read-buildbot-config step. 20:05:28 INFO - ##### 20:05:28 INFO - Running pre-action listener: _resource_record_pre_action 20:05:28 INFO - Running main action method: read_buildbot_config 20:05:28 INFO - Using buildbot properties: 20:05:28 INFO - { 20:05:28 INFO - "project": "", 20:05:28 INFO - "product": "firefox", 20:05:28 INFO - "script_repo_revision": "production", 20:05:28 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 20:05:28 INFO - "repository": "", 20:05:28 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 20:05:28 INFO - "buildid": "20160626173008", 20:05:28 INFO - "pgo_build": "True", 20:05:28 INFO - "basedir": "/builds/slave/test", 20:05:28 INFO - "buildnumber": 216, 20:05:28 INFO - "slavename": "talos-linux64-ix-060", 20:05:28 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 20:05:28 INFO - "platform": "ubuntu64_hw", 20:05:28 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 20:05:28 INFO - "branch": "fx-team", 20:05:28 INFO - "repo_path": "integration/fx-team", 20:05:28 INFO - "revision": "110c7ad7d399d16b9c77940f766a26df5d90f881", 20:05:28 INFO - "stage_platform": "linux64-pgo", 20:05:28 INFO - "builduid": "1048c84d6b4745c3b323e55cfdf449ed", 20:05:28 INFO - "slavebuilddir": "test" 20:05:28 INFO - } 20:05:28 INFO - Found installer url https://queue.taskcluster.net/v1/task/IG3vjAsMQomR6u3qUUOzoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 20:05:28 INFO - Running post-action listener: _resource_record_post_action 20:05:28 INFO - ##### 20:05:28 INFO - ##### Finished read-buildbot-config step (success) 20:05:28 INFO - ##### 20:05:28 INFO - ##### 20:05:28 INFO - ##### Running download-and-extract step. 20:05:28 INFO - ##### 20:05:28 INFO - Running pre-action listener: _resource_record_pre_action 20:05:28 INFO - Running main action method: download_and_extract 20:05:28 INFO - mkdir: /builds/slave/test/build/tests 20:05:28 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')]} 20:05:28 INFO - https://queue.taskcluster.net/v1/task/IG3vjAsMQomR6u3qUUOzoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 20:05:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IG3vjAsMQomR6u3qUUOzoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 20:05:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IG3vjAsMQomR6u3qUUOzoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 20:05:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IG3vjAsMQomR6u3qUUOzoA/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 20:05:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IG3vjAsMQomR6u3qUUOzoA/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 20:05:31 INFO - Downloaded 1361 bytes. 20:05:31 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 20:05:31 INFO - Using the following test package requirements: 20:05:31 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 20:05:31 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:05:31 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 20:05:31 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:05:31 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 20:05:31 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:05:31 INFO - u'jsshell-linux-x86_64.zip'], 20:05:31 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:05:31 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 20:05:31 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 20:05:31 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:05:31 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 20:05:31 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:05:31 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 20:05:31 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:05:31 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 20:05:31 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:05:31 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 20:05:31 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 20:05:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:05:31 INFO - https://queue.taskcluster.net/v1/task/IG3vjAsMQomR6u3qUUOzoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:05:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IG3vjAsMQomR6u3qUUOzoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 20:05:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IG3vjAsMQomR6u3qUUOzoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 20:05:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IG3vjAsMQomR6u3qUUOzoA/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 20:05:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IG3vjAsMQomR6u3qUUOzoA/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 20:05:42 INFO - Downloaded 24279422 bytes. 20:05:42 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'] 20:05:42 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 20:05:43 INFO - Return code: 0 20:05:43 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 20:05: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')]} 20:05:43 INFO - https://queue.taskcluster.net/v1/task/IG3vjAsMQomR6u3qUUOzoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:05:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IG3vjAsMQomR6u3qUUOzoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 20:05:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IG3vjAsMQomR6u3qUUOzoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 20:05:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IG3vjAsMQomR6u3qUUOzoA/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 20:05:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IG3vjAsMQomR6u3qUUOzoA/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 20:05:45 INFO - Downloaded 24279422 bytes. 20:05:45 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 20:05:45 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 20:05:46 INFO - Return code: 0 20:05:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:05:46 INFO - https://queue.taskcluster.net/v1/task/IG3vjAsMQomR6u3qUUOzoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 20:05:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IG3vjAsMQomR6u3qUUOzoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 20:05:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IG3vjAsMQomR6u3qUUOzoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 20:05:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IG3vjAsMQomR6u3qUUOzoA/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 20:05:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IG3vjAsMQomR6u3qUUOzoA/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 20:05:47 INFO - Downloaded 14405240 bytes. 20:05:47 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'] 20:05:47 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 20:05:48 INFO - Return code: 0 20:05:48 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')]} 20:05:48 INFO - https://queue.taskcluster.net/v1/task/IG3vjAsMQomR6u3qUUOzoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 20:05:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IG3vjAsMQomR6u3qUUOzoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 20:05:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IG3vjAsMQomR6u3qUUOzoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 20:05:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IG3vjAsMQomR6u3qUUOzoA/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 20:05:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IG3vjAsMQomR6u3qUUOzoA/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 20:05:49 INFO - Downloaded 60158240 bytes. 20:05:49 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/IG3vjAsMQomR6u3qUUOzoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 20:05:49 INFO - mkdir: /builds/slave/test/properties 20:05:49 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:05:49 INFO - Writing to file /builds/slave/test/properties/build_url 20:05:49 INFO - Contents: 20:05:49 INFO - build_url:https://queue.taskcluster.net/v1/task/IG3vjAsMQomR6u3qUUOzoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 20:05:50 INFO - Running post-action listener: _resource_record_post_action 20:05:50 INFO - Running post-action listener: set_extra_try_arguments 20:05:50 INFO - ##### 20:05:50 INFO - ##### Finished download-and-extract step (success) 20:05:50 INFO - ##### 20:05:50 INFO - ##### 20:05:50 INFO - ##### Running populate-webroot step. 20:05:50 INFO - ##### 20:05:50 INFO - Running pre-action listener: _resource_record_pre_action 20:05:50 INFO - Running main action method: populate_webroot 20:05:50 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:05:50 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:05:50 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:05:50 INFO - '--tppagecycles', 20:05:50 INFO - '7'], 20:05:50 INFO - 'tests': ['tsvgm']}}, 20:05:50 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:05:50 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:05:50 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:05:50 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:05:50 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:05:50 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:05:50 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:05:50 INFO - 'talos_options': ['--disable-e10s'], 20:05:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:05:50 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:05:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:05:50 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:05:50 INFO - 'talos_options': ['--disable-e10s'], 20:05:50 INFO - 'tests': ['damp', 'tps']}, 20:05:50 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:05:50 INFO - 'tests': ['damp', 'tps']}, 20:05:50 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:05:50 INFO - 'tests': ['dromaeo_dom']}, 20:05:50 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:05:50 INFO - 'g4': {'talos_options': ['--disable-e10s'], 20:05:50 INFO - 'tests': ['basic_compositor_video']}, 20:05:50 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 20:05:50 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:05:50 INFO - 'tests': ['a11yr', 20:05:50 INFO - 'ts_paint', 20:05:50 INFO - 'tpaint', 20:05:50 INFO - 'sessionrestore', 20:05:50 INFO - 'sessionrestore_no_auto_restore', 20:05:50 INFO - 'tabpaint']}, 20:05:50 INFO - 'other-e10s': {'tests': ['a11yr', 20:05:50 INFO - 'ts_paint', 20:05:50 INFO - 'tpaint', 20:05:50 INFO - 'sessionrestore', 20:05:50 INFO - 'sessionrestore_no_auto_restore', 20:05:50 INFO - 'tabpaint']}, 20:05:50 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:05:50 INFO - 'ts_paint', 20:05:50 INFO - 'tpaint', 20:05:50 INFO - 'sessionrestore', 20:05:50 INFO - 'sessionrestore_no_auto_restore', 20:05:50 INFO - 'tabpaint']}, 20:05:50 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:05:50 INFO - 'ts_paint', 20:05:50 INFO - 'tpaint', 20:05:50 INFO - 'sessionrestore', 20:05:50 INFO - 'sessionrestore_no_auto_restore', 20:05:50 INFO - 'tabpaint']}, 20:05:50 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:05:50 INFO - 'tests': ['a11yr', 20:05:50 INFO - 'ts_paint', 20:05:50 INFO - 'tpaint', 20:05:50 INFO - 'sessionrestore', 20:05:50 INFO - 'sessionrestore_no_auto_restore', 20:05:50 INFO - 'tabpaint']}, 20:05:50 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:05:50 INFO - 'tests': ['a11yr', 20:05:50 INFO - 'ts_paint', 20:05:50 INFO - 'tpaint', 20:05:50 INFO - 'sessionrestore', 20:05:50 INFO - 'sessionrestore_no_auto_restore', 20:05:50 INFO - 'tabpaint']}, 20:05:50 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:05:50 INFO - 'tests': ['tsvgx', 20:05:50 INFO - 'tsvgr_opacity', 20:05:50 INFO - 'tart', 20:05:50 INFO - 'tscrollx', 20:05:50 INFO - 'cart']}, 20:05:50 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:05:50 INFO - 'tsvgr_opacity', 20:05:50 INFO - 'tart', 20:05:50 INFO - 'tscrollx', 20:05:50 INFO - 'cart']}, 20:05:50 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:05:50 INFO - 'talos_options': ['--disable-e10s'], 20:05:50 INFO - 'tests': ['tp5o']}, 20:05:50 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:05:50 INFO - 'tests': ['tp5o']}, 20:05:50 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:05:50 INFO - 'talos_options': ['--disable-e10s', 20:05:50 INFO - '--xperf_path', 20:05:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:05:50 INFO - 'tests': ['tp5n']}, 20:05:50 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:05:50 INFO - 'talos_options': ['--xperf_path', 20:05:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:05:50 INFO - 'tests': ['tp5n']}}, 20:05:50 INFO - 'talos.zip': {'path': '', 20:05:50 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:05:50 INFO - Running post-action listener: _resource_record_post_action 20:05:50 INFO - ##### 20:05:50 INFO - ##### Finished populate-webroot step (success) 20:05:50 INFO - ##### 20:05:50 INFO - ##### 20:05:50 INFO - ##### Running create-virtualenv step. 20:05:50 INFO - ##### 20:05:50 INFO - Running pre-action listener: _resource_record_pre_action 20:05:50 INFO - Running main action method: create_virtualenv 20:05:50 INFO - Creating virtualenv /builds/slave/test/build/venv 20:05:50 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 20:05:50 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:05:50 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:05:50 INFO - Using real prefix '/usr' 20:05:50 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:05:50 INFO - Installing distribute.............................................................................................................................................................................................done. 20:05:52 INFO - Installing pip.................done. 20:05:52 INFO - Return code: 0 20:05:52 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:05: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')]} 20:05:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:05:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:05: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')]} 20:05:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:05:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:05: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0887668f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1241480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12d06f0>, '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 0x12d15f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12d1aa0>, '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': '337fe3f4b1febe37b85fccc40000019e-1466994791.249134-1438017817', '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 20:05: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', 'pip>=1.5'] in /builds/slave/test/build 20:05: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 pip>=1.5 20:05:52 INFO - Using env: {'DISPLAY': ':0', 20:05:52 INFO - 'HOME': '/home/cltbld', 20:05:52 INFO - 'LANG': 'en_US.UTF-8', 20:05:52 INFO - 'LANGUAGE': 'en_US:en', 20:05:52 INFO - 'LOGNAME': 'cltbld', 20:05:52 INFO - 'MAIL': '/var/mail/cltbld', 20:05:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:05:52 INFO - 'MOZ_NO_REMOTE': '1', 20:05:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:05:52 INFO - 'NO_EM_RESTART': '1', 20:05:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:05:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:05:52 INFO - 'PWD': '/builds/slave/test', 20:05:52 INFO - 'SHELL': '/bin/bash', 20:05:52 INFO - 'SHLVL': '1', 20:05:52 INFO - 'TERM': 'linux', 20:05:52 INFO - 'TMOUT': '86400', 20:05:52 INFO - 'USER': 'cltbld', 20:05:52 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1466994791.249134-1438017817', 20:05:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:05:52 INFO - '_': '/tools/buildbot/bin/python'} 20:05:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:05:52 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 20:05:52 INFO - Cleaning up... 20:05:52 INFO - Return code: 0 20:05:52 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 20:05: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')]} 20:05:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:05:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:05: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')]} 20:05:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:05:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:05: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', '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 0x7f0887668f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1241480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12d06f0>, '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 0x12d15f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12d1aa0>, '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': '337fe3f4b1febe37b85fccc40000019e-1466994791.249134-1438017817', '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 20:05: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', 'psutil>=3.1.1'] in /builds/slave/test/build 20:05: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 psutil>=3.1.1 20:05:52 INFO - Using env: {'DISPLAY': ':0', 20:05:52 INFO - 'HOME': '/home/cltbld', 20:05:52 INFO - 'LANG': 'en_US.UTF-8', 20:05:52 INFO - 'LANGUAGE': 'en_US:en', 20:05:52 INFO - 'LOGNAME': 'cltbld', 20:05:52 INFO - 'MAIL': '/var/mail/cltbld', 20:05:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:05:52 INFO - 'MOZ_NO_REMOTE': '1', 20:05:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:05:52 INFO - 'NO_EM_RESTART': '1', 20:05:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:05:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:05:52 INFO - 'PWD': '/builds/slave/test', 20:05:52 INFO - 'SHELL': '/bin/bash', 20:05:52 INFO - 'SHLVL': '1', 20:05:52 INFO - 'TERM': 'linux', 20:05:52 INFO - 'TMOUT': '86400', 20:05:52 INFO - 'USER': 'cltbld', 20:05:52 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1466994791.249134-1438017817', 20:05:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:05:52 INFO - '_': '/tools/buildbot/bin/python'} 20:05:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:05:53 INFO - Downloading/unpacking psutil>=3.1.1 20:05:53 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 20:05:53 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 20:05:53 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 20:05:53 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 20:05:53 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 20:05:53 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 20:05:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:05:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:05:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:05:55 INFO - Installing collected packages: psutil 20:05:55 INFO - Running setup.py install for psutil 20:05:55 INFO - building 'psutil._psutil_linux' extension 20:05:55 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 20:05:55 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 20:05:55 INFO - building 'psutil._psutil_posix' extension 20:05:55 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 20:05:55 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 20:05:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:05:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:05:55 INFO - Successfully installed psutil 20:05:55 INFO - Cleaning up... 20:05:55 INFO - Return code: 0 20:05:55 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 20:05: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')]} 20:05:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:05:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:05: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')]} 20:05:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:05:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:05:55 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 0x7f0887668f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1241480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12d06f0>, '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 0x12d15f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12d1aa0>, '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': '337fe3f4b1febe37b85fccc40000019e-1466994791.249134-1438017817', '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 20:05:55 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 20:05:55 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 20:05:55 INFO - Using env: {'DISPLAY': ':0', 20:05:55 INFO - 'HOME': '/home/cltbld', 20:05:55 INFO - 'LANG': 'en_US.UTF-8', 20:05:55 INFO - 'LANGUAGE': 'en_US:en', 20:05:55 INFO - 'LOGNAME': 'cltbld', 20:05:55 INFO - 'MAIL': '/var/mail/cltbld', 20:05:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:05:55 INFO - 'MOZ_NO_REMOTE': '1', 20:05:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:05:55 INFO - 'NO_EM_RESTART': '1', 20:05:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:05:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:05:55 INFO - 'PWD': '/builds/slave/test', 20:05:55 INFO - 'SHELL': '/bin/bash', 20:05:55 INFO - 'SHLVL': '1', 20:05:55 INFO - 'TERM': 'linux', 20:05:55 INFO - 'TMOUT': '86400', 20:05:55 INFO - 'USER': 'cltbld', 20:05:55 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1466994791.249134-1438017817', 20:05:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:05:55 INFO - '_': '/tools/buildbot/bin/python'} 20:05:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:05:55 INFO - Downloading/unpacking mozsystemmonitor==0.3 20:05:55 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 20:05:55 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 20:05:55 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 20:05:55 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 20:05:55 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 20:05:55 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 20:05:57 INFO - Downloading mozsystemmonitor-0.3.tar.gz 20:05:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:05:57 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 20:05:57 INFO - Installing collected packages: mozsystemmonitor 20:05:57 INFO - Running setup.py install for mozsystemmonitor 20:05:57 INFO - Successfully installed mozsystemmonitor 20:05:57 INFO - Cleaning up... 20:05:58 INFO - Return code: 0 20:05:58 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 20:05: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')]} 20:05:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:05:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:05: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')]} 20:05:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:05:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:05:58 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 0x7f0887668f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1241480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12d06f0>, '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 0x12d15f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12d1aa0>, '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': '337fe3f4b1febe37b85fccc40000019e-1466994791.249134-1438017817', '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 20:05:58 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 20:05:58 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 20:05:58 INFO - Using env: {'DISPLAY': ':0', 20:05:58 INFO - 'HOME': '/home/cltbld', 20:05:58 INFO - 'LANG': 'en_US.UTF-8', 20:05:58 INFO - 'LANGUAGE': 'en_US:en', 20:05:58 INFO - 'LOGNAME': 'cltbld', 20:05:58 INFO - 'MAIL': '/var/mail/cltbld', 20:05:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:05:58 INFO - 'MOZ_NO_REMOTE': '1', 20:05:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:05:58 INFO - 'NO_EM_RESTART': '1', 20:05:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:05:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:05:58 INFO - 'PWD': '/builds/slave/test', 20:05:58 INFO - 'SHELL': '/bin/bash', 20:05:58 INFO - 'SHLVL': '1', 20:05:58 INFO - 'TERM': 'linux', 20:05:58 INFO - 'TMOUT': '86400', 20:05:58 INFO - 'USER': 'cltbld', 20:05:58 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1466994791.249134-1438017817', 20:05:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:05:58 INFO - '_': '/tools/buildbot/bin/python'} 20:05:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:05:58 INFO - Downloading/unpacking jsonschema==2.5.1 20:05:58 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 20:05:58 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 20:05:58 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 20:05:58 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 20:05:58 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 20:05:58 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 20:06:00 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:06:00 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 20:06: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 20:06: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 20:06: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 20:06: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 20:06: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 20:06: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 20:06:00 INFO - Downloading functools32-3.2.3-2.tar.gz 20:06:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:06:00 INFO - warning: no files found matching '*.txt' 20:06:00 INFO - no previously-included directories found matching 'build' 20:06:00 INFO - no previously-included directories found matching 'dist' 20:06:00 INFO - no previously-included directories found matching '.git*' 20:06:00 INFO - Installing collected packages: jsonschema, functools32 20:06:00 INFO - Running setup.py install for functools32 20:06:00 INFO - warning: no files found matching '*.txt' 20:06:00 INFO - no previously-included directories found matching 'build' 20:06:00 INFO - no previously-included directories found matching 'dist' 20:06:00 INFO - no previously-included directories found matching '.git*' 20:06:00 INFO - Successfully installed jsonschema functools32 20:06:00 INFO - Cleaning up... 20:06:00 INFO - Return code: 0 20:06:00 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:06:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:06:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:06:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:06:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:06:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:00 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 0x7f0887668f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1241480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12d06f0>, '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 0x12d15f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12d1aa0>, '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': '337fe3f4b1febe37b85fccc40000019e-1466994791.249134-1438017817', '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 20:06:00 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 20:06:00 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 20:06:00 INFO - Using env: {'DISPLAY': ':0', 20:06:00 INFO - 'HOME': '/home/cltbld', 20:06:00 INFO - 'LANG': 'en_US.UTF-8', 20:06:00 INFO - 'LANGUAGE': 'en_US:en', 20:06:00 INFO - 'LOGNAME': 'cltbld', 20:06:00 INFO - 'MAIL': '/var/mail/cltbld', 20:06:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:06:00 INFO - 'MOZ_NO_REMOTE': '1', 20:06:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:06:00 INFO - 'NO_EM_RESTART': '1', 20:06:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:06:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:06:00 INFO - 'PWD': '/builds/slave/test', 20:06:00 INFO - 'SHELL': '/bin/bash', 20:06:00 INFO - 'SHLVL': '1', 20:06:00 INFO - 'TERM': 'linux', 20:06:00 INFO - 'TMOUT': '86400', 20:06:00 INFO - 'USER': 'cltbld', 20:06:00 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1466994791.249134-1438017817', 20:06:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:06:00 INFO - '_': '/tools/buildbot/bin/python'} 20:06:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:06:00 INFO - Downloading/unpacking blobuploader==1.2.4 20:06: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 20:06: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 20:06: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 20:06: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 20:06: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 20:06: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 20:06:02 INFO - Downloading blobuploader-1.2.4.tar.gz 20:06:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:06:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:06:02 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 20:06:02 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 20:06:02 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 20:06:02 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 20:06:02 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 20:06:02 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 20:06:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:06:03 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:06: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 20:06: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 20:06: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 20:06: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 20:06: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 20:06: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 20:06:03 INFO - Downloading docopt-0.6.1.tar.gz 20:06:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:06:03 INFO - Installing collected packages: blobuploader, requests, docopt 20:06:03 INFO - Running setup.py install for blobuploader 20:06:03 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:06:03 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:06:03 INFO - Running setup.py install for requests 20:06:03 INFO - Running setup.py install for docopt 20:06:04 INFO - Successfully installed blobuploader requests docopt 20:06:04 INFO - Cleaning up... 20:06:04 INFO - Return code: 0 20:06:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:06: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')]} 20:06:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:06:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06: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')]} 20:06:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:06:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:04 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 0x7f0887668f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1241480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12d06f0>, '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 0x12d15f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12d1aa0>, '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': '337fe3f4b1febe37b85fccc40000019e-1466994791.249134-1438017817', '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 20:06:04 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 20:06:04 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 20:06:04 INFO - Using env: {'DISPLAY': ':0', 20:06:04 INFO - 'HOME': '/home/cltbld', 20:06:04 INFO - 'LANG': 'en_US.UTF-8', 20:06:04 INFO - 'LANGUAGE': 'en_US:en', 20:06:04 INFO - 'LOGNAME': 'cltbld', 20:06:04 INFO - 'MAIL': '/var/mail/cltbld', 20:06:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:06:04 INFO - 'MOZ_NO_REMOTE': '1', 20:06:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:06:04 INFO - 'NO_EM_RESTART': '1', 20:06:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:06:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:06:04 INFO - 'PWD': '/builds/slave/test', 20:06:04 INFO - 'SHELL': '/bin/bash', 20:06:04 INFO - 'SHLVL': '1', 20:06:04 INFO - 'TERM': 'linux', 20:06:04 INFO - 'TMOUT': '86400', 20:06:04 INFO - 'USER': 'cltbld', 20:06:04 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1466994791.249134-1438017817', 20:06:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:06:04 INFO - '_': '/tools/buildbot/bin/python'} 20:06:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:06:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:06:04 INFO - Running setup.py (path:/tmp/pip-i_Nlb2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:06:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:06:04 INFO - Running setup.py (path:/tmp/pip-fL_pW4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:06:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:06:04 INFO - Running setup.py (path:/tmp/pip-0EUu4a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:06:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:06:04 INFO - Running setup.py (path:/tmp/pip-JT_fLp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:06:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:06:04 INFO - Running setup.py (path:/tmp/pip-gtGlTL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:06:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:06:04 INFO - Running setup.py (path:/tmp/pip-5FntPA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:06:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:06:04 INFO - Running setup.py (path:/tmp/pip-M6Ld65-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:06:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:06:04 INFO - Running setup.py (path:/tmp/pip-VS1s2m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:06:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:06:04 INFO - Running setup.py (path:/tmp/pip-B6RfAF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:06:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:06:04 INFO - Running setup.py (path:/tmp/pip-NKJkUZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:06:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:06:05 INFO - Running setup.py (path:/tmp/pip-kHYPdu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:06:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:06:05 INFO - Running setup.py (path:/tmp/pip-cMq7j9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:06:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:06:05 INFO - Running setup.py (path:/tmp/pip-u2KMRx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:06:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:06:05 INFO - Running setup.py (path:/tmp/pip-1E591p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:06:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:06:05 INFO - Running setup.py (path:/tmp/pip-KkMEZE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:06:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:06:05 INFO - Running setup.py (path:/tmp/pip-0tpAdJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:06:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:06:05 INFO - Running setup.py (path:/tmp/pip-Oa4kw8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:06:05 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:06:05 INFO - Running setup.py install for manifestparser 20:06:05 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:06:05 INFO - Running setup.py install for mozcrash 20:06:05 INFO - Running setup.py install for mozdebug 20:06:05 INFO - Running setup.py install for mozdevice 20:06:05 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:06:05 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:06:05 INFO - Running setup.py install for mozfile 20:06:06 INFO - Running setup.py install for mozhttpd 20:06:06 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:06:06 INFO - Running setup.py install for mozinfo 20:06:06 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:06:06 INFO - Running setup.py install for mozInstall 20:06:06 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:06:06 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:06:06 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:06:06 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:06:06 INFO - Running setup.py install for mozleak 20:06:06 INFO - Running setup.py install for mozlog 20:06:06 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:06:06 INFO - Running setup.py install for moznetwork 20:06:06 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:06:06 INFO - Running setup.py install for mozprocess 20:06:06 INFO - Running setup.py install for mozprofile 20:06:06 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:06:06 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:06:06 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:06:06 INFO - Running setup.py install for mozrunner 20:06:07 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:06:07 INFO - Running setup.py install for mozscreenshot 20:06:07 INFO - Running setup.py install for moztest 20:06:07 INFO - Running setup.py install for mozversion 20:06:07 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:06:07 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:06:07 INFO - Cleaning up... 20:06:07 INFO - Return code: 0 20:06:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:06: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')]} 20:06:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:06:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06: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')]} 20:06:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:06:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:07 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 0x7f0887668f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1241480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12d06f0>, '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 0x12d15f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12d1aa0>, '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': '337fe3f4b1febe37b85fccc40000019e-1466994791.249134-1438017817', '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 20:06:07 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 20:06:07 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 20:06:07 INFO - Using env: {'DISPLAY': ':0', 20:06:07 INFO - 'HOME': '/home/cltbld', 20:06:07 INFO - 'LANG': 'en_US.UTF-8', 20:06:07 INFO - 'LANGUAGE': 'en_US:en', 20:06:07 INFO - 'LOGNAME': 'cltbld', 20:06:07 INFO - 'MAIL': '/var/mail/cltbld', 20:06:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:06:07 INFO - 'MOZ_NO_REMOTE': '1', 20:06:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:06:07 INFO - 'NO_EM_RESTART': '1', 20:06:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:06:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:06:07 INFO - 'PWD': '/builds/slave/test', 20:06:07 INFO - 'SHELL': '/bin/bash', 20:06:07 INFO - 'SHLVL': '1', 20:06:07 INFO - 'TERM': 'linux', 20:06:07 INFO - 'TMOUT': '86400', 20:06:07 INFO - 'USER': 'cltbld', 20:06:07 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1466994791.249134-1438017817', 20:06:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:06:07 INFO - '_': '/tools/buildbot/bin/python'} 20:06:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:06:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:06:07 INFO - Running setup.py (path:/tmp/pip-weuOUl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:06:07 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)) 20:06:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:06:07 INFO - Running setup.py (path:/tmp/pip-4KaN8p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:06:07 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)) 20:06:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:06:07 INFO - Running setup.py (path:/tmp/pip-g6vguV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:06:07 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)) 20:06:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:06:07 INFO - Running setup.py (path:/tmp/pip-thGC2O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:06:07 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)) 20:06:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:06:07 INFO - Running setup.py (path:/tmp/pip-rgTLHD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:06:07 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)) 20:06:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:06:07 INFO - Running setup.py (path:/tmp/pip-WZg6lQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:06:07 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)) 20:06:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:06:08 INFO - Running setup.py (path:/tmp/pip-1o_BsN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:06:08 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)) 20:06:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:06:08 INFO - Running setup.py (path:/tmp/pip-h5F1Ho-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:06:08 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)) 20:06:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:06:08 INFO - Running setup.py (path:/tmp/pip-Cor9eY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:06:08 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)) 20:06:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:06:08 INFO - Running setup.py (path:/tmp/pip-iJmXkt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:06:08 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)) 20:06:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:06:08 INFO - Running setup.py (path:/tmp/pip-M0pt6l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:06:08 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)) 20:06:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:06:08 INFO - Running setup.py (path:/tmp/pip-FCxy74-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:06:08 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)) 20:06:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:06:08 INFO - Running setup.py (path:/tmp/pip-VVPwu1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:06:08 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)) 20:06:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:06:08 INFO - Running setup.py (path:/tmp/pip-rI9lIv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:06:08 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)) 20:06:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:06:08 INFO - Running setup.py (path:/tmp/pip-H7lEQJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:06:08 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)) 20:06:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:06:08 INFO - Running setup.py (path:/tmp/pip-TgB9zS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:06:08 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)) 20:06:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:06:08 INFO - Running setup.py (path:/tmp/pip-_ESm1j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:06:08 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)) 20:06:08 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)) 20:06:08 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)) 20:06:08 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)) 20:06:08 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)) 20:06:08 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)) 20:06:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:06:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:06:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:06:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:10 INFO - Downloading blessings-1.6.tar.gz 20:06:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:06:10 INFO - Installing collected packages: blessings 20:06:10 INFO - Running setup.py install for blessings 20:06:10 INFO - Successfully installed blessings 20:06:10 INFO - Cleaning up... 20:06:10 INFO - Return code: 0 20:06:10 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:06:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:06:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:06:11 INFO - Reading from file tmpfile_stdout 20:06:11 INFO - Current package versions: 20:06:11 INFO - argparse == 1.2.1 20:06:11 INFO - blessings == 1.6 20:06:11 INFO - blobuploader == 1.2.4 20:06:11 INFO - docopt == 0.6.1 20:06:11 INFO - functools32 == 3.2.3-2 20:06:11 INFO - jsonschema == 2.5.1 20:06:11 INFO - manifestparser == 1.1 20:06:11 INFO - mozInstall == 1.12 20:06:11 INFO - mozcrash == 0.17 20:06:11 INFO - mozdebug == 0.1 20:06:11 INFO - mozdevice == 0.48 20:06:11 INFO - mozfile == 1.2 20:06:11 INFO - mozhttpd == 0.7 20:06:11 INFO - mozinfo == 0.9 20:06:11 INFO - mozleak == 0.1 20:06:11 INFO - mozlog == 3.2 20:06:11 INFO - moznetwork == 0.27 20:06:11 INFO - mozprocess == 0.22 20:06:11 INFO - mozprofile == 0.28 20:06:11 INFO - mozrunner == 6.11 20:06:11 INFO - mozscreenshot == 0.1 20:06:11 INFO - mozsystemmonitor == 0.3 20:06:11 INFO - moztest == 0.7 20:06:11 INFO - mozversion == 1.4 20:06:11 INFO - psutil == 3.1.1 20:06:11 INFO - requests == 1.2.3 20:06:11 INFO - wsgiref == 0.1.2 20:06:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:06:11 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')]} 20:06:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:06:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:11 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')]} 20:06:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:06:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:11 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 0x7f0887668f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1241480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12d06f0>, '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 0x12d15f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12d1aa0>, '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': '337fe3f4b1febe37b85fccc40000019e-1466994791.249134-1438017817', '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 20:06:11 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 20:06:11 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 20:06:11 INFO - Using env: {'DISPLAY': ':0', 20:06:11 INFO - 'HOME': '/home/cltbld', 20:06:11 INFO - 'LANG': 'en_US.UTF-8', 20:06:11 INFO - 'LANGUAGE': 'en_US:en', 20:06:11 INFO - 'LOGNAME': 'cltbld', 20:06:11 INFO - 'MAIL': '/var/mail/cltbld', 20:06:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:06:11 INFO - 'MOZ_NO_REMOTE': '1', 20:06:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:06:11 INFO - 'NO_EM_RESTART': '1', 20:06:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:06:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:06:11 INFO - 'PWD': '/builds/slave/test', 20:06:11 INFO - 'SHELL': '/bin/bash', 20:06:11 INFO - 'SHLVL': '1', 20:06:11 INFO - 'TERM': 'linux', 20:06:11 INFO - 'TMOUT': '86400', 20:06:11 INFO - 'USER': 'cltbld', 20:06:11 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1466994791.249134-1438017817', 20:06:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:06:11 INFO - '_': '/tools/buildbot/bin/python'} 20:06:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:06:11 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)) 20:06:11 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)) 20:06:11 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)) 20:06:11 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)) 20:06:11 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)) 20:06:11 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)) 20:06:11 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)) 20:06:11 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)) 20:06:11 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)) 20:06:11 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)) 20:06:11 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)) 20:06:11 INFO - Cleaning up... 20:06:11 INFO - Return code: 0 20:06:11 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:06:11 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')]} 20:06:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:06:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:11 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')]} 20:06:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:06:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:11 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 0x7f0887668f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1241480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12d06f0>, '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 0x12d15f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12d1aa0>, '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': '337fe3f4b1febe37b85fccc40000019e-1466994791.249134-1438017817', '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 20:06:11 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 20:06:11 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 20:06:11 INFO - Using env: {'DISPLAY': ':0', 20:06:11 INFO - 'HOME': '/home/cltbld', 20:06:11 INFO - 'LANG': 'en_US.UTF-8', 20:06:11 INFO - 'LANGUAGE': 'en_US:en', 20:06:11 INFO - 'LOGNAME': 'cltbld', 20:06:11 INFO - 'MAIL': '/var/mail/cltbld', 20:06:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:06:11 INFO - 'MOZ_NO_REMOTE': '1', 20:06:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:06:11 INFO - 'NO_EM_RESTART': '1', 20:06:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:06:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:06:11 INFO - 'PWD': '/builds/slave/test', 20:06:11 INFO - 'SHELL': '/bin/bash', 20:06:11 INFO - 'SHLVL': '1', 20:06:11 INFO - 'TERM': 'linux', 20:06:11 INFO - 'TMOUT': '86400', 20:06:11 INFO - 'USER': 'cltbld', 20:06:11 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1466994791.249134-1438017817', 20:06:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:06:11 INFO - '_': '/tools/buildbot/bin/python'} 20:06:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:06:11 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 20:06:11 INFO - Cleaning up... 20:06:11 INFO - Return code: 0 20:06:11 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 20:06:11 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')]} 20:06:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:06:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:11 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')]} 20:06:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:06:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:11 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 0x7f0887668f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1241480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12d06f0>, '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 0x12d15f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12d1aa0>, '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': '337fe3f4b1febe37b85fccc40000019e-1466994791.249134-1438017817', '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 20:06:11 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 20:06:11 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 20:06:11 INFO - Using env: {'DISPLAY': ':0', 20:06:11 INFO - 'HOME': '/home/cltbld', 20:06:11 INFO - 'LANG': 'en_US.UTF-8', 20:06:11 INFO - 'LANGUAGE': 'en_US:en', 20:06:11 INFO - 'LOGNAME': 'cltbld', 20:06:11 INFO - 'MAIL': '/var/mail/cltbld', 20:06:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:06:11 INFO - 'MOZ_NO_REMOTE': '1', 20:06:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:06:11 INFO - 'NO_EM_RESTART': '1', 20:06:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:06:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:06:11 INFO - 'PWD': '/builds/slave/test', 20:06:11 INFO - 'SHELL': '/bin/bash', 20:06:11 INFO - 'SHLVL': '1', 20:06:11 INFO - 'TERM': 'linux', 20:06:11 INFO - 'TMOUT': '86400', 20:06:11 INFO - 'USER': 'cltbld', 20:06:11 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1466994791.249134-1438017817', 20:06:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:06:11 INFO - '_': '/tools/buildbot/bin/python'} 20:06:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:06:11 INFO - Downloading/unpacking flake8 20:06:11 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 20:06:11 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 20:06:11 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 20:06:11 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 20:06:11 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 20:06:11 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 20:06:13 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 20:06:13 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 20:06:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:06:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:06:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:13 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 20:06:13 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 20:06:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:06:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:06:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:14 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 20:06:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:06:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:06:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 20:06:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:06:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:06:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:06:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:06:14 INFO - no previously-included directories found matching 'docs/_build' 20:06:14 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 20:06:14 INFO - Running setup.py install for pep8 20:06:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:06:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:06:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:06:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:06:14 INFO - no previously-included directories found matching 'docs/_build' 20:06:14 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 20:06:14 INFO - Successfully installed flake8 mccabe pyflakes pep8 20:06:14 INFO - Cleaning up... 20:06:14 INFO - Return code: 0 20:06:14 INFO - Running post-action listener: _resource_record_post_action 20:06:14 INFO - Running post-action listener: _start_resource_monitoring 20:06:14 INFO - Starting resource monitoring. 20:06:14 INFO - ##### 20:06:14 INFO - ##### Finished create-virtualenv step (success) 20:06:14 INFO - ##### 20:06:14 INFO - ##### 20:06:14 INFO - ##### Running install step. 20:06:14 INFO - ##### 20:06:14 INFO - Running pre-action listener: _resource_record_pre_action 20:06:14 INFO - Running main action method: install 20:06:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:06:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:06:14 INFO - Reading from file tmpfile_stdout 20:06:14 INFO - Detecting whether we're running mozinstall >=1.0... 20:06:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:06:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:06:14 INFO - Reading from file tmpfile_stdout 20:06:14 INFO - Output received: 20:06:14 INFO - Usage: mozinstall [options] installer 20:06:14 INFO - Options: 20:06:14 INFO - -h, --help show this help message and exit 20:06:14 INFO - -d DEST, --destination=DEST 20:06:14 INFO - Directory to install application into. [default: 20:06:14 INFO - "/builds/slave/test"] 20:06:14 INFO - --app=APP Application being installed. [default: firefox] 20:06:14 INFO - mkdir: /builds/slave/test/build/application 20:06:14 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'] 20:06:14 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 20:06:32 INFO - Reading from file tmpfile_stdout 20:06:32 INFO - Output received: 20:06:32 INFO - /builds/slave/test/build/application/firefox/firefox 20:06:32 INFO - Running post-action listener: _resource_record_post_action 20:06:32 INFO - ##### 20:06:32 INFO - ##### Finished install step (success) 20:06:32 INFO - ##### 20:06:32 INFO - ##### 20:06:32 INFO - ##### Running run-tests step. 20:06:32 INFO - ##### 20:06:32 INFO - Running pre-action listener: _resource_record_pre_action 20:06:32 INFO - Running main action method: run_tests 20:06:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:06:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:06:32 INFO - Python 2.7.3 20:06:32 INFO - Return code: 0 20:06:32 INFO - grabbing minidump binary from tooltool 20:06:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:06:32 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 0x12d06f0>, '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 0x12d15f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12d1aa0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:06:32 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 20:06:32 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 20:06:32 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 20:06:32 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:06:32 INFO - Return code: 0 20:06:32 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 20:06:32 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:06:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:06:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 20:06:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:06:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 20:06:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 20:06:33 INFO - Return code: 0 20:06:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IG3vjAsMQomR6u3qUUOzoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--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 20:06:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/IG3vjAsMQomR6u3qUUOzoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-060 --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 20:06:33 INFO - Using env: {'DISPLAY': ':0', 20:06:33 INFO - 'HOME': '/home/cltbld', 20:06:33 INFO - 'LANG': 'en_US.UTF-8', 20:06:33 INFO - 'LANGUAGE': 'en_US:en', 20:06:33 INFO - 'LOGNAME': 'cltbld', 20:06:33 INFO - 'MAIL': '/var/mail/cltbld', 20:06:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:06:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 20:06:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:06:33 INFO - 'MOZ_NO_REMOTE': '1', 20:06:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:06:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:06:33 INFO - 'NO_EM_RESTART': '1', 20:06:33 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:06:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:06:33 INFO - 'PWD': '/builds/slave/test', 20:06:33 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:06:33 INFO - 'SHELL': '/bin/bash', 20:06:33 INFO - 'SHLVL': '1', 20:06:33 INFO - 'TERM': 'linux', 20:06:33 INFO - 'TMOUT': '86400', 20:06:33 INFO - 'USER': 'cltbld', 20:06:33 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1466994791.249134-1438017817', 20:06:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:06:33 INFO - '_': '/tools/buildbot/bin/python'} 20:06:33 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IG3vjAsMQomR6u3qUUOzoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--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 20:06:33 INFO - mozversion application_buildid: 20160626173008 20:06:33 INFO - mozversion application_changeset: 110c7ad7d399d16b9c77940f766a26df5d90f881 20:06:33 INFO - mozversion application_display_name: Nightly 20:06:33 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:06:33 INFO - mozversion application_name: Firefox 20:06:33 INFO - mozversion application_remotingname: firefox 20:06:33 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 20:06:33 INFO - mozversion application_vendor: Mozilla 20:06:33 INFO - mozversion application_version: 50.0a1 20:06:33 INFO - mozversion platform_buildid: 20160626173008 20:06:33 INFO - mozversion platform_changeset: 110c7ad7d399d16b9c77940f766a26df5d90f881 20:06:33 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 20:06:33 INFO - mozversion platform_version: 50.0a1 20:06:33 INFO - using testdate: 1466996793 20:06:33 INFO - actual date: 1466996793 20:06:33 INFO - starting webserver on 'localhost:48265' 20:06:33 INFO - SUITE-START | Running 2 tests 20:06:33 INFO - TEST-START | dromaeo_css 20:06:33 INFO - operating with platform_type : linux_ 20:06:33 INFO - Initialising browser for dromaeo_css test... 20:06:33 INFO - TEST-INFO | started process 14848 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnsZ8zd/profile http://localhost:48265/getInfo.html) 20:06:37 INFO - PROCESS | 14848 | __metrics Screen width/height:1600/1200 20:06:37 INFO - PROCESS | 14848 | colorDepth:24 20:06:37 INFO - PROCESS | 14848 | Browser inner width/height: 1024/697 20:06:37 INFO - PROCESS | 14848 | __metrics 20:06:38 INFO - PROCESS | 14848 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:06:39 INFO - TEST-INFO | 14848: exit 0 20:06:39 INFO - Browser initialized. 20:06:39 INFO - Running cycle 1/1 for dromaeo_css test... 20:06:39 INFO - TEST-INFO | started process 14927 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnsZ8zd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:06:51 INFO - PROCESS | 14927 | RSS: Main: 173821952 20:06:51 INFO - PROCESS | 14927 | 20:07:42 INFO - PROCESS | 14927 | 1466996862092 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] 20:09:51 INFO - PROCESS | 14927 | Cycle 1(1): loaded http://localhost:48265/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48265/tests/dromaeo/cssquery-ext.html) 20:09:52 INFO - PROCESS | 14927 | RSS: Main: 271110144 20:09:52 INFO - PROCESS | 14927 | 20:12:54 INFO - PROCESS | 14927 | Cycle 1(1): loaded http://localhost:48265/tests/dromaeo/cssquery-ext.html (next: http://localhost:48265/tests/dromaeo/cssquery-jquery.html) 20:12:54 INFO - PROCESS | 14927 | RSS: Main: 258191360 20:12:54 INFO - PROCESS | 14927 | 20:15:56 INFO - PROCESS | 14927 | Cycle 1(1): loaded http://localhost:48265/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48265/tests/dromaeo/cssquery-mootools.html) 20:15:57 INFO - PROCESS | 14927 | RSS: Main: 262860800 20:15:57 INFO - PROCESS | 14927 | 20:18:59 INFO - PROCESS | 14927 | Cycle 1(1): loaded http://localhost:48265/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48265/tests/dromaeo/cssquery-prototype.html) 20:19:00 INFO - PROCESS | 14927 | RSS: Main: 253874176 20:19:00 INFO - PROCESS | 14927 | 20:22:02 INFO - PROCESS | 14927 | Cycle 1(1): loaded http://localhost:48265/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48265/tests/dromaeo/cssquery-yui.html) 20:22:03 INFO - PROCESS | 14927 | RSS: Main: 244277248 20:22:03 INFO - PROCESS | 14927 | 20:25:06 INFO - PROCESS | 14927 | Cycle 1(1): loaded http://localhost:48265/tests/dromaeo/cssquery-yui.html (next: http://localhost:48265/tests/dromaeo/cssquery-dojo.html) 20:25:06 INFO - PROCESS | 14927 | RSS: Main: 281223168 20:25:06 INFO - PROCESS | 14927 | 20:25:06 INFO - PROCESS | 14927 | __start_tp_report 20:25:06 INFO - PROCESS | 14927 | _x_x_mozilla_page_load 20:25:06 INFO - PROCESS | 14927 | _x_x_mozilla_page_load_details 20:25:06 INFO - PROCESS | 14927 | |i|pagename|runs| 20:25:06 INFO - PROCESS | 14927 | |0;dojo.html;3081.5839861618674;3086.2130156810013;3100.8449577521124;3122.9531557026635;3147.449196390631;5250.133727934886;5298.284731561238;5332.840014799553;5381.730913454327;5397.676139431637;5348.839534813952;5390.78436862525;5408.107662235736;5428.511433970942;5438.972805135979;4863.051704917542;4933.186024306003;4944.901101977958;4958.950410495903;5052.065367906931;4942.209246520558;4966.627502937276;4996.750162491879;5001.324821149135;5020.974895125538;4784.497627749071;4804.063207674505;4840.515948405149;4866.46468888422;4876.292937524075;4846.466888642281;4865.318855360252;4867.683600565952;4922.507749225085;4963.354763880672;4886.70679759212;4915.5821755150855;4920.6309526785635;4922.876928076791;4959.404871415417;5195.948040519622;5274.604404669665;5354.839354819323;5357.464253574651;5384.488473595002;5782.190493330937;5795.797147099874;5808.6224395414165;5820.243368362086;5822.155787410802;5637.633553818989;5822.82531524055;5827.388124246935;5846.21076154718;5850.531957443394;5312.787488500456;5357.624966252325;5359.5444387227135;5423.484768946943;5434.076207044812;5892.793752218738;5896.498797602166;5899.174115623816;5909.940900590939;5913.231279933581;5509.696966666872;5645.407232240637;5701.087825947829;5720.542356611461;5726.570507211975;5769.307683077974;5772.307323121168;5773.307203135567;5813.79651712188;5820.650760954271;5700.23046888673;5733.971330143323;5740.598158128891;5749.051406517961;5749.683767392834;5543.805966791224;5547.972260138754;5569.275994120739;5758.222639943638;5759.65442073477;4303;4303.419038429772;4312.310030395121;4346.6522678185665;4348;3852.6725228355344;3874.7093967952515;3878.3794592865006;3899.629535194152;3906.2968665640456;5254.159334506537;5360.0351936650995;5365.946340536622;5373.570114390839;5394.514493695587;5795.971020144872;5799;5808.680522571299;5817.156512305692;5856.8535786604825;5441.319835020622;5450;5452.509274165265;5455.208994695747;5457.126859702428;4795.640326975491;4882.170031094723;4937.703737775745;4952.777125029383;4962.528559786814;5918;5930.55520835939;5936.851578710481;5942.64344139353;5943;5514.80698175562;5778.306603207642;5798.275215598051;5800.071988481823;5802.071668533014;5819.272590926134;5893.557983151367;5910.556708246812;5925.703714814156;5936.347001829881;5658.830235092953;5662.518685911744;5662.716864156693;5664.320281566238;5665.915011274752;5510;5711.543076553949;5765.135229715576;5767.394423585463;5776.104703770922;5567;5587.580931430078;5632.127020311858;5641.971790141023;5649.350324712711;5560.666360018412;5606.383297837153;5612.466815652507;5616.073347897551;5619.072852979212;5369.0872551665525;5463.207834863843;5524.281843360337;5530.225768392348;5541.612087153861;5589.77640894376;5695.715214239189;5702.800401985911;5715.914261286167;5717.285339332583;5480.753366098455;5502.889942201214;5508.9724551376985;5512.062949298709;5514.145307477347 20:25:06 INFO - PROCESS | 14927 | |1;ext.html;594.3966873623273;626.4455956478516;627.0656721484988;635.0632816595522;652.5986518291251;33411.16472088196;36021.45967810482;36031.459528107036;36149.45775813365;43246.78376608113;42141.15717685652;46075.30887036697;46114.76942615282;46124.07751844961;46156.30765538519;8695.434796738191;8857.114288571156;8859.512726800023;8862.06948270432;8863.202311791938;8650.221480066793;8768.956155219246;8780.078091800333;8809.339299552526;8821.647134114628;8840.646374145026;8858.645654173826;8869.645214191425;8885.244754195868;8887.644494220223;8831.116888311182;8874.778130546723;8880.866786998167;8881.111888811132;8882.11178882113;8817.559122043873;8900.154485323948;8913.509756963364;8915.197632213067;8921.286297096216;42527.36208956837;42848.78575607133;42851.14297714028;43106.56893431057;43140.78429607863;3559.323728491604;3579.6241394653707;3648.3068217038676;3679.6504332088407;3716.776993380379;31459.685403145904;33475.33049338999;33864.49203261953;34119.488207676906;34137.6586234137;3644.0525463379713;3678.1172518595345;3851.807409629507;3863.16941857502;3866.0914685048992;356547;357631;363444;363618;363663;32291.677083229337;64564.67717661382;64981.35018649847;65249;65517.7585793145;37777.43333849994;38001.23997520034;38066;38101.809490952364;38187;14542.127472351693;14600.488982885548;14602.196879171535;14603.050801697857;14675.77986330206;12984.480620775252;13124.409401576951;13151.145175563557;13159.144655597356;13164.078514504085;8425.452345597516;8436.493810371398;8473.533955632376;8513.702020429255;8536.786580335542;3268.4116858965613;3283.8029718216985;3291.7037466628117;3300.5379246905454;3311.9006429807146;1054.984175237372;1061.151079136703;1083.3337497439018;1090.5855774805523;1150.8216226484908;32273.51589726156;32882.835585821915;33384.666153338156;33644.83177584096;34051.48922766161;1144.8065963139377;1163.9825402618967;1169.3334799164566;1172.3376292394769;1197.3773637708516;17482.825171748373;17511.211995460235;17579;17587.29650813979;17739.290428382978;605456;617298;618534;619016;620579;59448.702756486804;60133.39866601278;60347.69826150841;60355.69822150949;60360.69819650874;1272.7454509098218;1357.6130802721375;1397.336265274007;1401.6145559970885;1412.941668825602;32573.18567035748;33435.83282083574;33868.153296167795;34155.14612134716;34261.31477370389;49592;50233;50262.497375025785;50276.748616256686;50305.74847125741;396432;400660;402193;402870;403212;25333.113341032975;25466.745332546438;27592;28336.574951375333;28504.287392814516;47756;47917.28124078072;48979;49263;49892.25315047862;41757.79121104497;42956.570434296504;43188.784056079516;43787;44739;40877.59122408857;42296.5770342305;42305.78847105745;42938.1412371757;43520.56479435165;42548.149037019706;42913.35629965615;43463.130737385705;43617.345739813296;43753.56246437622;35632.64367356397;37040.444393333586;37294.627053730204;37644;37727;28879.711202888542;29014.829290723646;29150;29309.413811723218;29431 20:25:06 INFO - PROCESS | 14927 | |2;jquery.html;373.7234446509583;380.17691697474976;383.25265731822935;386.98452061917527;388.2991200882408;18014.369497067604;19686.803131968674;20207.797922020756;20612.484687882792;20815.687764683542;18935.52661183471;19403.514912127204;19773.110210040548;20026.399208023748;20060.59878802427;5558.333000040001;5693.633527953282;5756.194132821398;5959.255093113361;5962.25471816023;5742.971285143569;5839.620424672404;5850.444207800273;5880.294364676223;5880.441358070998;5680.943190568103;5755.280589926259;5828.650280983134;5881.147233651118;5890.823275301748;5732.398098199671;5736.426357364272;5748.770049198006;5806.303243610751;5841.065429531276;4744.288356746481;5059.1905295152965;5094.235864620299;5101.0308041472;5102.846914592568;13528.188308701509;13967.473280200733;22673.206437774763;22842;22849.885750571306;2134.839887008465;2192.8245740340735;2299.8965046572944;2518.0179729905353;2625.737426257378;9456.952715236379;9693.70918872435;10150.695479135638;11031.944840275828;14143.151410915378;1874.7937726850037;1912.502749285182;1956.1001939108028;1961.2253160001862;1997.57052233769;54581.727091364286;68428.6578567109;69845.65077174582;79886;85449.57275213646;9086.591103400362;9911.80176396468;9958.701238962843;10107.444090575089;10310.639127630497;11857.34784586856;12594.81107783384;12628.305443200528;13267;13326;7758.107817600935;7781.494202876795;7905.367570594339;8119.269265766109;8120.14738452454;8136.471129376571;8184;8194.262516373556;8274.917250827535;8322.20939010793;3873.767573945572;4023.3964905264443;4046.615571520701;4091.284025295561;4159.812808423628;1732.497575703032;1769.2215425212864;1793.9461816145536;1829.762130922998;1912.540990162351;948.307735353196;968.1963969904962;968.3657204531044;1028.1620479309338;1037.5382954585289;19164.137613807412;19799.60400791976;19829.60340793176;19924.30264940749;19940.302089427092;967.1295833749682;974.4007435427161;985.1872205430549;997.4264797741328;1018.3319702379812;10674.946625266824;11080.61217857371;11091.889081109248;11127.721806954729;11201.495932683049;456632;462161;468998;480478;486156;87501;88243;89290.10709892948;90303.54848225717;90664;996.2913603170597;998.4758002048983;1005.1004351105865;1026.1124127629546;1028.4600584693096;15573.454929077428;17378.47864564065;17729.202185901922;18042.819571804637;18265.634687305912;27402.156489879537;29776.10671679853;31627.20931976627;35977.28045439024;37264;51449.48550514447;51898.221526676374;56383.43616563782;57059;57093;8192.549409782281;8619.8707019396;8774.38579299443;8819.29445644334;8842.513661748666;12602.36988150607;12989.545365912525;12999.350032498527;13444.193348399127;14459.855401446272;11970.281783093042;12046.75906481883;12072.698182545506;12101.334426606621;12642;11691.415429228675;11848.76302473963;11852.111091667986;11961.880381196077;12355.25868447896;11808.173427859967;12426;12693.682657933256;12714.491420343084;12818.102732808615;8370.832583348178;8373.455725377831;8480.236778689947;8588.484690918565;8603.483790972561;11028.28316159447;12238.510459581874;12351.75296494083;12351.93824030874;12500.437480313225 20:25:06 INFO - PROCESS | 14927 | |3;mootools.html;1298.1237664576408;1454.6872422429178;1482.599698081518;1567.9608009799754;1724.189630873489;8554.18735220154;8951.865722014176;8959.104089591046;9208.67769628063;9212.585433655484;8972.820543589125;9176.908230917688;9178.816423671522;9181.724548263563;9188.908110918888;2229.108356657338;2250.1561914282142;2252.538229662923;2256.6050941085246;2257.525919556895;2260.389694782408;2288.9885550572226;2293.289080385078;2295.885205739715;2297.5864344417996;2205.2612374854443;2206.095500844654;2239.7760223977552;2249.3701763506247;2254.77452254774;2158.7625361210253;2163.707899433572;2198.296545105567;2200.5378870437066;2203.6253836847773;2163.350994701583;2170.7829217078324;2174.3368272676826;2179.69484272202;2188.715466989297;8487.108853570347;8820.117988201193;8910.50992195429;8920.821583568357;9016.36885418021;5191.8442446726285;5335.013022590794;5348.973255133738;5356.38401583819;5359.598030147755;3309.8014119152926;3347.832608369596;3375.139339468444;3383.052745231339;3429.382711111999;1032.726327523207;1034.534459493231;1043.984340234897;1048.3657387280662;1058.2063452410691;12910.677233069155;12939.223646581235;12983.22100673972;12994.610161695164;13036.739265214737;4523.909521809545;4544.7045942013665;4573.588377046081;4619.1685496610935;4627.9074418511445;9897.7030689078;9948.502574871372;9952.353097048668;9953.353032052893;9968.900310996942;5200.6619569727845;5253.080710875658;5277.366715994105;5279.392869819943;5280.7359632019015;4167.687423443193;4234.872953811329;4802.711837289774;4834.516548345137;4834.564889159992;3768.9246215075545;3852.1910398816003;3867.903302417462;3895.7857317847224;3907.902302442462;1128.503458478267;1128.5316593613559;1133.1444759206747;1143.8112711402525;1144.6566030191077;863.8920134983127;940.4780346907532;945.1446440970794;964.7202311329636;989.1048601016092;5920.348761636216;5989.071693887455;6046.818595442144;6073.908891366633;6152.692365381713;450.73406690053025;454.0759554307035;461.5937974582346;464.3777338366605;471.7451578800374;3973.264945985002;4000.6797756740207;4090.9795451022555;4114.423980642712;4147.2534943710425;10989.61536346224;11417.42912854354;11423.942880285545;11560.76878462426;11562.132840037031;11399.259048161843;11478.827817582744;11516.251443656136;11528.769424611628;11561.30632162073;8060.556669383123;8460.576971151419;8475.70335038283;8673.6530538779;8693.521856297837;6035.336113027475;6093.329733729375;6148.1699970503405;6198.256209254918;6212.254529456494;10305.99033188551;10549.314294570828;10597.311174773615;10632.574697012033;10714.678559643224;10582.788344233226;10730.73173170677;10910.290831095954;11021.83467248008;11035.558577656804;7333.230010848997;7853.410994175346;8088.838223235384;8114.715984940735;8318.41771076043;8559.529225892637;9052.004279529378;9093.363464557417;9122.08779122109;9149.313801464783;7828.178041305581;7881.093674227537;7923.247291507298;7974.84050319002;8075.757727268191;7509.6245187739305;7673.8848917267405;7838.843223135619;7885.802854928444;7922.920770792219;7154.642267886481;7185.820354491179;7219.205887352492;7286.7085316586745;7299;4937.506249375034;4956.727379994135;5014.924776128288;5023.422306434807;5042.924356134734;5320.798268338241;5341.545968592558;5366.463353664602;5392.137258038695;5520.033994051106 20:25:06 INFO - PROCESS | 14927 | |4;prototype.html;309.87604958016794;310.5435010534515;314.3649827348756;322.41642626845425;327.0189431704885;5029.673071250366;5124.000819840133;5140.404095931554;5175.896482070361;5190.74046297685;5160.638755287131;5194;5199;5218.1650935850275;5223.71269580173;4103.774292413916;4108.753474791507;4112.115895082557;4113.465249517559;4116.620931987788;3798.753081049723;3885.2423777363424;4033.7378070425475;4110.424540564323;4131.7481972325;3990.3016972029923;4000.479937608107;4011.9197616047663;4011.9970007498127;4031.314676505001;4002.019505221225;4008.9709841608997;4010.5989401059805;4034.700220874103;4050;3460.4255063945843;3543.8050907200095;3551.147724546116;3552.786832790041;3556.7332450066347;5053.444121146671;5059.241113832918;5073.771680274396;5089.465606111342;5100.846974590768;4578.221702310615;4583.54164583539;4598.402207713009;4604.217283061887;4613.63090952723;5189.792408303663;5410.972945135289;5414.160805075219;5483.341998960111;5526.889462210774;3869.129445874684;3886;3902.395128755019;3907.8241479133508;3934.855503750463;5652.18043383707;5688.089905615123;5737.799177028825;5739.364281179885;5764.308283006066;3795.7342985991268;3934.626210509997;3937.2912875682077;3958.247932892741;3968.69033219037;3943.2846711679936;3986.7209295349626;3992.680585553149;3994.2410941920944;3998.1603863189057;4601.401817763736;4603.654725895572;4607.516210797818;4608.9308660370125;4615.376924115269;5407.78368865241;5523.87330877615;5525.861853453615;5532.170174473861;5556.638818476786;1308.7775078236723;1355.8407561534943;1378.3521744779937;1399.2514005007272;1403.810485584433;840.5923127283263;847.546562589012;853.9914600854037;863.4199415070406;887.7869311365226;4755.857324280277;4759.214729569582;4777.1878780606685;4782.178514676358;4794.880127996828;5078.695278283241;5079.4412614612365;5086.237064440364;5091.312672789126;5098.260752190911;4463.977680111579;4670.042641258534;4674.345591617176;4737.8341758038305;4779.115863565252;2658.70754217036;2717.5244332241778;2724.945501089967;2725.441284536665;2726.6591676040493;5065.744774389457;5088;5125.461826508237;5135.460776618401;5138.254953031789;5052.57053150479;5097.388313402415;5104.540591346797;5323.30796996388;5826.475617194473;5786.334571524329;5828.184054232495;5834.533237341003;5849.742305404358;5854.18041474194;5692.573057020657;5700.942990570041;5701.717113649562;5703.942960570341;5711.942880571141;5480.945190548203;5572.411862619134;5622.269105016322;5630.662160270397;5644.3508996465935;5756.971215143897;5803.245578074823;5814.73833677494;5829.15477255787;5869.8239052828485;3888.9222215556097;3948.526176858795;3967.206558688332;3971.960280397159;3983.203359328204;5433.293671822637;5705.22979397776;5713.857153571194;5714.628549144292;5714.828555143353;5422.810201643081;5547.362053363753;5563.638363506359;5567.47109024642;5569.136783798518;5462.672239665632;5490.450954904637;5513.365962914316;5537.28015358017;5537.390887002346;5202.531772140374;5435.510804027656;5435.945640543702;5440.238366628754;5446.264754258124;5453.863653408696;5469.179623056414;5520.944790552043;5525.867197224479;5565.276514053309;5351.545118664957;5401.648892821954;5427.48438898304;5438.728063596884;5441.707766801187 20:25:06 INFO - PROCESS | 14927 | |5;yui.html;752.9924700752995;792.845395147946;795.5306369242147;845.3659755183612;851.5103815306201;14072;14943.925280373584;14968.625784355369;14977.925110374461;15047.247637618117;14841.109533428002;14931.253437328118;14951;14957.10257384555;14969.326380312885;657.6054367379581;780.4068907630214;817.587118505157;821.9753407397758;823.8846561481367;806.4878801960739;813.8453693798159;814.1126172472004;815.571824791983;818.3862103422433;687.1994126842247;869.886914701088;870.8040690844573;872.6378552900538;872.6858331000834;721.9350258476736;724.0334153904544;807.144426907477;862.5730263519536;864.8356812205661;638.4094712391067;638.5913015669928;638.7891995641473;639.2967735490922;639.7185238495048;15272.465463708828;15285.082895026335;15326.616834579114;15337.30982105808;15362;13955.372008259652;14113.435462581587;14498.27508624575;14576.125432474086;14589.781153282604;12068.396580171044;12244.632661020183;12418.937905310506;12487.50049997999;12508.186967847061;4482.21561226784;4517.480489743656;4540.704854184468;4541.364209010741;4583.289590113504;67453.66273168652;70496.6475167626;70506.64746676285;72180;77288.99999999943;11199.832002519968;11593.88406115928;11732.589359372381;11761.88238117625;12133.937230670806;17714.114294285235;17719.379821706178;17732.822671773116;17732.91133544324;17800.3769868054;8755.168259015383;8980.506072166094;9030.232430243503;9287.442753434816;9327.300452466092;4924.384451943507;4929.630277729185;5028.84913452597;5094.719790411489;5229.241759944786;3540.858365665396;3641.6540428659237;3650.7809531428197;3652.561692596852;3656.542932133483;592.3602509289957;592.6325678079618;599.2389665125354;608.4311169056946;623.5230049012509;746.358132006474;765.1850778920543;768.2356055724479;789.1871372486348;814.1248158229927;9744.415335079917;9988.450635214987;10036.64871729486;10286.177105831515;10328.328658637165;721.3651986252064;732.3116270705519;735.4888352594895;760.013727996661;776.3207193705508;4881.365422495124;5045.394552653632;5053.242013697901;5067.062593420229;5078.974605127025;114080;117340.41329793296;118775;119762.4011879935;119816;101676.49161754144;105449.47275263727;105850;105941.64350138862;105967;55535;57226.427735722944;76201.23798761942;84940;85453.57273213594;9163.49600771964;9187.208693701607;9194.58624361892;9321.953390233006;9404.200642945152;51011;51495.74252128715;51552.742236290076;52330.47669523256;52943.20585191148;69223.65388173026;78352.60823695845;78371;78371.60814195893;78631;10557.9472102639;10652;10931.83602245951;11003.669889902996;11071.612493562687;13282.203067815963;13573.1856088635;13657.863421366057;13679.726405471636;14145.787813182606;11959.103067269816;12314.938425307817;12340.259584424963;14213.502527411905;15460.613484662974;14031.438742450187;14087.647808804863;14593.781093283396;14769.556913292618;15650.0609963398;13945.442182312594;14159.221242831743;14431.134131951696;14627.268636568342;14766.33551490207;10792.892071079188;10878.619248326271;11003.284786488852;11155.051820595016;11448.542058317575;11039.83440248413;11351.659450216506;11357.48891299877;11427.771444570895;11839.644810655695 20:25:06 INFO - PROCESS | 14927 | __end_tp_report 20:25:06 INFO - PROCESS | 14927 | __start_cc_report 20:25:06 INFO - PROCESS | 14927 | _x_x_mozilla_cycle_collect,850 20:25:06 INFO - PROCESS | 14927 | __end_cc_report 20:25:06 INFO - PROCESS | 14927 | __startTimestamp1466997906310__endTimestamp 20:25:06 INFO - PROCESS | 14927 | 20:25:06 INFO - PROCESS | 14927 | ------- Summary: start ------- 20:25:06 INFO - PROCESS | 14927 | Number of tests: 6 20:25:06 INFO - PROCESS | 14927 | 20:25:06 INFO - PROCESS | 14927 | [#0] dojo.html Cycles:165 Average:5333.43 Median:5512.06 stddev:610.60 (11.1%) stddev-sans-first:586.36 20:25:06 INFO - PROCESS | 14927 | Values: 3081.6 3086.2 3100.8 3123.0 3147.4 5250.1 5298.3 5332.8 5381.7 5397.7 5348.8 5390.8 5408.1 5428.5 5439.0 4863.1 4933.2 4944.9 4959.0 5052.1 4942.2 4966.6 4996.8 5001.3 5021.0 4784.5 4804.1 4840.5 4866.5 4876.3 4846.5 4865.3 4867.7 4922.5 4963.4 4886.7 4915.6 4920.6 4922.9 4959.4 5195.9 5274.6 5354.8 5357.5 5384.5 5782.2 5795.8 5808.6 5820.2 5822.2 5637.6 5822.8 5827.4 5846.2 5850.5 5312.8 5357.6 5359.5 5423.5 5434.1 5892.8 5896.5 5899.2 5909.9 5913.2 5509.7 5645.4 5701.1 5720.5 5726.6 5769.3 5772.3 5773.3 5813.8 5820.7 5700.2 5734.0 5740.6 5749.1 5749.7 5543.8 5548.0 5569.3 5758.2 5759.7 4303.0 4303.4 4312.3 4346.7 4348.0 3852.7 3874.7 3878.4 3899.6 3906.3 5254.2 5360.0 5365.9 5373.6 5394.5 5796.0 5799.0 5808.7 5817.2 5856.9 5441.3 5450.0 5452.5 5455.2 5457.1 4795.6 4882.2 4937.7 4952.8 4962.5 5918.0 5930.6 5936.9 5942.6 5943.0 5514.8 5778.3 5798.3 5800.1 5802.1 5819.3 5893.6 5910.6 5925.7 5936.3 5658.8 5662.5 5662.7 5664.3 5665.9 5510.0 5711.5 5765.1 5767.4 5776.1 5567.0 5587.6 5632.1 5642.0 5649.4 5560.7 5606.4 5612.5 5616.1 5619.1 5369.1 5463.2 5524.3 5530.2 5541.6 5589.8 5695.7 5702.8 5715.9 5717.3 5480.8 5502.9 5509.0 5512.1 5514.1 20:25:06 INFO - PROCESS | 14927 | 20:25:06 INFO - PROCESS | 14927 | [#1] ext.html Cycles:180 Average:60957.77 Median:398546.00 stddev:126070.81 (31.6%) stddev-sans-first:126343.01 20:25:06 INFO - PROCESS | 14927 | Values: 594.4 626.4 627.1 635.1 652.6 33411.2 36021.5 36031.5 36149.5 43246.8 42141.2 46075.3 46114.8 46124.1 46156.3 8695.4 8857.1 8859.5 8862.1 8863.2 8650.2 8769.0 8780.1 8809.3 8821.6 8840.6 8858.6 8869.6 8885.2 8887.6 8831.1 8874.8 8880.9 8881.1 8882.1 8817.6 8900.2 8913.5 8915.2 8921.3 42527.4 42848.8 42851.1 43106.6 43140.8 3559.3 3579.6 3648.3 3679.7 3716.8 31459.7 33475.3 33864.5 34119.5 34137.7 3644.1 3678.1 3851.8 3863.2 3866.1 356547.0 357631.0 363444.0 363618.0 363663.0 32291.7 64564.7 64981.4 65249.0 65517.8 37777.4 38001.2 38066.0 38101.8 38187.0 14542.1 14600.5 14602.2 14603.1 14675.8 12984.5 13124.4 13151.1 13159.1 13164.1 8425.5 8436.5 8473.5 8513.7 8536.8 3268.4 3283.8 3291.7 3300.5 3311.9 1055.0 1061.2 1083.3 1090.6 1150.8 32273.5 32882.8 33384.7 33644.8 34051.5 1144.8 1164.0 1169.3 1172.3 1197.4 17482.8 17511.2 17579.0 17587.3 17739.3 605456.0 617298.0 618534.0 619016.0 620579.0 59448.7 60133.4 60347.7 60355.7 60360.7 1272.7 1357.6 1397.3 1401.6 1412.9 32573.2 33435.8 33868.2 34155.1 34261.3 49592.0 50233.0 50262.5 50276.7 50305.7 396432.0 400660.0 402193.0 402870.0 403212.0 25333.1 25466.7 27592.0 28336.6 28504.3 47756.0 47917.3 48979.0 49263.0 49892.3 41757.8 42956.6 43188.8 43787.0 44739.0 40877.6 42296.6 42305.8 42938.1 43520.6 42548.1 42913.4 43463.1 43617.3 43753.6 35632.6 37040.4 37294.6 37644.0 37727.0 28879.7 29014.8 29150.0 29309.4 29431.0 20:25:06 INFO - PROCESS | 14927 | 20:25:06 INFO - PROCESS | 14927 | [#2] jquery.html Cycles:180 Average:27674.55 Median:18818.86 stddev:77524.95 (412.0%) stddev-sans-first:77715.32 20:25:06 INFO - PROCESS | 14927 | Values: 373.7 380.2 383.3 387.0 388.3 18014.4 19686.8 20207.8 20612.5 20815.7 18935.5 19403.5 19773.1 20026.4 20060.6 5558.3 5693.6 5756.2 5959.3 5962.3 5743.0 5839.6 5850.4 5880.3 5880.4 5680.9 5755.3 5828.7 5881.1 5890.8 5732.4 5736.4 5748.8 5806.3 5841.1 4744.3 5059.2 5094.2 5101.0 5102.8 13528.2 13967.5 22673.2 22842.0 22849.9 2134.8 2192.8 2299.9 2518.0 2625.7 9457.0 9693.7 10150.7 11031.9 14143.2 1874.8 1912.5 1956.1 1961.2 1997.6 54581.7 68428.7 69845.7 79886.0 85449.6 9086.6 9911.8 9958.7 10107.4 10310.6 11857.3 12594.8 12628.3 13267.0 13326.0 7758.1 7781.5 7905.4 8119.3 8120.1 8136.5 8184.0 8194.3 8274.9 8322.2 3873.8 4023.4 4046.6 4091.3 4159.8 1732.5 1769.2 1793.9 1829.8 1912.5 948.3 968.2 968.4 1028.2 1037.5 19164.1 19799.6 19829.6 19924.3 19940.3 967.1 974.4 985.2 997.4 1018.3 10674.9 11080.6 11091.9 11127.7 11201.5 456632.0 462161.0 468998.0 480478.0 486156.0 87501.0 88243.0 89290.1 90303.5 90664.0 996.3 998.5 1005.1 1026.1 1028.5 15573.5 17378.5 17729.2 18042.8 18265.6 27402.2 29776.1 31627.2 35977.3 37264.0 51449.5 51898.2 56383.4 57059.0 57093.0 8192.5 8619.9 8774.4 8819.3 8842.5 12602.4 12989.5 12999.4 13444.2 14459.9 11970.3 12046.8 12072.7 12101.3 12642.0 11691.4 11848.8 11852.1 11961.9 12355.3 11808.2 12426.0 12693.7 12714.5 12818.1 8370.8 8373.5 8480.2 8588.5 8603.5 11028.3 12238.5 12351.8 12351.9 12500.4 20:25:06 INFO - PROCESS | 14927 | 20:25:06 INFO - PROCESS | 14927 | [#3] mootools.html Cycles:180 Average:5897.34 Median:468.06 stddev:3504.56 (748.7%) stddev-sans-first:3497.35 20:25:06 INFO - PROCESS | 14927 | Values: 1298.1 1454.7 1482.6 1568.0 1724.2 8554.2 8951.9 8959.1 9208.7 9212.6 8972.8 9176.9 9178.8 9181.7 9188.9 2229.1 2250.2 2252.5 2256.6 2257.5 2260.4 2289.0 2293.3 2295.9 2297.6 2205.3 2206.1 2239.8 2249.4 2254.8 2158.8 2163.7 2198.3 2200.5 2203.6 2163.4 2170.8 2174.3 2179.7 2188.7 8487.1 8820.1 8910.5 8920.8 9016.4 5191.8 5335.0 5349.0 5356.4 5359.6 3309.8 3347.8 3375.1 3383.1 3429.4 1032.7 1034.5 1044.0 1048.4 1058.2 12910.7 12939.2 12983.2 12994.6 13036.7 4523.9 4544.7 4573.6 4619.2 4627.9 9897.7 9948.5 9952.4 9953.4 9968.9 5200.7 5253.1 5277.4 5279.4 5280.7 4167.7 4234.9 4802.7 4834.5 4834.6 3768.9 3852.2 3867.9 3895.8 3907.9 1128.5 1128.5 1133.1 1143.8 1144.7 863.9 940.5 945.1 964.7 989.1 5920.3 5989.1 6046.8 6073.9 6152.7 450.7 454.1 461.6 464.4 471.7 3973.3 4000.7 4091.0 4114.4 4147.3 10989.6 11417.4 11423.9 11560.8 11562.1 11399.3 11478.8 11516.3 11528.8 11561.3 8060.6 8460.6 8475.7 8673.7 8693.5 6035.3 6093.3 6148.2 6198.3 6212.3 10306.0 10549.3 10597.3 10632.6 10714.7 10582.8 10730.7 10910.3 11021.8 11035.6 7333.2 7853.4 8088.8 8114.7 8318.4 8559.5 9052.0 9093.4 9122.1 9149.3 7828.2 7881.1 7923.2 7974.8 8075.8 7509.6 7673.9 7838.8 7885.8 7922.9 7154.6 7185.8 7219.2 7286.7 7299.0 4937.5 4956.7 5014.9 5023.4 5042.9 5320.8 5341.5 5366.5 5392.1 5520.0 20:25:06 INFO - PROCESS | 14927 | 20:25:06 INFO - PROCESS | 14927 | [#4] prototype.html Cycles:180 Average:4521.69 Median:5090.39 stddev:1349.40 (26.5%) stddev-sans-first:1315.64 20:25:06 INFO - PROCESS | 14927 | Values: 309.9 310.5 314.4 322.4 327.0 5029.7 5124.0 5140.4 5175.9 5190.7 5160.6 5194.0 5199.0 5218.2 5223.7 4103.8 4108.8 4112.1 4113.5 4116.6 3798.8 3885.2 4033.7 4110.4 4131.7 3990.3 4000.5 4011.9 4012.0 4031.3 4002.0 4009.0 4010.6 4034.7 4050.0 3460.4 3543.8 3551.1 3552.8 3556.7 5053.4 5059.2 5073.8 5089.5 5100.8 4578.2 4583.5 4598.4 4604.2 4613.6 5189.8 5411.0 5414.2 5483.3 5526.9 3869.1 3886.0 3902.4 3907.8 3934.9 5652.2 5688.1 5737.8 5739.4 5764.3 3795.7 3934.6 3937.3 3958.2 3968.7 3943.3 3986.7 3992.7 3994.2 3998.2 4601.4 4603.7 4607.5 4608.9 4615.4 5407.8 5523.9 5525.9 5532.2 5556.6 1308.8 1355.8 1378.4 1399.3 1403.8 840.6 847.5 854.0 863.4 887.8 4755.9 4759.2 4777.2 4782.2 4794.9 5078.7 5079.4 5086.2 5091.3 5098.3 4464.0 4670.0 4674.3 4737.8 4779.1 2658.7 2717.5 2724.9 2725.4 2726.7 5065.7 5088.0 5125.5 5135.5 5138.3 5052.6 5097.4 5104.5 5323.3 5826.5 5786.3 5828.2 5834.5 5849.7 5854.2 5692.6 5700.9 5701.7 5703.9 5711.9 5480.9 5572.4 5622.3 5630.7 5644.4 5757.0 5803.2 5814.7 5829.2 5869.8 3888.9 3948.5 3967.2 3972.0 3983.2 5433.3 5705.2 5713.9 5714.6 5714.8 5422.8 5547.4 5563.6 5567.5 5569.1 5462.7 5490.5 5513.4 5537.3 5537.4 5202.5 5435.5 5435.9 5440.2 5446.3 5453.9 5469.2 5520.9 5525.9 5565.3 5351.5 5401.6 5427.5 5438.7 5441.7 20:25:06 INFO - PROCESS | 14927 | 20:25:06 INFO - PROCESS | 14927 | [#5] yui.html Cycles:180 Average:20518.93 Median:4541.03 stddev:29816.47 (656.6%) stddev-sans-first:29863.17 20:25:06 INFO - PROCESS | 14927 | Values: 753.0 792.8 795.5 845.4 851.5 14072.0 14943.9 14968.6 14977.9 15047.2 14841.1 14931.3 14951.0 14957.1 14969.3 657.6 780.4 817.6 822.0 823.9 806.5 813.8 814.1 815.6 818.4 687.2 869.9 870.8 872.6 872.7 721.9 724.0 807.1 862.6 864.8 638.4 638.6 638.8 639.3 639.7 15272.5 15285.1 15326.6 15337.3 15362.0 13955.4 14113.4 14498.3 14576.1 14589.8 12068.4 12244.6 12418.9 12487.5 12508.2 4482.2 4517.5 4540.7 4541.4 4583.3 67453.7 70496.6 70506.6 72180.0 77289.0 11199.8 11593.9 11732.6 11761.9 12133.9 17714.1 17719.4 17732.8 17732.9 17800.4 8755.2 8980.5 9030.2 9287.4 9327.3 4924.4 4929.6 5028.8 5094.7 5229.2 3540.9 3641.7 3650.8 3652.6 3656.5 592.4 592.6 599.2 608.4 623.5 746.4 765.2 768.2 789.2 814.1 9744.4 9988.5 10036.6 10286.2 10328.3 721.4 732.3 735.5 760.0 776.3 4881.4 5045.4 5053.2 5067.1 5079.0 114080.0 117340.4 118775.0 119762.4 119816.0 101676.5 105449.5 105850.0 105941.6 105967.0 55535.0 57226.4 76201.2 84940.0 85453.6 9163.5 9187.2 9194.6 9322.0 9404.2 51011.0 51495.7 51552.7 52330.5 52943.2 69223.7 78352.6 78371.0 78371.6 78631.0 10557.9 10652.0 10931.8 11003.7 11071.6 13282.2 13573.2 13657.9 13679.7 14145.8 11959.1 12314.9 12340.3 14213.5 15460.6 14031.4 14087.6 14593.8 14769.6 15650.1 13945.4 14159.2 14431.1 14627.3 14766.3 10792.9 10878.6 11003.3 11155.1 11448.5 11039.8 11351.7 11357.5 11427.8 11839.6 20:25:06 INFO - PROCESS | 14927 | -------- Summary: end -------- 20:25:06 INFO - PROCESS | 14927 | 20:25:07 INFO - TEST-INFO | 14927: exit 0 20:25:07 INFO - TEST-OK | dromaeo_css | took 1113845ms 20:25:07 INFO - TEST-START | kraken 20:25:07 INFO - operating with platform_type : linux_ 20:25:07 INFO - Initialising browser for kraken test... 20:25:07 INFO - TEST-INFO | started process 15116 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAazGaK/profile http://localhost:48265/getInfo.html) 20:25:11 INFO - PROCESS | 15116 | __metrics Screen width/height:1600/1200 20:25:11 INFO - PROCESS | 15116 | colorDepth:24 20:25:11 INFO - PROCESS | 15116 | Browser inner width/height: 1024/697 20:25:11 INFO - PROCESS | 15116 | __metrics 20:25:12 INFO - PROCESS | 15116 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:25:13 INFO - TEST-INFO | 15116: exit 0 20:25:13 INFO - Browser initialized. 20:25:13 INFO - Running cycle 1/1 for kraken test... 20:25:13 INFO - TEST-INFO | started process 15199 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAazGaK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:25:24 INFO - PROCESS | 15199 | RSS: Main: 174592000 20:25:24 INFO - PROCESS | 15199 | 20:25:27 INFO - PROCESS | 15199 | Cycle 1(1): loaded http://localhost:48265/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48265/tests/kraken/driver.html?testName=audio-beat-detection) 20:25:28 INFO - PROCESS | 15199 | RSS: Main: 232321024 20:25:28 INFO - PROCESS | 15199 | 20:25:31 INFO - PROCESS | 15199 | Cycle 1(1): loaded http://localhost:48265/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48265/tests/kraken/driver.html?testName=audio-dft) 20:25:31 INFO - PROCESS | 15199 | RSS: Main: 219910144 20:25:31 INFO - PROCESS | 15199 | 20:25:34 INFO - PROCESS | 15199 | Cycle 1(1): loaded http://localhost:48265/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48265/tests/kraken/driver.html?testName=audio-fft) 20:25:35 INFO - PROCESS | 15199 | RSS: Main: 285982720 20:25:35 INFO - PROCESS | 15199 | 20:25:37 INFO - PROCESS | 15199 | Cycle 1(1): loaded http://localhost:48265/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48265/tests/kraken/driver.html?testName=audio-oscillator) 20:25:37 INFO - PROCESS | 15199 | RSS: Main: 196857856 20:25:37 INFO - PROCESS | 15199 | 20:25:40 INFO - PROCESS | 15199 | Cycle 1(1): loaded http://localhost:48265/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48265/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:25:40 INFO - PROCESS | 15199 | RSS: Main: 201342976 20:25:40 INFO - PROCESS | 15199 | 20:25:43 INFO - PROCESS | 15199 | Cycle 1(1): loaded http://localhost:48265/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48265/tests/kraken/driver.html?testName=imaging-darkroom) 20:25:44 INFO - PROCESS | 15199 | RSS: Main: 235585536 20:25:44 INFO - PROCESS | 15199 | 20:25:47 INFO - PROCESS | 15199 | Cycle 1(1): loaded http://localhost:48265/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48265/tests/kraken/driver.html?testName=imaging-desaturate) 20:25:48 INFO - PROCESS | 15199 | RSS: Main: 238333952 20:25:48 INFO - PROCESS | 15199 | 20:25:51 INFO - PROCESS | 15199 | Cycle 1(1): loaded http://localhost:48265/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48265/tests/kraken/driver.html?testName=json-parse-financial) 20:25:51 INFO - PROCESS | 15199 | RSS: Main: 237408256 20:25:51 INFO - PROCESS | 15199 | 20:25:53 INFO - PROCESS | 15199 | Cycle 1(1): loaded http://localhost:48265/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48265/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:25:53 INFO - PROCESS | 15199 | RSS: Main: 225136640 20:25:53 INFO - PROCESS | 15199 | 20:25:55 INFO - PROCESS | 15199 | Cycle 1(1): loaded http://localhost:48265/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48265/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:25:56 INFO - PROCESS | 15199 | RSS: Main: 228990976 20:25:56 INFO - PROCESS | 15199 | 20:25:58 INFO - PROCESS | 15199 | Cycle 1(1): loaded http://localhost:48265/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48265/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:25:58 INFO - PROCESS | 15199 | RSS: Main: 237596672 20:25:58 INFO - PROCESS | 15199 | 20:26:01 INFO - PROCESS | 15199 | Cycle 1(1): loaded http://localhost:48265/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48265/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:26:02 INFO - PROCESS | 15199 | RSS: Main: 240287744 20:26:02 INFO - PROCESS | 15199 | 20:26:04 INFO - PROCESS | 15199 | Cycle 1(1): loaded http://localhost:48265/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48265/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:26:05 INFO - PROCESS | 15199 | RSS: Main: 241401856 20:26:05 INFO - PROCESS | 15199 | 20:26:07 INFO - PROCESS | 15199 | Cycle 1(1): loaded http://localhost:48265/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48265/tests/kraken/driver.html?testName=ai-astar) 20:26:07 INFO - PROCESS | 15199 | RSS: Main: 284213248 20:26:07 INFO - PROCESS | 15199 | 20:26:07 INFO - PROCESS | 15199 | __start_tp_report 20:26:07 INFO - PROCESS | 15199 | _x_x_mozilla_page_load 20:26:07 INFO - PROCESS | 15199 | _x_x_mozilla_page_load_details 20:26:07 INFO - PROCESS | 15199 | |i|pagename|runs| 20:26:07 INFO - PROCESS | 15199 | |0;ai-astar;102;111;113;111;109;111;109;110;109;118 20:26:07 INFO - PROCESS | 15199 | |1;audio-beat-detection;149;125;129;183;133;127;149;126;156;133 20:26:07 INFO - PROCESS | 15199 | |2;audio-dft;161;160;161;161;161;159;161;162;161;162 20:26:07 INFO - PROCESS | 15199 | |3;audio-fft;75;74;76;137;76;78;75;75;100;75 20:26:07 INFO - PROCESS | 15199 | |4;audio-oscillator;85;85;118;85;92;85;112;84;86;123 20:26:07 INFO - PROCESS | 15199 | |5;imaging-gaussian-blur;117;117;116;116;116;117;117;116;117;117 20:26:07 INFO - PROCESS | 15199 | |6;imaging-darkroom;145;146;146;146;145;146;146;146;146;145 20:26:07 INFO - PROCESS | 15199 | |7;imaging-desaturate;95;95;95;95;95;95;94;95;96;95 20:26:07 INFO - PROCESS | 15199 | |8;json-parse-financial;54;53;54;54;54;54;60;54;52;53 20:26:07 INFO - PROCESS | 15199 | |9;json-stringify-tinderbox;61;62;61;62;62;62;62;61;62;62 20:26:07 INFO - PROCESS | 15199 | |10;stanford-crypto-aes;79;79;85;79;79;80;81;81;98;80 20:26:07 INFO - PROCESS | 15199 | |11;stanford-crypto-ccm;130;124;125;133;122;123;128;130;125;127 20:26:07 INFO - PROCESS | 15199 | |12;stanford-crypto-pbkdf2;159;160;158;159;159;167;169;164;157;159 20:26:07 INFO - PROCESS | 15199 | |13;stanford-crypto-sha256-iterative;64;63;64;64;63;66;68;62;63;68 20:26:07 INFO - PROCESS | 15199 | __end_tp_report 20:26:07 INFO - PROCESS | 15199 | __start_cc_report 20:26:07 INFO - PROCESS | 15199 | _x_x_mozilla_cycle_collect,1606 20:26:07 INFO - PROCESS | 15199 | __end_cc_report 20:26:07 INFO - PROCESS | 15199 | __startTimestamp1466997967342__endTimestamp 20:26:07 INFO - PROCESS | 15199 | 20:26:07 INFO - PROCESS | 15199 | ------- Summary: start ------- 20:26:07 INFO - PROCESS | 15199 | Number of tests: 14 20:26:07 INFO - PROCESS | 15199 | 20:26:07 INFO - PROCESS | 15199 | [#0] ai-astar Cycles:10 Average:110.30 Median:111.00 stddev:3.97 (3.6%) stddev-sans-first:2.86 20:26:07 INFO - PROCESS | 15199 | Values: 102.0 111.0 113.0 111.0 109.0 111.0 109.0 110.0 109.0 118.0 20:26:07 INFO - PROCESS | 15199 | 20:26:07 INFO - PROCESS | 15199 | [#1] audio-beat-detection Cycles:10 Average:141.00 Median:141.00 stddev:18.46 (13.1%) stddev-sans-first:19.35 20:26:07 INFO - PROCESS | 15199 | Values: 149.0 125.0 129.0 183.0 133.0 127.0 149.0 126.0 156.0 133.0 20:26:07 INFO - PROCESS | 15199 | 20:26:07 INFO - PROCESS | 15199 | [#2] audio-dft Cycles:10 Average:160.90 Median:161.00 stddev:0.88 (0.5%) stddev-sans-first:0.93 20:26:07 INFO - PROCESS | 15199 | Values: 161.0 160.0 161.0 161.0 161.0 159.0 161.0 162.0 161.0 162.0 20:26:07 INFO - PROCESS | 15199 | 20:26:07 INFO - PROCESS | 15199 | [#3] audio-fft Cycles:10 Average:84.10 Median:75.00 stddev:20.15 (26.9%) stddev-sans-first:21.10 20:26:07 INFO - PROCESS | 15199 | Values: 75.0 74.0 76.0 137.0 76.0 78.0 75.0 75.0 100.0 75.0 20:26:07 INFO - PROCESS | 15199 | 20:26:07 INFO - PROCESS | 15199 | [#4] audio-oscillator Cycles:10 Average:95.50 Median:85.00 stddev:15.67 (18.4%) stddev-sans-first:16.16 20:26:07 INFO - PROCESS | 15199 | Values: 85.0 85.0 118.0 85.0 92.0 85.0 112.0 84.0 86.0 123.0 20:26:07 INFO - PROCESS | 15199 | 20:26:07 INFO - PROCESS | 15199 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 20:26:07 INFO - PROCESS | 15199 | Values: 117.0 117.0 116.0 116.0 116.0 117.0 117.0 116.0 117.0 117.0 20:26:07 INFO - PROCESS | 15199 | 20:26:07 INFO - PROCESS | 15199 | [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.48 (0.3%) stddev-sans-first:0.44 20:26:07 INFO - PROCESS | 15199 | Values: 145.0 146.0 146.0 146.0 145.0 146.0 146.0 146.0 146.0 145.0 20:26:07 INFO - PROCESS | 15199 | 20:26:07 INFO - PROCESS | 15199 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 20:26:07 INFO - PROCESS | 15199 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 94.0 95.0 96.0 95.0 20:26:07 INFO - PROCESS | 15199 | 20:26:07 INFO - PROCESS | 15199 | [#8] json-parse-financial Cycles:10 Average:54.20 Median:54.00 stddev:2.15 (4.0%) stddev-sans-first:2.28 20:26:07 INFO - PROCESS | 15199 | Values: 54.0 53.0 54.0 54.0 54.0 54.0 60.0 54.0 52.0 53.0 20:26:07 INFO - PROCESS | 15199 | 20:26:07 INFO - PROCESS | 15199 | [#9] json-stringify-tinderbox Cycles:10 Average:61.70 Median:62.00 stddev:0.48 (0.8%) stddev-sans-first:0.44 20:26:07 INFO - PROCESS | 15199 | Values: 61.0 62.0 61.0 62.0 62.0 62.0 62.0 61.0 62.0 62.0 20:26:07 INFO - PROCESS | 15199 | 20:26:07 INFO - PROCESS | 15199 | [#10] stanford-crypto-aes Cycles:10 Average:82.10 Median:80.50 stddev:5.88 (7.3%) stddev-sans-first:6.13 20:26:07 INFO - PROCESS | 15199 | Values: 79.0 79.0 85.0 79.0 79.0 80.0 81.0 81.0 98.0 80.0 20:26:07 INFO - PROCESS | 15199 | 20:26:07 INFO - PROCESS | 15199 | [#11] stanford-crypto-ccm Cycles:10 Average:126.70 Median:127.50 stddev:3.53 (2.8%) stddev-sans-first:3.54 20:26:07 INFO - PROCESS | 15199 | Values: 130.0 124.0 125.0 133.0 122.0 123.0 128.0 130.0 125.0 127.0 20:26:07 INFO - PROCESS | 15199 | 20:26:07 INFO - PROCESS | 15199 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.10 Median:159.50 stddev:4.09 (2.6%) stddev-sans-first:4.27 20:26:07 INFO - PROCESS | 15199 | Values: 159.0 160.0 158.0 159.0 159.0 167.0 169.0 164.0 157.0 159.0 20:26:07 INFO - PROCESS | 15199 | 20:26:07 INFO - PROCESS | 15199 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.50 Median:64.00 stddev:2.12 (3.3%) stddev-sans-first:2.24 20:26:07 INFO - PROCESS | 15199 | Values: 64.0 63.0 64.0 64.0 63.0 66.0 68.0 62.0 63.0 68.0 20:26:07 INFO - PROCESS | 15199 | -------- Summary: end -------- 20:26:07 INFO - PROCESS | 15199 | 20:26:08 INFO - TEST-INFO | 15199: exit 0 20:26:08 INFO - TEST-OK | kraken | took 61204ms 20:26:08 INFO - SUITE-END | took 1175s 20:26:08 INFO - Completed test suite (00:19:35) 20:26:08 INFO - javascript benchmark 20:26:08 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3081.5839861618674, 3086.2130156810013, 3100.8449577521124, 3122.9531557026635, 3147.449196390631, 5250.133727934886, 5298.284731561238, 5332.840014799553, 5381.730913454327, 5397.676139431637, 5348.839534813952, 5390.78436862525, 5408.107662235736, 5428.511433970942, 5438.972805135979, 4863.051704917542, 4933.186024306003, 4944.901101977958, 4958.950410495903, 5052.065367906931, 4942.209246520558, 4966.627502937276, 4996.750162491879, 5001.324821149135, 5020.974895125538, 4784.497627749071, 4804.063207674505, 4840.515948405149, 4866.46468888422, 4876.292937524075, 4846.466888642281, 4865.318855360252, 4867.683600565952, 4922.507749225085, 4963.354763880672, 4886.70679759212, 4915.5821755150855, 4920.6309526785635, 4922.876928076791, 4959.404871415417, 5195.948040519622, 5274.604404669665, 5354.839354819323, 5357.464253574651, 5384.488473595002, 5782.190493330937, 5795.797147099874, 5808.6224395414165, 5820.243368362086, 5822.155787410802, 5637.633553818989, 5822.82531524055, 5827.388124246935, 5846.21076154718, 5850.531957443394, 5312.787488500456, 5357.624966252325, 5359.5444387227135, 5423.484768946943, 5434.076207044812, 5892.793752218738, 5896.498797602166, 5899.174115623816, 5909.940900590939, 5913.231279933581, 5509.696966666872, 5645.407232240637, 5701.087825947829, 5720.542356611461, 5726.570507211975, 5769.307683077974, 5772.307323121168, 5773.307203135567, 5813.79651712188, 5820.650760954271, 5700.23046888673, 5733.971330143323, 5740.598158128891, 5749.051406517961, 5749.683767392834, 5543.805966791224, 5547.972260138754, 5569.275994120739, 5758.222639943638, 5759.65442073477, 4303.0, 4303.419038429772, 4312.310030395121, 4346.6522678185665, 4348.0, 3852.6725228355344, 3874.7093967952515, 3878.3794592865006, 3899.629535194152, 3906.2968665640456, 5254.159334506537, 5360.0351936650995, 5365.946340536622, 5373.570114390839, 5394.514493695587, 5795.971020144872, 5799.0, 5808.680522571299, 5817.156512305692, 5856.8535786604825, 5441.319835020622, 5450.0, 5452.509274165265, 5455.208994695747, 5457.126859702428, 4795.640326975491, 4882.170031094723, 4937.703737775745, 4952.777125029383, 4962.528559786814, 5918.0, 5930.55520835939, 5936.851578710481, 5942.64344139353, 5943.0, 5514.80698175562, 5778.306603207642, 5798.275215598051, 5800.071988481823, 5802.071668533014, 5819.272590926134, 5893.557983151367, 5910.556708246812, 5925.703714814156, 5936.347001829881, 5658.830235092953, 5662.518685911744, 5662.716864156693, 5664.320281566238, 5665.915011274752, 5510.0, 5711.543076553949, 5765.135229715576, 5767.394423585463, 5776.104703770922, 5567.0, 5587.580931430078, 5632.127020311858, 5641.971790141023, 5649.350324712711, 5560.666360018412, 5606.383297837153, 5612.466815652507, 5616.073347897551, 5619.072852979212, 5369.0872551665525, 5463.207834863843, 5524.281843360337, 5530.225768392348, 5541.612087153861, 5589.77640894376, 5695.715214239189, 5702.800401985911, 5715.914261286167, 5717.285339332583, 5480.753366098455, 5502.889942201214, 5508.9724551376985, 5512.062949298709, 5514.145307477347], "value": 5291.817820813715, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [594.3966873623273, 626.4455956478516, 627.0656721484988, 635.0632816595522, 652.5986518291251, 33411.16472088196, 36021.45967810482, 36031.459528107036, 36149.45775813365, 43246.78376608113, 42141.15717685652, 46075.30887036697, 46114.76942615282, 46124.07751844961, 46156.30765538519, 8695.434796738191, 8857.114288571156, 8859.512726800023, 8862.06948270432, 8863.202311791938, 8650.221480066793, 8768.956155219246, 8780.078091800333, 8809.339299552526, 8821.647134114628, 8840.646374145026, 8858.645654173826, 8869.645214191425, 8885.244754195868, 8887.644494220223, 8831.116888311182, 8874.778130546723, 8880.866786998167, 8881.111888811132, 8882.11178882113, 8817.559122043873, 8900.154485323948, 8913.509756963364, 8915.197632213067, 8921.286297096216, 42527.36208956837, 42848.78575607133, 42851.14297714028, 43106.56893431057, 43140.78429607863, 3559.323728491604, 3579.6241394653707, 3648.3068217038676, 3679.6504332088407, 3716.776993380379, 31459.685403145904, 33475.33049338999, 33864.49203261953, 34119.488207676906, 34137.6586234137, 3644.0525463379713, 3678.1172518595345, 3851.807409629507, 3863.16941857502, 3866.0914685048992, 356547.0, 357631.0, 363444.0, 363618.0, 363663.0, 32291.677083229337, 64564.67717661382, 64981.35018649847, 65249.0, 65517.7585793145, 37777.43333849994, 38001.23997520034, 38066.0, 38101.809490952364, 38187.0, 14542.127472351693, 14600.488982885548, 14602.196879171535, 14603.050801697857, 14675.77986330206, 12984.480620775252, 13124.409401576951, 13151.145175563557, 13159.144655597356, 13164.078514504085, 8425.452345597516, 8436.493810371398, 8473.533955632376, 8513.702020429255, 8536.786580335542, 3268.4116858965613, 3283.8029718216985, 3291.7037466628117, 3300.5379246905454, 3311.9006429807146, 1054.984175237372, 1061.151079136703, 1083.3337497439018, 1090.5855774805523, 1150.8216226484908, 32273.51589726156, 32882.835585821915, 33384.666153338156, 33644.83177584096, 34051.48922766161, 1144.8065963139377, 1163.9825402618967, 1169.3334799164566, 1172.3376292394769, 1197.3773637708516, 17482.825171748373, 17511.211995460235, 17579.0, 17587.29650813979, 17739.290428382978, 605456.0, 617298.0, 618534.0, 619016.0, 620579.0, 59448.702756486804, 60133.39866601278, 60347.69826150841, 60355.69822150949, 60360.69819650874, 1272.7454509098218, 1357.6130802721375, 1397.336265274007, 1401.6145559970885, 1412.941668825602, 32573.18567035748, 33435.83282083574, 33868.153296167795, 34155.14612134716, 34261.31477370389, 49592.0, 50233.0, 50262.497375025785, 50276.748616256686, 50305.74847125741, 396432.0, 400660.0, 402193.0, 402870.0, 403212.0, 25333.113341032975, 25466.745332546438, 27592.0, 28336.574951375333, 28504.287392814516, 47756.0, 47917.28124078072, 48979.0, 49263.0, 49892.25315047862, 41757.79121104497, 42956.570434296504, 43188.784056079516, 43787.0, 44739.0, 40877.59122408857, 42296.5770342305, 42305.78847105745, 42938.1412371757, 43520.56479435165, 42548.149037019706, 42913.35629965615, 43463.130737385705, 43617.345739813296, 43753.56246437622, 35632.64367356397, 37040.444393333586, 37294.627053730204, 37644.0, 37727.0, 28879.711202888542, 29014.829290723646, 29150.0, 29309.413811723218, 29431.0], "value": 19133.837609897182, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [373.7234446509583, 380.17691697474976, 383.25265731822935, 386.98452061917527, 388.2991200882408, 18014.369497067604, 19686.803131968674, 20207.797922020756, 20612.484687882792, 20815.687764683542, 18935.52661183471, 19403.514912127204, 19773.110210040548, 20026.399208023748, 20060.59878802427, 5558.333000040001, 5693.633527953282, 5756.194132821398, 5959.255093113361, 5962.25471816023, 5742.971285143569, 5839.620424672404, 5850.444207800273, 5880.294364676223, 5880.441358070998, 5680.943190568103, 5755.280589926259, 5828.650280983134, 5881.147233651118, 5890.823275301748, 5732.398098199671, 5736.426357364272, 5748.770049198006, 5806.303243610751, 5841.065429531276, 4744.288356746481, 5059.1905295152965, 5094.235864620299, 5101.0308041472, 5102.846914592568, 13528.188308701509, 13967.473280200733, 22673.206437774763, 22842.0, 22849.885750571306, 2134.839887008465, 2192.8245740340735, 2299.8965046572944, 2518.0179729905353, 2625.737426257378, 9456.952715236379, 9693.70918872435, 10150.695479135638, 11031.944840275828, 14143.151410915378, 1874.7937726850037, 1912.502749285182, 1956.1001939108028, 1961.2253160001862, 1997.57052233769, 54581.727091364286, 68428.6578567109, 69845.65077174582, 79886.0, 85449.57275213646, 9086.591103400362, 9911.80176396468, 9958.701238962843, 10107.444090575089, 10310.639127630497, 11857.34784586856, 12594.81107783384, 12628.305443200528, 13267.0, 13326.0, 7758.107817600935, 7781.494202876795, 7905.367570594339, 8119.269265766109, 8120.14738452454, 8136.471129376571, 8184.0, 8194.262516373556, 8274.917250827535, 8322.20939010793, 3873.767573945572, 4023.3964905264443, 4046.615571520701, 4091.284025295561, 4159.812808423628, 1732.497575703032, 1769.2215425212864, 1793.9461816145536, 1829.762130922998, 1912.540990162351, 948.307735353196, 968.1963969904962, 968.3657204531044, 1028.1620479309338, 1037.5382954585289, 19164.137613807412, 19799.60400791976, 19829.60340793176, 19924.30264940749, 19940.302089427092, 967.1295833749682, 974.4007435427161, 985.1872205430549, 997.4264797741328, 1018.3319702379812, 10674.946625266824, 11080.61217857371, 11091.889081109248, 11127.721806954729, 11201.495932683049, 456632.0, 462161.0, 468998.0, 480478.0, 486156.0, 87501.0, 88243.0, 89290.10709892948, 90303.54848225717, 90664.0, 996.2913603170597, 998.4758002048983, 1005.1004351105865, 1026.1124127629546, 1028.4600584693096, 15573.454929077428, 17378.47864564065, 17729.202185901922, 18042.819571804637, 18265.634687305912, 27402.156489879537, 29776.10671679853, 31627.20931976627, 35977.28045439024, 37264.0, 51449.48550514447, 51898.221526676374, 56383.43616563782, 57059.0, 57093.0, 8192.549409782281, 8619.8707019396, 8774.38579299443, 8819.29445644334, 8842.513661748666, 12602.36988150607, 12989.545365912525, 12999.350032498527, 13444.193348399127, 14459.855401446272, 11970.281783093042, 12046.75906481883, 12072.698182545506, 12101.334426606621, 12642.0, 11691.415429228675, 11848.76302473963, 11852.111091667986, 11961.880381196077, 12355.25868447896, 11808.173427859967, 12426.0, 12693.682657933256, 12714.491420343084, 12818.102732808615, 8370.832583348178, 8373.455725377831, 8480.236778689947, 8588.484690918565, 8603.483790972561, 11028.28316159447, 12238.510459581874, 12351.75296494083, 12351.93824030874, 12500.437480313225], "value": 8981.629638268681, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1298.1237664576408, 1454.6872422429178, 1482.599698081518, 1567.9608009799754, 1724.189630873489, 8554.18735220154, 8951.865722014176, 8959.104089591046, 9208.67769628063, 9212.585433655484, 8972.820543589125, 9176.908230917688, 9178.816423671522, 9181.724548263563, 9188.908110918888, 2229.108356657338, 2250.1561914282142, 2252.538229662923, 2256.6050941085246, 2257.525919556895, 2260.389694782408, 2288.9885550572226, 2293.289080385078, 2295.885205739715, 2297.5864344417996, 2205.2612374854443, 2206.095500844654, 2239.7760223977552, 2249.3701763506247, 2254.77452254774, 2158.7625361210253, 2163.707899433572, 2198.296545105567, 2200.5378870437066, 2203.6253836847773, 2163.350994701583, 2170.7829217078324, 2174.3368272676826, 2179.69484272202, 2188.715466989297, 8487.108853570347, 8820.117988201193, 8910.50992195429, 8920.821583568357, 9016.36885418021, 5191.8442446726285, 5335.013022590794, 5348.973255133738, 5356.38401583819, 5359.598030147755, 3309.8014119152926, 3347.832608369596, 3375.139339468444, 3383.052745231339, 3429.382711111999, 1032.726327523207, 1034.534459493231, 1043.984340234897, 1048.3657387280662, 1058.2063452410691, 12910.677233069155, 12939.223646581235, 12983.22100673972, 12994.610161695164, 13036.739265214737, 4523.909521809545, 4544.7045942013665, 4573.588377046081, 4619.1685496610935, 4627.9074418511445, 9897.7030689078, 9948.502574871372, 9952.353097048668, 9953.353032052893, 9968.900310996942, 5200.6619569727845, 5253.080710875658, 5277.366715994105, 5279.392869819943, 5280.7359632019015, 4167.687423443193, 4234.872953811329, 4802.711837289774, 4834.516548345137, 4834.564889159992, 3768.9246215075545, 3852.1910398816003, 3867.903302417462, 3895.7857317847224, 3907.902302442462, 1128.503458478267, 1128.5316593613559, 1133.1444759206747, 1143.8112711402525, 1144.6566030191077, 863.8920134983127, 940.4780346907532, 945.1446440970794, 964.7202311329636, 989.1048601016092, 5920.348761636216, 5989.071693887455, 6046.818595442144, 6073.908891366633, 6152.692365381713, 450.73406690053025, 454.0759554307035, 461.5937974582346, 464.3777338366605, 471.7451578800374, 3973.264945985002, 4000.6797756740207, 4090.9795451022555, 4114.423980642712, 4147.2534943710425, 10989.61536346224, 11417.42912854354, 11423.942880285545, 11560.76878462426, 11562.132840037031, 11399.259048161843, 11478.827817582744, 11516.251443656136, 11528.769424611628, 11561.30632162073, 8060.556669383123, 8460.576971151419, 8475.70335038283, 8673.6530538779, 8693.521856297837, 6035.336113027475, 6093.329733729375, 6148.1699970503405, 6198.256209254918, 6212.254529456494, 10305.99033188551, 10549.314294570828, 10597.311174773615, 10632.574697012033, 10714.678559643224, 10582.788344233226, 10730.73173170677, 10910.290831095954, 11021.83467248008, 11035.558577656804, 7333.230010848997, 7853.410994175346, 8088.838223235384, 8114.715984940735, 8318.41771076043, 8559.529225892637, 9052.004279529378, 9093.363464557417, 9122.08779122109, 9149.313801464783, 7828.178041305581, 7881.093674227537, 7923.247291507298, 7974.84050319002, 8075.757727268191, 7509.6245187739305, 7673.8848917267405, 7838.843223135619, 7885.802854928444, 7922.920770792219, 7154.642267886481, 7185.820354491179, 7219.205887352492, 7286.7085316586745, 7299.0, 4937.506249375034, 4956.727379994135, 5014.924776128288, 5023.422306434807, 5042.924356134734, 5320.798268338241, 5341.545968592558, 5366.463353664602, 5392.137258038695, 5520.033994051106], "value": 4551.6950192917475, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [309.87604958016794, 310.5435010534515, 314.3649827348756, 322.41642626845425, 327.0189431704885, 5029.673071250366, 5124.000819840133, 5140.404095931554, 5175.896482070361, 5190.74046297685, 5160.638755287131, 5194.0, 5199.0, 5218.1650935850275, 5223.71269580173, 4103.774292413916, 4108.753474791507, 4112.115895082557, 4113.465249517559, 4116.620931987788, 3798.753081049723, 3885.2423777363424, 4033.7378070425475, 4110.424540564323, 4131.7481972325, 3990.3016972029923, 4000.479937608107, 4011.9197616047663, 4011.9970007498127, 4031.314676505001, 4002.019505221225, 4008.9709841608997, 4010.5989401059805, 4034.700220874103, 4050.0, 3460.4255063945843, 3543.8050907200095, 3551.147724546116, 3552.786832790041, 3556.7332450066347, 5053.444121146671, 5059.241113832918, 5073.771680274396, 5089.465606111342, 5100.846974590768, 4578.221702310615, 4583.54164583539, 4598.402207713009, 4604.217283061887, 4613.63090952723, 5189.792408303663, 5410.972945135289, 5414.160805075219, 5483.341998960111, 5526.889462210774, 3869.129445874684, 3886.0, 3902.395128755019, 3907.8241479133508, 3934.855503750463, 5652.18043383707, 5688.089905615123, 5737.799177028825, 5739.364281179885, 5764.308283006066, 3795.7342985991268, 3934.626210509997, 3937.2912875682077, 3958.247932892741, 3968.69033219037, 3943.2846711679936, 3986.7209295349626, 3992.680585553149, 3994.2410941920944, 3998.1603863189057, 4601.401817763736, 4603.654725895572, 4607.516210797818, 4608.9308660370125, 4615.376924115269, 5407.78368865241, 5523.87330877615, 5525.861853453615, 5532.170174473861, 5556.638818476786, 1308.7775078236723, 1355.8407561534943, 1378.3521744779937, 1399.2514005007272, 1403.810485584433, 840.5923127283263, 847.546562589012, 853.9914600854037, 863.4199415070406, 887.7869311365226, 4755.857324280277, 4759.214729569582, 4777.1878780606685, 4782.178514676358, 4794.880127996828, 5078.695278283241, 5079.4412614612365, 5086.237064440364, 5091.312672789126, 5098.260752190911, 4463.977680111579, 4670.042641258534, 4674.345591617176, 4737.8341758038305, 4779.115863565252, 2658.70754217036, 2717.5244332241778, 2724.945501089967, 2725.441284536665, 2726.6591676040493, 5065.744774389457, 5088.0, 5125.461826508237, 5135.460776618401, 5138.254953031789, 5052.57053150479, 5097.388313402415, 5104.540591346797, 5323.30796996388, 5826.475617194473, 5786.334571524329, 5828.184054232495, 5834.533237341003, 5849.742305404358, 5854.18041474194, 5692.573057020657, 5700.942990570041, 5701.717113649562, 5703.942960570341, 5711.942880571141, 5480.945190548203, 5572.411862619134, 5622.269105016322, 5630.662160270397, 5644.3508996465935, 5756.971215143897, 5803.245578074823, 5814.73833677494, 5829.15477255787, 5869.8239052828485, 3888.9222215556097, 3948.526176858795, 3967.206558688332, 3971.960280397159, 3983.203359328204, 5433.293671822637, 5705.22979397776, 5713.857153571194, 5714.628549144292, 5714.828555143353, 5422.810201643081, 5547.362053363753, 5563.638363506359, 5567.47109024642, 5569.136783798518, 5462.672239665632, 5490.450954904637, 5513.365962914316, 5537.28015358017, 5537.390887002346, 5202.531772140374, 5435.510804027656, 5435.945640543702, 5440.238366628754, 5446.264754258124, 5453.863653408696, 5469.179623056414, 5520.944790552043, 5525.867197224479, 5565.276514053309, 5351.545118664957, 5401.648892821954, 5427.48438898304, 5438.728063596884, 5441.707766801187], "value": 4086.2720969254324, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [752.9924700752995, 792.845395147946, 795.5306369242147, 845.3659755183612, 851.5103815306201, 14072.0, 14943.925280373584, 14968.625784355369, 14977.925110374461, 15047.247637618117, 14841.109533428002, 14931.253437328118, 14951.0, 14957.10257384555, 14969.326380312885, 657.6054367379581, 780.4068907630214, 817.587118505157, 821.9753407397758, 823.8846561481367, 806.4878801960739, 813.8453693798159, 814.1126172472004, 815.571824791983, 818.3862103422433, 687.1994126842247, 869.886914701088, 870.8040690844573, 872.6378552900538, 872.6858331000834, 721.9350258476736, 724.0334153904544, 807.144426907477, 862.5730263519536, 864.8356812205661, 638.4094712391067, 638.5913015669928, 638.7891995641473, 639.2967735490922, 639.7185238495048, 15272.465463708828, 15285.082895026335, 15326.616834579114, 15337.30982105808, 15362.0, 13955.372008259652, 14113.435462581587, 14498.27508624575, 14576.125432474086, 14589.781153282604, 12068.396580171044, 12244.632661020183, 12418.937905310506, 12487.50049997999, 12508.186967847061, 4482.21561226784, 4517.480489743656, 4540.704854184468, 4541.364209010741, 4583.289590113504, 67453.66273168652, 70496.6475167626, 70506.64746676285, 72180.0, 77288.99999999943, 11199.832002519968, 11593.88406115928, 11732.589359372381, 11761.88238117625, 12133.937230670806, 17714.114294285235, 17719.379821706178, 17732.822671773116, 17732.91133544324, 17800.3769868054, 8755.168259015383, 8980.506072166094, 9030.232430243503, 9287.442753434816, 9327.300452466092, 4924.384451943507, 4929.630277729185, 5028.84913452597, 5094.719790411489, 5229.241759944786, 3540.858365665396, 3641.6540428659237, 3650.7809531428197, 3652.561692596852, 3656.542932133483, 592.3602509289957, 592.6325678079618, 599.2389665125354, 608.4311169056946, 623.5230049012509, 746.358132006474, 765.1850778920543, 768.2356055724479, 789.1871372486348, 814.1248158229927, 9744.415335079917, 9988.450635214987, 10036.64871729486, 10286.177105831515, 10328.328658637165, 721.3651986252064, 732.3116270705519, 735.4888352594895, 760.013727996661, 776.3207193705508, 4881.365422495124, 5045.394552653632, 5053.242013697901, 5067.062593420229, 5078.974605127025, 114080.0, 117340.41329793296, 118775.0, 119762.4011879935, 119816.0, 101676.49161754144, 105449.47275263727, 105850.0, 105941.64350138862, 105967.0, 55535.0, 57226.427735722944, 76201.23798761942, 84940.0, 85453.57273213594, 9163.49600771964, 9187.208693701607, 9194.58624361892, 9321.953390233006, 9404.200642945152, 51011.0, 51495.74252128715, 51552.742236290076, 52330.47669523256, 52943.20585191148, 69223.65388173026, 78352.60823695845, 78371.0, 78371.60814195893, 78631.0, 10557.9472102639, 10652.0, 10931.83602245951, 11003.669889902996, 11071.612493562687, 13282.203067815963, 13573.1856088635, 13657.863421366057, 13679.726405471636, 14145.787813182606, 11959.103067269816, 12314.938425307817, 12340.259584424963, 14213.502527411905, 15460.613484662974, 14031.438742450187, 14087.647808804863, 14593.781093283396, 14769.556913292618, 15650.0609963398, 13945.442182312594, 14159.221242831743, 14431.134131951696, 14627.268636568342, 14766.33551490207, 10792.892071079188, 10878.619248326271, 11003.284786488852, 11155.051820595016, 11448.542058317575, 11039.83440248413, 11351.659450216506, 11357.48891299877, 11427.771444570895, 11839.644810655695], "value": 7569.772682430779, "unit": "score"}], "name": "dromaeo_css", "value": 7099.56524832524, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 111.0, 113.0, 111.0, 109.0, 111.0, 109.0, 110.0, 109.0, 118.0], "value": 110.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 125.0, 129.0, 183.0, 133.0, 127.0, 149.0, 126.0, 156.0, 133.0], "value": 141.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 161.0, 161.0, 161.0, 159.0, 161.0, 162.0, 161.0, 162.0], "value": 160.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 76.0, 137.0, 76.0, 78.0, 75.0, 75.0, 100.0, 75.0], "value": 84.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 118.0, 85.0, 92.0, 85.0, 112.0, 84.0, 86.0, 123.0], "value": 95.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 116.0, 116.0, 117.0, 117.0, 116.0, 117.0, 117.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 146.0, 146.0, 145.0, 146.0, 146.0, 146.0, 146.0, 145.0], "value": 145.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 96.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 54.0, 54.0, 54.0, 54.0, 60.0, 54.0, 52.0, 53.0], "value": 54.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 61.0, 62.0, 62.0, 62.0, 62.0, 61.0, 62.0, 62.0], "value": 61.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 85.0, 79.0, 79.0, 80.0, 81.0, 81.0, 98.0, 80.0], "value": 82.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 124.0, 125.0, 133.0, 122.0, 123.0, 128.0, 130.0, 125.0, 127.0], "value": 126.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 160.0, 158.0, 159.0, 159.0, 167.0, 169.0, 164.0, 157.0, 159.0], "value": 161.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 64.0, 64.0, 63.0, 66.0, 68.0, 62.0, 63.0, 68.0], "value": 64.5, "unit": "score"}], "name": "kraken", "value": 1499.4, "alertThreshold": 2.0}]} 20:26:08 INFO - Return code: 0 20:26:08 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 20:26:08 INFO - # TBPL SUCCESS # 20:26:08 INFO - Running post-action listener: _resource_record_post_action 20:26:08 INFO - ##### 20:26:08 INFO - ##### Finished run-tests step (success) 20:26:08 INFO - ##### 20:26:08 INFO - Running post-run listener: _resource_record_post_run 20:26:08 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 4096; Write bytes: 550723584; Read time: 20; Write time: 477844 20:26:08 INFO - TinderboxPrint: CPU usage
13.2% 20:26:08 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 20 20:26:08 INFO - TinderboxPrint: I/O write bytes / time
550,723,584 / 477,844 20:26:08 INFO - TinderboxPrint: CPU idle
8,265.5 (86.8%) 20:26:08 INFO - TinderboxPrint: CPU user
1,205.3 (12.7%) 20:26:08 INFO - TinderboxPrint: Swap in / out
0 / 0 20:26:08 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 256299008; Read time: 0; Write time: 248036 20:26:08 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 4096; Write bytes: 293838848; Read time: 20; Write time: 229800 20:26:09 INFO - Running post-run listener: _upload_blobber_files 20:26:09 INFO - Blob upload gear active. 20:26:09 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:26:09 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 20:26:09 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', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 20:26:09 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 -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 20:26:09 INFO - (blobuploader) - INFO - Open directory for files ... 20:26:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 20:26:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:26:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:26:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 20:26:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:26:10 INFO - (blobuploader) - INFO - Done attempting. 20:26:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 20:26:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:26:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:26:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 20:26:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:26:11 INFO - (blobuploader) - INFO - Done attempting. 20:26:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:26:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:26:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:26:14 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:26:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:26:14 INFO - (blobuploader) - INFO - Done attempting. 20:26:14 INFO - (blobuploader) - INFO - Iteration through files over. 20:26:14 INFO - Return code: 0 20:26:14 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:26:14 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:26:14 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c0a64a616f8b78b80fd112e275d5952435bce83d9271f7f0dc425423e3c86a9dd8d2730668d8fc2a2cb2a3b84c9a2174390c6ff28d32c0c95957064479272fc4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8e7ddcc59be4736f5285a4c778f9aa91e37b2510f145b3cea8af1a0e53ccce1fed98d5a7b7a5dabd9274a1b1ea188067273984eac99f850c560556680634aa86", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3eb60c14f388b6c1bba19fd07b2466fce274c0ec04335af74b5da651103b293d7c4abe2e691bec6bed5a82211c4b0e36b0e08dc9e2e542c096cd8c3ebb4f6da8"} 20:26:14 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:26:14 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:26:14 INFO - Contents: 20:26:14 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c0a64a616f8b78b80fd112e275d5952435bce83d9271f7f0dc425423e3c86a9dd8d2730668d8fc2a2cb2a3b84c9a2174390c6ff28d32c0c95957064479272fc4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8e7ddcc59be4736f5285a4c778f9aa91e37b2510f145b3cea8af1a0e53ccce1fed98d5a7b7a5dabd9274a1b1ea188067273984eac99f850c560556680634aa86", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3eb60c14f388b6c1bba19fd07b2466fce274c0ec04335af74b5da651103b293d7c4abe2e691bec6bed5a82211c4b0e36b0e08dc9e2e542c096cd8c3ebb4f6da8"} 20:26:14 INFO - Running post-run listener: copy_logs_to_upload_dir 20:26:14 INFO - Copying logs to upload dir... 20:26:14 INFO - mkdir: /builds/slave/test/build/upload/logs 20:26:14 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1246.447299 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-06-26 20:26:14.252158) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-26 20:26:14.256066) ========= 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=337fe3f4b1febe37b85fccc40000019e-1466994791.249134-1438017817 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/sha512/c0a64a616f8b78b80fd112e275d5952435bce83d9271f7f0dc425423e3c86a9dd8d2730668d8fc2a2cb2a3b84c9a2174390c6ff28d32c0c95957064479272fc4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8e7ddcc59be4736f5285a4c778f9aa91e37b2510f145b3cea8af1a0e53ccce1fed98d5a7b7a5dabd9274a1b1ea188067273984eac99f850c560556680634aa86", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3eb60c14f388b6c1bba19fd07b2466fce274c0ec04335af74b5da651103b293d7c4abe2e691bec6bed5a82211c4b0e36b0e08dc9e2e542c096cd8c3ebb4f6da8"} build_url:https://queue.taskcluster.net/v1/task/IG3vjAsMQomR6u3qUUOzoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011240 build_url: 'https://queue.taskcluster.net/v1/task/IG3vjAsMQomR6u3qUUOzoA/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/sha512/c0a64a616f8b78b80fd112e275d5952435bce83d9271f7f0dc425423e3c86a9dd8d2730668d8fc2a2cb2a3b84c9a2174390c6ff28d32c0c95957064479272fc4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8e7ddcc59be4736f5285a4c778f9aa91e37b2510f145b3cea8af1a0e53ccce1fed98d5a7b7a5dabd9274a1b1ea188067273984eac99f850c560556680634aa86", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3eb60c14f388b6c1bba19fd07b2466fce274c0ec04335af74b5da651103b293d7c4abe2e691bec6bed5a82211c4b0e36b0e08dc9e2e542c096cd8c3ebb4f6da8"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-26 20:26:14.282201) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-26 20:26:14.282596) ========= 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=337fe3f4b1febe37b85fccc40000019e-1466994791.249134-1438017817 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004460 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-26 20:26:14.367818) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-26 20:26:14.368183) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-26 20:26:14.368529) ========= ========= Total master_lag: 0.26 =========