builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-023 starttime: 1465861394.37 results: success (0) buildid: 20160613160126 builduid: 146100b9149e43e29af39c1d72e7b822 revision: 270ba15c5f00b917a230a08c46e61672f834a3aa ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-13 16:43:14.366559) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-13 16:43:14.366983) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-13 16:43:14.367259) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-13 16:43:14.850874) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-13 16:43:14.851124) ========= 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=6d15e502d8e29d5d2676d664000001c3-1465860552.841221-322978396 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-13 16:43:15-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.1M=0s 2016-06-13 16:43:16 (43.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.119060 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-13 16:43:15.011624) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-13 16:43:15.014741) ========= 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=6d15e502d8e29d5d2676d664000001c3-1465860552.841221-322978396 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014980 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-13 16:43:15.080775) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-13 16:43:15.081082) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 270ba15c5f00b917a230a08c46e61672f834a3aa --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 270ba15c5f00b917a230a08c46e61672f834a3aa --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=6d15e502d8e29d5d2676d664000001c3-1465860552.841221-322978396 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-13 16:43:16,260 truncating revision to first 12 chars 2016-06-13 16:43:16,260 Setting DEBUG logging. 2016-06-13 16:43:16,260 attempt 1/10 2016-06-13 16:43:16,260 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/270ba15c5f00?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-13 16:43:16,707 unpacking tar archive at: fx-team-270ba15c5f00/testing/mozharness/ program finished with exit code 0 elapsedTime=0.799098 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-13 16:43:15.897643) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-13 16:43:15.897940) ========= script_repo_revision: 270ba15c5f00b917a230a08c46e61672f834a3aa ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-13 16:43:15.898377) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-13 16:43:15.898654) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-13 16:43:15.910641) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2016-06-13 16:43:15.910905) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6d15e502d8e29d5d2676d664000001c3-1465860552.841221-322978396 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:43:17 INFO - MultiFileLogger online at 20160613 16:43:17 in /builds/slave/test 16:43:17 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 16:43:17 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:43:17 INFO - {'append_to_log': False, 16:43:17 INFO - 'base_work_dir': '/builds/slave/test', 16:43:17 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 16:43:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:43:17 INFO - 'branch': 'Fx-Team-Non-PGO', 16:43:17 INFO - 'buildbot_json_path': 'buildprops.json', 16:43:17 INFO - 'config_files': ('talos/linux_config.py',), 16:43:17 INFO - 'default_actions': ('clobber', 16:43:17 INFO - 'read-buildbot-config', 16:43:17 INFO - 'download-and-extract', 16:43:17 INFO - 'populate-webroot', 16:43:17 INFO - 'create-virtualenv', 16:43:17 INFO - 'install', 16:43:17 INFO - 'run-tests'), 16:43:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:43:17 INFO - 'download_minidump_stackwalk': True, 16:43:17 INFO - 'download_symbols': 'ondemand', 16:43:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:43:17 INFO - 'tooltool.py': '/tools/tooltool.py', 16:43:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:43:17 INFO - '/tools/misc-python/virtualenv.py')}, 16:43:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:43:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:43:17 INFO - 'installer_path': 'installer.exe', 16:43:17 INFO - 'log_level': 'info', 16:43:17 INFO - 'log_name': 'talos', 16:43:17 INFO - 'log_to_console': True, 16:43:17 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:43:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:43:17 INFO - 'opt_config_files': (), 16:43:17 INFO - 'pip_index': False, 16:43:17 INFO - 'sps_profile': False, 16:43:17 INFO - 'sps_profile_interval': 0, 16:43:17 INFO - 'suite': 'dromaeojs', 16:43:17 INFO - 'system_bits': '32', 16:43:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:43:17 INFO - 'title': 'talos-linux64-ix-023', 16:43:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:43:17 INFO - 'use_talos_json': True, 16:43:17 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:43:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:43:17 INFO - 'work_dir': 'build'} 16:43:17 INFO - ##### 16:43:17 INFO - ##### Running clobber step. 16:43:17 INFO - ##### 16:43:17 INFO - Running pre-action listener: _resource_record_pre_action 16:43:17 INFO - Running main action method: clobber 16:43:17 INFO - rmtree: /builds/slave/test/build 16:43:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:43:18 INFO - Running post-action listener: _resource_record_post_action 16:43:18 INFO - ##### 16:43:18 INFO - ##### Finished clobber step (success) 16:43:18 INFO - ##### 16:43:18 INFO - ##### 16:43:18 INFO - ##### Running read-buildbot-config step. 16:43:18 INFO - ##### 16:43:18 INFO - Running pre-action listener: _resource_record_pre_action 16:43:18 INFO - Running main action method: read_buildbot_config 16:43:18 INFO - Using buildbot properties: 16:43:18 INFO - { 16:43:18 INFO - "project": "", 16:43:18 INFO - "product": "firefox", 16:43:18 INFO - "script_repo_revision": "production", 16:43:18 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 16:43:18 INFO - "repository": "", 16:43:18 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 16:43:18 INFO - "buildid": "20160613160126", 16:43:18 INFO - "pgo_build": "False", 16:43:18 INFO - "basedir": "/builds/slave/test", 16:43:18 INFO - "buildnumber": 3084, 16:43:18 INFO - "slavename": "talos-linux64-ix-023", 16:43:18 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 16:43:18 INFO - "platform": "ubuntu64_hw", 16:43:18 INFO - "scheduler": "tests-fx-team-linux64-talos", 16:43:18 INFO - "branch": "fx-team", 16:43:18 INFO - "repo_path": "integration/fx-team", 16:43:18 INFO - "revision": "270ba15c5f00b917a230a08c46e61672f834a3aa", 16:43:18 INFO - "stage_platform": "linux64", 16:43:18 INFO - "builduid": "146100b9149e43e29af39c1d72e7b822", 16:43:18 INFO - "slavebuilddir": "test" 16:43:18 INFO - } 16:43:18 INFO - Found installer url https://queue.taskcluster.net/v1/task/HMZuK8HLQLi7-k-ElrtUEw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 16:43:18 INFO - Running post-action listener: _resource_record_post_action 16:43:18 INFO - ##### 16:43:18 INFO - ##### Finished read-buildbot-config step (success) 16:43:18 INFO - ##### 16:43:18 INFO - ##### 16:43:18 INFO - ##### Running download-and-extract step. 16:43:18 INFO - ##### 16:43:18 INFO - Running pre-action listener: _resource_record_pre_action 16:43:18 INFO - Running main action method: download_and_extract 16:43:18 INFO - mkdir: /builds/slave/test/build/tests 16:43:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:43:18 INFO - https://queue.taskcluster.net/v1/task/HMZuK8HLQLi7-k-ElrtUEw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 16:43:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HMZuK8HLQLi7-k-ElrtUEw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 16:43:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HMZuK8HLQLi7-k-ElrtUEw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 16:43:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HMZuK8HLQLi7-k-ElrtUEw/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 16:43:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HMZuK8HLQLi7-k-ElrtUEw/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 16:43:25 INFO - Downloaded 1361 bytes. 16:43:25 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 16:43:25 INFO - Using the following test package requirements: 16:43:25 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 16:43:25 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:43:25 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 16:43:25 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:43:25 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 16:43:25 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:43:25 INFO - u'jsshell-linux-x86_64.zip'], 16:43:25 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:43:25 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 16:43:25 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 16:43:25 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:43:25 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 16:43:25 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:43:25 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 16:43:25 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:43:25 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 16:43:25 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:43:25 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 16:43:25 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:43:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:43:25 INFO - https://queue.taskcluster.net/v1/task/HMZuK8HLQLi7-k-ElrtUEw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:43:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HMZuK8HLQLi7-k-ElrtUEw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 16:43:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HMZuK8HLQLi7-k-ElrtUEw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 16:43:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HMZuK8HLQLi7-k-ElrtUEw/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 16:43:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HMZuK8HLQLi7-k-ElrtUEw/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 16:43:34 INFO - Downloaded 22651503 bytes. 16:43:34 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'] 16:43:34 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 16:43:35 INFO - Return code: 0 16:43:35 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 16:43:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:43:35 INFO - https://queue.taskcluster.net/v1/task/HMZuK8HLQLi7-k-ElrtUEw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:43:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HMZuK8HLQLi7-k-ElrtUEw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 16:43:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HMZuK8HLQLi7-k-ElrtUEw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 16:43:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HMZuK8HLQLi7-k-ElrtUEw/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 16:43:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HMZuK8HLQLi7-k-ElrtUEw/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 16:43:36 INFO - Downloaded 22651503 bytes. 16:43:36 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'] 16:43:36 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 16:43:37 INFO - Return code: 0 16:43:37 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')]} 16:43:37 INFO - https://queue.taskcluster.net/v1/task/HMZuK8HLQLi7-k-ElrtUEw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 16:43:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HMZuK8HLQLi7-k-ElrtUEw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 16:43:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HMZuK8HLQLi7-k-ElrtUEw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 16:43:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HMZuK8HLQLi7-k-ElrtUEw/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 16:43:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HMZuK8HLQLi7-k-ElrtUEw/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 16:43:38 INFO - Downloaded 14405384 bytes. 16:43:38 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'] 16:43:38 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 16:43:39 INFO - Return code: 0 16:43:39 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')]} 16:43:39 INFO - https://queue.taskcluster.net/v1/task/HMZuK8HLQLi7-k-ElrtUEw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 16:43:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HMZuK8HLQLi7-k-ElrtUEw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 16:43:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HMZuK8HLQLi7-k-ElrtUEw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 16:43:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HMZuK8HLQLi7-k-ElrtUEw/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 16:43:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HMZuK8HLQLi7-k-ElrtUEw/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 16:43:41 INFO - Downloaded 55398663 bytes. 16:43:41 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HMZuK8HLQLi7-k-ElrtUEw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 16:43:41 INFO - mkdir: /builds/slave/test/properties 16:43:41 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:43:41 INFO - Writing to file /builds/slave/test/properties/build_url 16:43:41 INFO - Contents: 16:43:41 INFO - build_url:https://queue.taskcluster.net/v1/task/HMZuK8HLQLi7-k-ElrtUEw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 16:43:41 INFO - Running post-action listener: _resource_record_post_action 16:43:41 INFO - Running post-action listener: set_extra_try_arguments 16:43:41 INFO - ##### 16:43:41 INFO - ##### Finished download-and-extract step (success) 16:43:41 INFO - ##### 16:43:41 INFO - ##### 16:43:41 INFO - ##### Running populate-webroot step. 16:43:41 INFO - ##### 16:43:41 INFO - Running pre-action listener: _resource_record_pre_action 16:43:41 INFO - Running main action method: populate_webroot 16:43:41 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:43:41 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:43:41 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:43:41 INFO - '--tppagecycles', 16:43:41 INFO - '7'], 16:43:41 INFO - 'tests': ['tsvgm']}}, 16:43:41 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:43:41 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:43:41 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:43:41 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:43:41 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:43:41 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:43:41 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:43:41 INFO - 'talos_options': ['--disable-e10s'], 16:43:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:43:41 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:43:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:43:41 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:43:41 INFO - 'talos_options': ['--disable-e10s'], 16:43:41 INFO - 'tests': ['damp', 'tps']}, 16:43:41 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:43:41 INFO - 'tests': ['damp', 'tps']}, 16:43:41 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:43:41 INFO - 'tests': ['dromaeo_dom']}, 16:43:41 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:43:41 INFO - 'g4': {'talos_options': ['--disable-e10s'], 16:43:41 INFO - 'tests': ['basic_compositor_video']}, 16:43:41 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 16:43:41 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:43:41 INFO - 'tests': ['a11yr', 16:43:41 INFO - 'ts_paint', 16:43:41 INFO - 'tpaint', 16:43:41 INFO - 'sessionrestore', 16:43:41 INFO - 'sessionrestore_no_auto_restore', 16:43:41 INFO - 'tabpaint']}, 16:43:41 INFO - 'other-e10s': {'tests': ['a11yr', 16:43:41 INFO - 'ts_paint', 16:43:41 INFO - 'tpaint', 16:43:41 INFO - 'sessionrestore', 16:43:41 INFO - 'sessionrestore_no_auto_restore', 16:43:41 INFO - 'tabpaint']}, 16:43:41 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:43:41 INFO - 'ts_paint', 16:43:41 INFO - 'tpaint', 16:43:41 INFO - 'sessionrestore', 16:43:41 INFO - 'sessionrestore_no_auto_restore', 16:43:41 INFO - 'tabpaint']}, 16:43:41 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:43:41 INFO - 'ts_paint', 16:43:41 INFO - 'tpaint', 16:43:41 INFO - 'sessionrestore', 16:43:41 INFO - 'sessionrestore_no_auto_restore', 16:43:41 INFO - 'tabpaint']}, 16:43:41 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:43:41 INFO - 'tests': ['a11yr', 16:43:41 INFO - 'ts_paint', 16:43:41 INFO - 'tpaint', 16:43:41 INFO - 'sessionrestore', 16:43:41 INFO - 'sessionrestore_no_auto_restore', 16:43:41 INFO - 'tabpaint']}, 16:43:41 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:43:41 INFO - 'tests': ['a11yr', 16:43:41 INFO - 'ts_paint', 16:43:41 INFO - 'tpaint', 16:43:41 INFO - 'sessionrestore', 16:43:41 INFO - 'sessionrestore_no_auto_restore', 16:43:41 INFO - 'tabpaint']}, 16:43:41 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:43:41 INFO - 'tests': ['tsvgx', 16:43:41 INFO - 'tsvgr_opacity', 16:43:41 INFO - 'tart', 16:43:41 INFO - 'tscrollx', 16:43:41 INFO - 'cart']}, 16:43:41 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:43:41 INFO - 'tsvgr_opacity', 16:43:41 INFO - 'tart', 16:43:41 INFO - 'tscrollx', 16:43:41 INFO - 'cart']}, 16:43:41 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:43:41 INFO - 'talos_options': ['--disable-e10s'], 16:43:41 INFO - 'tests': ['tp5o']}, 16:43:41 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:43:41 INFO - 'tests': ['tp5o']}, 16:43:41 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:43:41 INFO - 'talos_options': ['--disable-e10s', 16:43:41 INFO - '--xperf_path', 16:43:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:43:41 INFO - 'tests': ['tp5n']}, 16:43:41 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:43:41 INFO - 'talos_options': ['--xperf_path', 16:43:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:43:41 INFO - 'tests': ['tp5n']}}, 16:43:41 INFO - 'talos.zip': {'path': '', 16:43:41 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:43:41 INFO - Running post-action listener: _resource_record_post_action 16:43:41 INFO - ##### 16:43:41 INFO - ##### Finished populate-webroot step (success) 16:43:41 INFO - ##### 16:43:41 INFO - ##### 16:43:41 INFO - ##### Running create-virtualenv step. 16:43:41 INFO - ##### 16:43:41 INFO - Running pre-action listener: _resource_record_pre_action 16:43:41 INFO - Running main action method: create_virtualenv 16:43:41 INFO - Creating virtualenv /builds/slave/test/build/venv 16:43:41 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 16:43:41 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:43:42 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:43:42 INFO - Using real prefix '/usr' 16:43:42 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:43:42 INFO - Installing distribute.............................................................................................................................................................................................done. 16:43:44 INFO - Installing pip.................done. 16:43:44 INFO - Return code: 0 16:43:44 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:43:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:43:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:43:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:43:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:43:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:43:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:43:44 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 0x7fb9f4830f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bb5020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c472e0>, '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 0x2bb3140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bb35d0>, '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': '6d15e502d8e29d5d2676d664000001c3-1465860552.841221-322978396', '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 16:43:44 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 16:43:44 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 16:43:44 INFO - Using env: {'DISPLAY': ':0', 16:43:44 INFO - 'HOME': '/home/cltbld', 16:43:44 INFO - 'LANG': 'en_US.UTF-8', 16:43:44 INFO - 'LANGUAGE': 'en_US:en', 16:43:44 INFO - 'LOGNAME': 'cltbld', 16:43:44 INFO - 'MAIL': '/var/mail/cltbld', 16:43:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:43:44 INFO - 'MOZ_NO_REMOTE': '1', 16:43:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:43:44 INFO - 'NO_EM_RESTART': '1', 16:43:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:43:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:43:44 INFO - 'PWD': '/builds/slave/test', 16:43:44 INFO - 'SHELL': '/bin/bash', 16:43:44 INFO - 'SHLVL': '1', 16:43:44 INFO - 'TERM': 'linux', 16:43:44 INFO - 'TMOUT': '86400', 16:43:44 INFO - 'USER': 'cltbld', 16:43:44 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1465860552.841221-322978396', 16:43:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:43:44 INFO - '_': '/tools/buildbot/bin/python'} 16:43:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:43:44 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 16:43:44 INFO - Cleaning up... 16:43:44 INFO - Return code: 0 16:43:44 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:43:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:43:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:43:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:43:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:43:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:43:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:43:44 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 0x7fb9f4830f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bb5020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c472e0>, '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 0x2bb3140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bb35d0>, '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': '6d15e502d8e29d5d2676d664000001c3-1465860552.841221-322978396', '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 16:43:44 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 16:43:44 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 16:43:44 INFO - Using env: {'DISPLAY': ':0', 16:43:44 INFO - 'HOME': '/home/cltbld', 16:43:44 INFO - 'LANG': 'en_US.UTF-8', 16:43:44 INFO - 'LANGUAGE': 'en_US:en', 16:43:44 INFO - 'LOGNAME': 'cltbld', 16:43:44 INFO - 'MAIL': '/var/mail/cltbld', 16:43:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:43:44 INFO - 'MOZ_NO_REMOTE': '1', 16:43:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:43:44 INFO - 'NO_EM_RESTART': '1', 16:43:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:43:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:43:44 INFO - 'PWD': '/builds/slave/test', 16:43:44 INFO - 'SHELL': '/bin/bash', 16:43:44 INFO - 'SHLVL': '1', 16:43:44 INFO - 'TERM': 'linux', 16:43:44 INFO - 'TMOUT': '86400', 16:43:44 INFO - 'USER': 'cltbld', 16:43:44 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1465860552.841221-322978396', 16:43:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:43:44 INFO - '_': '/tools/buildbot/bin/python'} 16:43:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:43:44 INFO - Downloading/unpacking psutil>=3.1.1 16:43:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:43:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:43:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:43:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:43:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:43:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:43:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:43:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:43:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:43:46 INFO - Installing collected packages: psutil 16:43:46 INFO - Running setup.py install for psutil 16:43:47 INFO - building 'psutil._psutil_linux' extension 16:43:47 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 16:43:47 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 16:43:47 INFO - building 'psutil._psutil_posix' extension 16:43:47 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 16:43:47 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 16:43:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:43:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:43:47 INFO - Successfully installed psutil 16:43:47 INFO - Cleaning up... 16:43:47 INFO - Return code: 0 16:43:47 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:43:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:43:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:43:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:43:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:43:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:43:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:43:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb9f4830f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bb5020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c472e0>, '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 0x2bb3140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bb35d0>, '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': '6d15e502d8e29d5d2676d664000001c3-1465860552.841221-322978396', '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 16:43:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 16:43:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 16:43:47 INFO - Using env: {'DISPLAY': ':0', 16:43:47 INFO - 'HOME': '/home/cltbld', 16:43:47 INFO - 'LANG': 'en_US.UTF-8', 16:43:47 INFO - 'LANGUAGE': 'en_US:en', 16:43:47 INFO - 'LOGNAME': 'cltbld', 16:43:47 INFO - 'MAIL': '/var/mail/cltbld', 16:43:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:43:47 INFO - 'MOZ_NO_REMOTE': '1', 16:43:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:43:47 INFO - 'NO_EM_RESTART': '1', 16:43:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:43:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:43:47 INFO - 'PWD': '/builds/slave/test', 16:43:47 INFO - 'SHELL': '/bin/bash', 16:43:47 INFO - 'SHLVL': '1', 16:43:47 INFO - 'TERM': 'linux', 16:43:47 INFO - 'TMOUT': '86400', 16:43:47 INFO - 'USER': 'cltbld', 16:43:47 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1465860552.841221-322978396', 16:43:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:43:47 INFO - '_': '/tools/buildbot/bin/python'} 16:43:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:43:47 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:43:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:43:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:43:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:43:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:43:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:43:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:43:49 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:43:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:43:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:43:49 INFO - Installing collected packages: mozsystemmonitor 16:43:49 INFO - Running setup.py install for mozsystemmonitor 16:43:49 INFO - Successfully installed mozsystemmonitor 16:43:49 INFO - Cleaning up... 16:43:49 INFO - Return code: 0 16:43:49 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:43:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:43:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:43:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:43:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:43:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:43:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:43:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb9f4830f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bb5020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c472e0>, '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 0x2bb3140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bb35d0>, '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': '6d15e502d8e29d5d2676d664000001c3-1465860552.841221-322978396', '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 16:43:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 16:43:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 16:43:49 INFO - Using env: {'DISPLAY': ':0', 16:43:49 INFO - 'HOME': '/home/cltbld', 16:43:49 INFO - 'LANG': 'en_US.UTF-8', 16:43:49 INFO - 'LANGUAGE': 'en_US:en', 16:43:49 INFO - 'LOGNAME': 'cltbld', 16:43:49 INFO - 'MAIL': '/var/mail/cltbld', 16:43:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:43:49 INFO - 'MOZ_NO_REMOTE': '1', 16:43:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:43:49 INFO - 'NO_EM_RESTART': '1', 16:43:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:43:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:43:49 INFO - 'PWD': '/builds/slave/test', 16:43:49 INFO - 'SHELL': '/bin/bash', 16:43:49 INFO - 'SHLVL': '1', 16:43:49 INFO - 'TERM': 'linux', 16:43:49 INFO - 'TMOUT': '86400', 16:43:49 INFO - 'USER': 'cltbld', 16:43:49 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1465860552.841221-322978396', 16:43:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:43:49 INFO - '_': '/tools/buildbot/bin/python'} 16:43:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:43:50 INFO - Downloading/unpacking jsonschema==2.5.1 16:43:50 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 16:43:50 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 16:43:50 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 16:43:50 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 16:43:50 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 16:43:50 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 16:43:51 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:43:51 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:43:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:43:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:43:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:43:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:43:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:43:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:43:52 INFO - Downloading functools32-3.2.3-2.tar.gz 16:43:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:43:52 INFO - warning: no files found matching '*.txt' 16:43:52 INFO - no previously-included directories found matching 'build' 16:43:52 INFO - no previously-included directories found matching 'dist' 16:43:52 INFO - no previously-included directories found matching '.git*' 16:43:52 INFO - Installing collected packages: jsonschema, functools32 16:43:52 INFO - Running setup.py install for functools32 16:43:52 INFO - warning: no files found matching '*.txt' 16:43:52 INFO - no previously-included directories found matching 'build' 16:43:52 INFO - no previously-included directories found matching 'dist' 16:43:52 INFO - no previously-included directories found matching '.git*' 16:43:52 INFO - Successfully installed jsonschema functools32 16:43:52 INFO - Cleaning up... 16:43:52 INFO - Return code: 0 16:43:52 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:43: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')]} 16:43:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:43:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:43: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')]} 16:43:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:43:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:43:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb9f4830f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bb5020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c472e0>, '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 0x2bb3140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bb35d0>, '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': '6d15e502d8e29d5d2676d664000001c3-1465860552.841221-322978396', '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 16:43:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 16:43:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 16:43:52 INFO - Using env: {'DISPLAY': ':0', 16:43:52 INFO - 'HOME': '/home/cltbld', 16:43:52 INFO - 'LANG': 'en_US.UTF-8', 16:43:52 INFO - 'LANGUAGE': 'en_US:en', 16:43:52 INFO - 'LOGNAME': 'cltbld', 16:43:52 INFO - 'MAIL': '/var/mail/cltbld', 16:43:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:43:52 INFO - 'MOZ_NO_REMOTE': '1', 16:43:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:43:52 INFO - 'NO_EM_RESTART': '1', 16:43:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:43:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:43:52 INFO - 'PWD': '/builds/slave/test', 16:43:52 INFO - 'SHELL': '/bin/bash', 16:43:52 INFO - 'SHLVL': '1', 16:43:52 INFO - 'TERM': 'linux', 16:43:52 INFO - 'TMOUT': '86400', 16:43:52 INFO - 'USER': 'cltbld', 16:43:52 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1465860552.841221-322978396', 16:43:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:43:52 INFO - '_': '/tools/buildbot/bin/python'} 16:43:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:43:52 INFO - Downloading/unpacking blobuploader==1.2.4 16:43:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:43:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:43:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:43:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:43:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:43:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:43:54 INFO - Downloading blobuploader-1.2.4.tar.gz 16:43:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:43:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:43:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:43:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:43:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:43:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:43:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:43:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:43:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:43:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:43: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 16:43: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 16:43: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 16:43: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 16:43: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 16:43: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 16:43:55 INFO - Downloading docopt-0.6.1.tar.gz 16:43:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:43:55 INFO - Installing collected packages: blobuploader, requests, docopt 16:43:55 INFO - Running setup.py install for blobuploader 16:43:55 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:43:55 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:43:55 INFO - Running setup.py install for requests 16:43:55 INFO - Running setup.py install for docopt 16:43:55 INFO - Successfully installed blobuploader requests docopt 16:43:55 INFO - Cleaning up... 16:43:55 INFO - Return code: 0 16:43:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:43: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')]} 16:43:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:43:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:43:56 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')]} 16:43:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:43:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:43:56 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 0x7fb9f4830f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bb5020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c472e0>, '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 0x2bb3140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bb35d0>, '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': '6d15e502d8e29d5d2676d664000001c3-1465860552.841221-322978396', '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 16:43:56 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 16:43:56 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 16:43:56 INFO - Using env: {'DISPLAY': ':0', 16:43:56 INFO - 'HOME': '/home/cltbld', 16:43:56 INFO - 'LANG': 'en_US.UTF-8', 16:43:56 INFO - 'LANGUAGE': 'en_US:en', 16:43:56 INFO - 'LOGNAME': 'cltbld', 16:43:56 INFO - 'MAIL': '/var/mail/cltbld', 16:43:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:43:56 INFO - 'MOZ_NO_REMOTE': '1', 16:43:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:43:56 INFO - 'NO_EM_RESTART': '1', 16:43:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:43:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:43:56 INFO - 'PWD': '/builds/slave/test', 16:43:56 INFO - 'SHELL': '/bin/bash', 16:43:56 INFO - 'SHLVL': '1', 16:43:56 INFO - 'TERM': 'linux', 16:43:56 INFO - 'TMOUT': '86400', 16:43:56 INFO - 'USER': 'cltbld', 16:43:56 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1465860552.841221-322978396', 16:43:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:43:56 INFO - '_': '/tools/buildbot/bin/python'} 16:43:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:43:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:43:56 INFO - Running setup.py (path:/tmp/pip-QQvDH1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:43:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:43:56 INFO - Running setup.py (path:/tmp/pip-p1DzTl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:43:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:43:56 INFO - Running setup.py (path:/tmp/pip-gKl20T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:43:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:43:56 INFO - Running setup.py (path:/tmp/pip-65iEFj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:43:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:43:56 INFO - Running setup.py (path:/tmp/pip-cyqyYC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:43:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:43:56 INFO - Running setup.py (path:/tmp/pip-Lwyk0k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:43:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:43:56 INFO - Running setup.py (path:/tmp/pip-QJQGkN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:43:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:43:56 INFO - Running setup.py (path:/tmp/pip-cJHaPb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:43:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:43:56 INFO - Running setup.py (path:/tmp/pip-oPIqtd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:43:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:43:56 INFO - Running setup.py (path:/tmp/pip-6CKeRN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:43:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:43:56 INFO - Running setup.py (path:/tmp/pip-2Hx2IH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:43:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:43:57 INFO - Running setup.py (path:/tmp/pip-mXQBqb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:43:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:43:57 INFO - Running setup.py (path:/tmp/pip-po0gRc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:43:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:43:57 INFO - Running setup.py (path:/tmp/pip-OTh6Gc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:43:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:43:57 INFO - Running setup.py (path:/tmp/pip-I6SKel-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:43:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:43:57 INFO - Running setup.py (path:/tmp/pip-co9zkS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:43:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:43:57 INFO - Running setup.py (path:/tmp/pip-1li0di-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:43:57 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:43:57 INFO - Running setup.py install for manifestparser 16:43:57 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:43:57 INFO - Running setup.py install for mozcrash 16:43:57 INFO - Running setup.py install for mozdebug 16:43:57 INFO - Running setup.py install for mozdevice 16:43:57 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:43:57 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:43:57 INFO - Running setup.py install for mozfile 16:43:57 INFO - Running setup.py install for mozhttpd 16:43:58 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:43:58 INFO - Running setup.py install for mozinfo 16:43:58 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:43:58 INFO - Running setup.py install for mozInstall 16:43:58 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:43:58 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:43:58 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:43:58 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:43:58 INFO - Running setup.py install for mozleak 16:43:58 INFO - Running setup.py install for mozlog 16:43:58 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:43:58 INFO - Running setup.py install for moznetwork 16:43:58 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:43:58 INFO - Running setup.py install for mozprocess 16:43:58 INFO - Running setup.py install for mozprofile 16:43:58 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:43:58 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:43:58 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:43:58 INFO - Running setup.py install for mozrunner 16:43:58 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:43:58 INFO - Running setup.py install for mozscreenshot 16:43:59 INFO - Running setup.py install for moztest 16:43:59 INFO - Running setup.py install for mozversion 16:43:59 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:43:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:43:59 INFO - Cleaning up... 16:43:59 INFO - Return code: 0 16:43:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:43:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:43:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:43:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:43:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:43:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:43:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:43:59 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 0x7fb9f4830f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bb5020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c472e0>, '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 0x2bb3140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bb35d0>, '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': '6d15e502d8e29d5d2676d664000001c3-1465860552.841221-322978396', '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 16:43:59 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 16:43:59 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 16:43:59 INFO - Using env: {'DISPLAY': ':0', 16:43:59 INFO - 'HOME': '/home/cltbld', 16:43:59 INFO - 'LANG': 'en_US.UTF-8', 16:43:59 INFO - 'LANGUAGE': 'en_US:en', 16:43:59 INFO - 'LOGNAME': 'cltbld', 16:43:59 INFO - 'MAIL': '/var/mail/cltbld', 16:43:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:43:59 INFO - 'MOZ_NO_REMOTE': '1', 16:43:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:43:59 INFO - 'NO_EM_RESTART': '1', 16:43:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:43:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:43:59 INFO - 'PWD': '/builds/slave/test', 16:43:59 INFO - 'SHELL': '/bin/bash', 16:43:59 INFO - 'SHLVL': '1', 16:43:59 INFO - 'TERM': 'linux', 16:43:59 INFO - 'TMOUT': '86400', 16:43:59 INFO - 'USER': 'cltbld', 16:43:59 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1465860552.841221-322978396', 16:43:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:43:59 INFO - '_': '/tools/buildbot/bin/python'} 16:43:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:43:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:43:59 INFO - Running setup.py (path:/tmp/pip-lJ4S7z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:43:59 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 16:43:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:43:59 INFO - Running setup.py (path:/tmp/pip-ZoB5Cz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:43:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:43:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:43:59 INFO - Running setup.py (path:/tmp/pip-Ii3art-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:43:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 16:43:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:43:59 INFO - Running setup.py (path:/tmp/pip-wZrE3L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:43:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:43:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:43:59 INFO - Running setup.py (path:/tmp/pip-yIDyZM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:43:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 16:43:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:43:59 INFO - Running setup.py (path:/tmp/pip-nquvRZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:43:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 16:43:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:43:59 INFO - Running setup.py (path:/tmp/pip-GfUJGR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:43:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 16:43:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:43:59 INFO - Running setup.py (path:/tmp/pip-VDZwiL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:44:00 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)) 16:44:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:44:00 INFO - Running setup.py (path:/tmp/pip-iJDsZk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:44:00 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)) 16:44:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:44:00 INFO - Running setup.py (path:/tmp/pip-sVPtqG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:44:00 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)) 16:44:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:44:00 INFO - Running setup.py (path:/tmp/pip-y_SetL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:44:00 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)) 16:44:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:44:00 INFO - Running setup.py (path:/tmp/pip-XSUqEh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:44:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 16:44:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:44:00 INFO - Running setup.py (path:/tmp/pip-Uptx8P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:44:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 16:44:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:44:00 INFO - Running setup.py (path:/tmp/pip-HpOXVz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:44:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 16:44:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:44:00 INFO - Running setup.py (path:/tmp/pip-62MVqZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:44:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 16:44:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:44:00 INFO - Running setup.py (path:/tmp/pip-Cr8MgN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:44:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 16:44:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:44:00 INFO - Running setup.py (path:/tmp/pip-iWlmJv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:44:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 16:44:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:44:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:44:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 16:44:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:44:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:44:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:44: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 16:44: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 16:44: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 16:44: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 16:44: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 16:44: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 16:44:02 INFO - Downloading blessings-1.6.tar.gz 16:44:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:44:02 INFO - Installing collected packages: blessings 16:44:02 INFO - Running setup.py install for blessings 16:44:02 INFO - Successfully installed blessings 16:44:02 INFO - Cleaning up... 16:44:02 INFO - Return code: 0 16:44:02 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:44:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:44:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:44:03 INFO - Reading from file tmpfile_stdout 16:44:03 INFO - Current package versions: 16:44:03 INFO - argparse == 1.2.1 16:44:03 INFO - blessings == 1.6 16:44:03 INFO - blobuploader == 1.2.4 16:44:03 INFO - docopt == 0.6.1 16:44:03 INFO - functools32 == 3.2.3-2 16:44:03 INFO - jsonschema == 2.5.1 16:44:03 INFO - manifestparser == 1.1 16:44:03 INFO - mozInstall == 1.12 16:44:03 INFO - mozcrash == 0.17 16:44:03 INFO - mozdebug == 0.1 16:44:03 INFO - mozdevice == 0.48 16:44:03 INFO - mozfile == 1.2 16:44:03 INFO - mozhttpd == 0.7 16:44:03 INFO - mozinfo == 0.9 16:44:03 INFO - mozleak == 0.1 16:44:03 INFO - mozlog == 3.2 16:44:03 INFO - moznetwork == 0.27 16:44:03 INFO - mozprocess == 0.22 16:44:03 INFO - mozprofile == 0.28 16:44:03 INFO - mozrunner == 6.11 16:44:03 INFO - mozscreenshot == 0.1 16:44:03 INFO - mozsystemmonitor == 0.3 16:44:03 INFO - moztest == 0.7 16:44:03 INFO - mozversion == 1.4 16:44:03 INFO - psutil == 3.1.1 16:44:03 INFO - requests == 1.2.3 16:44:03 INFO - wsgiref == 0.1.2 16:44:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:44:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:44:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:44:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:44:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:44:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:44:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:44:03 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 0x7fb9f4830f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bb5020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c472e0>, '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 0x2bb3140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bb35d0>, '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': '6d15e502d8e29d5d2676d664000001c3-1465860552.841221-322978396', '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 16:44:03 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 16:44:03 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 16:44:03 INFO - Using env: {'DISPLAY': ':0', 16:44:03 INFO - 'HOME': '/home/cltbld', 16:44:03 INFO - 'LANG': 'en_US.UTF-8', 16:44:03 INFO - 'LANGUAGE': 'en_US:en', 16:44:03 INFO - 'LOGNAME': 'cltbld', 16:44:03 INFO - 'MAIL': '/var/mail/cltbld', 16:44:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:44:03 INFO - 'MOZ_NO_REMOTE': '1', 16:44:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:44:03 INFO - 'NO_EM_RESTART': '1', 16:44:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:44:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:44:03 INFO - 'PWD': '/builds/slave/test', 16:44:03 INFO - 'SHELL': '/bin/bash', 16:44:03 INFO - 'SHLVL': '1', 16:44:03 INFO - 'TERM': 'linux', 16:44:03 INFO - 'TMOUT': '86400', 16:44:03 INFO - 'USER': 'cltbld', 16:44:03 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1465860552.841221-322978396', 16:44:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:44:03 INFO - '_': '/tools/buildbot/bin/python'} 16:44:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:44:03 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)) 16:44:03 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)) 16:44:03 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)) 16:44:03 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)) 16:44:03 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)) 16:44:03 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)) 16:44:03 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)) 16:44:03 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)) 16:44:03 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)) 16:44:03 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)) 16:44:03 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)) 16:44:03 INFO - Cleaning up... 16:44:03 INFO - Return code: 0 16:44:03 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:44:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:44:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:44:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:44:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:44:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:44:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:44:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb9f4830f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bb5020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c472e0>, '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 0x2bb3140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bb35d0>, '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': '6d15e502d8e29d5d2676d664000001c3-1465860552.841221-322978396', '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 16:44:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 16:44:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 16:44:03 INFO - Using env: {'DISPLAY': ':0', 16:44:03 INFO - 'HOME': '/home/cltbld', 16:44:03 INFO - 'LANG': 'en_US.UTF-8', 16:44:03 INFO - 'LANGUAGE': 'en_US:en', 16:44:03 INFO - 'LOGNAME': 'cltbld', 16:44:03 INFO - 'MAIL': '/var/mail/cltbld', 16:44:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:44:03 INFO - 'MOZ_NO_REMOTE': '1', 16:44:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:44:03 INFO - 'NO_EM_RESTART': '1', 16:44:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:44:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:44:03 INFO - 'PWD': '/builds/slave/test', 16:44:03 INFO - 'SHELL': '/bin/bash', 16:44:03 INFO - 'SHLVL': '1', 16:44:03 INFO - 'TERM': 'linux', 16:44:03 INFO - 'TMOUT': '86400', 16:44:03 INFO - 'USER': 'cltbld', 16:44:03 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1465860552.841221-322978396', 16:44:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:44:03 INFO - '_': '/tools/buildbot/bin/python'} 16:44:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:44:03 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:44:03 INFO - Cleaning up... 16:44:03 INFO - Return code: 0 16:44:03 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 16:44:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:44:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:44:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:44:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:44:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:44:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:44:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb9f4830f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bb5020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c472e0>, '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 0x2bb3140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bb35d0>, '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': '6d15e502d8e29d5d2676d664000001c3-1465860552.841221-322978396', '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 16:44:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 16:44:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 16:44:03 INFO - Using env: {'DISPLAY': ':0', 16:44:03 INFO - 'HOME': '/home/cltbld', 16:44:03 INFO - 'LANG': 'en_US.UTF-8', 16:44:03 INFO - 'LANGUAGE': 'en_US:en', 16:44:03 INFO - 'LOGNAME': 'cltbld', 16:44:03 INFO - 'MAIL': '/var/mail/cltbld', 16:44:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:44:03 INFO - 'MOZ_NO_REMOTE': '1', 16:44:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:44:03 INFO - 'NO_EM_RESTART': '1', 16:44:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:44:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:44:03 INFO - 'PWD': '/builds/slave/test', 16:44:03 INFO - 'SHELL': '/bin/bash', 16:44:03 INFO - 'SHLVL': '1', 16:44:03 INFO - 'TERM': 'linux', 16:44:03 INFO - 'TMOUT': '86400', 16:44:03 INFO - 'USER': 'cltbld', 16:44:03 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1465860552.841221-322978396', 16:44:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:44:03 INFO - '_': '/tools/buildbot/bin/python'} 16:44:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:44:03 INFO - Downloading/unpacking flake8 16:44: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 16:44: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 16:44: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 16:44: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 16:44: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 16:44: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 16:44:05 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 16:44:05 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 16:44:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:44:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:44:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:44:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:44:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:44:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:44:05 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 16:44:05 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 16:44:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:44:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:44:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:44:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:44:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:44:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:44:06 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 16:44:06 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 16:44:06 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 16:44:06 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 16:44:06 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 16:44:06 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 16:44:06 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 16:44:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 16:44:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:44:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:44:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:44:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:44:06 INFO - no previously-included directories found matching 'docs/_build' 16:44:06 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 16:44:06 INFO - Running setup.py install for pep8 16:44:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:44:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:44:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:44:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:44:06 INFO - no previously-included directories found matching 'docs/_build' 16:44:06 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 16:44:06 INFO - Successfully installed flake8 mccabe pyflakes pep8 16:44:06 INFO - Cleaning up... 16:44:06 INFO - Return code: 0 16:44:06 INFO - Running post-action listener: _resource_record_post_action 16:44:06 INFO - Running post-action listener: _start_resource_monitoring 16:44:06 INFO - Starting resource monitoring. 16:44:06 INFO - ##### 16:44:06 INFO - ##### Finished create-virtualenv step (success) 16:44:06 INFO - ##### 16:44:06 INFO - ##### 16:44:06 INFO - ##### Running install step. 16:44:06 INFO - ##### 16:44:06 INFO - Running pre-action listener: _resource_record_pre_action 16:44:06 INFO - Running main action method: install 16:44:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:44:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:44:06 INFO - Reading from file tmpfile_stdout 16:44:06 INFO - Detecting whether we're running mozinstall >=1.0... 16:44:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:44:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:44:06 INFO - Reading from file tmpfile_stdout 16:44:06 INFO - Output received: 16:44:06 INFO - Usage: mozinstall [options] installer 16:44:06 INFO - Options: 16:44:06 INFO - -h, --help show this help message and exit 16:44:06 INFO - -d DEST, --destination=DEST 16:44:06 INFO - Directory to install application into. [default: 16:44:06 INFO - "/builds/slave/test"] 16:44:06 INFO - --app=APP Application being installed. [default: firefox] 16:44:06 INFO - mkdir: /builds/slave/test/build/application 16:44:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 16:44:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 16:44:22 INFO - Reading from file tmpfile_stdout 16:44:22 INFO - Output received: 16:44:22 INFO - /builds/slave/test/build/application/firefox/firefox 16:44:22 INFO - Running post-action listener: _resource_record_post_action 16:44:22 INFO - ##### 16:44:22 INFO - ##### Finished install step (success) 16:44:22 INFO - ##### 16:44:22 INFO - ##### 16:44:22 INFO - ##### Running run-tests step. 16:44:22 INFO - ##### 16:44:22 INFO - Running pre-action listener: _resource_record_pre_action 16:44:22 INFO - Running main action method: run_tests 16:44:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:44:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:44:22 INFO - Python 2.7.3 16:44:22 INFO - Return code: 0 16:44:22 INFO - grabbing minidump binary from tooltool 16:44:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:44:22 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c472e0>, '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 0x2bb3140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bb35d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:44:22 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 16:44:22 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 16:44:22 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 16:44:22 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:44:22 INFO - Return code: 0 16:44:22 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:44:22 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:44:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:44:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:44:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:44:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 16:44:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 16:44:23 INFO - Return code: 0 16:44:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HMZuK8HLQLi7-k-ElrtUEw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--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 16:44:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/HMZuK8HLQLi7-k-ElrtUEw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-023 --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 16:44:23 INFO - Using env: {'DISPLAY': ':0', 16:44:23 INFO - 'HOME': '/home/cltbld', 16:44:23 INFO - 'LANG': 'en_US.UTF-8', 16:44:23 INFO - 'LANGUAGE': 'en_US:en', 16:44:23 INFO - 'LOGNAME': 'cltbld', 16:44:23 INFO - 'MAIL': '/var/mail/cltbld', 16:44:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:44:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:44:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:44:23 INFO - 'MOZ_NO_REMOTE': '1', 16:44:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:44:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:44:23 INFO - 'NO_EM_RESTART': '1', 16:44:23 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:44:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:44:23 INFO - 'PWD': '/builds/slave/test', 16:44:23 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:44:23 INFO - 'SHELL': '/bin/bash', 16:44:23 INFO - 'SHLVL': '1', 16:44:23 INFO - 'TERM': 'linux', 16:44:23 INFO - 'TMOUT': '86400', 16:44:23 INFO - 'USER': 'cltbld', 16:44:23 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1465860552.841221-322978396', 16:44:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:44:23 INFO - '_': '/tools/buildbot/bin/python'} 16:44:23 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HMZuK8HLQLi7-k-ElrtUEw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--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 16:44:24 INFO - mozversion application_buildid: 20160613160126 16:44:24 INFO - mozversion application_changeset: 270ba15c5f00b917a230a08c46e61672f834a3aa 16:44:24 INFO - mozversion application_display_name: Nightly 16:44:24 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:44:24 INFO - mozversion application_name: Firefox 16:44:24 INFO - mozversion application_remotingname: firefox 16:44:24 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 16:44:24 INFO - mozversion application_vendor: Mozilla 16:44:24 INFO - mozversion application_version: 50.0a1 16:44:24 INFO - mozversion platform_buildid: 20160613160126 16:44:24 INFO - mozversion platform_changeset: 270ba15c5f00b917a230a08c46e61672f834a3aa 16:44:24 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 16:44:24 INFO - mozversion platform_version: 50.0a1 16:44:24 INFO - using testdate: 1465861464 16:44:24 INFO - actual date: 1465861464 16:44:24 INFO - starting webserver on 'localhost:33963' 16:44:24 INFO - SUITE-START | Running 2 tests 16:44:24 INFO - TEST-START | dromaeo_css 16:44:24 INFO - operating with platform_type : linux_ 16:44:24 INFO - Initialising browser for dromaeo_css test... 16:44:24 INFO - TEST-INFO | started process 28733 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpK5yOJs/profile http://localhost:33963/getInfo.html) 16:44:28 INFO - PROCESS | 28733 | __metrics Screen width/height:1600/1200 16:44:28 INFO - PROCESS | 28733 | colorDepth:24 16:44:28 INFO - PROCESS | 28733 | Browser inner width/height: 1024/697 16:44:28 INFO - PROCESS | 28733 | __metrics 16:44:29 INFO - PROCESS | 28733 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:44:29 INFO - PROCESS | 28733 | console.error: PushService: 16:44:29 INFO - PROCESS | 28733 | stateChangeProcessEnqueue: Error transitioning state 16:44:29 INFO - PROCESS | 28733 | UnknownError 16:44:30 INFO - TEST-INFO | 28733: exit 0 16:44:30 INFO - Browser initialized. 16:44:30 INFO - Running cycle 1/1 for dromaeo_css test... 16:44:30 INFO - TEST-INFO | started process 28813 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpK5yOJs/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:44:42 INFO - PROCESS | 28813 | RSS: Main: 175489024 16:44:42 INFO - PROCESS | 28813 | 16:45:33 INFO - PROCESS | 28813 | 1465861533290 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] 16:47:46 INFO - PROCESS | 28813 | Cycle 1(1): loaded http://localhost:33963/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33963/tests/dromaeo/cssquery-ext.html) 16:47:47 INFO - PROCESS | 28813 | RSS: Main: 291323904 16:47:47 INFO - PROCESS | 28813 | 16:50:50 INFO - PROCESS | 28813 | Cycle 1(1): loaded http://localhost:33963/tests/dromaeo/cssquery-ext.html (next: http://localhost:33963/tests/dromaeo/cssquery-jquery.html) 16:50:50 INFO - PROCESS | 28813 | RSS: Main: 265916416 16:50:50 INFO - PROCESS | 28813 | 16:53:53 INFO - PROCESS | 28813 | Cycle 1(1): loaded http://localhost:33963/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33963/tests/dromaeo/cssquery-mootools.html) 16:53:53 INFO - PROCESS | 28813 | RSS: Main: 262848512 16:53:53 INFO - PROCESS | 28813 | 16:56:55 INFO - PROCESS | 28813 | Cycle 1(1): loaded http://localhost:33963/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33963/tests/dromaeo/cssquery-prototype.html) 16:56:56 INFO - PROCESS | 28813 | RSS: Main: 260669440 16:56:56 INFO - PROCESS | 28813 | 16:59:59 INFO - PROCESS | 28813 | Cycle 1(1): loaded http://localhost:33963/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33963/tests/dromaeo/cssquery-yui.html) 17:00:00 INFO - PROCESS | 28813 | RSS: Main: 240738304 17:00:00 INFO - PROCESS | 28813 | 17:03:02 INFO - PROCESS | 28813 | Cycle 1(1): loaded http://localhost:33963/tests/dromaeo/cssquery-yui.html (next: http://localhost:33963/tests/dromaeo/cssquery-dojo.html) 17:03:03 INFO - PROCESS | 28813 | RSS: Main: 294506496 17:03:03 INFO - PROCESS | 28813 | 17:03:03 INFO - PROCESS | 28813 | __start_tp_report 17:03:03 INFO - PROCESS | 28813 | _x_x_mozilla_page_load 17:03:03 INFO - PROCESS | 28813 | _x_x_mozilla_page_load_details 17:03:03 INFO - PROCESS | 28813 | |i|pagename|runs| 17:03:03 INFO - PROCESS | 28813 | |0;dojo.html;2640.1023651958335;2660.4014096828205;2693.771029462495;2697.0829917827946;2702.4595080983795;4704.0827038727375;4799.352087468191;4874.9275159464905;4904.239842824359;4978.900421991562;4742.359781429506;4795.400574928134;4798.376211092553;4802.111609352272;4813.4223893132785;4382.737035777855;4407.977960110211;4452.39356121541;4506.616937560311;4600.97699511502;4470.843520476784;4522.253828118373;4566.657500687462;4589.036302376505;4596.448426188862;4288.742675439484;4339.544347843463;4432.71187372823;4434.800433980478;4486.214912390318;4414.271645178542;4439.5560443955665;4488.865334039984;4493.9101217975785;4505.346724724896;4461.5092339842595;4473.642108631302;4483.439570053743;4528.8641340759505;4530.116627257686;4657.534246575349;4743.501932297128;4800.759962001886;4814.66297359185;4875.268709693539;5163.586913046985;5190.662606930538;5190.961807638488;5197.66215196011;5220.190870415092;4990.925136122961;5237.921431178535;5238.60710446718;5248.081585722483;5251.396089449724;4762.357081793983;4824.589909857701;4833.10587541299;4861.343718597944;4892.315075889378;5363.275957745733;5365.865853353619;5376.381716102698;5382.569394448435;5387.46125387466;4916.5820905222745;5004.424491183488;5107.821226257063;5146.022255771466;5146.330976972969;5151.536361727388;5241.213817927265;5272.209168624737;5284.022455845681;5285.735713214324;5154.355705536808;5169.534741873174;5173.508516690908;5174.456682048406;5219.086659834514;4954.355933728592;5152.845414637492;5161.767720452589;5161.948380516147;5163.14808056674;4274.786260686953;4324;4349.369341445473;4353.760543170093;4406.096750166208;3824.043989002749;3829.7127715421457;3838.7696738195796;3875.844966201377;3877.825497852547;4388.188185185751;4390.868273951786;4394.296912494049;4400.515943246241;4443.888902777457;4996.875702966803;5035.144025515671;5058.747062646853;5085.593152547787;5112.872178195575;4320.697551171388;4328.329108988112;4330.133973205371;4338.6312163466455;4380.846670366522;4582.793774280165;4624.791884365211;4635.930461043087;4636.744979026186;4680.53194680536;4706.623470122382;4737.407824021997;4761.1905975984855;4783.497732738151;4803.087413391444;5116;5120.513551212629;5133.332666753298;5143.099957507496;5194.35070616173;4677.812887484462;4781.187198176249;4794.304825800309;4799.064182484382;4842.806287748592;5064.265681476239;5073.568746656576;5097.260897169964;5119.846404607868;5135.87160320995;5126.7949282029795;5131.974340128276;5140.564653752887;5147.510986456281;5177.508136727005;4894.681845680019;5000.924986125284;5001.024800163933;5008.073506401327;5010;4988.575971042502;5093.159628661229;5112.97443512795;5123.3339665843205;5166.173412254021;5024.447310795883;5042.84871453857;5083.288339632529;5085.262636917701;5089.083964886356;4895.681780684244;4997.725125118008;5057.797688092435;5108.821191258288;5143.5113664201845;4947.678400903929;4970.403551573834;4970.478099799469;4972.179590367549;5015.097282489041 17:03:03 INFO - PROCESS | 28813 | |1;ext.html;537.4335393016236;576.4379729763481;582.7261187242;589.1310317282008;596.8149873539202;27087;38475.422868656955;39463.802680986555;39463.80268098663;39559.60440395595;39504.40743388851;39749.40375894364;39768.80115599418;39825.80087099568;39960.400593991115;7475.476716629838;7886.250806173419;8046.637901294426;8052.396070294752;10191.745206369826;9923.40459572428;10416.166706663449;10422.270441069128;10424.583016679324;10425;10446.477676116163;10458.424786636731;10483.68548943533;10489.685309440729;10506.369617822955;7588.165301816795;10131.341462804969;10362.689119326433;10370.9481452593;10376.844347334796;10214.233932455096;10250.9487452563;10316.845247321296;10322.845157322647;10325.277230593862;38447.807760961296;38726.419103713466;38810.417843732364;38817.22365552673;38850.61149388526;3140.230643492336;3160.8893688720786;3223.516472529116;3229.4832826747843;3511.280187561569;26401;26484.205473835624;29109.56335654967;29830.40339193204;30110;3399.9490007649906;3418.5214070030215;3426.1434641339665;3482.355764183634;3554.733394995386;250333;251072;252698.73650631812;252939;253546;31869;33146.171345716066;49729.75135124301;50258.246126308135;50291.49708502941;33300.66699333024;33345.666543334744;33365;33495.16262093467;33539.832300838825;12838.16551924122;12918.354082295848;12961.481540738454;12968.221906685629;12980.15628984113;8798.824023519493;10550.683479495627;10641.574337026432;10719.946400267949;10819.891801082045;7779.4943328684585;7838.784988326818;7849.882251766228;7940.404469664798;7972.405518896244;3082.4841607045787;3090.98454507726;3111.3621707549896;3153.101366110693;3174.571432856535;942.58997336159;968.5593055159885;994.8159590475785;1001.2740762946951;1020.102309967239;27235.591466128022;27242.5913611296;27816.582751258746;27983.16050518488;28068.578971315448;985.9161971232526;994.6021591363512;998.4408731110601;1068.2308737708838;1080.9135269178446;14521.92739036298;14668.119912805052;14733.484328048682;15156.848431515544;15232.390704371923;373529;377215;378428;379053;379246;50326.24510632343;50756.49243507592;50932.74533627308;50958.490415096116;50998.74500627473;1046.931949423285;1109.9611513596985;1168.661088284388;1182.2079206931376;1183.7810005149074;25916.611250830876;28736.137476271524;28814.423711526073;29047.56428653614;29487.410251795274;42103;42119.157616848104;42565.36151957785;42697.78651106724;42701.35947960845;288062;289172;289507;290252;290473;21791.782082178976;24596.50806983886;24999;25958;26127.346816329744;41958.16083678248;42284.788576056926;42553;43108.13783724371;43334.34998474962;34574.30851383009;36365.81817090898;36519.26961460703;36761.81619091887;37354;34050.659493404746;37350;37472.250554989296;37908.81045594755;38124.809375952944;35679.28641427209;35684.821575892995;36014.63985360217;36316;36566.26867462689;32046.519302210952;32300.83849580737;32407.675923240466;32766.508502372006;32924.34151317008;25157.371065723502;25187.496250075263;25200.243992680247;25403.29835082459;25501.23496295114 17:03:03 INFO - PROCESS | 28813 | |2;jquery.html;368.3369934118586;368.8967089215019;373.87101449999744;389.40615561269044;390.7050177116277;15561.221938903067;16646.500604981855;17084.48746537604;17672.20475078621;17700.91149544254;16509.422170224043;17172;17631.38290159845;17726.29094836205;17737;5018.573421259197;5222.164453687392;5244.685318880879;5259.053370393328;5264.499872512124;3718.1634132320146;3957.9010524736823;5904.143899134623;6283.874322513547;6296.6222026678315;6124.326324104367;6234.127222188898;6246.25044994599;6254.687265636723;6257.843553911166;5916.645001299936;6061.393860613904;6084.026555751058;6094.421030002165;6168.537359698018;3391.796492210475;3607.1162565171703;3611.5124458198334;3691.50164727761;5328.600354973354;20647.483812904647;20691.379258622266;20953.37139885806;20983.790162098336;21006.474838129016;2106.368089573122;2114.048678094848;2126.8723876567456;2296.9893246971446;2395.6286775549643;12846.678833029155;13373.197608143542;13577.864221357857;13739.587812365646;13951.720965580631;1699.9490015299561;1715.511079342394;1754.8069712331633;1772.6543324051815;1850.7686539182603;58612;58863;59309.40690593082;59387;59727.70136149292;9687.467189304514;9875.901240987498;9882.752931176778;10095.545700443497;10111.64609238673;13598.728025439435;13668.863311366758;13693.863061369459;13737.24445155526;13748.793768093487;7226.205117437078;7381.224971378036;7406.222346653632;7487.513311634726;7490.101187857492;6982.930170698228;7081.929180708127;7148.499605027599;7186.353228209487;7206.351428371367;6247;6387.489000879918;6431.260405053479;6441.32366101562;6478.514111441661;1600.2158942118278;1734.956626084358;1803.1164729282557;1823.1249000479843;1838.4484654603566;811.241489207581;889.2397000564424;903.3089686389917;982.7641366072235;985.2413641496008;16736.916315418344;16755.581110472092;17357.47927562175;17369.305227790748;17413.91293043552;859.5487369131256;871.5511511571545;887.2369762004671;906.6445663732761;973.3429934793986;10272.33229840073;10347.27569070158;10454.790904181873;10459.633912813015;10474.47627618616;382496;385947;388634;388720;392239;61344.38655613476;64345.35654643487;64603.35396646067;64989.67505162444;65597.34402656008;915.2632131134368;919.2691810011057;940.0787228516092;942.79258563116;951.5955718819474;14901.776473352691;15814.68370632604;15870;16112.597185070466;16136.193190340202;33101.33797324088;33328.33343333168;34302.48546271758;34471.19022020503;35449.645503544634;45318;47066.76466617645;47747.28379074386;48782;54212.18681719698;6858.4856135791015;7191.316824901626;7239.746608868664;7339.596322202116;7518.398528117847;10994.450277486254;11868.762624747284;12141.15011949155;12217.45021474018;12400.81398779037;6285.654289014148;9844.556994935101;10045.045720656526;10158.695239142837;10512.369257844553;10057.24570657189;10082.54628541732;10251.794964100825;10421.322614030063;10436.63471778484;10284.125849302893;10463.529141188512;10712.303700259457;10750.354978701303;10881.238313317992;6998.40513556333;7086.326798954091;7315.817104572428;7324.743633972786;7485.588292643739;8900.753894454652;10329.9483502582;10543.402949619047;10629;10634.574617015232 17:03:03 INFO - PROCESS | 28813 | |3;mootools.html;1172.1091970102718;1336.3719052045537;1386.8127802746628;1432.4413478743293;1684.9663006739866;6796.3543463371025;7527.360174385177;7905.565193914333;7931;8111.148329425414;7802.531848089118;7981.600919953994;7997.360211183106;8002.079760827507;8015.158408367125;1905.3902751119647;1990.3431867483696;1993.8903360315178;2210.3700445373033;2241.57410092082;2042.5914817036578;2206.4925067234544;2273.5111950930545;2274.9545009099807;2305.1816605105114;2217.545403192342;2232.263353093483;2237.2505210754416;2242.3385101395047;2243.3606422169687;1907.1513176636402;2198.1756841184474;2201.0315461197183;2204.570108828779;2209.2598979341938;2171.207509259125;2255.9661605075935;2256.706628138348;2257.164849005862;2280.05377768226;7503.474756767028;7595.316421522034;7785.844283114363;7786.3381612563;7789.337906277973;4680.953190468086;4831.227003679394;4833.3958255218095;4834.105690447243;4835.44392394872;2815.0850973433717;2952.778541609388;2988.4620768261702;2998.130542142776;3025.9243518911985;865.7878819689154;888.4713595410785;893.2362829780509;906.8866391701038;908.0556221529602;11047.226694131414;11294.322340659504;11297.322160670305;11306.547738090549;11323.150763692674;4252.340887162495;4292.613664770186;4406;4412.205802955499;4425.6238219751685;9509.619615215452;9531.666391676257;9538.23694104484;9543.61825526985;9569.186619137452;4877.268409738567;4882.316475693406;4883.731394773251;4888.340074090023;4900;3547.5742910850863;3702.123437189908;4418.64650827933;4449.421575195204;4457.509673935864;3709.295233905549;3803.2773772983046;3841.250956063541;3853.903652408656;3868.1103346230525;1218.8537375514818;1236.1655882279426;1244.937753112359;1256.6104507602672;1259.225576270587;691.629977961788;714.810575197573;837.8701301298308;848.1942154952819;852.9786755331043;5065.696058236517;5151.304573882553;5168.819091331786;5210.557102646242;5256.185291279858;880.8766772651834;897.2776914583692;911.6171208092485;913.4336711239074;918.2149262380702;3422.6064002640014;3527.4356103023392;3590.9281814363567;3646.21606354635;3673.6142705016123;9680.419174849532;9918.355306905029;9955.601775929026;10021.198304135653;10048.145907597936;9925.553350099262;9931;9939.950300248596;9952.701418957442;9964.701058968098;7142;7401.888971665429;7424.554526728413;7469.402447804163;7484.438667099989;5010.949890501049;5046;5157.871053223699;5307.150855863043;5380;9010.774730631787;9149.496777677292;9173.633054678005;9289.34974551775;9350.67272645454;8287.378446616407;9147.359684821999;9286.164245217962;9453.196478299147;9473.194778443909;6049.969750151221;6318.399752023551;6351.491880649444;6462.547621666438;6517.055027021151;7594.6202689866395;7759.728409505866;7772.961135194288;7773.766786996399;7781.37748980069;7125.216226215216;7126.251743567058;7167.892481612885;7204.207537171012;7304.96347518259;6670.699818508276;6697.2633010367845;6701.631410272482;6708.597484150967;6847.863042739018;6485.578437401554;6507.154069970874;6555.2133743951035;6561.278259391368;6567.835804104936;4624.699394539344;4696.600788932979;4730.787114579921;4761.1429942609275;4771.332013518041;4765.642576806684;4786.521347865186;4822.276658501253;4874.22012478016;4899.632527560376 17:03:03 INFO - PROCESS | 28813 | |4;prototype.html;285.717140031369;287.53132394197456;293.81489661513245;305.9617547806524;307.6108722466081;4762.523747625236;4780.665353425257;4812.374391329126;4821.710697358157;4823.673489790301;4730.881727956803;4736.123817093831;4742.312364707115;4794.640401969848;4794.9760251198695;3805.6574908258253;3829.215010922768;3830.5211848518798;3853.2678791029753;3869.8258578364043;3613.5844377896483;3677.926441471169;3837.443570682249;3839.404892241707;3873.5158105236846;3231.221959573542;3602.1534939289377;3683.502727131843;3700.85196592136;3751.005983414397;3644.908877278063;3723.515942927429;3748.3253014457387;3772.830222639988;3778.338790711628;3322.3853587086223;3324.1855745342546;3324.734021278292;3329.4839299908554;3334.5998480182293;4501.414816073922;4678.298255261704;4690.202665546865;4696.694714843558;4706.517177288782;4154.065335299563;4272.974486123308;4277.037666525007;4285.485741710983;4286.592773686495;4990.500949905017;5002.374703162105;5009.173486374781;5049.697018178921;5061.139606266906;3686.3548878946076;3691.354013047706;3693.2244228712;3696.2977034363653;3697.9815100924325;5056.696598204119;5214.843554693365;5231.215317702375;5236.293100431431;5251.264822924793;3730.477733117366;3750.6811920986474;3761.3793724035777;3761.7931013794505;3781;3808.638179372955;3809.7523660961947;3810.028442747137;3827.8468861245797;3849.634284742945;4196.706230563831;4231.830726770895;4275.850345237902;4329.982454123341;4335.934960975588;5015.297858299841;5043.747812609355;5052.065367906949;5063.1898896176435;5071.822486212965;1325.6950901292757;1343.7849944009108;1350.1763924006348;1354.395041875381;1361.5370773936909;809.8461292354434;850.608719988812;857.1128881607507;867.9974629303165;877.5217506458995;3944.9408258876138;3945.230680017369;3958.148997965451;3965.9490235087724;3981.462502562117;4584.289435137559;4603.010352774169;4623.398958135421;4629.837955671535;4640.97679511607;4001.3197756381487;4013.177298653827;4022.2558826616582;4025.154717509356;4036.192761447722;2496.2636022373445;2556.6292887531204;2776.1532732516775;2786.582012698071;2790.7906906982057;4845.394325709286;4896.5837903777865;4911.803527858917;4919.65562410635;4938.975305123523;5100.642954993189;5129.717865517432;5333.893322133536;5337.5463085637375;5352.304200453916;4903.975480122648;4906.484819094015;4908.410990681141;4920.286558449076;4943.629227807929;5168.9483105168465;5205.245239440335;5211.973940130275;5228.503292187236;5235.764390602508;4898.730569818694;5062.316587260672;5077.796888124433;5082.669626474268;5136.922946155736;4851.75741212945;4902.85291441243;4908.312836203006;4918.95081049185;4936.2102063669645;3703;3711.2206436648607;3716.9628303716618;3754.6433088856515;3755.661990420875;4946.727929963887;5239.816606418757;5248.868778280574;5267.631265811509;5294.814681486129;4984.675996060245;5018.974905125451;5029.673071250357;5077.492250774893;5100.872478188075;5050.242463630485;5056.949430505648;5067.771950262173;5069.566608028241;5080.644354895122;4775.904481910273;4906.092372911023;4980.477049909708;4994.9500504994485;5024.346834911438;5094.6688465249645;5109.386873575195;5109.726171853489;5111.846644600668;5130.999455106367;5004.274380214775;5016.4231113420965;5021.297018417352;5031;5043.87390315245 17:03:03 INFO - PROCESS | 28813 | |5;yui.html;653.748306901843;705.6119134476037;720.0711082703313;729.3836707981756;764.6597264217426;11542.942285288573;13136.211827290357;13277.269750163738;13605.455781768742;13699.45202191911;13799.103058301203;13903.860961390383;13976.371063302151;14117.858821411783;14132.364043618036;611.0955785437556;750.0549307872066;804.1556365815899;807.2492581898832;808.0787901791962;803.0203152154392;805.2712295372697;806.2904643913348;808.5270116981543;809.9109097999216;845.1464021338462;847.1570787066877;847.3602430165216;847.5677404523707;847.7033038436529;640.4748106552629;677.9017042528806;678.2369833936821;679.9490038247151;842.0148426341195;581.5899790647584;619.662284055191;622.6295354264206;622.8162692005869;623.9844003899893;13337.466501339935;13341.466341346335;13350.599482015457;13365.198088114745;13366.331683415887;12196.268223906594;12346.876531234662;12777.425015874307;12838.422270997735;12854.228746275254;11315.58300974248;11841;11952.581659641957;12107;12559.686007849785;4111.773852438115;4183.5398106208295;4193.182329445729;4280.700350975433;4300.591443812833;59551;59927.99999999956;60483;60662.39337606612;60723.69638151825;9925.65260215889;10158.949205254074;10190.235732320105;10238.744031399126;10277.845832312521;18147.72778408325;19270.71093933592;19320.903395482932;19324.71012934807;19336.4199074028;6597.175353080865;6826.897596536056;7202.135743710788;7403.851922961619;7514.135874374517;3730.1607138393642;3772.86794962175;3875.6899448044087;3893.9415908761393;4045.2516284486874;3077.538369244631;3234.530993006048;3235.3367559650214;3245.3996010737615;3248.6588908164777;539.3500831498036;540.9188621706776;544.3821262866596;557.5706705836483;562.2185162623956;506.8530126263416;585.6222736335125;585.7539833270037;587.2014060877203;590.7548367427555;7156.928430715626;7454.552726836408;7456.440766942393;7571.46999710015;7658;543.7118327286545;550.5650536076535;552.6352607279176;554.464941331617;570.0337927213417;3256.1859535116223;3704.5184126063978;3709.7588656737225;3773.113318370181;3899.707521935866;62267.6886615564;93202;95571.52214238884;95664;95933.5203323979;47731.52268477271;49500.75249623729;80493.59753201196;81721;81965;71055;74948.62525687336;74968.75218734636;75505.62247188728;76240;7171.964140179266;7175.2465991070185;7355.963220183865;7476.289752473724;7482.812929676802;36371.45442818307;36792.44811327886;37340.813295933345;42134.36798447964;43065.78467107644;60443.69778151081;63330;63989;64888;66949.33050669431;11109.277896936674;11328.03711684516;11507.136964727511;11529;11589.7102572433;12035.157538972539;12173.39133043362;12435.253884766942;12831.486740530274;12954.157979731288;9225.538723063686;10138.087572118544;11216.55133794639;11263.605773797877;11591.88408115908;12070.698232544257;12310.630681079581;12422.565210217599;13245.80131298012;13247.20516768997;9077;9189.540522973692;9280.164785169367;9308.069193080908;9803.803923921625;9848.113669769755;9897.505124743879;10152.64465743725;10157;10219.386836789816;9865.210783137189;9974.60101595928;10099.44453055089;10293.073623373932;10360.274780765576 17:03:03 INFO - PROCESS | 28813 | __end_tp_report 17:03:03 INFO - PROCESS | 28813 | __start_cc_report 17:03:03 INFO - PROCESS | 28813 | _x_x_mozilla_cycle_collect,1068 17:03:03 INFO - PROCESS | 28813 | __end_cc_report 17:03:03 INFO - PROCESS | 28813 | __startTimestamp1465862583216__endTimestamp 17:03:03 INFO - PROCESS | 28813 | 17:03:03 INFO - PROCESS | 28813 | ------- Summary: start ------- 17:03:03 INFO - PROCESS | 28813 | Number of tests: 6 17:03:03 INFO - PROCESS | 28813 | 17:03:03 INFO - PROCESS | 28813 | [#0] dojo.html Cycles:165 Average:4769.39 Median:4892.32 stddev:507.17 (10.4%) stddev-sans-first:480.43 17:03:03 INFO - PROCESS | 28813 | Values: 2640.1 2660.4 2693.8 2697.1 2702.5 4704.1 4799.4 4874.9 4904.2 4978.9 4742.4 4795.4 4798.4 4802.1 4813.4 4382.7 4408.0 4452.4 4506.6 4601.0 4470.8 4522.3 4566.7 4589.0 4596.4 4288.7 4339.5 4432.7 4434.8 4486.2 4414.3 4439.6 4488.9 4493.9 4505.3 4461.5 4473.6 4483.4 4528.9 4530.1 4657.5 4743.5 4800.8 4814.7 4875.3 5163.6 5190.7 5191.0 5197.7 5220.2 4990.9 5237.9 5238.6 5248.1 5251.4 4762.4 4824.6 4833.1 4861.3 4892.3 5363.3 5365.9 5376.4 5382.6 5387.5 4916.6 5004.4 5107.8 5146.0 5146.3 5151.5 5241.2 5272.2 5284.0 5285.7 5154.4 5169.5 5173.5 5174.5 5219.1 4954.4 5152.8 5161.8 5161.9 5163.1 4274.8 4324.0 4349.4 4353.8 4406.1 3824.0 3829.7 3838.8 3875.8 3877.8 4388.2 4390.9 4394.3 4400.5 4443.9 4996.9 5035.1 5058.7 5085.6 5112.9 4320.7 4328.3 4330.1 4338.6 4380.8 4582.8 4624.8 4635.9 4636.7 4680.5 4706.6 4737.4 4761.2 4783.5 4803.1 5116.0 5120.5 5133.3 5143.1 5194.4 4677.8 4781.2 4794.3 4799.1 4842.8 5064.3 5073.6 5097.3 5119.8 5135.9 5126.8 5132.0 5140.6 5147.5 5177.5 4894.7 5000.9 5001.0 5008.1 5010.0 4988.6 5093.2 5113.0 5123.3 5166.2 5024.4 5042.8 5083.3 5085.3 5089.1 4895.7 4997.7 5057.8 5108.8 5143.5 4947.7 4970.4 4970.5 4972.2 5015.1 17:03:03 INFO - PROCESS | 28813 | 17:03:03 INFO - PROCESS | 28813 | [#1] ext.html Cycles:180 Average:45326.44 Median:32587.09 stddev:81772.06 (250.9%) stddev-sans-first:81932.30 17:03:03 INFO - PROCESS | 28813 | Values: 537.4 576.4 582.7 589.1 596.8 27087.0 38475.4 39463.8 39463.8 39559.6 39504.4 39749.4 39768.8 39825.8 39960.4 7475.5 7886.3 8046.6 8052.4 10191.7 9923.4 10416.2 10422.3 10424.6 10425.0 10446.5 10458.4 10483.7 10489.7 10506.4 7588.2 10131.3 10362.7 10370.9 10376.8 10214.2 10250.9 10316.8 10322.8 10325.3 38447.8 38726.4 38810.4 38817.2 38850.6 3140.2 3160.9 3223.5 3229.5 3511.3 26401.0 26484.2 29109.6 29830.4 30110.0 3399.9 3418.5 3426.1 3482.4 3554.7 250333.0 251072.0 252698.7 252939.0 253546.0 31869.0 33146.2 49729.8 50258.2 50291.5 33300.7 33345.7 33365.0 33495.2 33539.8 12838.2 12918.4 12961.5 12968.2 12980.2 8798.8 10550.7 10641.6 10719.9 10819.9 7779.5 7838.8 7849.9 7940.4 7972.4 3082.5 3091.0 3111.4 3153.1 3174.6 942.6 968.6 994.8 1001.3 1020.1 27235.6 27242.6 27816.6 27983.2 28068.6 985.9 994.6 998.4 1068.2 1080.9 14521.9 14668.1 14733.5 15156.8 15232.4 373529.0 377215.0 378428.0 379053.0 379246.0 50326.2 50756.5 50932.7 50958.5 50998.7 1046.9 1110.0 1168.7 1182.2 1183.8 25916.6 28736.1 28814.4 29047.6 29487.4 42103.0 42119.2 42565.4 42697.8 42701.4 288062.0 289172.0 289507.0 290252.0 290473.0 21791.8 24596.5 24999.0 25958.0 26127.3 41958.2 42284.8 42553.0 43108.1 43334.3 34574.3 36365.8 36519.3 36761.8 37354.0 34050.7 37350.0 37472.3 37908.8 38124.8 35679.3 35684.8 36014.6 36316.0 36566.3 32046.5 32300.8 32407.7 32766.5 32924.3 25157.4 25187.5 25200.2 25403.3 25501.2 17:03:03 INFO - PROCESS | 28813 | 17:03:03 INFO - PROCESS | 28813 | [#2] jquery.html Cycles:180 Average:23681.56 Median:2046.02 stddev:63495.18 (3103.4%) stddev-sans-first:63649.17 17:03:03 INFO - PROCESS | 28813 | Values: 368.3 368.9 373.9 389.4 390.7 15561.2 16646.5 17084.5 17672.2 17700.9 16509.4 17172.0 17631.4 17726.3 17737.0 5018.6 5222.2 5244.7 5259.1 5264.5 3718.2 3957.9 5904.1 6283.9 6296.6 6124.3 6234.1 6246.3 6254.7 6257.8 5916.6 6061.4 6084.0 6094.4 6168.5 3391.8 3607.1 3611.5 3691.5 5328.6 20647.5 20691.4 20953.4 20983.8 21006.5 2106.4 2114.0 2126.9 2297.0 2395.6 12846.7 13373.2 13577.9 13739.6 13951.7 1699.9 1715.5 1754.8 1772.7 1850.8 58612.0 58863.0 59309.4 59387.0 59727.7 9687.5 9875.9 9882.8 10095.5 10111.6 13598.7 13668.9 13693.9 13737.2 13748.8 7226.2 7381.2 7406.2 7487.5 7490.1 6982.9 7081.9 7148.5 7186.4 7206.4 6247.0 6387.5 6431.3 6441.3 6478.5 1600.2 1735.0 1803.1 1823.1 1838.4 811.2 889.2 903.3 982.8 985.2 16736.9 16755.6 17357.5 17369.3 17413.9 859.5 871.6 887.2 906.6 973.3 10272.3 10347.3 10454.8 10459.6 10474.5 382496.0 385947.0 388634.0 388720.0 392239.0 61344.4 64345.4 64603.4 64989.7 65597.3 915.3 919.3 940.1 942.8 951.6 14901.8 15814.7 15870.0 16112.6 16136.2 33101.3 33328.3 34302.5 34471.2 35449.6 45318.0 47066.8 47747.3 48782.0 54212.2 6858.5 7191.3 7239.7 7339.6 7518.4 10994.5 11868.8 12141.2 12217.5 12400.8 6285.7 9844.6 10045.0 10158.7 10512.4 10057.2 10082.5 10251.8 10421.3 10436.6 10284.1 10463.5 10712.3 10750.4 10881.2 6998.4 7086.3 7315.8 7324.7 7485.6 8900.8 10329.9 10543.4 10629.0 10634.6 17:03:03 INFO - PROCESS | 28813 | 17:03:03 INFO - PROCESS | 28813 | [#3] mootools.html Cycles:180 Average:5242.87 Median:5154.59 stddev:2976.00 (57.7%) stddev-sans-first:2968.62 17:03:03 INFO - PROCESS | 28813 | Values: 1172.1 1336.4 1386.8 1432.4 1685.0 6796.4 7527.4 7905.6 7931.0 8111.1 7802.5 7981.6 7997.4 8002.1 8015.2 1905.4 1990.3 1993.9 2210.4 2241.6 2042.6 2206.5 2273.5 2275.0 2305.2 2217.5 2232.3 2237.3 2242.3 2243.4 1907.2 2198.2 2201.0 2204.6 2209.3 2171.2 2256.0 2256.7 2257.2 2280.1 7503.5 7595.3 7785.8 7786.3 7789.3 4681.0 4831.2 4833.4 4834.1 4835.4 2815.1 2952.8 2988.5 2998.1 3025.9 865.8 888.5 893.2 906.9 908.1 11047.2 11294.3 11297.3 11306.5 11323.2 4252.3 4292.6 4406.0 4412.2 4425.6 9509.6 9531.7 9538.2 9543.6 9569.2 4877.3 4882.3 4883.7 4888.3 4900.0 3547.6 3702.1 4418.6 4449.4 4457.5 3709.3 3803.3 3841.3 3853.9 3868.1 1218.9 1236.2 1244.9 1256.6 1259.2 691.6 714.8 837.9 848.2 853.0 5065.7 5151.3 5168.8 5210.6 5256.2 880.9 897.3 911.6 913.4 918.2 3422.6 3527.4 3590.9 3646.2 3673.6 9680.4 9918.4 9955.6 10021.2 10048.1 9925.6 9931.0 9940.0 9952.7 9964.7 7142.0 7401.9 7424.6 7469.4 7484.4 5010.9 5046.0 5157.9 5307.2 5380.0 9010.8 9149.5 9173.6 9289.3 9350.7 8287.4 9147.4 9286.2 9453.2 9473.2 6050.0 6318.4 6351.5 6462.5 6517.1 7594.6 7759.7 7773.0 7773.8 7781.4 7125.2 7126.3 7167.9 7204.2 7305.0 6670.7 6697.3 6701.6 6708.6 6847.9 6485.6 6507.2 6555.2 6561.3 6567.8 4624.7 4696.6 4730.8 4761.1 4771.3 4765.6 4786.5 4822.3 4874.2 4899.6 17:03:03 INFO - PROCESS | 28813 | 17:03:03 INFO - PROCESS | 28813 | [#4] prototype.html Cycles:180 Average:4157.20 Median:4733.50 stddev:1203.45 (25.4%) stddev-sans-first:1171.22 17:03:03 INFO - PROCESS | 28813 | Values: 285.7 287.5 293.8 306.0 307.6 4762.5 4780.7 4812.4 4821.7 4823.7 4730.9 4736.1 4742.3 4794.6 4795.0 3805.7 3829.2 3830.5 3853.3 3869.8 3613.6 3677.9 3837.4 3839.4 3873.5 3231.2 3602.2 3683.5 3700.9 3751.0 3644.9 3723.5 3748.3 3772.8 3778.3 3322.4 3324.2 3324.7 3329.5 3334.6 4501.4 4678.3 4690.2 4696.7 4706.5 4154.1 4273.0 4277.0 4285.5 4286.6 4990.5 5002.4 5009.2 5049.7 5061.1 3686.4 3691.4 3693.2 3696.3 3698.0 5056.7 5214.8 5231.2 5236.3 5251.3 3730.5 3750.7 3761.4 3761.8 3781.0 3808.6 3809.8 3810.0 3827.8 3849.6 4196.7 4231.8 4275.9 4330.0 4335.9 5015.3 5043.7 5052.1 5063.2 5071.8 1325.7 1343.8 1350.2 1354.4 1361.5 809.8 850.6 857.1 868.0 877.5 3944.9 3945.2 3958.1 3965.9 3981.5 4584.3 4603.0 4623.4 4629.8 4641.0 4001.3 4013.2 4022.3 4025.2 4036.2 2496.3 2556.6 2776.2 2786.6 2790.8 4845.4 4896.6 4911.8 4919.7 4939.0 5100.6 5129.7 5333.9 5337.5 5352.3 4904.0 4906.5 4908.4 4920.3 4943.6 5168.9 5205.2 5212.0 5228.5 5235.8 4898.7 5062.3 5077.8 5082.7 5136.9 4851.8 4902.9 4908.3 4919.0 4936.2 3703.0 3711.2 3717.0 3754.6 3755.7 4946.7 5239.8 5248.9 5267.6 5294.8 4984.7 5019.0 5029.7 5077.5 5100.9 5050.2 5056.9 5067.8 5069.6 5080.6 4775.9 4906.1 4980.5 4995.0 5024.3 5094.7 5109.4 5109.7 5111.8 5131.0 5004.3 5016.4 5021.3 5031.0 5043.9 17:03:03 INFO - PROCESS | 28813 | 17:03:03 INFO - PROCESS | 28813 | [#5] yui.html Cycles:180 Average:16905.36 Median:547.47 stddev:23549.39 (4301.5%) stddev-sans-first:23583.83 17:03:03 INFO - PROCESS | 28813 | Values: 653.7 705.6 720.1 729.4 764.7 11542.9 13136.2 13277.3 13605.5 13699.5 13799.1 13903.9 13976.4 14117.9 14132.4 611.1 750.1 804.2 807.2 808.1 803.0 805.3 806.3 808.5 809.9 845.1 847.2 847.4 847.6 847.7 640.5 677.9 678.2 679.9 842.0 581.6 619.7 622.6 622.8 624.0 13337.5 13341.5 13350.6 13365.2 13366.3 12196.3 12346.9 12777.4 12838.4 12854.2 11315.6 11841.0 11952.6 12107.0 12559.7 4111.8 4183.5 4193.2 4280.7 4300.6 59551.0 59928.0 60483.0 60662.4 60723.7 9925.7 10158.9 10190.2 10238.7 10277.8 18147.7 19270.7 19320.9 19324.7 19336.4 6597.2 6826.9 7202.1 7403.9 7514.1 3730.2 3772.9 3875.7 3893.9 4045.3 3077.5 3234.5 3235.3 3245.4 3248.7 539.4 540.9 544.4 557.6 562.2 506.9 585.6 585.8 587.2 590.8 7156.9 7454.6 7456.4 7571.5 7658.0 543.7 550.6 552.6 554.5 570.0 3256.2 3704.5 3709.8 3773.1 3899.7 62267.7 93202.0 95571.5 95664.0 95933.5 47731.5 49500.8 80493.6 81721.0 81965.0 71055.0 74948.6 74968.8 75505.6 76240.0 7172.0 7175.2 7356.0 7476.3 7482.8 36371.5 36792.4 37340.8 42134.4 43065.8 60443.7 63330.0 63989.0 64888.0 66949.3 11109.3 11328.0 11507.1 11529.0 11589.7 12035.2 12173.4 12435.3 12831.5 12954.2 9225.5 10138.1 11216.6 11263.6 11591.9 12070.7 12310.6 12422.6 13245.8 13247.2 9077.0 9189.5 9280.2 9308.1 9803.8 9848.1 9897.5 10152.6 10157.0 10219.4 9865.2 9974.6 10099.4 10293.1 10360.3 17:03:03 INFO - PROCESS | 28813 | -------- Summary: end -------- 17:03:03 INFO - PROCESS | 28813 | 17:03:03 INFO - TEST-INFO | 28813: exit 0 17:03:03 INFO - TEST-OK | dromaeo_css | took 1119856ms 17:03:03 INFO - TEST-START | kraken 17:03:03 INFO - operating with platform_type : linux_ 17:03:03 INFO - Initialising browser for kraken test... 17:03:03 INFO - TEST-INFO | started process 28991 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaEmTth/profile http://localhost:33963/getInfo.html) 17:03:08 INFO - PROCESS | 28991 | __metrics Screen width/height:1600/1200 17:03:08 INFO - PROCESS | 28991 | colorDepth:24 17:03:08 INFO - PROCESS | 28991 | Browser inner width/height: 1024/697 17:03:08 INFO - PROCESS | 28991 | __metrics 17:03:09 INFO - PROCESS | 28991 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:03:09 INFO - PROCESS | 28991 | console.error: PushService: 17:03:09 INFO - PROCESS | 28991 | stateChangeProcessEnqueue: Error transitioning state 17:03:09 INFO - PROCESS | 28991 | UnknownError 17:03:09 INFO - TEST-INFO | 28991: exit 0 17:03:09 INFO - Browser initialized. 17:03:09 INFO - Running cycle 1/1 for kraken test... 17:03:10 INFO - TEST-INFO | started process 29069 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaEmTth/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:03:22 INFO - PROCESS | 29069 | RSS: Main: 175570944 17:03:22 INFO - PROCESS | 29069 | 17:03:24 INFO - PROCESS | 29069 | Cycle 1(1): loaded http://localhost:33963/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33963/tests/kraken/driver.html?testName=audio-beat-detection) 17:03:25 INFO - PROCESS | 29069 | RSS: Main: 233066496 17:03:25 INFO - PROCESS | 29069 | 17:03:28 INFO - PROCESS | 29069 | Cycle 1(1): loaded http://localhost:33963/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33963/tests/kraken/driver.html?testName=audio-dft) 17:03:29 INFO - PROCESS | 29069 | RSS: Main: 220962816 17:03:29 INFO - PROCESS | 29069 | 17:03:32 INFO - PROCESS | 29069 | Cycle 1(1): loaded http://localhost:33963/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33963/tests/kraken/driver.html?testName=audio-fft) 17:03:33 INFO - PROCESS | 29069 | RSS: Main: 287920128 17:03:33 INFO - PROCESS | 29069 | 17:03:35 INFO - PROCESS | 29069 | Cycle 1(1): loaded http://localhost:33963/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33963/tests/kraken/driver.html?testName=audio-oscillator) 17:03:35 INFO - PROCESS | 29069 | RSS: Main: 198316032 17:03:35 INFO - PROCESS | 29069 | 17:03:38 INFO - PROCESS | 29069 | Cycle 1(1): loaded http://localhost:33963/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33963/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:03:38 INFO - PROCESS | 29069 | RSS: Main: 203309056 17:03:38 INFO - PROCESS | 29069 | 17:03:41 INFO - PROCESS | 29069 | Cycle 1(1): loaded http://localhost:33963/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33963/tests/kraken/driver.html?testName=imaging-darkroom) 17:03:42 INFO - PROCESS | 29069 | RSS: Main: 238919680 17:03:42 INFO - PROCESS | 29069 | 17:03:45 INFO - PROCESS | 29069 | Cycle 1(1): loaded http://localhost:33963/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33963/tests/kraken/driver.html?testName=imaging-desaturate) 17:03:46 INFO - PROCESS | 29069 | RSS: Main: 240324608 17:03:46 INFO - PROCESS | 29069 | 17:03:49 INFO - PROCESS | 29069 | Cycle 1(1): loaded http://localhost:33963/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33963/tests/kraken/driver.html?testName=json-parse-financial) 17:03:50 INFO - PROCESS | 29069 | RSS: Main: 239517696 17:03:50 INFO - PROCESS | 29069 | 17:03:51 INFO - PROCESS | 29069 | Cycle 1(1): loaded http://localhost:33963/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33963/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:03:52 INFO - PROCESS | 29069 | RSS: Main: 224317440 17:03:52 INFO - PROCESS | 29069 | 17:03:54 INFO - PROCESS | 29069 | Cycle 1(1): loaded http://localhost:33963/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33963/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:03:54 INFO - PROCESS | 29069 | RSS: Main: 229638144 17:03:54 INFO - PROCESS | 29069 | 17:03:57 INFO - PROCESS | 29069 | Cycle 1(1): loaded http://localhost:33963/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33963/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:03:57 INFO - PROCESS | 29069 | RSS: Main: 237854720 17:03:57 INFO - PROCESS | 29069 | 17:04:00 INFO - PROCESS | 29069 | Cycle 1(1): loaded http://localhost:33963/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33963/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:04:01 INFO - PROCESS | 29069 | RSS: Main: 240234496 17:04:01 INFO - PROCESS | 29069 | 17:04:04 INFO - PROCESS | 29069 | Cycle 1(1): loaded http://localhost:33963/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33963/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:04:04 INFO - PROCESS | 29069 | RSS: Main: 239521792 17:04:04 INFO - PROCESS | 29069 | 17:04:06 INFO - PROCESS | 29069 | Cycle 1(1): loaded http://localhost:33963/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33963/tests/kraken/driver.html?testName=ai-astar) 17:04:06 INFO - PROCESS | 29069 | RSS: Main: 284037120 17:04:06 INFO - PROCESS | 29069 | 17:04:06 INFO - PROCESS | 29069 | __start_tp_report 17:04:06 INFO - PROCESS | 29069 | _x_x_mozilla_page_load 17:04:06 INFO - PROCESS | 29069 | _x_x_mozilla_page_load_details 17:04:06 INFO - PROCESS | 29069 | |i|pagename|runs| 17:04:06 INFO - PROCESS | 29069 | |0;ai-astar;112;108;113;115;112;111;112;111;112;112 17:04:06 INFO - PROCESS | 29069 | |1;audio-beat-detection;157;130;131;190;137;140;161;131;192;137 17:04:06 INFO - PROCESS | 29069 | |2;audio-dft;162;162;163;164;161;162;161;162;160;161 17:04:06 INFO - PROCESS | 29069 | |3;audio-fft;76;76;75;101;75;75;76;75;97;75 17:04:06 INFO - PROCESS | 29069 | |4;audio-oscillator;86;86;113;86;87;87;121;86;86;126 17:04:06 INFO - PROCESS | 29069 | |5;imaging-gaussian-blur;117;117;116;116;116;116;117;116;117;117 17:04:06 INFO - PROCESS | 29069 | |6;imaging-darkroom;146;146;146;146;146;146;145;146;146;146 17:04:06 INFO - PROCESS | 29069 | |7;imaging-desaturate;95;94;95;95;94;95;95;94;95;94 17:04:06 INFO - PROCESS | 29069 | |8;json-parse-financial;63;64;65;64;64;64;66;63;63;64 17:04:06 INFO - PROCESS | 29069 | |9;json-stringify-tinderbox;66;65;64;64;65;65;65;66;65;66 17:04:06 INFO - PROCESS | 29069 | |10;stanford-crypto-aes;84;88;87;82;84;85;84;91;125;84 17:04:06 INFO - PROCESS | 29069 | |11;stanford-crypto-ccm;132;133;130;129;143;131;132;130;147;135 17:04:06 INFO - PROCESS | 29069 | |12;stanford-crypto-pbkdf2;168;179;168;169;174;175;171;172;170;170 17:04:06 INFO - PROCESS | 29069 | |13;stanford-crypto-sha256-iterative;69;67;67;67;69;66;66;71;65;64 17:04:06 INFO - PROCESS | 29069 | __end_tp_report 17:04:06 INFO - PROCESS | 29069 | __start_cc_report 17:04:06 INFO - PROCESS | 29069 | _x_x_mozilla_cycle_collect,1928 17:04:06 INFO - PROCESS | 29069 | __end_cc_report 17:04:06 INFO - PROCESS | 29069 | __startTimestamp1465862646752__endTimestamp 17:04:06 INFO - PROCESS | 29069 | 17:04:06 INFO - PROCESS | 29069 | ------- Summary: start ------- 17:04:06 INFO - PROCESS | 29069 | Number of tests: 14 17:04:06 INFO - PROCESS | 29069 | 17:04:06 INFO - PROCESS | 29069 | [#0] ai-astar Cycles:10 Average:111.80 Median:112.00 stddev:1.75 (1.6%) stddev-sans-first:1.86 17:04:06 INFO - PROCESS | 29069 | Values: 112.0 108.0 113.0 115.0 112.0 111.0 112.0 111.0 112.0 112.0 17:04:06 INFO - PROCESS | 29069 | 17:04:06 INFO - PROCESS | 29069 | [#1] audio-beat-detection Cycles:10 Average:150.60 Median:148.50 stddev:23.78 (16.0%) stddev-sans-first:25.11 17:04:06 INFO - PROCESS | 29069 | Values: 157.0 130.0 131.0 190.0 137.0 140.0 161.0 131.0 192.0 137.0 17:04:06 INFO - PROCESS | 29069 | 17:04:06 INFO - PROCESS | 29069 | [#2] audio-dft Cycles:10 Average:161.80 Median:162.00 stddev:1.14 (0.7%) stddev-sans-first:1.20 17:04:06 INFO - PROCESS | 29069 | Values: 162.0 162.0 163.0 164.0 161.0 162.0 161.0 162.0 160.0 161.0 17:04:06 INFO - PROCESS | 29069 | 17:04:06 INFO - PROCESS | 29069 | [#3] audio-fft Cycles:10 Average:80.10 Median:75.50 stddev:10.02 (13.3%) stddev-sans-first:10.51 17:04:06 INFO - PROCESS | 29069 | Values: 76.0 76.0 75.0 101.0 75.0 75.0 76.0 75.0 97.0 75.0 17:04:06 INFO - PROCESS | 29069 | 17:04:06 INFO - PROCESS | 29069 | [#4] audio-oscillator Cycles:10 Average:96.40 Median:86.00 stddev:16.58 (19.3%) stddev-sans-first:17.15 17:04:06 INFO - PROCESS | 29069 | Values: 86.0 86.0 113.0 86.0 87.0 87.0 121.0 86.0 86.0 126.0 17:04:06 INFO - PROCESS | 29069 | 17:04:06 INFO - PROCESS | 29069 | [#5] imaging-gaussian-blur Cycles:10 Average:116.50 Median:117.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 17:04:06 INFO - PROCESS | 29069 | Values: 117.0 117.0 116.0 116.0 116.0 116.0 117.0 116.0 117.0 117.0 17:04:06 INFO - PROCESS | 29069 | 17:04:06 INFO - PROCESS | 29069 | [#6] imaging-darkroom Cycles:10 Average:145.90 Median:146.00 stddev:0.32 (0.2%) stddev-sans-first:0.33 17:04:06 INFO - PROCESS | 29069 | Values: 146.0 146.0 146.0 146.0 146.0 146.0 145.0 146.0 146.0 146.0 17:04:06 INFO - PROCESS | 29069 | 17:04:06 INFO - PROCESS | 29069 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 17:04:06 INFO - PROCESS | 29069 | Values: 95.0 94.0 95.0 95.0 94.0 95.0 95.0 94.0 95.0 94.0 17:04:06 INFO - PROCESS | 29069 | 17:04:06 INFO - PROCESS | 29069 | [#8] json-parse-financial Cycles:10 Average:64.00 Median:64.00 stddev:0.94 (1.5%) stddev-sans-first:0.93 17:04:06 INFO - PROCESS | 29069 | Values: 63.0 64.0 65.0 64.0 64.0 64.0 66.0 63.0 63.0 64.0 17:04:06 INFO - PROCESS | 29069 | 17:04:06 INFO - PROCESS | 29069 | [#9] json-stringify-tinderbox Cycles:10 Average:65.10 Median:65.00 stddev:0.74 (1.1%) stddev-sans-first:0.71 17:04:06 INFO - PROCESS | 29069 | Values: 66.0 65.0 64.0 64.0 65.0 65.0 65.0 66.0 65.0 66.0 17:04:06 INFO - PROCESS | 29069 | 17:04:06 INFO - PROCESS | 29069 | [#10] stanford-crypto-aes Cycles:10 Average:89.40 Median:84.50 stddev:12.77 (15.1%) stddev-sans-first:13.40 17:04:06 INFO - PROCESS | 29069 | Values: 84.0 88.0 87.0 82.0 84.0 85.0 84.0 91.0 125.0 84.0 17:04:06 INFO - PROCESS | 29069 | 17:04:06 INFO - PROCESS | 29069 | [#11] stanford-crypto-ccm Cycles:10 Average:134.20 Median:132.50 stddev:6.01 (4.5%) stddev-sans-first:6.33 17:04:06 INFO - PROCESS | 29069 | Values: 132.0 133.0 130.0 129.0 143.0 131.0 132.0 130.0 147.0 135.0 17:04:06 INFO - PROCESS | 29069 | 17:04:06 INFO - PROCESS | 29069 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.60 Median:171.50 stddev:3.50 (2.0%) stddev-sans-first:3.46 17:04:06 INFO - PROCESS | 29069 | Values: 168.0 179.0 168.0 169.0 174.0 175.0 171.0 172.0 170.0 170.0 17:04:06 INFO - PROCESS | 29069 | 17:04:06 INFO - PROCESS | 29069 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.10 Median:67.00 stddev:2.08 (3.1%) stddev-sans-first:2.09 17:04:06 INFO - PROCESS | 29069 | Values: 69.0 67.0 67.0 67.0 69.0 66.0 66.0 71.0 65.0 64.0 17:04:06 INFO - PROCESS | 29069 | -------- Summary: end -------- 17:04:06 INFO - PROCESS | 29069 | 17:04:07 INFO - TEST-INFO | 29069: exit 0 17:04:07 INFO - TEST-OK | kraken | took 63923ms 17:04:07 INFO - SUITE-END | took 1183s 17:04:07 INFO - Completed test suite (00:19:43) 17:04:07 INFO - javascript benchmark 17:04:07 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2640.1023651958335, 2660.4014096828205, 2693.771029462495, 2697.0829917827946, 2702.4595080983795, 4704.0827038727375, 4799.352087468191, 4874.9275159464905, 4904.239842824359, 4978.900421991562, 4742.359781429506, 4795.400574928134, 4798.376211092553, 4802.111609352272, 4813.4223893132785, 4382.737035777855, 4407.977960110211, 4452.39356121541, 4506.616937560311, 4600.97699511502, 4470.843520476784, 4522.253828118373, 4566.657500687462, 4589.036302376505, 4596.448426188862, 4288.742675439484, 4339.544347843463, 4432.71187372823, 4434.800433980478, 4486.214912390318, 4414.271645178542, 4439.5560443955665, 4488.865334039984, 4493.9101217975785, 4505.346724724896, 4461.5092339842595, 4473.642108631302, 4483.439570053743, 4528.8641340759505, 4530.116627257686, 4657.534246575349, 4743.501932297128, 4800.759962001886, 4814.66297359185, 4875.268709693539, 5163.586913046985, 5190.662606930538, 5190.961807638488, 5197.66215196011, 5220.190870415092, 4990.925136122961, 5237.921431178535, 5238.60710446718, 5248.081585722483, 5251.396089449724, 4762.357081793983, 4824.589909857701, 4833.10587541299, 4861.343718597944, 4892.315075889378, 5363.275957745733, 5365.865853353619, 5376.381716102698, 5382.569394448435, 5387.46125387466, 4916.5820905222745, 5004.424491183488, 5107.821226257063, 5146.022255771466, 5146.330976972969, 5151.536361727388, 5241.213817927265, 5272.209168624737, 5284.022455845681, 5285.735713214324, 5154.355705536808, 5169.534741873174, 5173.508516690908, 5174.456682048406, 5219.086659834514, 4954.355933728592, 5152.845414637492, 5161.767720452589, 5161.948380516147, 5163.14808056674, 4274.786260686953, 4324.0, 4349.369341445473, 4353.760543170093, 4406.096750166208, 3824.043989002749, 3829.7127715421457, 3838.7696738195796, 3875.844966201377, 3877.825497852547, 4388.188185185751, 4390.868273951786, 4394.296912494049, 4400.515943246241, 4443.888902777457, 4996.875702966803, 5035.144025515671, 5058.747062646853, 5085.593152547787, 5112.872178195575, 4320.697551171388, 4328.329108988112, 4330.133973205371, 4338.6312163466455, 4380.846670366522, 4582.793774280165, 4624.791884365211, 4635.930461043087, 4636.744979026186, 4680.53194680536, 4706.623470122382, 4737.407824021997, 4761.1905975984855, 4783.497732738151, 4803.087413391444, 5116.0, 5120.513551212629, 5133.332666753298, 5143.099957507496, 5194.35070616173, 4677.812887484462, 4781.187198176249, 4794.304825800309, 4799.064182484382, 4842.806287748592, 5064.265681476239, 5073.568746656576, 5097.260897169964, 5119.846404607868, 5135.87160320995, 5126.7949282029795, 5131.974340128276, 5140.564653752887, 5147.510986456281, 5177.508136727005, 4894.681845680019, 5000.924986125284, 5001.024800163933, 5008.073506401327, 5010.0, 4988.575971042502, 5093.159628661229, 5112.97443512795, 5123.3339665843205, 5166.173412254021, 5024.447310795883, 5042.84871453857, 5083.288339632529, 5085.262636917701, 5089.083964886356, 4895.681780684244, 4997.725125118008, 5057.797688092435, 5108.821191258288, 5143.5113664201845, 4947.678400903929, 4970.403551573834, 4970.478099799469, 4972.179590367549, 5015.097282489041], "value": 4736.653355390229, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [537.4335393016236, 576.4379729763481, 582.7261187242, 589.1310317282008, 596.8149873539202, 27087.0, 38475.422868656955, 39463.802680986555, 39463.80268098663, 39559.60440395595, 39504.40743388851, 39749.40375894364, 39768.80115599418, 39825.80087099568, 39960.400593991115, 7475.476716629838, 7886.250806173419, 8046.637901294426, 8052.396070294752, 10191.745206369826, 9923.40459572428, 10416.166706663449, 10422.270441069128, 10424.583016679324, 10425.0, 10446.477676116163, 10458.424786636731, 10483.68548943533, 10489.685309440729, 10506.369617822955, 7588.165301816795, 10131.341462804969, 10362.689119326433, 10370.9481452593, 10376.844347334796, 10214.233932455096, 10250.9487452563, 10316.845247321296, 10322.845157322647, 10325.277230593862, 38447.807760961296, 38726.419103713466, 38810.417843732364, 38817.22365552673, 38850.61149388526, 3140.230643492336, 3160.8893688720786, 3223.516472529116, 3229.4832826747843, 3511.280187561569, 26401.0, 26484.205473835624, 29109.56335654967, 29830.40339193204, 30110.0, 3399.9490007649906, 3418.5214070030215, 3426.1434641339665, 3482.355764183634, 3554.733394995386, 250333.0, 251072.0, 252698.73650631812, 252939.0, 253546.0, 31869.0, 33146.171345716066, 49729.75135124301, 50258.246126308135, 50291.49708502941, 33300.66699333024, 33345.666543334744, 33365.0, 33495.16262093467, 33539.832300838825, 12838.16551924122, 12918.354082295848, 12961.481540738454, 12968.221906685629, 12980.15628984113, 8798.824023519493, 10550.683479495627, 10641.574337026432, 10719.946400267949, 10819.891801082045, 7779.4943328684585, 7838.784988326818, 7849.882251766228, 7940.404469664798, 7972.405518896244, 3082.4841607045787, 3090.98454507726, 3111.3621707549896, 3153.101366110693, 3174.571432856535, 942.58997336159, 968.5593055159885, 994.8159590475785, 1001.2740762946951, 1020.102309967239, 27235.591466128022, 27242.5913611296, 27816.582751258746, 27983.16050518488, 28068.578971315448, 985.9161971232526, 994.6021591363512, 998.4408731110601, 1068.2308737708838, 1080.9135269178446, 14521.92739036298, 14668.119912805052, 14733.484328048682, 15156.848431515544, 15232.390704371923, 373529.0, 377215.0, 378428.0, 379053.0, 379246.0, 50326.24510632343, 50756.49243507592, 50932.74533627308, 50958.490415096116, 50998.74500627473, 1046.931949423285, 1109.9611513596985, 1168.661088284388, 1182.2079206931376, 1183.7810005149074, 25916.611250830876, 28736.137476271524, 28814.423711526073, 29047.56428653614, 29487.410251795274, 42103.0, 42119.157616848104, 42565.36151957785, 42697.78651106724, 42701.35947960845, 288062.0, 289172.0, 289507.0, 290252.0, 290473.0, 21791.782082178976, 24596.50806983886, 24999.0, 25958.0, 26127.346816329744, 41958.16083678248, 42284.788576056926, 42553.0, 43108.13783724371, 43334.34998474962, 34574.30851383009, 36365.81817090898, 36519.26961460703, 36761.81619091887, 37354.0, 34050.659493404746, 37350.0, 37472.250554989296, 37908.81045594755, 38124.809375952944, 35679.28641427209, 35684.821575892995, 36014.63985360217, 36316.0, 36566.26867462689, 32046.519302210952, 32300.83849580737, 32407.675923240466, 32766.508502372006, 32924.34151317008, 25157.371065723502, 25187.496250075263, 25200.243992680247, 25403.29835082459, 25501.23496295114], "value": 16868.55118793613, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [368.3369934118586, 368.8967089215019, 373.87101449999744, 389.40615561269044, 390.7050177116277, 15561.221938903067, 16646.500604981855, 17084.48746537604, 17672.20475078621, 17700.91149544254, 16509.422170224043, 17172.0, 17631.38290159845, 17726.29094836205, 17737.0, 5018.573421259197, 5222.164453687392, 5244.685318880879, 5259.053370393328, 5264.499872512124, 3718.1634132320146, 3957.9010524736823, 5904.143899134623, 6283.874322513547, 6296.6222026678315, 6124.326324104367, 6234.127222188898, 6246.25044994599, 6254.687265636723, 6257.843553911166, 5916.645001299936, 6061.393860613904, 6084.026555751058, 6094.421030002165, 6168.537359698018, 3391.796492210475, 3607.1162565171703, 3611.5124458198334, 3691.50164727761, 5328.600354973354, 20647.483812904647, 20691.379258622266, 20953.37139885806, 20983.790162098336, 21006.474838129016, 2106.368089573122, 2114.048678094848, 2126.8723876567456, 2296.9893246971446, 2395.6286775549643, 12846.678833029155, 13373.197608143542, 13577.864221357857, 13739.587812365646, 13951.720965580631, 1699.9490015299561, 1715.511079342394, 1754.8069712331633, 1772.6543324051815, 1850.7686539182603, 58612.0, 58863.0, 59309.40690593082, 59387.0, 59727.70136149292, 9687.467189304514, 9875.901240987498, 9882.752931176778, 10095.545700443497, 10111.64609238673, 13598.728025439435, 13668.863311366758, 13693.863061369459, 13737.24445155526, 13748.793768093487, 7226.205117437078, 7381.224971378036, 7406.222346653632, 7487.513311634726, 7490.101187857492, 6982.930170698228, 7081.929180708127, 7148.499605027599, 7186.353228209487, 7206.351428371367, 6247.0, 6387.489000879918, 6431.260405053479, 6441.32366101562, 6478.514111441661, 1600.2158942118278, 1734.956626084358, 1803.1164729282557, 1823.1249000479843, 1838.4484654603566, 811.241489207581, 889.2397000564424, 903.3089686389917, 982.7641366072235, 985.2413641496008, 16736.916315418344, 16755.581110472092, 17357.47927562175, 17369.305227790748, 17413.91293043552, 859.5487369131256, 871.5511511571545, 887.2369762004671, 906.6445663732761, 973.3429934793986, 10272.33229840073, 10347.27569070158, 10454.790904181873, 10459.633912813015, 10474.47627618616, 382496.0, 385947.0, 388634.0, 388720.0, 392239.0, 61344.38655613476, 64345.35654643487, 64603.35396646067, 64989.67505162444, 65597.34402656008, 915.2632131134368, 919.2691810011057, 940.0787228516092, 942.79258563116, 951.5955718819474, 14901.776473352691, 15814.68370632604, 15870.0, 16112.597185070466, 16136.193190340202, 33101.33797324088, 33328.33343333168, 34302.48546271758, 34471.19022020503, 35449.645503544634, 45318.0, 47066.76466617645, 47747.28379074386, 48782.0, 54212.18681719698, 6858.4856135791015, 7191.316824901626, 7239.746608868664, 7339.596322202116, 7518.398528117847, 10994.450277486254, 11868.762624747284, 12141.15011949155, 12217.45021474018, 12400.81398779037, 6285.654289014148, 9844.556994935101, 10045.045720656526, 10158.695239142837, 10512.369257844553, 10057.24570657189, 10082.54628541732, 10251.794964100825, 10421.322614030063, 10436.63471778484, 10284.125849302893, 10463.529141188512, 10712.303700259457, 10750.354978701303, 10881.238313317992, 6998.40513556333, 7086.326798954091, 7315.817104572428, 7324.743633972786, 7485.588292643739, 8900.753894454652, 10329.9483502582, 10543.402949619047, 10629.0, 10634.574617015232], "value": 8325.197435802374, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1172.1091970102718, 1336.3719052045537, 1386.8127802746628, 1432.4413478743293, 1684.9663006739866, 6796.3543463371025, 7527.360174385177, 7905.565193914333, 7931.0, 8111.148329425414, 7802.531848089118, 7981.600919953994, 7997.360211183106, 8002.079760827507, 8015.158408367125, 1905.3902751119647, 1990.3431867483696, 1993.8903360315178, 2210.3700445373033, 2241.57410092082, 2042.5914817036578, 2206.4925067234544, 2273.5111950930545, 2274.9545009099807, 2305.1816605105114, 2217.545403192342, 2232.263353093483, 2237.2505210754416, 2242.3385101395047, 2243.3606422169687, 1907.1513176636402, 2198.1756841184474, 2201.0315461197183, 2204.570108828779, 2209.2598979341938, 2171.207509259125, 2255.9661605075935, 2256.706628138348, 2257.164849005862, 2280.05377768226, 7503.474756767028, 7595.316421522034, 7785.844283114363, 7786.3381612563, 7789.337906277973, 4680.953190468086, 4831.227003679394, 4833.3958255218095, 4834.105690447243, 4835.44392394872, 2815.0850973433717, 2952.778541609388, 2988.4620768261702, 2998.130542142776, 3025.9243518911985, 865.7878819689154, 888.4713595410785, 893.2362829780509, 906.8866391701038, 908.0556221529602, 11047.226694131414, 11294.322340659504, 11297.322160670305, 11306.547738090549, 11323.150763692674, 4252.340887162495, 4292.613664770186, 4406.0, 4412.205802955499, 4425.6238219751685, 9509.619615215452, 9531.666391676257, 9538.23694104484, 9543.61825526985, 9569.186619137452, 4877.268409738567, 4882.316475693406, 4883.731394773251, 4888.340074090023, 4900.0, 3547.5742910850863, 3702.123437189908, 4418.64650827933, 4449.421575195204, 4457.509673935864, 3709.295233905549, 3803.2773772983046, 3841.250956063541, 3853.903652408656, 3868.1103346230525, 1218.8537375514818, 1236.1655882279426, 1244.937753112359, 1256.6104507602672, 1259.225576270587, 691.629977961788, 714.810575197573, 837.8701301298308, 848.1942154952819, 852.9786755331043, 5065.696058236517, 5151.304573882553, 5168.819091331786, 5210.557102646242, 5256.185291279858, 880.8766772651834, 897.2776914583692, 911.6171208092485, 913.4336711239074, 918.2149262380702, 3422.6064002640014, 3527.4356103023392, 3590.9281814363567, 3646.21606354635, 3673.6142705016123, 9680.419174849532, 9918.355306905029, 9955.601775929026, 10021.198304135653, 10048.145907597936, 9925.553350099262, 9931.0, 9939.950300248596, 9952.701418957442, 9964.701058968098, 7142.0, 7401.888971665429, 7424.554526728413, 7469.402447804163, 7484.438667099989, 5010.949890501049, 5046.0, 5157.871053223699, 5307.150855863043, 5380.0, 9010.774730631787, 9149.496777677292, 9173.633054678005, 9289.34974551775, 9350.67272645454, 8287.378446616407, 9147.359684821999, 9286.164245217962, 9453.196478299147, 9473.194778443909, 6049.969750151221, 6318.399752023551, 6351.491880649444, 6462.547621666438, 6517.055027021151, 7594.6202689866395, 7759.728409505866, 7772.961135194288, 7773.766786996399, 7781.37748980069, 7125.216226215216, 7126.251743567058, 7167.892481612885, 7204.207537171012, 7304.96347518259, 6670.699818508276, 6697.2633010367845, 6701.631410272482, 6708.597484150967, 6847.863042739018, 6485.578437401554, 6507.154069970874, 6555.2133743951035, 6561.278259391368, 6567.835804104936, 4624.699394539344, 4696.600788932979, 4730.787114579921, 4761.1429942609275, 4771.332013518041, 4765.642576806684, 4786.521347865186, 4822.276658501253, 4874.22012478016, 4899.632527560376], "value": 4199.043099187337, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [285.717140031369, 287.53132394197456, 293.81489661513245, 305.9617547806524, 307.6108722466081, 4762.523747625236, 4780.665353425257, 4812.374391329126, 4821.710697358157, 4823.673489790301, 4730.881727956803, 4736.123817093831, 4742.312364707115, 4794.640401969848, 4794.9760251198695, 3805.6574908258253, 3829.215010922768, 3830.5211848518798, 3853.2678791029753, 3869.8258578364043, 3613.5844377896483, 3677.926441471169, 3837.443570682249, 3839.404892241707, 3873.5158105236846, 3231.221959573542, 3602.1534939289377, 3683.502727131843, 3700.85196592136, 3751.005983414397, 3644.908877278063, 3723.515942927429, 3748.3253014457387, 3772.830222639988, 3778.338790711628, 3322.3853587086223, 3324.1855745342546, 3324.734021278292, 3329.4839299908554, 3334.5998480182293, 4501.414816073922, 4678.298255261704, 4690.202665546865, 4696.694714843558, 4706.517177288782, 4154.065335299563, 4272.974486123308, 4277.037666525007, 4285.485741710983, 4286.592773686495, 4990.500949905017, 5002.374703162105, 5009.173486374781, 5049.697018178921, 5061.139606266906, 3686.3548878946076, 3691.354013047706, 3693.2244228712, 3696.2977034363653, 3697.9815100924325, 5056.696598204119, 5214.843554693365, 5231.215317702375, 5236.293100431431, 5251.264822924793, 3730.477733117366, 3750.6811920986474, 3761.3793724035777, 3761.7931013794505, 3781.0, 3808.638179372955, 3809.7523660961947, 3810.028442747137, 3827.8468861245797, 3849.634284742945, 4196.706230563831, 4231.830726770895, 4275.850345237902, 4329.982454123341, 4335.934960975588, 5015.297858299841, 5043.747812609355, 5052.065367906949, 5063.1898896176435, 5071.822486212965, 1325.6950901292757, 1343.7849944009108, 1350.1763924006348, 1354.395041875381, 1361.5370773936909, 809.8461292354434, 850.608719988812, 857.1128881607507, 867.9974629303165, 877.5217506458995, 3944.9408258876138, 3945.230680017369, 3958.148997965451, 3965.9490235087724, 3981.462502562117, 4584.289435137559, 4603.010352774169, 4623.398958135421, 4629.837955671535, 4640.97679511607, 4001.3197756381487, 4013.177298653827, 4022.2558826616582, 4025.154717509356, 4036.192761447722, 2496.2636022373445, 2556.6292887531204, 2776.1532732516775, 2786.582012698071, 2790.7906906982057, 4845.394325709286, 4896.5837903777865, 4911.803527858917, 4919.65562410635, 4938.975305123523, 5100.642954993189, 5129.717865517432, 5333.893322133536, 5337.5463085637375, 5352.304200453916, 4903.975480122648, 4906.484819094015, 4908.410990681141, 4920.286558449076, 4943.629227807929, 5168.9483105168465, 5205.245239440335, 5211.973940130275, 5228.503292187236, 5235.764390602508, 4898.730569818694, 5062.316587260672, 5077.796888124433, 5082.669626474268, 5136.922946155736, 4851.75741212945, 4902.85291441243, 4908.312836203006, 4918.95081049185, 4936.2102063669645, 3703.0, 3711.2206436648607, 3716.9628303716618, 3754.6433088856515, 3755.661990420875, 4946.727929963887, 5239.816606418757, 5248.868778280574, 5267.631265811509, 5294.814681486129, 4984.675996060245, 5018.974905125451, 5029.673071250357, 5077.492250774893, 5100.872478188075, 5050.242463630485, 5056.949430505648, 5067.771950262173, 5069.566608028241, 5080.644354895122, 4775.904481910273, 4906.092372911023, 4980.477049909708, 4994.9500504994485, 5024.346834911438, 5094.6688465249645, 5109.386873575195, 5109.726171853489, 5111.846644600668, 5130.999455106367, 5004.274380214775, 5016.4231113420965, 5021.297018417352, 5031.0, 5043.87390315245], "value": 3777.443717984559, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [653.748306901843, 705.6119134476037, 720.0711082703313, 729.3836707981756, 764.6597264217426, 11542.942285288573, 13136.211827290357, 13277.269750163738, 13605.455781768742, 13699.45202191911, 13799.103058301203, 13903.860961390383, 13976.371063302151, 14117.858821411783, 14132.364043618036, 611.0955785437556, 750.0549307872066, 804.1556365815899, 807.2492581898832, 808.0787901791962, 803.0203152154392, 805.2712295372697, 806.2904643913348, 808.5270116981543, 809.9109097999216, 845.1464021338462, 847.1570787066877, 847.3602430165216, 847.5677404523707, 847.7033038436529, 640.4748106552629, 677.9017042528806, 678.2369833936821, 679.9490038247151, 842.0148426341195, 581.5899790647584, 619.662284055191, 622.6295354264206, 622.8162692005869, 623.9844003899893, 13337.466501339935, 13341.466341346335, 13350.599482015457, 13365.198088114745, 13366.331683415887, 12196.268223906594, 12346.876531234662, 12777.425015874307, 12838.422270997735, 12854.228746275254, 11315.58300974248, 11841.0, 11952.581659641957, 12107.0, 12559.686007849785, 4111.773852438115, 4183.5398106208295, 4193.182329445729, 4280.700350975433, 4300.591443812833, 59551.0, 59927.99999999956, 60483.0, 60662.39337606612, 60723.69638151825, 9925.65260215889, 10158.949205254074, 10190.235732320105, 10238.744031399126, 10277.845832312521, 18147.72778408325, 19270.71093933592, 19320.903395482932, 19324.71012934807, 19336.4199074028, 6597.175353080865, 6826.897596536056, 7202.135743710788, 7403.851922961619, 7514.135874374517, 3730.1607138393642, 3772.86794962175, 3875.6899448044087, 3893.9415908761393, 4045.2516284486874, 3077.538369244631, 3234.530993006048, 3235.3367559650214, 3245.3996010737615, 3248.6588908164777, 539.3500831498036, 540.9188621706776, 544.3821262866596, 557.5706705836483, 562.2185162623956, 506.8530126263416, 585.6222736335125, 585.7539833270037, 587.2014060877203, 590.7548367427555, 7156.928430715626, 7454.552726836408, 7456.440766942393, 7571.46999710015, 7658.0, 543.7118327286545, 550.5650536076535, 552.6352607279176, 554.464941331617, 570.0337927213417, 3256.1859535116223, 3704.5184126063978, 3709.7588656737225, 3773.113318370181, 3899.707521935866, 62267.6886615564, 93202.0, 95571.52214238884, 95664.0, 95933.5203323979, 47731.52268477271, 49500.75249623729, 80493.59753201196, 81721.0, 81965.0, 71055.0, 74948.62525687336, 74968.75218734636, 75505.62247188728, 76240.0, 7171.964140179266, 7175.2465991070185, 7355.963220183865, 7476.289752473724, 7482.812929676802, 36371.45442818307, 36792.44811327886, 37340.813295933345, 42134.36798447964, 43065.78467107644, 60443.69778151081, 63330.0, 63989.0, 64888.0, 66949.33050669431, 11109.277896936674, 11328.03711684516, 11507.136964727511, 11529.0, 11589.7102572433, 12035.157538972539, 12173.39133043362, 12435.253884766942, 12831.486740530274, 12954.157979731288, 9225.538723063686, 10138.087572118544, 11216.55133794639, 11263.605773797877, 11591.88408115908, 12070.698232544257, 12310.630681079581, 12422.565210217599, 13245.80131298012, 13247.20516768997, 9077.0, 9189.540522973692, 9280.164785169367, 9308.069193080908, 9803.803923921625, 9848.113669769755, 9897.505124743879, 10152.64465743725, 10157.0, 10219.386836789816, 9865.210783137189, 9974.60101595928, 10099.44453055089, 10293.073623373932, 10360.274780765576], "value": 6500.839635221938, "unit": "score"}], "name": "dromaeo_css", "value": 6398.107589235457, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 108.0, 113.0, 115.0, 112.0, 111.0, 112.0, 111.0, 112.0, 112.0], "value": 111.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 130.0, 131.0, 190.0, 137.0, 140.0, 161.0, 131.0, 192.0, 137.0], "value": 150.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 163.0, 164.0, 161.0, 162.0, 161.0, 162.0, 160.0, 161.0], "value": 161.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 75.0, 101.0, 75.0, 75.0, 76.0, 75.0, 97.0, 75.0], "value": 80.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 113.0, 86.0, 87.0, 87.0, 121.0, 86.0, 86.0, 126.0], "value": 96.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 116.0, 116.0, 116.0, 117.0, 116.0, 117.0, 117.0], "value": 116.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 145.0, 146.0, 146.0, 146.0], "value": 145.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 95.0, 94.0, 95.0, 95.0, 94.0, 95.0, 94.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 65.0, 64.0, 64.0, 64.0, 66.0, 63.0, 63.0, 64.0], "value": 64.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 64.0, 64.0, 65.0, 65.0, 65.0, 66.0, 65.0, 66.0], "value": 65.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 88.0, 87.0, 82.0, 84.0, 85.0, 84.0, 91.0, 125.0, 84.0], "value": 89.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 133.0, 130.0, 129.0, 143.0, 131.0, 132.0, 130.0, 147.0, 135.0], "value": 134.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 179.0, 168.0, 169.0, 174.0, 175.0, 171.0, 172.0, 170.0, 170.0], "value": 171.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 67.0, 67.0, 67.0, 69.0, 66.0, 66.0, 71.0, 65.0, 64.0], "value": 67.1, "unit": "score"}], "name": "kraken", "value": 1549.1, "alertThreshold": 2.0}]} 17:04:07 INFO - Return code: 0 17:04:08 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:04:08 INFO - # TBPL SUCCESS # 17:04:08 INFO - Running post-action listener: _resource_record_post_action 17:04:08 INFO - ##### 17:04:08 INFO - ##### Finished run-tests step (success) 17:04:08 INFO - ##### 17:04:08 INFO - Running post-run listener: _resource_record_post_run 17:04:08 INFO - Total resource usage - Wall time: 1201s; CPU: 13.0%; Read bytes: 12288; Write bytes: 531812352; Read time: 544; Write time: 503888 17:04:08 INFO - TinderboxPrint: CPU usage
13.2% 17:04:08 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 544 17:04:08 INFO - TinderboxPrint: I/O write bytes / time
531,812,352 / 503,888 17:04:08 INFO - TinderboxPrint: CPU idle
8,319.4 (86.8%) 17:04:08 INFO - TinderboxPrint: CPU user
1,217.3 (12.7%) 17:04:08 INFO - TinderboxPrint: Swap in / out
0 / 0 17:04:08 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 4096; Write bytes: 244846592; Read time: 336; Write time: 295324 17:04:08 INFO - run-tests - Wall time: 1185s; CPU: 13.0%; Read bytes: 8192; Write bytes: 286240768; Read time: 208; Write time: 208544 17:04:08 INFO - Running post-run listener: _upload_blobber_files 17:04:08 INFO - Blob upload gear active. 17:04:08 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:04:08 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 17:04:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:04:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:04:09 INFO - (blobuploader) - INFO - Open directory for files ... 17:04:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 17:04:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:04:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:04:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:04:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:04:09 INFO - (blobuploader) - INFO - Done attempting. 17:04:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:04:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:04:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:04:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:04:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:04:10 INFO - (blobuploader) - INFO - Done attempting. 17:04:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:04:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:04:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:04:14 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:04:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:04:14 INFO - (blobuploader) - INFO - Done attempting. 17:04:14 INFO - (blobuploader) - INFO - Iteration through files over. 17:04:14 INFO - Return code: 0 17:04:14 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:04:14 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:04:14 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/22fca3f08c03d2d3e22368e3e07944ebbc7cefc116a64e9c929053d402b4b5a26f6d4e725c851d48ef547fe2f2ae93c50abf129b8abbd1e4a7dca8ad38df377e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e614a07e044d69bf53f2170cf32dda22f6353f20f5be9596f0ba684218a8454ca1c864fbdd41d4ea06694aaebddb3cb0356662437d837ec9015c203a22db2de9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1f80f351742d05f7f7eb13a4f3ba3691be9a353cdee429113e258bae469c5b78372b8ad690dc9179c258d49e07d89c89820d96225aaefd17839ca2d45b54dd6f"} 17:04:14 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:04:14 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:04:14 INFO - Contents: 17:04:14 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/22fca3f08c03d2d3e22368e3e07944ebbc7cefc116a64e9c929053d402b4b5a26f6d4e725c851d48ef547fe2f2ae93c50abf129b8abbd1e4a7dca8ad38df377e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e614a07e044d69bf53f2170cf32dda22f6353f20f5be9596f0ba684218a8454ca1c864fbdd41d4ea06694aaebddb3cb0356662437d837ec9015c203a22db2de9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1f80f351742d05f7f7eb13a4f3ba3691be9a353cdee429113e258bae469c5b78372b8ad690dc9179c258d49e07d89c89820d96225aaefd17839ca2d45b54dd6f"} 17:04:14 INFO - Running post-run listener: copy_logs_to_upload_dir 17:04:14 INFO - Copying logs to upload dir... 17:04:14 INFO - mkdir: /builds/slave/test/build/upload/logs 17:04:14 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1257.836262 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2016-06-13 17:04:13.754184) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-13 17:04:13.757966) ========= 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=6d15e502d8e29d5d2676d664000001c3-1465860552.841221-322978396 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/22fca3f08c03d2d3e22368e3e07944ebbc7cefc116a64e9c929053d402b4b5a26f6d4e725c851d48ef547fe2f2ae93c50abf129b8abbd1e4a7dca8ad38df377e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e614a07e044d69bf53f2170cf32dda22f6353f20f5be9596f0ba684218a8454ca1c864fbdd41d4ea06694aaebddb3cb0356662437d837ec9015c203a22db2de9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1f80f351742d05f7f7eb13a4f3ba3691be9a353cdee429113e258bae469c5b78372b8ad690dc9179c258d49e07d89c89820d96225aaefd17839ca2d45b54dd6f"} build_url:https://queue.taskcluster.net/v1/task/HMZuK8HLQLi7-k-ElrtUEw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011405 build_url: 'https://queue.taskcluster.net/v1/task/HMZuK8HLQLi7-k-ElrtUEw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/22fca3f08c03d2d3e22368e3e07944ebbc7cefc116a64e9c929053d402b4b5a26f6d4e725c851d48ef547fe2f2ae93c50abf129b8abbd1e4a7dca8ad38df377e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e614a07e044d69bf53f2170cf32dda22f6353f20f5be9596f0ba684218a8454ca1c864fbdd41d4ea06694aaebddb3cb0356662437d837ec9015c203a22db2de9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1f80f351742d05f7f7eb13a4f3ba3691be9a353cdee429113e258bae469c5b78372b8ad690dc9179c258d49e07d89c89820d96225aaefd17839ca2d45b54dd6f"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-13 17:04:13.783252) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-13 17:04:13.783595) ========= 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=6d15e502d8e29d5d2676d664000001c3-1465860552.841221-322978396 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004404 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-13 17:04:13.869339) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-13 17:04:13.869733) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-13 17:04:13.870040) ========= ========= Total master_lag: 0.21 =========