builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-030 starttime: 1466532438.14 results: success (0) buildid: 20160621101300 builduid: de20d89cd8a947e7b2cb9f18bbc5490e revision: 448ad5bf7e92885c8c73acb0aee5d3e217712f95 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-21 11:07:18.136277) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-21 11:07:18.137548) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-21 11:07:18.137833) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-21 11:07:18.156023) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 11:07:18.156346) ========= 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=4ac8d263c7293b36a1be1aed000001be-1466531826.591108-350510343 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-21 11:07:18-- 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% 52.0M=0s 2016-06-21 11:07:18 (52.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.122988 ========= master_lag: 0.21 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 11:07:18.490008) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 11:07:18.490297) ========= 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=4ac8d263c7293b36a1be1aed000001be-1466531826.591108-350510343 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020631 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 11:07:18.530057) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-21 11:07:18.530383) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 448ad5bf7e92885c8c73acb0aee5d3e217712f95 --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 448ad5bf7e92885c8c73acb0aee5d3e217712f95 --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=4ac8d263c7293b36a1be1aed000001be-1466531826.591108-350510343 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-21 11:07:18,615 truncating revision to first 12 chars 2016-06-21 11:07:18,615 Setting DEBUG logging. 2016-06-21 11:07:18,615 attempt 1/10 2016-06-21 11:07:18,615 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/448ad5bf7e92?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-21 11:07:20,160 unpacking tar archive at: fx-team-448ad5bf7e92/testing/mozharness/ program finished with exit code 0 elapsedTime=1.916894 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-21 11:07:20.463031) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-21 11:07:20.463385) ========= script_repo_revision: 448ad5bf7e92885c8c73acb0aee5d3e217712f95 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-21 11:07:20.463779) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-21 11:07:20.464045) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-21 11:07:20.473634) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 28 secs) (at 2016-06-21 11:07:20.473914) ========= /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=4ac8d263c7293b36a1be1aed000001be-1466531826.591108-350510343 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:07:20 INFO - MultiFileLogger online at 20160621 11:07:20 in /builds/slave/test 11:07:20 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 11:07:20 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:07:20 INFO - {'append_to_log': False, 11:07:20 INFO - 'base_work_dir': '/builds/slave/test', 11:07:20 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 11:07:20 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:07:20 INFO - 'branch': 'Fx-Team-Non-PGO', 11:07:20 INFO - 'buildbot_json_path': 'buildprops.json', 11:07:20 INFO - 'config_files': ('talos/linux_config.py',), 11:07:20 INFO - 'default_actions': ('clobber', 11:07:20 INFO - 'read-buildbot-config', 11:07:20 INFO - 'download-and-extract', 11:07:20 INFO - 'populate-webroot', 11:07:20 INFO - 'create-virtualenv', 11:07:20 INFO - 'install', 11:07:20 INFO - 'run-tests'), 11:07:20 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:07:20 INFO - 'download_minidump_stackwalk': True, 11:07:20 INFO - 'download_symbols': 'ondemand', 11:07:20 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:07:20 INFO - 'tooltool.py': '/tools/tooltool.py', 11:07:20 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:07:20 INFO - '/tools/misc-python/virtualenv.py')}, 11:07:20 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:07:20 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:07:20 INFO - 'installer_path': 'installer.exe', 11:07:20 INFO - 'log_level': 'info', 11:07:20 INFO - 'log_name': 'talos', 11:07:20 INFO - 'log_to_console': True, 11:07:20 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:07:20 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:07:20 INFO - 'opt_config_files': (), 11:07:20 INFO - 'pip_index': False, 11:07:20 INFO - 'sps_profile': False, 11:07:20 INFO - 'sps_profile_interval': 0, 11:07:20 INFO - 'suite': 'dromaeojs', 11:07:20 INFO - 'system_bits': '32', 11:07:20 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:07:20 INFO - 'title': 'talos-linux64-ix-030', 11:07:20 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:07:20 INFO - 'use_talos_json': True, 11:07:20 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:07:20 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:07:20 INFO - 'work_dir': 'build'} 11:07:20 INFO - ##### 11:07:20 INFO - ##### Running clobber step. 11:07:20 INFO - ##### 11:07:20 INFO - Running pre-action listener: _resource_record_pre_action 11:07:20 INFO - Running main action method: clobber 11:07:20 INFO - rmtree: /builds/slave/test/build 11:07:20 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:07:21 INFO - Running post-action listener: _resource_record_post_action 11:07:21 INFO - ##### 11:07:21 INFO - ##### Finished clobber step (success) 11:07:21 INFO - ##### 11:07:21 INFO - ##### 11:07:21 INFO - ##### Running read-buildbot-config step. 11:07:21 INFO - ##### 11:07:21 INFO - Running pre-action listener: _resource_record_pre_action 11:07:21 INFO - Running main action method: read_buildbot_config 11:07:21 INFO - Using buildbot properties: 11:07:21 INFO - { 11:07:21 INFO - "project": "", 11:07:21 INFO - "product": "firefox", 11:07:21 INFO - "script_repo_revision": "production", 11:07:21 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 11:07:21 INFO - "repository": "", 11:07:21 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 11:07:21 INFO - "buildid": "20160621101300", 11:07:21 INFO - "pgo_build": "False", 11:07:21 INFO - "basedir": "/builds/slave/test", 11:07:21 INFO - "buildnumber": 1768, 11:07:21 INFO - "slavename": "talos-linux64-ix-030", 11:07:21 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 11:07:21 INFO - "platform": "ubuntu64_hw", 11:07:21 INFO - "scheduler": "tests-fx-team-linux64-talos", 11:07:21 INFO - "branch": "fx-team", 11:07:21 INFO - "repo_path": "integration/fx-team", 11:07:21 INFO - "revision": "448ad5bf7e92885c8c73acb0aee5d3e217712f95", 11:07:21 INFO - "stage_platform": "linux64", 11:07:21 INFO - "builduid": "de20d89cd8a947e7b2cb9f18bbc5490e", 11:07:21 INFO - "slavebuilddir": "test" 11:07:21 INFO - } 11:07:21 INFO - Found installer url https://queue.taskcluster.net/v1/task/dNLmmIbSSc-iBbKMvjEwEw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 11:07:21 INFO - Running post-action listener: _resource_record_post_action 11:07:21 INFO - ##### 11:07:21 INFO - ##### Finished read-buildbot-config step (success) 11:07:21 INFO - ##### 11:07:21 INFO - ##### 11:07:21 INFO - ##### Running download-and-extract step. 11:07:21 INFO - ##### 11:07:21 INFO - Running pre-action listener: _resource_record_pre_action 11:07:21 INFO - Running main action method: download_and_extract 11:07:21 INFO - mkdir: /builds/slave/test/build/tests 11:07:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:07:21 INFO - https://queue.taskcluster.net/v1/task/dNLmmIbSSc-iBbKMvjEwEw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 11:07:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dNLmmIbSSc-iBbKMvjEwEw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 11:07:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dNLmmIbSSc-iBbKMvjEwEw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 11:07:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dNLmmIbSSc-iBbKMvjEwEw/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 11:07:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dNLmmIbSSc-iBbKMvjEwEw/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 11:07:23 INFO - Downloaded 1361 bytes. 11:07:23 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 11:07:23 INFO - Using the following test package requirements: 11:07:23 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 11:07:23 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:07:23 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 11:07:23 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:07:23 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 11:07:23 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:07:23 INFO - u'jsshell-linux-x86_64.zip'], 11:07:23 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:07:23 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 11:07:23 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 11:07:23 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:07:23 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 11:07:23 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:07:23 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 11:07:23 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:07:23 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 11:07:23 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 11:07:23 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 11:07:23 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:07:23 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')]} 11:07:23 INFO - https://queue.taskcluster.net/v1/task/dNLmmIbSSc-iBbKMvjEwEw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:07:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dNLmmIbSSc-iBbKMvjEwEw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 11:07:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dNLmmIbSSc-iBbKMvjEwEw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 11:07:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dNLmmIbSSc-iBbKMvjEwEw/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 11:07:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dNLmmIbSSc-iBbKMvjEwEw/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 11:07:24 INFO - Downloaded 22658989 bytes. 11:07:24 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'] 11:07:24 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 11:07:25 INFO - Return code: 0 11:07:25 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 11:07: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')]} 11:07:25 INFO - https://queue.taskcluster.net/v1/task/dNLmmIbSSc-iBbKMvjEwEw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:07:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dNLmmIbSSc-iBbKMvjEwEw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 11:07:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dNLmmIbSSc-iBbKMvjEwEw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 11:07:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dNLmmIbSSc-iBbKMvjEwEw/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 11:07:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dNLmmIbSSc-iBbKMvjEwEw/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 11:07:26 INFO - Downloaded 22658989 bytes. 11:07:26 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'] 11:07:26 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 11:07:28 INFO - Return code: 0 11:07:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:07:28 INFO - https://queue.taskcluster.net/v1/task/dNLmmIbSSc-iBbKMvjEwEw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 11:07:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dNLmmIbSSc-iBbKMvjEwEw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 11:07:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dNLmmIbSSc-iBbKMvjEwEw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 11:07:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dNLmmIbSSc-iBbKMvjEwEw/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 11:07:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dNLmmIbSSc-iBbKMvjEwEw/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 11:07:29 INFO - Downloaded 14405384 bytes. 11:07:29 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'] 11:07:29 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 11:07:29 INFO - Return code: 0 11:07:29 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')]} 11:07:29 INFO - https://queue.taskcluster.net/v1/task/dNLmmIbSSc-iBbKMvjEwEw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 11:07:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dNLmmIbSSc-iBbKMvjEwEw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 11:07:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dNLmmIbSSc-iBbKMvjEwEw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 11:07:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dNLmmIbSSc-iBbKMvjEwEw/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 11:07:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dNLmmIbSSc-iBbKMvjEwEw/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 11:08:15 INFO - Downloaded 56239400 bytes. 11:08:15 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dNLmmIbSSc-iBbKMvjEwEw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 11:08:15 INFO - mkdir: /builds/slave/test/properties 11:08:15 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:08:15 INFO - Writing to file /builds/slave/test/properties/build_url 11:08:15 INFO - Contents: 11:08:15 INFO - build_url:https://queue.taskcluster.net/v1/task/dNLmmIbSSc-iBbKMvjEwEw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 11:08:16 INFO - Running post-action listener: _resource_record_post_action 11:08:16 INFO - Running post-action listener: set_extra_try_arguments 11:08:16 INFO - ##### 11:08:16 INFO - ##### Finished download-and-extract step (success) 11:08:16 INFO - ##### 11:08:16 INFO - ##### 11:08:16 INFO - ##### Running populate-webroot step. 11:08:16 INFO - ##### 11:08:16 INFO - Running pre-action listener: _resource_record_pre_action 11:08:16 INFO - Running main action method: populate_webroot 11:08:16 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:08:16 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:08:16 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:08:16 INFO - '--tppagecycles', 11:08:16 INFO - '7'], 11:08:16 INFO - 'tests': ['tsvgm']}}, 11:08:16 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:08:16 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:08:16 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:08:16 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:08:16 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:08:16 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:08:16 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:08:16 INFO - 'talos_options': ['--disable-e10s'], 11:08:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:08:16 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:08:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:08:16 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:08:16 INFO - 'talos_options': ['--disable-e10s'], 11:08:16 INFO - 'tests': ['damp', 'tps']}, 11:08:16 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:08:16 INFO - 'tests': ['damp', 'tps']}, 11:08:16 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:08:16 INFO - 'tests': ['dromaeo_dom']}, 11:08:16 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:08:16 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:08:16 INFO - 'tests': ['basic_compositor_video']}, 11:08:16 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:08:16 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:08:16 INFO - 'tests': ['a11yr', 11:08:16 INFO - 'ts_paint', 11:08:16 INFO - 'tpaint', 11:08:16 INFO - 'sessionrestore', 11:08:16 INFO - 'sessionrestore_no_auto_restore', 11:08:16 INFO - 'tabpaint']}, 11:08:16 INFO - 'other-e10s': {'tests': ['a11yr', 11:08:16 INFO - 'ts_paint', 11:08:16 INFO - 'tpaint', 11:08:16 INFO - 'sessionrestore', 11:08:16 INFO - 'sessionrestore_no_auto_restore', 11:08:16 INFO - 'tabpaint']}, 11:08:16 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:08:16 INFO - 'ts_paint', 11:08:16 INFO - 'tpaint', 11:08:16 INFO - 'sessionrestore', 11:08:16 INFO - 'sessionrestore_no_auto_restore', 11:08:16 INFO - 'tabpaint']}, 11:08:16 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:08:16 INFO - 'ts_paint', 11:08:16 INFO - 'tpaint', 11:08:16 INFO - 'sessionrestore', 11:08:16 INFO - 'sessionrestore_no_auto_restore', 11:08:16 INFO - 'tabpaint']}, 11:08:16 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:08:16 INFO - 'tests': ['a11yr', 11:08:16 INFO - 'ts_paint', 11:08:16 INFO - 'tpaint', 11:08:16 INFO - 'sessionrestore', 11:08:16 INFO - 'sessionrestore_no_auto_restore', 11:08:16 INFO - 'tabpaint']}, 11:08:16 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:08:16 INFO - 'tests': ['a11yr', 11:08:16 INFO - 'ts_paint', 11:08:16 INFO - 'tpaint', 11:08:16 INFO - 'sessionrestore', 11:08:16 INFO - 'sessionrestore_no_auto_restore', 11:08:16 INFO - 'tabpaint']}, 11:08:16 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:08:16 INFO - 'tests': ['tsvgx', 11:08:16 INFO - 'tsvgr_opacity', 11:08:16 INFO - 'tart', 11:08:16 INFO - 'tscrollx', 11:08:16 INFO - 'cart']}, 11:08:16 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:08:16 INFO - 'tsvgr_opacity', 11:08:16 INFO - 'tart', 11:08:16 INFO - 'tscrollx', 11:08:16 INFO - 'cart']}, 11:08:16 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:08:16 INFO - 'talos_options': ['--disable-e10s'], 11:08:16 INFO - 'tests': ['tp5o']}, 11:08:16 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:08:16 INFO - 'tests': ['tp5o']}, 11:08:16 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:08:16 INFO - 'talos_options': ['--disable-e10s', 11:08:16 INFO - '--xperf_path', 11:08:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:08:16 INFO - 'tests': ['tp5n']}, 11:08:16 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:08:16 INFO - 'talos_options': ['--xperf_path', 11:08:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:08:16 INFO - 'tests': ['tp5n']}}, 11:08:16 INFO - 'talos.zip': {'path': '', 11:08:16 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:08:16 INFO - Running post-action listener: _resource_record_post_action 11:08:16 INFO - ##### 11:08:16 INFO - ##### Finished populate-webroot step (success) 11:08:16 INFO - ##### 11:08:16 INFO - ##### 11:08:16 INFO - ##### Running create-virtualenv step. 11:08:16 INFO - ##### 11:08:16 INFO - Running pre-action listener: _resource_record_pre_action 11:08:16 INFO - Running main action method: create_virtualenv 11:08:16 INFO - Creating virtualenv /builds/slave/test/build/venv 11:08:16 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 11:08:16 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:08:16 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:08:16 INFO - Using real prefix '/usr' 11:08:16 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:08:17 INFO - Installing distribute.............................................................................................................................................................................................done. 11:08:19 INFO - Installing pip.................done. 11:08:19 INFO - Return code: 0 11:08:19 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:08:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:08:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:08:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:08:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:08:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:08:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:08:19 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 0x7fa40c518f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20a0350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x212f1c0>, '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 0x21300c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2130550>, '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': '4ac8d263c7293b36a1be1aed000001be-1466531826.591108-350510343', '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 11:08:19 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 11:08:19 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 11:08:19 INFO - Using env: {'DISPLAY': ':0', 11:08:19 INFO - 'HOME': '/home/cltbld', 11:08:19 INFO - 'LANG': 'en_US.UTF-8', 11:08:19 INFO - 'LANGUAGE': 'en_US:en', 11:08:19 INFO - 'LOGNAME': 'cltbld', 11:08:19 INFO - 'MAIL': '/var/mail/cltbld', 11:08:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:08:19 INFO - 'MOZ_NO_REMOTE': '1', 11:08:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:08:19 INFO - 'NO_EM_RESTART': '1', 11:08:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:08:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:08:19 INFO - 'PWD': '/builds/slave/test', 11:08:19 INFO - 'SHELL': '/bin/bash', 11:08:19 INFO - 'SHLVL': '1', 11:08:19 INFO - 'TERM': 'linux', 11:08:19 INFO - 'TMOUT': '86400', 11:08:19 INFO - 'USER': 'cltbld', 11:08:19 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1466531826.591108-350510343', 11:08:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:08:19 INFO - '_': '/tools/buildbot/bin/python'} 11:08:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:08:19 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 11:08:19 INFO - Cleaning up... 11:08:19 INFO - Return code: 0 11:08:19 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:08:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:08:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:08:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:08:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:08:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:08:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:08:19 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 0x7fa40c518f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20a0350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x212f1c0>, '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 0x21300c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2130550>, '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': '4ac8d263c7293b36a1be1aed000001be-1466531826.591108-350510343', '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 11:08:19 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 11:08:19 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 11:08:19 INFO - Using env: {'DISPLAY': ':0', 11:08:19 INFO - 'HOME': '/home/cltbld', 11:08:19 INFO - 'LANG': 'en_US.UTF-8', 11:08:19 INFO - 'LANGUAGE': 'en_US:en', 11:08:19 INFO - 'LOGNAME': 'cltbld', 11:08:19 INFO - 'MAIL': '/var/mail/cltbld', 11:08:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:08:19 INFO - 'MOZ_NO_REMOTE': '1', 11:08:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:08:19 INFO - 'NO_EM_RESTART': '1', 11:08:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:08:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:08:19 INFO - 'PWD': '/builds/slave/test', 11:08:19 INFO - 'SHELL': '/bin/bash', 11:08:19 INFO - 'SHLVL': '1', 11:08:19 INFO - 'TERM': 'linux', 11:08:19 INFO - 'TMOUT': '86400', 11:08:19 INFO - 'USER': 'cltbld', 11:08:19 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1466531826.591108-350510343', 11:08:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:08:19 INFO - '_': '/tools/buildbot/bin/python'} 11:08:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:08:19 INFO - Downloading/unpacking psutil>=3.1.1 11:08:19 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 11:08:19 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 11:08:19 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 11:08:19 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 11:08:19 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 11:08:19 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 11:08:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:08:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:08:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:08:21 INFO - Installing collected packages: psutil 11:08:21 INFO - Running setup.py install for psutil 11:08:21 INFO - building 'psutil._psutil_linux' extension 11:08:21 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 11:08:21 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 11:08:21 INFO - building 'psutil._psutil_posix' extension 11:08:21 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 11:08:21 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 11:08:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:08:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:08:22 INFO - Successfully installed psutil 11:08:22 INFO - Cleaning up... 11:08:22 INFO - Return code: 0 11:08:22 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:08: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')]} 11:08:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:08:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:08: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')]} 11:08:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:08:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:08:22 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 0x7fa40c518f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20a0350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x212f1c0>, '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 0x21300c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2130550>, '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': '4ac8d263c7293b36a1be1aed000001be-1466531826.591108-350510343', '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 11:08:22 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 11:08:22 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 11:08:22 INFO - Using env: {'DISPLAY': ':0', 11:08:22 INFO - 'HOME': '/home/cltbld', 11:08:22 INFO - 'LANG': 'en_US.UTF-8', 11:08:22 INFO - 'LANGUAGE': 'en_US:en', 11:08:22 INFO - 'LOGNAME': 'cltbld', 11:08:22 INFO - 'MAIL': '/var/mail/cltbld', 11:08:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:08:22 INFO - 'MOZ_NO_REMOTE': '1', 11:08:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:08:22 INFO - 'NO_EM_RESTART': '1', 11:08:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:08:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:08:22 INFO - 'PWD': '/builds/slave/test', 11:08:22 INFO - 'SHELL': '/bin/bash', 11:08:22 INFO - 'SHLVL': '1', 11:08:22 INFO - 'TERM': 'linux', 11:08:22 INFO - 'TMOUT': '86400', 11:08:22 INFO - 'USER': 'cltbld', 11:08:22 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1466531826.591108-350510343', 11:08:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:08:22 INFO - '_': '/tools/buildbot/bin/python'} 11:08:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:08:22 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:08:22 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 11:08:22 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 11:08:22 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 11:08:22 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 11:08:22 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 11:08:22 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 11:08:24 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:08:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:08:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:08:24 INFO - Installing collected packages: mozsystemmonitor 11:08:24 INFO - Running setup.py install for mozsystemmonitor 11:08:24 INFO - Successfully installed mozsystemmonitor 11:08:24 INFO - Cleaning up... 11:08:24 INFO - Return code: 0 11:08:24 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:08:24 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')]} 11:08:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:08:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:08:24 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')]} 11:08:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:08:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:08:24 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 0x7fa40c518f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20a0350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x212f1c0>, '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 0x21300c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2130550>, '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': '4ac8d263c7293b36a1be1aed000001be-1466531826.591108-350510343', '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 11:08:24 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 11:08:24 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 11:08:24 INFO - Using env: {'DISPLAY': ':0', 11:08:24 INFO - 'HOME': '/home/cltbld', 11:08:24 INFO - 'LANG': 'en_US.UTF-8', 11:08:24 INFO - 'LANGUAGE': 'en_US:en', 11:08:24 INFO - 'LOGNAME': 'cltbld', 11:08:24 INFO - 'MAIL': '/var/mail/cltbld', 11:08:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:08:24 INFO - 'MOZ_NO_REMOTE': '1', 11:08:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:08:24 INFO - 'NO_EM_RESTART': '1', 11:08:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:08:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:08:24 INFO - 'PWD': '/builds/slave/test', 11:08:24 INFO - 'SHELL': '/bin/bash', 11:08:24 INFO - 'SHLVL': '1', 11:08:24 INFO - 'TERM': 'linux', 11:08:24 INFO - 'TMOUT': '86400', 11:08:24 INFO - 'USER': 'cltbld', 11:08:24 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1466531826.591108-350510343', 11:08:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:08:24 INFO - '_': '/tools/buildbot/bin/python'} 11:08:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:08:24 INFO - Downloading/unpacking jsonschema==2.5.1 11:08:24 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 11:08:24 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 11:08:24 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 11:08:24 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 11:08:24 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 11:08:24 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 11:08:26 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:08:26 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:08:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:08:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:08:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:08:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:08:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:08:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:08:26 INFO - Downloading functools32-3.2.3-2.tar.gz 11:08:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:08:26 INFO - warning: no files found matching '*.txt' 11:08:26 INFO - no previously-included directories found matching 'build' 11:08:26 INFO - no previously-included directories found matching 'dist' 11:08:26 INFO - no previously-included directories found matching '.git*' 11:08:26 INFO - Installing collected packages: jsonschema, functools32 11:08:26 INFO - Running setup.py install for functools32 11:08:26 INFO - warning: no files found matching '*.txt' 11:08:26 INFO - no previously-included directories found matching 'build' 11:08:26 INFO - no previously-included directories found matching 'dist' 11:08:26 INFO - no previously-included directories found matching '.git*' 11:08:26 INFO - Successfully installed jsonschema functools32 11:08:26 INFO - Cleaning up... 11:08:26 INFO - Return code: 0 11:08:26 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:08:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:08:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:08:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:08:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:08:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:08:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:08:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fa40c518f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20a0350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x212f1c0>, '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 0x21300c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2130550>, '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': '4ac8d263c7293b36a1be1aed000001be-1466531826.591108-350510343', '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 11:08:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:08:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 11:08:26 INFO - Using env: {'DISPLAY': ':0', 11:08:26 INFO - 'HOME': '/home/cltbld', 11:08:26 INFO - 'LANG': 'en_US.UTF-8', 11:08:26 INFO - 'LANGUAGE': 'en_US:en', 11:08:26 INFO - 'LOGNAME': 'cltbld', 11:08:26 INFO - 'MAIL': '/var/mail/cltbld', 11:08:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:08:26 INFO - 'MOZ_NO_REMOTE': '1', 11:08:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:08:26 INFO - 'NO_EM_RESTART': '1', 11:08:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:08:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:08:26 INFO - 'PWD': '/builds/slave/test', 11:08:26 INFO - 'SHELL': '/bin/bash', 11:08:26 INFO - 'SHLVL': '1', 11:08:26 INFO - 'TERM': 'linux', 11:08:26 INFO - 'TMOUT': '86400', 11:08:26 INFO - 'USER': 'cltbld', 11:08:26 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1466531826.591108-350510343', 11:08:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:08:26 INFO - '_': '/tools/buildbot/bin/python'} 11:08:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:08:27 INFO - Downloading/unpacking blobuploader==1.2.4 11:08:27 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 11:08:27 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 11:08:27 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 11:08:27 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 11:08:27 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 11:08:27 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 11:08:28 INFO - Downloading blobuploader-1.2.4.tar.gz 11:08:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:08:29 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:08:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:08:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:08:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:08:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:08:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:08:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:08:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:08:29 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:08:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:08:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:08:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:08:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:08:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:08:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:08:29 INFO - Downloading docopt-0.6.1.tar.gz 11:08:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:08:29 INFO - Installing collected packages: blobuploader, requests, docopt 11:08:29 INFO - Running setup.py install for blobuploader 11:08:29 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:08:29 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:08:29 INFO - Running setup.py install for requests 11:08:30 INFO - Running setup.py install for docopt 11:08:30 INFO - Successfully installed blobuploader requests docopt 11:08:30 INFO - Cleaning up... 11:08:30 INFO - Return code: 0 11:08:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:08:30 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')]} 11:08:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:08:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:08:30 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')]} 11:08:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:08:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:08:30 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 0x7fa40c518f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20a0350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x212f1c0>, '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 0x21300c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2130550>, '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': '4ac8d263c7293b36a1be1aed000001be-1466531826.591108-350510343', '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 11:08:30 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 11:08:30 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 11:08:30 INFO - Using env: {'DISPLAY': ':0', 11:08:30 INFO - 'HOME': '/home/cltbld', 11:08:30 INFO - 'LANG': 'en_US.UTF-8', 11:08:30 INFO - 'LANGUAGE': 'en_US:en', 11:08:30 INFO - 'LOGNAME': 'cltbld', 11:08:30 INFO - 'MAIL': '/var/mail/cltbld', 11:08:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:08:30 INFO - 'MOZ_NO_REMOTE': '1', 11:08:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:08:30 INFO - 'NO_EM_RESTART': '1', 11:08:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:08:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:08:30 INFO - 'PWD': '/builds/slave/test', 11:08:30 INFO - 'SHELL': '/bin/bash', 11:08:30 INFO - 'SHLVL': '1', 11:08:30 INFO - 'TERM': 'linux', 11:08:30 INFO - 'TMOUT': '86400', 11:08:30 INFO - 'USER': 'cltbld', 11:08:30 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1466531826.591108-350510343', 11:08:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:08:30 INFO - '_': '/tools/buildbot/bin/python'} 11:08:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:08:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:08:30 INFO - Running setup.py (path:/tmp/pip-TevzIV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:08:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:08:30 INFO - Running setup.py (path:/tmp/pip-RhhBKj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:08:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:08:30 INFO - Running setup.py (path:/tmp/pip-wyGMTC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:08:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:08:30 INFO - Running setup.py (path:/tmp/pip-HXqR_8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:08:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:08:30 INFO - Running setup.py (path:/tmp/pip-X6CCWQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:08:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:08:30 INFO - Running setup.py (path:/tmp/pip-jXRAva-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:08:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:08:30 INFO - Running setup.py (path:/tmp/pip-gIA5oM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:08:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:08:31 INFO - Running setup.py (path:/tmp/pip-UqL6X1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:08:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:08:31 INFO - Running setup.py (path:/tmp/pip-Uqfu59-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:08:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:08:31 INFO - Running setup.py (path:/tmp/pip-IGrm5d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:08:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:08:31 INFO - Running setup.py (path:/tmp/pip-qDzgY6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:08:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:08:31 INFO - Running setup.py (path:/tmp/pip-eb2ZES-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:08:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:08:31 INFO - Running setup.py (path:/tmp/pip-Czxcwk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:08:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:08:31 INFO - Running setup.py (path:/tmp/pip-gleMZx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:08:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:08:31 INFO - Running setup.py (path:/tmp/pip-leLpzn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:08:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:08:31 INFO - Running setup.py (path:/tmp/pip-q0KPtl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:08:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:08:31 INFO - Running setup.py (path:/tmp/pip-PmGzOQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:08:31 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:08:31 INFO - Running setup.py install for manifestparser 11:08:31 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:08:31 INFO - Running setup.py install for mozcrash 11:08:31 INFO - Running setup.py install for mozdebug 11:08:32 INFO - Running setup.py install for mozdevice 11:08:32 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:08:32 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:08:32 INFO - Running setup.py install for mozfile 11:08:32 INFO - Running setup.py install for mozhttpd 11:08:32 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:08:32 INFO - Running setup.py install for mozinfo 11:08:32 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:08:32 INFO - Running setup.py install for mozInstall 11:08:32 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:08:32 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:08:32 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:08:32 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:08:32 INFO - Running setup.py install for mozleak 11:08:32 INFO - Running setup.py install for mozlog 11:08:32 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:08:32 INFO - Running setup.py install for moznetwork 11:08:32 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:08:32 INFO - Running setup.py install for mozprocess 11:08:32 INFO - Running setup.py install for mozprofile 11:08:33 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:08:33 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:08:33 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:08:33 INFO - Running setup.py install for mozrunner 11:08:33 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:08:33 INFO - Running setup.py install for mozscreenshot 11:08:33 INFO - Running setup.py install for moztest 11:08:33 INFO - Running setup.py install for mozversion 11:08:33 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:08:33 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:08:33 INFO - Cleaning up... 11:08:33 INFO - Return code: 0 11:08:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:08:33 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')]} 11:08:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:08:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:08:33 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')]} 11:08:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:08:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:08:33 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 0x7fa40c518f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20a0350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x212f1c0>, '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 0x21300c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2130550>, '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': '4ac8d263c7293b36a1be1aed000001be-1466531826.591108-350510343', '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 11:08:33 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 11:08:33 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 11:08:33 INFO - Using env: {'DISPLAY': ':0', 11:08:33 INFO - 'HOME': '/home/cltbld', 11:08:33 INFO - 'LANG': 'en_US.UTF-8', 11:08:33 INFO - 'LANGUAGE': 'en_US:en', 11:08:33 INFO - 'LOGNAME': 'cltbld', 11:08:33 INFO - 'MAIL': '/var/mail/cltbld', 11:08:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:08:33 INFO - 'MOZ_NO_REMOTE': '1', 11:08:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:08:33 INFO - 'NO_EM_RESTART': '1', 11:08:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:08:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:08:33 INFO - 'PWD': '/builds/slave/test', 11:08:33 INFO - 'SHELL': '/bin/bash', 11:08:33 INFO - 'SHLVL': '1', 11:08:33 INFO - 'TERM': 'linux', 11:08:33 INFO - 'TMOUT': '86400', 11:08:33 INFO - 'USER': 'cltbld', 11:08:33 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1466531826.591108-350510343', 11:08:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:08:33 INFO - '_': '/tools/buildbot/bin/python'} 11:08:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:08:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:08:33 INFO - Running setup.py (path:/tmp/pip-HEEf92-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:08:33 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)) 11:08:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:08:33 INFO - Running setup.py (path:/tmp/pip-WLfKVD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:08:33 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)) 11:08:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:08:33 INFO - Running setup.py (path:/tmp/pip-o6LF6R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:08:33 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)) 11:08:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:08:33 INFO - Running setup.py (path:/tmp/pip-XT5jBI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:08:34 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)) 11:08:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:08:34 INFO - Running setup.py (path:/tmp/pip-OnMB92-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:08:34 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)) 11:08:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:08:34 INFO - Running setup.py (path:/tmp/pip-DSM1_g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:08:34 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)) 11:08:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:08:34 INFO - Running setup.py (path:/tmp/pip-EZA6tC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:08:34 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)) 11:08:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:08:34 INFO - Running setup.py (path:/tmp/pip-Lg4YYU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:08:34 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)) 11:08:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:08:34 INFO - Running setup.py (path:/tmp/pip-FnMr7N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:08:34 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)) 11:08:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:08:34 INFO - Running setup.py (path:/tmp/pip-jbgkad-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:08:34 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)) 11:08:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:08:34 INFO - Running setup.py (path:/tmp/pip-fTnFqA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:08:34 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)) 11:08:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:08:34 INFO - Running setup.py (path:/tmp/pip-SDD8NQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:08:34 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)) 11:08:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:08:34 INFO - Running setup.py (path:/tmp/pip-H51A3r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:08:34 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)) 11:08:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:08:34 INFO - Running setup.py (path:/tmp/pip-ePr6tW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:08:34 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)) 11:08:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:08:34 INFO - Running setup.py (path:/tmp/pip-Nozof1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:08:34 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)) 11:08:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:08:34 INFO - Running setup.py (path:/tmp/pip-R0v3Ip-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:08:34 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)) 11:08:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:08:34 INFO - Running setup.py (path:/tmp/pip-AbkyRE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:08:34 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)) 11:08:34 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)) 11:08:34 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)) 11:08:34 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)) 11:08:34 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)) 11:08:34 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)) 11:08:34 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:08:34 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 11:08:34 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 11:08:34 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 11:08:34 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 11:08:35 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 11:08:35 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 11:08:36 INFO - Downloading blessings-1.6.tar.gz 11:08:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:08:36 INFO - Installing collected packages: blessings 11:08:36 INFO - Running setup.py install for blessings 11:08:37 INFO - Successfully installed blessings 11:08:37 INFO - Cleaning up... 11:08:37 INFO - Return code: 0 11:08:37 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:08:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:08:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:08:37 INFO - Reading from file tmpfile_stdout 11:08:37 INFO - Current package versions: 11:08:37 INFO - argparse == 1.2.1 11:08:37 INFO - blessings == 1.6 11:08:37 INFO - blobuploader == 1.2.4 11:08:37 INFO - docopt == 0.6.1 11:08:37 INFO - functools32 == 3.2.3-2 11:08:37 INFO - jsonschema == 2.5.1 11:08:37 INFO - manifestparser == 1.1 11:08:37 INFO - mozInstall == 1.12 11:08:37 INFO - mozcrash == 0.17 11:08:37 INFO - mozdebug == 0.1 11:08:37 INFO - mozdevice == 0.48 11:08:37 INFO - mozfile == 1.2 11:08:37 INFO - mozhttpd == 0.7 11:08:37 INFO - mozinfo == 0.9 11:08:37 INFO - mozleak == 0.1 11:08:37 INFO - mozlog == 3.2 11:08:37 INFO - moznetwork == 0.27 11:08:37 INFO - mozprocess == 0.22 11:08:37 INFO - mozprofile == 0.28 11:08:37 INFO - mozrunner == 6.11 11:08:37 INFO - mozscreenshot == 0.1 11:08:37 INFO - mozsystemmonitor == 0.3 11:08:37 INFO - moztest == 0.7 11:08:37 INFO - mozversion == 1.4 11:08:37 INFO - psutil == 3.1.1 11:08:37 INFO - requests == 1.2.3 11:08:37 INFO - wsgiref == 0.1.2 11:08:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:08: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')]} 11:08:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:08:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:08: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')]} 11:08:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:08:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:08:37 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 0x7fa40c518f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20a0350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x212f1c0>, '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 0x21300c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2130550>, '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': '4ac8d263c7293b36a1be1aed000001be-1466531826.591108-350510343', '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 11:08:37 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 11:08:37 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 11:08:37 INFO - Using env: {'DISPLAY': ':0', 11:08:37 INFO - 'HOME': '/home/cltbld', 11:08:37 INFO - 'LANG': 'en_US.UTF-8', 11:08:37 INFO - 'LANGUAGE': 'en_US:en', 11:08:37 INFO - 'LOGNAME': 'cltbld', 11:08:37 INFO - 'MAIL': '/var/mail/cltbld', 11:08:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:08:37 INFO - 'MOZ_NO_REMOTE': '1', 11:08:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:08:37 INFO - 'NO_EM_RESTART': '1', 11:08:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:08:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:08:37 INFO - 'PWD': '/builds/slave/test', 11:08:37 INFO - 'SHELL': '/bin/bash', 11:08:37 INFO - 'SHLVL': '1', 11:08:37 INFO - 'TERM': 'linux', 11:08:37 INFO - 'TMOUT': '86400', 11:08:37 INFO - 'USER': 'cltbld', 11:08:37 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1466531826.591108-350510343', 11:08:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:08:37 INFO - '_': '/tools/buildbot/bin/python'} 11:08:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:08:37 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)) 11:08:37 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)) 11:08:37 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)) 11:08:37 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)) 11:08:37 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)) 11:08:37 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)) 11:08:37 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)) 11:08:37 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)) 11:08:37 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)) 11:08:37 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)) 11:08:37 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)) 11:08:37 INFO - Cleaning up... 11:08:37 INFO - Return code: 0 11:08:37 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:08: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')]} 11:08:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:08:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:08: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')]} 11:08:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:08:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:08:37 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 0x7fa40c518f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20a0350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x212f1c0>, '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 0x21300c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2130550>, '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': '4ac8d263c7293b36a1be1aed000001be-1466531826.591108-350510343', '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 11:08:37 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 11:08:37 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 11:08:37 INFO - Using env: {'DISPLAY': ':0', 11:08:37 INFO - 'HOME': '/home/cltbld', 11:08:37 INFO - 'LANG': 'en_US.UTF-8', 11:08:37 INFO - 'LANGUAGE': 'en_US:en', 11:08:37 INFO - 'LOGNAME': 'cltbld', 11:08:37 INFO - 'MAIL': '/var/mail/cltbld', 11:08:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:08:37 INFO - 'MOZ_NO_REMOTE': '1', 11:08:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:08:37 INFO - 'NO_EM_RESTART': '1', 11:08:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:08:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:08:37 INFO - 'PWD': '/builds/slave/test', 11:08:37 INFO - 'SHELL': '/bin/bash', 11:08:37 INFO - 'SHLVL': '1', 11:08:37 INFO - 'TERM': 'linux', 11:08:37 INFO - 'TMOUT': '86400', 11:08:37 INFO - 'USER': 'cltbld', 11:08:37 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1466531826.591108-350510343', 11:08:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:08:37 INFO - '_': '/tools/buildbot/bin/python'} 11:08:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:08:37 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:08:37 INFO - Cleaning up... 11:08:37 INFO - Return code: 0 11:08:37 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 11:08: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')]} 11:08:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:08:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:08: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')]} 11:08:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:08:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:08:37 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 0x7fa40c518f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20a0350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x212f1c0>, '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 0x21300c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2130550>, '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': '4ac8d263c7293b36a1be1aed000001be-1466531826.591108-350510343', '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 11:08:37 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 11:08:37 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 11:08:37 INFO - Using env: {'DISPLAY': ':0', 11:08:37 INFO - 'HOME': '/home/cltbld', 11:08:37 INFO - 'LANG': 'en_US.UTF-8', 11:08:37 INFO - 'LANGUAGE': 'en_US:en', 11:08:37 INFO - 'LOGNAME': 'cltbld', 11:08:37 INFO - 'MAIL': '/var/mail/cltbld', 11:08:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:08:37 INFO - 'MOZ_NO_REMOTE': '1', 11:08:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:08:37 INFO - 'NO_EM_RESTART': '1', 11:08:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:08:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:08:37 INFO - 'PWD': '/builds/slave/test', 11:08:37 INFO - 'SHELL': '/bin/bash', 11:08:37 INFO - 'SHLVL': '1', 11:08:37 INFO - 'TERM': 'linux', 11:08:37 INFO - 'TMOUT': '86400', 11:08:37 INFO - 'USER': 'cltbld', 11:08:37 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1466531826.591108-350510343', 11:08:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:08:37 INFO - '_': '/tools/buildbot/bin/python'} 11:08:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:08:37 INFO - Downloading/unpacking flake8 11:08:37 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 11:08:37 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 11:08:37 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 11:08:37 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 11:08:37 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 11:08:37 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 11:08:39 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 11:08:39 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 11:08:39 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 11:08:39 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 11:08:39 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 11:08:39 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 11:08:39 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 11:08:39 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 11:08:40 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 11:08:40 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 11:08:40 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 11:08:40 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 11:08:40 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 11:08:40 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 11:08:40 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 11:08:40 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 11:08:40 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 11:08:40 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 11:08:40 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 11:08:40 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 11:08:40 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 11:08:40 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 11:08:40 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 11:08:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 11:08:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:08:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:08:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:08:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:08:40 INFO - no previously-included directories found matching 'docs/_build' 11:08:40 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 11:08:40 INFO - Running setup.py install for pep8 11:08:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:08:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:08:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:08:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:08:40 INFO - no previously-included directories found matching 'docs/_build' 11:08:40 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 11:08:40 INFO - Successfully installed flake8 mccabe pyflakes pep8 11:08:40 INFO - Cleaning up... 11:08:40 INFO - Return code: 0 11:08:40 INFO - Running post-action listener: _resource_record_post_action 11:08:40 INFO - Running post-action listener: _start_resource_monitoring 11:08:40 INFO - Starting resource monitoring. 11:08:40 INFO - ##### 11:08:40 INFO - ##### Finished create-virtualenv step (success) 11:08:40 INFO - ##### 11:08:40 INFO - ##### 11:08:40 INFO - ##### Running install step. 11:08:40 INFO - ##### 11:08:40 INFO - Running pre-action listener: _resource_record_pre_action 11:08:40 INFO - Running main action method: install 11:08:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:08:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:08:41 INFO - Reading from file tmpfile_stdout 11:08:41 INFO - Detecting whether we're running mozinstall >=1.0... 11:08:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:08:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:08:41 INFO - Reading from file tmpfile_stdout 11:08:41 INFO - Output received: 11:08:41 INFO - Usage: mozinstall [options] installer 11:08:41 INFO - Options: 11:08:41 INFO - -h, --help show this help message and exit 11:08:41 INFO - -d DEST, --destination=DEST 11:08:41 INFO - Directory to install application into. [default: 11:08:41 INFO - "/builds/slave/test"] 11:08:41 INFO - --app=APP Application being installed. [default: firefox] 11:08:41 INFO - mkdir: /builds/slave/test/build/application 11:08:41 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'] 11:08:41 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 11:08:57 INFO - Reading from file tmpfile_stdout 11:08:57 INFO - Output received: 11:08:57 INFO - /builds/slave/test/build/application/firefox/firefox 11:08:57 INFO - Running post-action listener: _resource_record_post_action 11:08:57 INFO - ##### 11:08:57 INFO - ##### Finished install step (success) 11:08:57 INFO - ##### 11:08:57 INFO - ##### 11:08:57 INFO - ##### Running run-tests step. 11:08:57 INFO - ##### 11:08:57 INFO - Running pre-action listener: _resource_record_pre_action 11:08:57 INFO - Running main action method: run_tests 11:08:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:08:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:08:57 INFO - Python 2.7.3 11:08:57 INFO - Return code: 0 11:08:57 INFO - grabbing minidump binary from tooltool 11:08:57 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')]} 11:08:57 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 0x212f1c0>, '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 0x21300c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2130550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:08:57 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 11:08:57 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 11:08:57 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 11:08:57 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:08:57 INFO - Return code: 0 11:08:57 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:08:57 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:08:57 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:08:57 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:08:57 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:08:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 11:08:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 11:08:58 INFO - Return code: 0 11:08:58 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/dNLmmIbSSc-iBbKMvjEwEw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-030', '--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 11:08:58 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/dNLmmIbSSc-iBbKMvjEwEw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-030 --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 11:08:58 INFO - Using env: {'DISPLAY': ':0', 11:08:58 INFO - 'HOME': '/home/cltbld', 11:08:58 INFO - 'LANG': 'en_US.UTF-8', 11:08:58 INFO - 'LANGUAGE': 'en_US:en', 11:08:58 INFO - 'LOGNAME': 'cltbld', 11:08:58 INFO - 'MAIL': '/var/mail/cltbld', 11:08:58 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:08:58 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:08:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:08:58 INFO - 'MOZ_NO_REMOTE': '1', 11:08:58 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:08:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:08:58 INFO - 'NO_EM_RESTART': '1', 11:08:58 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:08:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:08:58 INFO - 'PWD': '/builds/slave/test', 11:08:58 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:08:58 INFO - 'SHELL': '/bin/bash', 11:08:58 INFO - 'SHLVL': '1', 11:08:58 INFO - 'TERM': 'linux', 11:08:58 INFO - 'TMOUT': '86400', 11:08:58 INFO - 'USER': 'cltbld', 11:08:58 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1466531826.591108-350510343', 11:08:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:08:58 INFO - '_': '/tools/buildbot/bin/python'} 11:08:58 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/dNLmmIbSSc-iBbKMvjEwEw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-030', '--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 11:08:58 INFO - mozversion application_buildid: 20160621101300 11:08:58 INFO - mozversion application_changeset: 448ad5bf7e92885c8c73acb0aee5d3e217712f95 11:08:58 INFO - mozversion application_display_name: Nightly 11:08:58 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:08:58 INFO - mozversion application_name: Firefox 11:08:58 INFO - mozversion application_remotingname: firefox 11:08:58 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 11:08:58 INFO - mozversion application_vendor: Mozilla 11:08:58 INFO - mozversion application_version: 50.0a1 11:08:58 INFO - mozversion platform_buildid: 20160621101300 11:08:58 INFO - mozversion platform_changeset: 448ad5bf7e92885c8c73acb0aee5d3e217712f95 11:08:58 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 11:08:58 INFO - mozversion platform_version: 50.0a1 11:08:58 INFO - using testdate: 1466532538 11:08:58 INFO - actual date: 1466532538 11:08:58 INFO - starting webserver on 'localhost:40462' 11:08:58 INFO - SUITE-START | Running 2 tests 11:08:58 INFO - TEST-START | dromaeo_css 11:08:58 INFO - operating with platform_type : linux_ 11:08:58 INFO - Initialising browser for dromaeo_css test... 11:08:58 INFO - TEST-INFO | started process 7718 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpK6dD1C/profile http://localhost:40462/getInfo.html) 11:09:02 INFO - PROCESS | 7718 | __metrics Screen width/height:1600/1200 11:09:02 INFO - PROCESS | 7718 | colorDepth:24 11:09:02 INFO - PROCESS | 7718 | Browser inner width/height: 1024/697 11:09:02 INFO - PROCESS | 7718 | __metrics 11:09:03 INFO - PROCESS | 7718 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:09:04 INFO - TEST-INFO | 7718: exit 0 11:09:04 INFO - Browser initialized. 11:09:04 INFO - Running cycle 1/1 for dromaeo_css test... 11:09:04 INFO - TEST-INFO | started process 7799 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpK6dD1C/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:09:17 INFO - PROCESS | 7799 | RSS: Main: 175583232 11:09:17 INFO - PROCESS | 7799 | 11:10:08 INFO - PROCESS | 7799 | 1466532608067 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] 11:12:20 INFO - PROCESS | 7799 | Cycle 1(1): loaded http://localhost:40462/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40462/tests/dromaeo/cssquery-ext.html) 11:12:21 INFO - PROCESS | 7799 | RSS: Main: 252276736 11:12:21 INFO - PROCESS | 7799 | 11:15:24 INFO - PROCESS | 7799 | Cycle 1(1): loaded http://localhost:40462/tests/dromaeo/cssquery-ext.html (next: http://localhost:40462/tests/dromaeo/cssquery-jquery.html) 11:15:25 INFO - PROCESS | 7799 | RSS: Main: 256356352 11:15:25 INFO - PROCESS | 7799 | 11:18:27 INFO - PROCESS | 7799 | Cycle 1(1): loaded http://localhost:40462/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40462/tests/dromaeo/cssquery-mootools.html) 11:18:27 INFO - PROCESS | 7799 | RSS: Main: 255152128 11:18:27 INFO - PROCESS | 7799 | 11:21:30 INFO - PROCESS | 7799 | Cycle 1(1): loaded http://localhost:40462/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40462/tests/dromaeo/cssquery-prototype.html) 11:21:30 INFO - PROCESS | 7799 | RSS: Main: 255324160 11:21:30 INFO - PROCESS | 7799 | 11:24:33 INFO - PROCESS | 7799 | Cycle 1(1): loaded http://localhost:40462/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40462/tests/dromaeo/cssquery-yui.html) 11:24:34 INFO - PROCESS | 7799 | RSS: Main: 241188864 11:24:34 INFO - PROCESS | 7799 | 11:27:36 INFO - PROCESS | 7799 | Cycle 1(1): loaded http://localhost:40462/tests/dromaeo/cssquery-yui.html (next: http://localhost:40462/tests/dromaeo/cssquery-dojo.html) 11:27:37 INFO - PROCESS | 7799 | RSS: Main: 310640640 11:27:37 INFO - PROCESS | 7799 | 11:27:37 INFO - PROCESS | 7799 | __start_tp_report 11:27:37 INFO - PROCESS | 7799 | _x_x_mozilla_page_load 11:27:37 INFO - PROCESS | 7799 | _x_x_mozilla_page_load_details 11:27:37 INFO - PROCESS | 7799 | |i|pagename|runs| 11:27:37 INFO - PROCESS | 7799 | |0;dojo.html;2619.607058941159;2629.3426643339167;2653.5223659741246;2657.800664950128;2660.2817239345377;4577.153226653071;4617.122746678128;4638.373819534362;4701.965567575132;4709.317149013391;4678.695884767496;4710.85867423977;4722.598579120779;4738.123447162277;4744.07490539345;4316.503602085753;4335.43639326887;4409.096135292258;4433.578810013044;4537;4431.113777244548;4459.509453960078;4486.304622783474;4486.842960496383;4515.819367225324;4219.11398606293;4275.957240427618;4314.525402205786;4360.520342762294;4409.294512877957;4351.4995775485595;4370.956290437119;4371.4098596689355;4398.252297109467;4405.163019026407;4394.582514661102;4416.055123520095;4417;4442.289233722621;4460;4554.567316104964;4628.560286772785;4663.393758811367;4670.065986802653;4796.448408433005;5019.3976722793495;5026.095302845486;5036.917062831472;5037.949620503785;5049.545540901337;5034.370703662043;5065.341505604248;5070.442251352349;5076.847694569132;5078.187490001619;4673.345731597579;4747.905041899143;4778.880527986758;4796.088743138793;4812.25410061441;5233.267342572043;5256.316678831804;5266.236395722675;5309.867253318621;5316.76074576645;4790.089882922233;5056.595472362203;5093.898122037538;5101.51535604117;5103.157978933435;5035.748212589356;5105.719185444762;5110.66780659256;5126.410462796752;5135.075686376488;5086.364204474441;5093.286939828427;5096;5096.745162741848;5143.485651434827;4842.249451335048;4878.07316609843;5055.620828437882;5072.949270507322;5081.364829396325;4343.305071188594;4367.934480982788;4375.168717943644;4385.846495372647;4401.449818772653;3812.5234345706785;3816.5610954740005;3821.7133714971487;3844.884653460401;3860.729748917549;4105.4662893823615;4281;4379.430674012422;4412.24991751403;4427;5024.84925452237;5029.798808047637;5038.748062596856;5047.570956468668;5091.363579552556;4348.64719798025;4372.23485889968;4375.912481750411;4411.536788637211;4414.962483816301;4445.555444455528;4532;4556.886077848014;4558.566936141061;4562;4734.455537613081;4769.73766442849;4794.520547945178;4802.471728109975;4807.158747219153;5064.772085256099;5095.26118712792;5100.617453691062;5109.514596113363;5156.40701319338;4673.065386922697;4745.406824146981;4766.499517550607;4768.213244814706;4796.8081276748535;5055.34280543527;5067.49325067505;5068.82259120929;5071.974640126776;5120.02719483297;5117.667351622133;5124.308218390619;5130.153524668388;5131.897362052663;5192.9740351298005;4798.7840547174765;4908.165611846066;4949.678270912379;4975.601951843916;4988.625853060962;4961.751912404293;4977.552020318189;4985.626078044089;4986.576141028053;5021.397432308;4915.21356582945;4919.458859525378;4957.876053098557;4960.082384758831;4968;4795.280707893844;4962.181240095489;4965.652404331662;5012.348394708664;5054.873628159326;4938;4948.851534453972;4948.9854579810335;4949.653524253267;5003.324551185543 11:27:37 INFO - PROCESS | 7799 | |1;ext.html;564.3989151553595;583.2650859916505;585.7364186116249;599.1581827532318;604.4892066204056;29018.709812901863;29840.104796856103;29893.701062989363;38393.42409863854;38948.22103557927;36658;37197.442038369445;37313.813430932874;40825.18349633006;40857.59142408575;7724.536527808349;7876.606169691492;7880.487768295071;7893.763187104396;7911.485753426037;7481.177070522238;9891.802163956716;10129.797404051915;10149.898501015006;10520.579176832918;10133.645322413717;10228.33515821473;10230.130438912702;10231.846522302172;10234.948825255864;10197.439140847251;10255.025772551595;10264.076233139054;10264.127549158331;10264.486775661187;10086.89913100867;10159.847602285972;10165.644202452953;10166.186705063577;10168.13570846479;38582;39148.41277380841;39200.41199382012;39205;39233;2915.3440475892967;2964.184849166475;3007.052778374805;3024.561438591414;3106.990228175852;29184.854075729698;30068;30118.096457106323;30421.39157216843;31343.529847052312;3450.6721861423125;3583.301256255031;3600.063983364318;3624.3838547447;3663.6336366363416;243151.99999999822;243857;243937;244143;244188;53438;53711.19433208505;53763.73118134463;53780.546334440114;53823.46176538263;57292.140617890764;57489.712551436976;57493.13760293599;57497.400207983264;57714.71142644344;14793.408263669333;14929;14933.775993360108;14952.177630230442;14967.401303947938;10626.203034772423;11741.88258117425;11922.880771192351;12021.579244726567;12150.33173175466;17439.21523531444;17692.646147076986;17703.38038168658;17716.114194290232;17733.11334433273;6506.60960342381;6626.304238055031;6635.2037755469655;6685.598864068172;6746.190457145174;818.4516374029415;899.6941040046415;904.7918978634951;911.4576826788051;1006.6929586476195;27570.310742231202;28546.286342841595;28807.5678864813;29030.85484572606;29186.708132918822;944.3578366710702;960.9183219426287;974.6929717139078;977.1108291454742;1013.4729940430934;14787.454704485817;15123.924380378028;15168.620784480256;15213.239338033054;15453.613659658598;382007;383008;383534.564216399;384576;387541;48722;49720.75139624351;49971.25043124356;50006;50013.499865000886;1060.9681709548727;1140.4012893230954;1169.3101070368523;1170.2861254634665;1198.2451055835118;27879.721202788525;28827.855860720563;28886.277843053253;29616.407671846013;29774;42174.36738448864;42418.78790606027;42807.571924281605;42826;42872.35691464568;300046;302202;302252;302447;304116;31418.528722069645;31589.8420507896;32410.67589324171;32432.513512297806;32632.83683581567;41973;42577.787111064245;42653.36019959765;43397.132057359304;43607.34588981231;35438.82280588581;35958.8202058988;35985.280294393444;36237;36288;35612;35796.64203358037;36111.916642500764;36426.8178659105;36438.63561364458;35467.467987980715;35500.82249588839;35527.82236088803;36239;36257.461977662366;31627;32276.515852262706;32764.91108823229;32912.67087329096;33315.83342083371;25102.24693259205;25261;25276.873615631805;25434.855431505996;25503.744962550136 11:27:37 INFO - PROCESS | 7799 | |2;jquery.html;371.49291217488127;373.1678357263303;380.9028697682091;385.61245947822437;391.7864763703781;15691.293891774869;16322.102284374354;16722.08028558429;16726.665466690672;16798.244079016444;16326;17103.657926841457;17484.21321040553;17512.036837973905;17525.64948701025;4866.756662166887;5080.720560369178;5109.591232701394;5114.897702045957;5117;3680.926381472369;4957.727324997124;5559.777608895639;5887.999040163182;5908.054711246202;5920.733566989475;5932.110183472492;5947.732352044169;5975.880482390349;5980.43185897339;5622.100463925773;5854.765809367663;5863.736131874055;5864.530837533009;5866;3291.391092647868;3448.5516882805327;3456.2050728332374;3457.775244609092;4792.400949881265;19607.9215643141;19902.303419380398;20554.177832886668;20600.587988240302;21132;1909.3317338931402;1910.2645481489587;1915.8179972902692;1919.8272155506072;1945.6400565895356;13148.86851131486;13448.260345681081;13454.260015699132;13608.251546164956;13872;1704.4034587894262;1734.1242672450458;1736.40094167512;1834.3579747088545;1837.0968303120887;41996.160076798296;53390.733046334906;64534.354656453776;64921.67539162321;65926;8267.793305167419;8658.220760131619;8877.689280875138;8988.775280618036;8995.865062024075;11736.295822250522;11740.236884602473;11807.940960295315;11816.881831181578;11824.822627660593;6956.478264130211;7057.4001209896705;7128.821779455451;7227.349538541452;7252.129744430702;6917.792466226021;6947.305269473113;6981.3367730065565;7106.964465177641;7120.181179164462;3721.739478236552;3724.217914237986;3789.07167743899;3818.1218319786603;3835.9424608630893;1699.7365408361725;1795.703708888045;1800.6938820400562;1801.3695206677558;1805.395192610464;806.3428305930647;869.5956380283199;879.1296616349896;884.4118661090303;918.6187732091241;16943.237554310086;17259.74110388345;17418.91290543539;17442.825571744375;17732.202050907483;864.148813418782;869.5130726792889;883.5449743382163;897.2866571076011;906.3927168796922;9472.95263523678;9918.25613079022;9951.55218015191;10005.699829005142;10042.748931276776;133379;134362;134613.3269333647;134747.32626337002;137111.31444342714;78183.60908195423;80516;80532.59733701294;81586.59206703928;81732.59133704293;890.3144578674385;891.4517571693361;894.0389081737159;909.2271569166156;912.7216199059218;15373.615659608598;15506.9224653876;15601.609959751097;15734.527964161094;16018.919905400398;33916.49125263074;34978.125546861535;37117.81441092777;37351.813240933625;38228.80885595554;49624.50375496199;50376.74811626065;51234;51797;51956.480435196674;6842.349976752201;7202.71189152428;7281.890771638324;7362.22696616869;7788.182240864854;8689.478631282143;11281.21031527818;12153.635390937932;12239.449224785085;12314.75370492603;9762.511874406393;10109.545070471699;10127.64553240633;10343.534540945526;10525.78948421012;10080.798384032132;10592;10732.302400343953;10839.566417343533;10974.835377469184;10343.741406464598;10702.571897124339;10859.131269498579;10875.51060202277;11111.666650000512;6585.209774827052;7839.255270749498;7855;7890.329322007694;8003.6798528058225;7790.4936179150445;9902.504874756089;10229.795404092025;10263.794724105626;10621 11:27:37 INFO - PROCESS | 7799 | |3;mootools.html;1211.660734994202;1380.096037095702;1409.78148387;1489.605254607529;1735.1237624999364;6843.384095431416;7673.347765439938;7930.405219608538;7944.6424910879;8168.673253069885;7913.723019694312;8082.313003394718;8089.433739638228;8089.474184178024;8097.433179677425;1866.6826639471255;1921.4812000759787;1923.2979962313725;2216.63425534787;2248.4716091718433;1969.6946973219174;2197.121151539381;2273.3634582316977;2275.954480910381;2295.816334693229;2215.235743668432;2239.585676649825;2247.3033359658475;2251.5159240763232;2252.707148070757;1839.9908000459911;2079.272254710854;2087.5407410369694;2094.6857971304275;2095.161935225914;2086.0612724273988;2162.394529531718;2163.2428649972385;2173.7065496158134;2179.063002908749;8001.079875814297;8027.397945154078;8028.277455029075;8045.115037345888;8059;4475.843345482925;4598.8620341389815;4600;4602.148602508547;4612.100640375128;2903.2306438793735;2964.2441177499813;3048.786584939055;3063.035143929655;3083.2446050717494;952.4285428742768;957.6504575829772;990.3463713948831;990.9256805739599;997.7006897930592;10931.508082136323;10959;10983.121350292038;10989.230753847234;11050.613228536962;4157.168566286755;4278.101598664315;4357.172137293904;4369.69412141147;4379.211741886491;9304.8604270936;9340.579673914553;9341.486218258062;9351.906480935104;9352.345335826563;4628.352030715702;4690.859274221779;4740.454847692559;4740.834070807574;4742.407199100113;3752.924941501209;3843.2505661396317;4064.4716186896108;4100;4100.384942258625;3641.1079285574674;3681.7606855554304;3765.4351847223134;3800.3729384651774;3804.2962052020466;1173.501261963679;1200.1059210887945;1207.1610230889448;1209.1415095282448;1213.6541085790684;750.986168672288;824.5506199121493;864.0797550608581;875.5578432891476;886.2245535156737;5334.1732031535175;5560.527355174855;5561.110222364402;5607.775688972477;5659.405762394971;861.5218553702755;861.724248240557;874.5845723281391;886.2599729226168;924.7179610218814;3911.9608803911597;3972.1658451724884;4002.1195337025806;4023.1350259693722;4054.5134583850127;9205.263578913671;9892.208623310118;9916.405015699082;9947.701568952943;9963.352382095141;9686.564104615309;9754.9024509754;9849.064338887794;9856.950715246378;9857.408555486694;7324.2309557496765;7392.55644661322;7477.102747670315;7487.401007919353;7495;5571.387147413862;5575.944240557543;5694.800681976111;5736.8282284583365;5759.94240057594;9045.728628141167;9310.068993100907;9333.626654933998;9335.766605834908;9350.438973661601;8853.60158792843;9288.396254243453;9443.575039123118;9449.574769135543;9469.47917864524;6273.090401891792;6491.350864913471;6516.087747715418;6558.540902136805;6659.2008958925235;7582.241775822374;7596.08846938371;7806.258405451473;7883.84232315362;7885.64514596833;6732.528722989344;6881.277465866212;6963.756268530779;7047;7096.7516136934955;6879.105716257055;6890.345417185359;6933.7226510939;6992.30076992317;7000.124984376953;6474.514411419256;6515.869682606227;6516.934830651822;6526.641034743135;6653.600783952978;4968.950310496849;4971.080350135092;4985.351904252569;5000.649045902517;5037.949620503748;4729.716217026989;4815.22956326986;4913.901721965469;4928.581070609039;4999.45006049327 11:27:37 INFO - PROCESS | 7799 | |4;prototype.html;300.67076551176456;309.82804543478363;312.0855892235749;317.95707579476766;318.6383454778825;4682.578567928886;4789.2097803862325;4842.443119041312;4896.216605343146;4949.985253023136;4713.646476514258;4797.1125341811785;4810.927836082462;4830.661853670244;4841.370621819158;3842.2699687059508;3858.3023469673253;3861.9806900965455;3867.613238676138;3901.141748815256;3661.212839239563;3673.320435719387;3828;3878.2825177342143;3893.7469064510856;3767.1147280389087;3785.9053523661855;3806.6574008339244;3809.295280373126;3810.2379524095154;3797.3734333835023;3798.9810050949704;3810.7805502239016;3820.9044773880596;3832.80835958201;3396.6942975132356;3404.7446441516986;3406.5401170841865;3413.4026545354714;3437.2609888873762;4610.2854057621125;4681.063787242531;4690.788914498856;4692.10849938514;4720.268358404453;4291.4850217973735;4315.432317770921;4342.717723347972;4343.82624695015;4352.934705979413;4978.576820970222;4985.825496107655;4986.601071914238;4995.975020124913;4996.90006199874;3595.280943811222;3681.4845921571;3692.8522859085606;3693.8522459101605;3716.8141592920247;5139.12634852076;5182.611304152166;5191.377034755854;5192.71440070796;5195.818146364897;3773.981130094332;3779.848806047727;3779.905502362463;3783.375743002374;3798.4682144499793;3766.9434958475645;3774.8490060397826;3827.2154208387215;3833.750806197588;3840.4490678546013;4264.893377665583;4278.272693642089;4292.59220374064;4300.462442194726;4303.548127446636;4825.879353016133;4932.506749325111;4964.578010869044;5001.199808030698;5002.549770520671;1295.9935200323937;1330.9134906231257;1347.1109068015062;1349.8650134986424;1349.9392527336292;850.5024560631975;850.6172222499899;861.8147098373754;892.9687460938836;893.3567831161554;3877.3602355611574;3970.285348637273;3976.423418604344;3995.860144894915;4031.6169963853386;4521.61566266871;4570.7257564546235;4585.647234065958;4594.46085561334;4601.332806743004;3939.4484772131923;3949.980250098731;3965.5241371035086;3996.320625493615;4000.8599699010397;2296.9081236750344;2422.8007136467563;2460.6063029915126;2463.4210960424284;2468;4310.762908040025;4339.5660433956355;4353.82584696615;4374.147041326911;4397.82307757662;4675.5324467553655;4704.388429504143;4729.361536192639;4743.833965811249;4769.284607308931;4056.249593825152;4312;4344.54382289855;4348.63036641889;4352.521222665504;4554.772261386984;4573.977130114328;4599.356090147449;4603.516630753723;4672.883177920579;4480.215962206666;4547.3633691282585;4570.200214962435;4576.26779715244;4589.5772310583825;4120;4374.278244089817;4387.310885309243;4427.760227136407;4488.39406680094;3486.546748922624;3517.982410087933;3522.260325331709;3532.91167720809;3556.2354093868908;4576.679632425698;4584.449866015966;4666.650001249987;5008.599312055099;5042.268871013755;5049.621278404061;5092.872678182927;5099.617528685438;5107.795688172431;5122.359705036871;5067.391912970467;5098.954714283637;5102.193793413682;5129.410117836496;5156.587473002226;4752.786124624331;4980.551750342486;4980.900381992412;5009.7244651544515;5012.398512178562;5045.84862454127;5067.746612669278;5069.2902993581665;5099.3370861787735;5112.897742045064;4968.602511799119;4976;4997.151054110002;5007.349044624176;5030.8239211627415 11:27:37 INFO - PROCESS | 7799 | |5;yui.html;707.7239876448186;713.7252157919202;722.4112348436024;735.6027745017691;757.5681861339039;12108.515659373625;12895;13933.512327068554;14279.857201427983;14282;12642.810357844617;12671.049671274644;12738.235705857654;12745.936270318658;12754.936225318861;766.0921807657916;788.081884604438;789.3211837819471;791;791.9485233459807;631.3623240527078;760.106874422554;801.3629164813987;804.3766081287021;809.5102463009853;843.4475418600827;846.3990566697652;849.133883438892;850.0988951711206;850.1158794853345;654.8624788794359;841.6801615386175;842.4229402859031;842.700841201377;842.7303262955857;575.1028395702717;596.758312883283;598.1775059293471;599.7840777320162;602.1148911100674;13479.123856949365;13482.19106853592;13484.325783710776;13508.527201547899;13515.526956556572;12481.812772808415;12775.808362874564;13052.934735326262;13216;13383.464661413533;11708.833865734867;11782.941085294604;11823.586174483939;12006.399680015964;12075.516979320817;4098.774567398792;4149.83400663973;4208.242516347056;4222.0289333453175;4271.081717430768;60868.391316086716;60891.39108608902;60913;60967.08549371763;61052;10005.19958403326;10253.58985640566;10280.383177009404;10309.84535231972;10335.586576537005;19078;19121;19139.712904306445;19139.904300478407;19177.232910683695;6537.444317233088;6722.1261236039;6773;6894.827629309207;6971.755988540478;3596.9100772480897;3611.1513794258326;3618.475321078429;3663.175785448253;3688.8524459021874;2791.3579876628487;2863.0695024117244;2880.7119288071026;2884.0194333926565;2886.942261154765;474.5776259129378;481.89639227566244;489.37115806189587;489.50070927653593;496.88323244038344;490.20341944340447;493.91109600272296;495.554001398744;534.2920630165047;561.4834352395724;7846.411519135973;7905.407094467938;8024.117347091816;8125.75622731319;8243.546604936786;463.7495752293791;469.8519966210633;540.3299908113911;567.4297331182136;577.7515668262687;3757.1170774867883;3826.7129965252716;3857.1321452673487;3878.864239751595;3954.9011274717786;95654;95937;96030.23818570908;98023.50988245013;99092.50453747685;68147.31852681508;70976;70999;80653.59673201713;80898;74009.6299518499;74061;74720.62639686876;75071;75136.62431687806;8545.961557613735;8721.389502734748;8979.865302020344;9004.59479323419;9035.096490351176;43037;43735;44189.77905110454;44249;45427.77286113548;58702.412975869694;60186;60904.39095608987;62791.372086278556;63296;10897.509612067317;10935.781284374427;11383.772324553296;11414.543418263509;11443.313401195956;11605.30368177912;12199.634010979686;12710.682232944251;12758.744825103631;13274.668133296746;12336;12936.223826570436;13058.673533161747;13380.330983450984;13538;11386.430678465878;11874.522559818703;11945.07148231778;11958.222715523463;12006.049443720764;12224.268345807988;12528.185667931555;12678.366081696062;12691.682707932376;12697.42861571213;9495.572699228413;9609.615615375307;9865.358751681119;10384.169266458815;10399.844002340122;9948.602055917681;10185.694429167137;10292.794144117226;10624.628138015132;10852 11:27:37 INFO - PROCESS | 7799 | __end_tp_report 11:27:37 INFO - PROCESS | 7799 | __start_cc_report 11:27:37 INFO - PROCESS | 7799 | _x_x_mozilla_cycle_collect,1018 11:27:37 INFO - PROCESS | 7799 | __end_cc_report 11:27:37 INFO - PROCESS | 7799 | __startTimestamp1466533657134__endTimestamp 11:27:37 INFO - PROCESS | 7799 | 11:27:37 INFO - PROCESS | 7799 | ------- Summary: start ------- 11:27:37 INFO - PROCESS | 7799 | Number of tests: 6 11:27:37 INFO - PROCESS | 7799 | 11:27:37 INFO - PROCESS | 7799 | [#0] dojo.html Cycles:165 Average:4701.49 Median:4796.45 stddev:492.73 (10.3%) stddev-sans-first:466.39 11:27:37 INFO - PROCESS | 7799 | Values: 2619.6 2629.3 2653.5 2657.8 2660.3 4577.2 4617.1 4638.4 4702.0 4709.3 4678.7 4710.9 4722.6 4738.1 4744.1 4316.5 4335.4 4409.1 4433.6 4537.0 4431.1 4459.5 4486.3 4486.8 4515.8 4219.1 4276.0 4314.5 4360.5 4409.3 4351.5 4371.0 4371.4 4398.3 4405.2 4394.6 4416.1 4417.0 4442.3 4460.0 4554.6 4628.6 4663.4 4670.1 4796.4 5019.4 5026.1 5036.9 5037.9 5049.5 5034.4 5065.3 5070.4 5076.8 5078.2 4673.3 4747.9 4778.9 4796.1 4812.3 5233.3 5256.3 5266.2 5309.9 5316.8 4790.1 5056.6 5093.9 5101.5 5103.2 5035.7 5105.7 5110.7 5126.4 5135.1 5086.4 5093.3 5096.0 5096.7 5143.5 4842.2 4878.1 5055.6 5072.9 5081.4 4343.3 4367.9 4375.2 4385.8 4401.4 3812.5 3816.6 3821.7 3844.9 3860.7 4105.5 4281.0 4379.4 4412.2 4427.0 5024.8 5029.8 5038.7 5047.6 5091.4 4348.6 4372.2 4375.9 4411.5 4415.0 4445.6 4532.0 4556.9 4558.6 4562.0 4734.5 4769.7 4794.5 4802.5 4807.2 5064.8 5095.3 5100.6 5109.5 5156.4 4673.1 4745.4 4766.5 4768.2 4796.8 5055.3 5067.5 5068.8 5072.0 5120.0 5117.7 5124.3 5130.2 5131.9 5193.0 4798.8 4908.2 4949.7 4975.6 4988.6 4961.8 4977.6 4985.6 4986.6 5021.4 4915.2 4919.5 4957.9 4960.1 4968.0 4795.3 4962.2 4965.7 5012.3 5054.9 4938.0 4948.9 4949.0 4949.7 5003.3 11:27:37 INFO - PROCESS | 7799 | 11:27:37 INFO - PROCESS | 7799 | [#1] ext.html Cycles:180 Average:47152.13 Median:32838.79 stddev:82793.36 (252.1%) stddev-sans-first:82951.73 11:27:37 INFO - PROCESS | 7799 | Values: 564.4 583.3 585.7 599.2 604.5 29018.7 29840.1 29893.7 38393.4 38948.2 36658.0 37197.4 37313.8 40825.2 40857.6 7724.5 7876.6 7880.5 7893.8 7911.5 7481.2 9891.8 10129.8 10149.9 10520.6 10133.6 10228.3 10230.1 10231.8 10234.9 10197.4 10255.0 10264.1 10264.1 10264.5 10086.9 10159.8 10165.6 10166.2 10168.1 38582.0 39148.4 39200.4 39205.0 39233.0 2915.3 2964.2 3007.1 3024.6 3107.0 29184.9 30068.0 30118.1 30421.4 31343.5 3450.7 3583.3 3600.1 3624.4 3663.6 243152.0 243857.0 243937.0 244143.0 244188.0 53438.0 53711.2 53763.7 53780.5 53823.5 57292.1 57489.7 57493.1 57497.4 57714.7 14793.4 14929.0 14933.8 14952.2 14967.4 10626.2 11741.9 11922.9 12021.6 12150.3 17439.2 17692.6 17703.4 17716.1 17733.1 6506.6 6626.3 6635.2 6685.6 6746.2 818.5 899.7 904.8 911.5 1006.7 27570.3 28546.3 28807.6 29030.9 29186.7 944.4 960.9 974.7 977.1 1013.5 14787.5 15123.9 15168.6 15213.2 15453.6 382007.0 383008.0 383534.6 384576.0 387541.0 48722.0 49720.8 49971.3 50006.0 50013.5 1061.0 1140.4 1169.3 1170.3 1198.2 27879.7 28827.9 28886.3 29616.4 29774.0 42174.4 42418.8 42807.6 42826.0 42872.4 300046.0 302202.0 302252.0 302447.0 304116.0 31418.5 31589.8 32410.7 32432.5 32632.8 41973.0 42577.8 42653.4 43397.1 43607.3 35438.8 35958.8 35985.3 36237.0 36288.0 35612.0 35796.6 36111.9 36426.8 36438.6 35467.5 35500.8 35527.8 36239.0 36257.5 31627.0 32276.5 32764.9 32912.7 33315.8 25102.2 25261.0 25276.9 25434.9 25503.7 11:27:37 INFO - PROCESS | 7799 | 11:27:37 INFO - PROCESS | 7799 | [#2] jquery.html Cycles:180 Average:16986.58 Median:20570.44 stddev:26229.31 (127.5%) stddev-sans-first:26273.22 11:27:37 INFO - PROCESS | 7799 | Values: 371.5 373.2 380.9 385.6 391.8 15691.3 16322.1 16722.1 16726.7 16798.2 16326.0 17103.7 17484.2 17512.0 17525.6 4866.8 5080.7 5109.6 5114.9 5117.0 3680.9 4957.7 5559.8 5888.0 5908.1 5920.7 5932.1 5947.7 5975.9 5980.4 5622.1 5854.8 5863.7 5864.5 5866.0 3291.4 3448.6 3456.2 3457.8 4792.4 19607.9 19902.3 20554.2 20600.6 21132.0 1909.3 1910.3 1915.8 1919.8 1945.6 13148.9 13448.3 13454.3 13608.3 13872.0 1704.4 1734.1 1736.4 1834.4 1837.1 41996.2 53390.7 64534.4 64921.7 65926.0 8267.8 8658.2 8877.7 8988.8 8995.9 11736.3 11740.2 11807.9 11816.9 11824.8 6956.5 7057.4 7128.8 7227.3 7252.1 6917.8 6947.3 6981.3 7107.0 7120.2 3721.7 3724.2 3789.1 3818.1 3835.9 1699.7 1795.7 1800.7 1801.4 1805.4 806.3 869.6 879.1 884.4 918.6 16943.2 17259.7 17418.9 17442.8 17732.2 864.1 869.5 883.5 897.3 906.4 9473.0 9918.3 9951.6 10005.7 10042.7 133379.0 134362.0 134613.3 134747.3 137111.3 78183.6 80516.0 80532.6 81586.6 81732.6 890.3 891.5 894.0 909.2 912.7 15373.6 15506.9 15601.6 15734.5 16018.9 33916.5 34978.1 37117.8 37351.8 38228.8 49624.5 50376.7 51234.0 51797.0 51956.5 6842.3 7202.7 7281.9 7362.2 7788.2 8689.5 11281.2 12153.6 12239.4 12314.8 9762.5 10109.5 10127.6 10343.5 10525.8 10080.8 10592.0 10732.3 10839.6 10974.8 10343.7 10702.6 10859.1 10875.5 11111.7 6585.2 7839.3 7855.0 7890.3 8003.7 7790.5 9902.5 10229.8 10263.8 10621.0 11:27:37 INFO - PROCESS | 7799 | 11:27:37 INFO - PROCESS | 7799 | [#3] mootools.html Cycles:180 Average:5272.18 Median:5633.59 stddev:2964.00 (52.6%) stddev-sans-first:2956.61 11:27:37 INFO - PROCESS | 7799 | Values: 1211.7 1380.1 1409.8 1489.6 1735.1 6843.4 7673.3 7930.4 7944.6 8168.7 7913.7 8082.3 8089.4 8089.5 8097.4 1866.7 1921.5 1923.3 2216.6 2248.5 1969.7 2197.1 2273.4 2276.0 2295.8 2215.2 2239.6 2247.3 2251.5 2252.7 1840.0 2079.3 2087.5 2094.7 2095.2 2086.1 2162.4 2163.2 2173.7 2179.1 8001.1 8027.4 8028.3 8045.1 8059.0 4475.8 4598.9 4600.0 4602.1 4612.1 2903.2 2964.2 3048.8 3063.0 3083.2 952.4 957.7 990.3 990.9 997.7 10931.5 10959.0 10983.1 10989.2 11050.6 4157.2 4278.1 4357.2 4369.7 4379.2 9304.9 9340.6 9341.5 9351.9 9352.3 4628.4 4690.9 4740.5 4740.8 4742.4 3752.9 3843.3 4064.5 4100.0 4100.4 3641.1 3681.8 3765.4 3800.4 3804.3 1173.5 1200.1 1207.2 1209.1 1213.7 751.0 824.6 864.1 875.6 886.2 5334.2 5560.5 5561.1 5607.8 5659.4 861.5 861.7 874.6 886.3 924.7 3912.0 3972.2 4002.1 4023.1 4054.5 9205.3 9892.2 9916.4 9947.7 9963.4 9686.6 9754.9 9849.1 9857.0 9857.4 7324.2 7392.6 7477.1 7487.4 7495.0 5571.4 5575.9 5694.8 5736.8 5759.9 9045.7 9310.1 9333.6 9335.8 9350.4 8853.6 9288.4 9443.6 9449.6 9469.5 6273.1 6491.4 6516.1 6558.5 6659.2 7582.2 7596.1 7806.3 7883.8 7885.6 6732.5 6881.3 6963.8 7047.0 7096.8 6879.1 6890.3 6933.7 6992.3 7000.1 6474.5 6515.9 6516.9 6526.6 6653.6 4969.0 4971.1 4985.4 5000.6 5037.9 4729.7 4815.2 4913.9 4928.6 4999.5 11:27:37 INFO - PROCESS | 7799 | 11:27:37 INFO - PROCESS | 7799 | [#4] prototype.html Cycles:180 Average:4051.07 Median:4380.79 stddev:1147.31 (26.2%) stddev-sans-first:1115.46 11:27:37 INFO - PROCESS | 7799 | Values: 300.7 309.8 312.1 318.0 318.6 4682.6 4789.2 4842.4 4896.2 4950.0 4713.6 4797.1 4810.9 4830.7 4841.4 3842.3 3858.3 3862.0 3867.6 3901.1 3661.2 3673.3 3828.0 3878.3 3893.7 3767.1 3785.9 3806.7 3809.3 3810.2 3797.4 3799.0 3810.8 3820.9 3832.8 3396.7 3404.7 3406.5 3413.4 3437.3 4610.3 4681.1 4690.8 4692.1 4720.3 4291.5 4315.4 4342.7 4343.8 4352.9 4978.6 4985.8 4986.6 4996.0 4996.9 3595.3 3681.5 3692.9 3693.9 3716.8 5139.1 5182.6 5191.4 5192.7 5195.8 3774.0 3779.8 3779.9 3783.4 3798.5 3766.9 3774.8 3827.2 3833.8 3840.4 4264.9 4278.3 4292.6 4300.5 4303.5 4825.9 4932.5 4964.6 5001.2 5002.5 1296.0 1330.9 1347.1 1349.9 1349.9 850.5 850.6 861.8 893.0 893.4 3877.4 3970.3 3976.4 3995.9 4031.6 4521.6 4570.7 4585.6 4594.5 4601.3 3939.4 3950.0 3965.5 3996.3 4000.9 2296.9 2422.8 2460.6 2463.4 2468.0 4310.8 4339.6 4353.8 4374.1 4397.8 4675.5 4704.4 4729.4 4743.8 4769.3 4056.2 4312.0 4344.5 4348.6 4352.5 4554.8 4574.0 4599.4 4603.5 4672.9 4480.2 4547.4 4570.2 4576.3 4589.6 4120.0 4374.3 4387.3 4427.8 4488.4 3486.5 3518.0 3522.3 3532.9 3556.2 4576.7 4584.4 4666.7 5008.6 5042.3 5049.6 5092.9 5099.6 5107.8 5122.4 5067.4 5099.0 5102.2 5129.4 5156.6 4752.8 4980.6 4980.9 5009.7 5012.4 5045.8 5067.7 5069.3 5099.3 5112.9 4968.6 4976.0 4997.2 5007.3 5030.8 11:27:37 INFO - PROCESS | 7799 | 11:27:37 INFO - PROCESS | 7799 | [#5] yui.html Cycles:180 Average:17550.47 Median:22945.76 stddev:24421.15 (106.4%) stddev-sans-first:24456.91 11:27:37 INFO - PROCESS | 7799 | Values: 707.7 713.7 722.4 735.6 757.6 12108.5 12895.0 13933.5 14279.9 14282.0 12642.8 12671.0 12738.2 12745.9 12754.9 766.1 788.1 789.3 791.0 791.9 631.4 760.1 801.4 804.4 809.5 843.4 846.4 849.1 850.1 850.1 654.9 841.7 842.4 842.7 842.7 575.1 596.8 598.2 599.8 602.1 13479.1 13482.2 13484.3 13508.5 13515.5 12481.8 12775.8 13052.9 13216.0 13383.5 11708.8 11782.9 11823.6 12006.4 12075.5 4098.8 4149.8 4208.2 4222.0 4271.1 60868.4 60891.4 60913.0 60967.1 61052.0 10005.2 10253.6 10280.4 10309.8 10335.6 19078.0 19121.0 19139.7 19139.9 19177.2 6537.4 6722.1 6773.0 6894.8 6971.8 3596.9 3611.2 3618.5 3663.2 3688.9 2791.4 2863.1 2880.7 2884.0 2886.9 474.6 481.9 489.4 489.5 496.9 490.2 493.9 495.6 534.3 561.5 7846.4 7905.4 8024.1 8125.8 8243.5 463.7 469.9 540.3 567.4 577.8 3757.1 3826.7 3857.1 3878.9 3954.9 95654.0 95937.0 96030.2 98023.5 99092.5 68147.3 70976.0 70999.0 80653.6 80898.0 74009.6 74061.0 74720.6 75071.0 75136.6 8546.0 8721.4 8979.9 9004.6 9035.1 43037.0 43735.0 44189.8 44249.0 45427.8 58702.4 60186.0 60904.4 62791.4 63296.0 10897.5 10935.8 11383.8 11414.5 11443.3 11605.3 12199.6 12710.7 12758.7 13274.7 12336.0 12936.2 13058.7 13380.3 13538.0 11386.4 11874.5 11945.1 11958.2 12006.0 12224.3 12528.2 12678.4 12691.7 12697.4 9495.6 9609.6 9865.4 10384.2 10399.8 9948.6 10185.7 10292.8 10624.6 10852.0 11:27:37 INFO - PROCESS | 7799 | -------- Summary: end -------- 11:27:37 INFO - PROCESS | 7799 | 11:27:37 INFO - TEST-INFO | 7799: exit 0 11:27:37 INFO - TEST-OK | dromaeo_css | took 1119457ms 11:27:37 INFO - TEST-START | kraken 11:27:37 INFO - operating with platform_type : linux_ 11:27:37 INFO - Initialising browser for kraken test... 11:27:37 INFO - TEST-INFO | started process 7980 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpodQFX9/profile http://localhost:40462/getInfo.html) 11:27:42 INFO - PROCESS | 7980 | __metrics Screen width/height:1600/1200 11:27:42 INFO - PROCESS | 7980 | colorDepth:24 11:27:42 INFO - PROCESS | 7980 | Browser inner width/height: 1024/697 11:27:42 INFO - PROCESS | 7980 | __metrics 11:27:42 INFO - PROCESS | 7980 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:27:43 INFO - TEST-INFO | 7980: exit 0 11:27:43 INFO - Browser initialized. 11:27:43 INFO - Running cycle 1/1 for kraken test... 11:27:43 INFO - TEST-INFO | started process 8058 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpodQFX9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:27:55 INFO - PROCESS | 8058 | RSS: Main: 175390720 11:27:55 INFO - PROCESS | 8058 | 11:27:58 INFO - PROCESS | 8058 | Cycle 1(1): loaded http://localhost:40462/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40462/tests/kraken/driver.html?testName=audio-beat-detection) 11:27:59 INFO - PROCESS | 8058 | RSS: Main: 234070016 11:27:59 INFO - PROCESS | 8058 | 11:28:02 INFO - PROCESS | 8058 | Cycle 1(1): loaded http://localhost:40462/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40462/tests/kraken/driver.html?testName=audio-dft) 11:28:02 INFO - PROCESS | 8058 | RSS: Main: 221159424 11:28:02 INFO - PROCESS | 8058 | 11:28:06 INFO - PROCESS | 8058 | Cycle 1(1): loaded http://localhost:40462/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40462/tests/kraken/driver.html?testName=audio-fft) 11:28:06 INFO - PROCESS | 8058 | RSS: Main: 289230848 11:28:06 INFO - PROCESS | 8058 | 11:28:09 INFO - PROCESS | 8058 | Cycle 1(1): loaded http://localhost:40462/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40462/tests/kraken/driver.html?testName=audio-oscillator) 11:28:09 INFO - PROCESS | 8058 | RSS: Main: 199241728 11:28:09 INFO - PROCESS | 8058 | 11:28:11 INFO - PROCESS | 8058 | Cycle 1(1): loaded http://localhost:40462/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40462/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:28:12 INFO - PROCESS | 8058 | RSS: Main: 202608640 11:28:12 INFO - PROCESS | 8058 | 11:28:15 INFO - PROCESS | 8058 | Cycle 1(1): loaded http://localhost:40462/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40462/tests/kraken/driver.html?testName=imaging-darkroom) 11:28:16 INFO - PROCESS | 8058 | RSS: Main: 239353856 11:28:16 INFO - PROCESS | 8058 | 11:28:19 INFO - PROCESS | 8058 | Cycle 1(1): loaded http://localhost:40462/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40462/tests/kraken/driver.html?testName=imaging-desaturate) 11:28:20 INFO - PROCESS | 8058 | RSS: Main: 235110400 11:28:20 INFO - PROCESS | 8058 | 11:28:23 INFO - PROCESS | 8058 | Cycle 1(1): loaded http://localhost:40462/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40462/tests/kraken/driver.html?testName=json-parse-financial) 11:28:23 INFO - PROCESS | 8058 | RSS: Main: 237916160 11:28:23 INFO - PROCESS | 8058 | 11:28:25 INFO - PROCESS | 8058 | Cycle 1(1): loaded http://localhost:40462/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40462/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:28:26 INFO - PROCESS | 8058 | RSS: Main: 227758080 11:28:26 INFO - PROCESS | 8058 | 11:28:28 INFO - PROCESS | 8058 | Cycle 1(1): loaded http://localhost:40462/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40462/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:28:28 INFO - PROCESS | 8058 | RSS: Main: 233922560 11:28:28 INFO - PROCESS | 8058 | 11:28:30 INFO - PROCESS | 8058 | Cycle 1(1): loaded http://localhost:40462/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40462/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:28:31 INFO - PROCESS | 8058 | RSS: Main: 238059520 11:28:31 INFO - PROCESS | 8058 | 11:28:34 INFO - PROCESS | 8058 | Cycle 1(1): loaded http://localhost:40462/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40462/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:28:35 INFO - PROCESS | 8058 | RSS: Main: 241078272 11:28:35 INFO - PROCESS | 8058 | 11:28:37 INFO - PROCESS | 8058 | Cycle 1(1): loaded http://localhost:40462/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40462/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:28:38 INFO - PROCESS | 8058 | RSS: Main: 240521216 11:28:38 INFO - PROCESS | 8058 | 11:28:40 INFO - PROCESS | 8058 | Cycle 1(1): loaded http://localhost:40462/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40462/tests/kraken/driver.html?testName=ai-astar) 11:28:40 INFO - PROCESS | 8058 | RSS: Main: 283766784 11:28:40 INFO - PROCESS | 8058 | 11:28:40 INFO - PROCESS | 8058 | __start_tp_report 11:28:40 INFO - PROCESS | 8058 | _x_x_mozilla_page_load 11:28:40 INFO - PROCESS | 8058 | _x_x_mozilla_page_load_details 11:28:40 INFO - PROCESS | 8058 | |i|pagename|runs| 11:28:40 INFO - PROCESS | 8058 | |0;ai-astar;111;108;111;114;114;112;112;112;112;112 11:28:40 INFO - PROCESS | 8058 | |1;audio-beat-detection;164;128;133;177;132;140;152;136;184;127 11:28:40 INFO - PROCESS | 8058 | |2;audio-dft;162;161;161;162;162;161;160;160;161;160 11:28:40 INFO - PROCESS | 8058 | |3;audio-fft;75;76;75;102;75;76;77;76;100;75 11:28:40 INFO - PROCESS | 8058 | |4;audio-oscillator;87;93;121;86;86;85;119;85;86;135 11:28:40 INFO - PROCESS | 8058 | |5;imaging-gaussian-blur;117;117;118;117;117;116;117;117;116;116 11:28:40 INFO - PROCESS | 8058 | |6;imaging-darkroom;147;147;146;147;146;147;146;145;151;146 11:28:40 INFO - PROCESS | 8058 | |7;imaging-desaturate;95;95;96;95;95;96;95;95;96;95 11:28:40 INFO - PROCESS | 8058 | |8;json-parse-financial;61;62;62;63;63;63;62;63;62;63 11:28:40 INFO - PROCESS | 8058 | |9;json-stringify-tinderbox;64;64;64;64;65;63;63;65;65;64 11:28:40 INFO - PROCESS | 8058 | |10;stanford-crypto-aes;83;83;89;82;83;84;90;90;117;83 11:28:40 INFO - PROCESS | 8058 | |11;stanford-crypto-ccm;142;133;141;131;140;133;130;132;151;134 11:28:40 INFO - PROCESS | 8058 | |12;stanford-crypto-pbkdf2;175;167;168;174;173;172;166;173;165;168 11:28:40 INFO - PROCESS | 8058 | |13;stanford-crypto-sha256-iterative;71;67;67;67;71;65;67;65;66;67 11:28:40 INFO - PROCESS | 8058 | __end_tp_report 11:28:40 INFO - PROCESS | 8058 | __start_cc_report 11:28:40 INFO - PROCESS | 8058 | _x_x_mozilla_cycle_collect,1944 11:28:40 INFO - PROCESS | 8058 | __end_cc_report 11:28:40 INFO - PROCESS | 8058 | __startTimestamp1466533720545__endTimestamp 11:28:40 INFO - PROCESS | 8058 | 11:28:40 INFO - PROCESS | 8058 | ------- Summary: start ------- 11:28:40 INFO - PROCESS | 8058 | Number of tests: 14 11:28:40 INFO - PROCESS | 8058 | 11:28:40 INFO - PROCESS | 8058 | [#0] ai-astar Cycles:10 Average:111.80 Median:112.00 stddev:1.69 (1.5%) stddev-sans-first:1.76 11:28:40 INFO - PROCESS | 8058 | Values: 111.0 108.0 111.0 114.0 114.0 112.0 112.0 112.0 112.0 112.0 11:28:40 INFO - PROCESS | 8058 | 11:28:40 INFO - PROCESS | 8058 | [#1] audio-beat-detection Cycles:10 Average:147.30 Median:146.00 stddev:20.91 (14.3%) stddev-sans-first:21.28 11:28:40 INFO - PROCESS | 8058 | Values: 164.0 128.0 133.0 177.0 132.0 140.0 152.0 136.0 184.0 127.0 11:28:40 INFO - PROCESS | 8058 | 11:28:40 INFO - PROCESS | 8058 | [#2] audio-dft Cycles:10 Average:161.00 Median:161.00 stddev:0.82 (0.5%) stddev-sans-first:0.78 11:28:40 INFO - PROCESS | 8058 | Values: 162.0 161.0 161.0 162.0 162.0 161.0 160.0 160.0 161.0 160.0 11:28:40 INFO - PROCESS | 8058 | 11:28:40 INFO - PROCESS | 8058 | [#3] audio-fft Cycles:10 Average:80.70 Median:75.50 stddev:10.73 (14.2%) stddev-sans-first:11.18 11:28:40 INFO - PROCESS | 8058 | Values: 75.0 76.0 75.0 102.0 75.0 76.0 77.0 76.0 100.0 75.0 11:28:40 INFO - PROCESS | 8058 | 11:28:40 INFO - PROCESS | 8058 | [#4] audio-oscillator Cycles:10 Average:98.30 Median:86.00 stddev:19.01 (22.1%) stddev-sans-first:19.72 11:28:40 INFO - PROCESS | 8058 | Values: 87.0 93.0 121.0 86.0 86.0 85.0 119.0 85.0 86.0 135.0 11:28:40 INFO - PROCESS | 8058 | 11:28:40 INFO - PROCESS | 8058 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.63 (0.5%) stddev-sans-first:0.67 11:28:40 INFO - PROCESS | 8058 | Values: 117.0 117.0 118.0 117.0 117.0 116.0 117.0 117.0 116.0 116.0 11:28:40 INFO - PROCESS | 8058 | 11:28:40 INFO - PROCESS | 8058 | [#6] imaging-darkroom Cycles:10 Average:146.80 Median:147.00 stddev:1.62 (1.1%) stddev-sans-first:1.72 11:28:40 INFO - PROCESS | 8058 | Values: 147.0 147.0 146.0 147.0 146.0 147.0 146.0 145.0 151.0 146.0 11:28:40 INFO - PROCESS | 8058 | 11:28:40 INFO - PROCESS | 8058 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 11:28:40 INFO - PROCESS | 8058 | Values: 95.0 95.0 96.0 95.0 95.0 96.0 95.0 95.0 96.0 95.0 11:28:40 INFO - PROCESS | 8058 | 11:28:40 INFO - PROCESS | 8058 | [#8] json-parse-financial Cycles:10 Average:62.40 Median:63.00 stddev:0.70 (1.1%) stddev-sans-first:0.53 11:28:40 INFO - PROCESS | 8058 | Values: 61.0 62.0 62.0 63.0 63.0 63.0 62.0 63.0 62.0 63.0 11:28:40 INFO - PROCESS | 8058 | 11:28:40 INFO - PROCESS | 8058 | [#9] json-stringify-tinderbox Cycles:10 Average:64.10 Median:64.00 stddev:0.74 (1.2%) stddev-sans-first:0.78 11:28:40 INFO - PROCESS | 8058 | Values: 64.0 64.0 64.0 64.0 65.0 63.0 63.0 65.0 65.0 64.0 11:28:40 INFO - PROCESS | 8058 | 11:28:40 INFO - PROCESS | 8058 | [#10] stanford-crypto-aes Cycles:10 Average:88.40 Median:83.50 stddev:10.54 (12.6%) stddev-sans-first:11.00 11:28:40 INFO - PROCESS | 8058 | Values: 83.0 83.0 89.0 82.0 83.0 84.0 90.0 90.0 117.0 83.0 11:28:40 INFO - PROCESS | 8058 | 11:28:40 INFO - PROCESS | 8058 | [#11] stanford-crypto-ccm Cycles:10 Average:136.70 Median:137.00 stddev:6.63 (4.8%) stddev-sans-first:6.75 11:28:40 INFO - PROCESS | 8058 | Values: 142.0 133.0 141.0 131.0 140.0 133.0 130.0 132.0 151.0 134.0 11:28:40 INFO - PROCESS | 8058 | 11:28:40 INFO - PROCESS | 8058 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.10 Median:172.50 stddev:3.67 (2.1%) stddev-sans-first:3.43 11:28:40 INFO - PROCESS | 8058 | Values: 175.0 167.0 168.0 174.0 173.0 172.0 166.0 173.0 165.0 168.0 11:28:40 INFO - PROCESS | 8058 | 11:28:40 INFO - PROCESS | 8058 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.30 Median:67.00 stddev:2.11 (3.2%) stddev-sans-first:1.76 11:28:40 INFO - PROCESS | 8058 | Values: 71.0 67.0 67.0 67.0 71.0 65.0 67.0 65.0 66.0 67.0 11:28:40 INFO - PROCESS | 8058 | -------- Summary: end -------- 11:28:40 INFO - PROCESS | 8058 | 11:28:41 INFO - TEST-INFO | 8058: exit 0 11:28:41 INFO - TEST-OK | kraken | took 63710ms 11:28:41 INFO - SUITE-END | took 1183s 11:28:41 INFO - Completed test suite (00:19:43) 11:28:41 INFO - javascript benchmark 11:28:41 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2619.607058941159, 2629.3426643339167, 2653.5223659741246, 2657.800664950128, 2660.2817239345377, 4577.153226653071, 4617.122746678128, 4638.373819534362, 4701.965567575132, 4709.317149013391, 4678.695884767496, 4710.85867423977, 4722.598579120779, 4738.123447162277, 4744.07490539345, 4316.503602085753, 4335.43639326887, 4409.096135292258, 4433.578810013044, 4537.0, 4431.113777244548, 4459.509453960078, 4486.304622783474, 4486.842960496383, 4515.819367225324, 4219.11398606293, 4275.957240427618, 4314.525402205786, 4360.520342762294, 4409.294512877957, 4351.4995775485595, 4370.956290437119, 4371.4098596689355, 4398.252297109467, 4405.163019026407, 4394.582514661102, 4416.055123520095, 4417.0, 4442.289233722621, 4460.0, 4554.567316104964, 4628.560286772785, 4663.393758811367, 4670.065986802653, 4796.448408433005, 5019.3976722793495, 5026.095302845486, 5036.917062831472, 5037.949620503785, 5049.545540901337, 5034.370703662043, 5065.341505604248, 5070.442251352349, 5076.847694569132, 5078.187490001619, 4673.345731597579, 4747.905041899143, 4778.880527986758, 4796.088743138793, 4812.25410061441, 5233.267342572043, 5256.316678831804, 5266.236395722675, 5309.867253318621, 5316.76074576645, 4790.089882922233, 5056.595472362203, 5093.898122037538, 5101.51535604117, 5103.157978933435, 5035.748212589356, 5105.719185444762, 5110.66780659256, 5126.410462796752, 5135.075686376488, 5086.364204474441, 5093.286939828427, 5096.0, 5096.745162741848, 5143.485651434827, 4842.249451335048, 4878.07316609843, 5055.620828437882, 5072.949270507322, 5081.364829396325, 4343.305071188594, 4367.934480982788, 4375.168717943644, 4385.846495372647, 4401.449818772653, 3812.5234345706785, 3816.5610954740005, 3821.7133714971487, 3844.884653460401, 3860.729748917549, 4105.4662893823615, 4281.0, 4379.430674012422, 4412.24991751403, 4427.0, 5024.84925452237, 5029.798808047637, 5038.748062596856, 5047.570956468668, 5091.363579552556, 4348.64719798025, 4372.23485889968, 4375.912481750411, 4411.536788637211, 4414.962483816301, 4445.555444455528, 4532.0, 4556.886077848014, 4558.566936141061, 4562.0, 4734.455537613081, 4769.73766442849, 4794.520547945178, 4802.471728109975, 4807.158747219153, 5064.772085256099, 5095.26118712792, 5100.617453691062, 5109.514596113363, 5156.40701319338, 4673.065386922697, 4745.406824146981, 4766.499517550607, 4768.213244814706, 4796.8081276748535, 5055.34280543527, 5067.49325067505, 5068.82259120929, 5071.974640126776, 5120.02719483297, 5117.667351622133, 5124.308218390619, 5130.153524668388, 5131.897362052663, 5192.9740351298005, 4798.7840547174765, 4908.165611846066, 4949.678270912379, 4975.601951843916, 4988.625853060962, 4961.751912404293, 4977.552020318189, 4985.626078044089, 4986.576141028053, 5021.397432308, 4915.21356582945, 4919.458859525378, 4957.876053098557, 4960.082384758831, 4968.0, 4795.280707893844, 4962.181240095489, 4965.652404331662, 5012.348394708664, 5054.873628159326, 4938.0, 4948.851534453972, 4948.9854579810335, 4949.653524253267, 5003.324551185543], "value": 4670.070773873463, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [564.3989151553595, 583.2650859916505, 585.7364186116249, 599.1581827532318, 604.4892066204056, 29018.709812901863, 29840.104796856103, 29893.701062989363, 38393.42409863854, 38948.22103557927, 36658.0, 37197.442038369445, 37313.813430932874, 40825.18349633006, 40857.59142408575, 7724.536527808349, 7876.606169691492, 7880.487768295071, 7893.763187104396, 7911.485753426037, 7481.177070522238, 9891.802163956716, 10129.797404051915, 10149.898501015006, 10520.579176832918, 10133.645322413717, 10228.33515821473, 10230.130438912702, 10231.846522302172, 10234.948825255864, 10197.439140847251, 10255.025772551595, 10264.076233139054, 10264.127549158331, 10264.486775661187, 10086.89913100867, 10159.847602285972, 10165.644202452953, 10166.186705063577, 10168.13570846479, 38582.0, 39148.41277380841, 39200.41199382012, 39205.0, 39233.0, 2915.3440475892967, 2964.184849166475, 3007.052778374805, 3024.561438591414, 3106.990228175852, 29184.854075729698, 30068.0, 30118.096457106323, 30421.39157216843, 31343.529847052312, 3450.6721861423125, 3583.301256255031, 3600.063983364318, 3624.3838547447, 3663.6336366363416, 243151.99999999822, 243857.0, 243937.0, 244143.0, 244188.0, 53438.0, 53711.19433208505, 53763.73118134463, 53780.546334440114, 53823.46176538263, 57292.140617890764, 57489.712551436976, 57493.13760293599, 57497.400207983264, 57714.71142644344, 14793.408263669333, 14929.0, 14933.775993360108, 14952.177630230442, 14967.401303947938, 10626.203034772423, 11741.88258117425, 11922.880771192351, 12021.579244726567, 12150.33173175466, 17439.21523531444, 17692.646147076986, 17703.38038168658, 17716.114194290232, 17733.11334433273, 6506.60960342381, 6626.304238055031, 6635.2037755469655, 6685.598864068172, 6746.190457145174, 818.4516374029415, 899.6941040046415, 904.7918978634951, 911.4576826788051, 1006.6929586476195, 27570.310742231202, 28546.286342841595, 28807.5678864813, 29030.85484572606, 29186.708132918822, 944.3578366710702, 960.9183219426287, 974.6929717139078, 977.1108291454742, 1013.4729940430934, 14787.454704485817, 15123.924380378028, 15168.620784480256, 15213.239338033054, 15453.613659658598, 382007.0, 383008.0, 383534.564216399, 384576.0, 387541.0, 48722.0, 49720.75139624351, 49971.25043124356, 50006.0, 50013.499865000886, 1060.9681709548727, 1140.4012893230954, 1169.3101070368523, 1170.2861254634665, 1198.2451055835118, 27879.721202788525, 28827.855860720563, 28886.277843053253, 29616.407671846013, 29774.0, 42174.36738448864, 42418.78790606027, 42807.571924281605, 42826.0, 42872.35691464568, 300046.0, 302202.0, 302252.0, 302447.0, 304116.0, 31418.528722069645, 31589.8420507896, 32410.67589324171, 32432.513512297806, 32632.83683581567, 41973.0, 42577.787111064245, 42653.36019959765, 43397.132057359304, 43607.34588981231, 35438.82280588581, 35958.8202058988, 35985.280294393444, 36237.0, 36288.0, 35612.0, 35796.64203358037, 36111.916642500764, 36426.8178659105, 36438.63561364458, 35467.467987980715, 35500.82249588839, 35527.82236088803, 36239.0, 36257.461977662366, 31627.0, 32276.515852262706, 32764.91108823229, 32912.67087329096, 33315.83342083371, 25102.24693259205, 25261.0, 25276.873615631805, 25434.855431505996, 25503.744962550136], "value": 18120.862112764225, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [371.49291217488127, 373.1678357263303, 380.9028697682091, 385.61245947822437, 391.7864763703781, 15691.293891774869, 16322.102284374354, 16722.08028558429, 16726.665466690672, 16798.244079016444, 16326.0, 17103.657926841457, 17484.21321040553, 17512.036837973905, 17525.64948701025, 4866.756662166887, 5080.720560369178, 5109.591232701394, 5114.897702045957, 5117.0, 3680.926381472369, 4957.727324997124, 5559.777608895639, 5887.999040163182, 5908.054711246202, 5920.733566989475, 5932.110183472492, 5947.732352044169, 5975.880482390349, 5980.43185897339, 5622.100463925773, 5854.765809367663, 5863.736131874055, 5864.530837533009, 5866.0, 3291.391092647868, 3448.5516882805327, 3456.2050728332374, 3457.775244609092, 4792.400949881265, 19607.9215643141, 19902.303419380398, 20554.177832886668, 20600.587988240302, 21132.0, 1909.3317338931402, 1910.2645481489587, 1915.8179972902692, 1919.8272155506072, 1945.6400565895356, 13148.86851131486, 13448.260345681081, 13454.260015699132, 13608.251546164956, 13872.0, 1704.4034587894262, 1734.1242672450458, 1736.40094167512, 1834.3579747088545, 1837.0968303120887, 41996.160076798296, 53390.733046334906, 64534.354656453776, 64921.67539162321, 65926.0, 8267.793305167419, 8658.220760131619, 8877.689280875138, 8988.775280618036, 8995.865062024075, 11736.295822250522, 11740.236884602473, 11807.940960295315, 11816.881831181578, 11824.822627660593, 6956.478264130211, 7057.4001209896705, 7128.821779455451, 7227.349538541452, 7252.129744430702, 6917.792466226021, 6947.305269473113, 6981.3367730065565, 7106.964465177641, 7120.181179164462, 3721.739478236552, 3724.217914237986, 3789.07167743899, 3818.1218319786603, 3835.9424608630893, 1699.7365408361725, 1795.703708888045, 1800.6938820400562, 1801.3695206677558, 1805.395192610464, 806.3428305930647, 869.5956380283199, 879.1296616349896, 884.4118661090303, 918.6187732091241, 16943.237554310086, 17259.74110388345, 17418.91290543539, 17442.825571744375, 17732.202050907483, 864.148813418782, 869.5130726792889, 883.5449743382163, 897.2866571076011, 906.3927168796922, 9472.95263523678, 9918.25613079022, 9951.55218015191, 10005.699829005142, 10042.748931276776, 133379.0, 134362.0, 134613.3269333647, 134747.32626337002, 137111.31444342714, 78183.60908195423, 80516.0, 80532.59733701294, 81586.59206703928, 81732.59133704293, 890.3144578674385, 891.4517571693361, 894.0389081737159, 909.2271569166156, 912.7216199059218, 15373.615659608598, 15506.9224653876, 15601.609959751097, 15734.527964161094, 16018.919905400398, 33916.49125263074, 34978.125546861535, 37117.81441092777, 37351.813240933625, 38228.80885595554, 49624.50375496199, 50376.74811626065, 51234.0, 51797.0, 51956.480435196674, 6842.349976752201, 7202.71189152428, 7281.890771638324, 7362.22696616869, 7788.182240864854, 8689.478631282143, 11281.21031527818, 12153.635390937932, 12239.449224785085, 12314.75370492603, 9762.511874406393, 10109.545070471699, 10127.64553240633, 10343.534540945526, 10525.78948421012, 10080.798384032132, 10592.0, 10732.302400343953, 10839.566417343533, 10974.835377469184, 10343.741406464598, 10702.571897124339, 10859.131269498579, 10875.51060202277, 11111.666650000512, 6585.209774827052, 7839.255270749498, 7855.0, 7890.329322007694, 8003.6798528058225, 7790.4936179150445, 9902.504874756089, 10229.795404092025, 10263.794724105626, 10621.0], "value": 7875.346688439129, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1211.660734994202, 1380.096037095702, 1409.78148387, 1489.605254607529, 1735.1237624999364, 6843.384095431416, 7673.347765439938, 7930.405219608538, 7944.6424910879, 8168.673253069885, 7913.723019694312, 8082.313003394718, 8089.433739638228, 8089.474184178024, 8097.433179677425, 1866.6826639471255, 1921.4812000759787, 1923.2979962313725, 2216.63425534787, 2248.4716091718433, 1969.6946973219174, 2197.121151539381, 2273.3634582316977, 2275.954480910381, 2295.816334693229, 2215.235743668432, 2239.585676649825, 2247.3033359658475, 2251.5159240763232, 2252.707148070757, 1839.9908000459911, 2079.272254710854, 2087.5407410369694, 2094.6857971304275, 2095.161935225914, 2086.0612724273988, 2162.394529531718, 2163.2428649972385, 2173.7065496158134, 2179.063002908749, 8001.079875814297, 8027.397945154078, 8028.277455029075, 8045.115037345888, 8059.0, 4475.843345482925, 4598.8620341389815, 4600.0, 4602.148602508547, 4612.100640375128, 2903.2306438793735, 2964.2441177499813, 3048.786584939055, 3063.035143929655, 3083.2446050717494, 952.4285428742768, 957.6504575829772, 990.3463713948831, 990.9256805739599, 997.7006897930592, 10931.508082136323, 10959.0, 10983.121350292038, 10989.230753847234, 11050.613228536962, 4157.168566286755, 4278.101598664315, 4357.172137293904, 4369.69412141147, 4379.211741886491, 9304.8604270936, 9340.579673914553, 9341.486218258062, 9351.906480935104, 9352.345335826563, 4628.352030715702, 4690.859274221779, 4740.454847692559, 4740.834070807574, 4742.407199100113, 3752.924941501209, 3843.2505661396317, 4064.4716186896108, 4100.0, 4100.384942258625, 3641.1079285574674, 3681.7606855554304, 3765.4351847223134, 3800.3729384651774, 3804.2962052020466, 1173.501261963679, 1200.1059210887945, 1207.1610230889448, 1209.1415095282448, 1213.6541085790684, 750.986168672288, 824.5506199121493, 864.0797550608581, 875.5578432891476, 886.2245535156737, 5334.1732031535175, 5560.527355174855, 5561.110222364402, 5607.775688972477, 5659.405762394971, 861.5218553702755, 861.724248240557, 874.5845723281391, 886.2599729226168, 924.7179610218814, 3911.9608803911597, 3972.1658451724884, 4002.1195337025806, 4023.1350259693722, 4054.5134583850127, 9205.263578913671, 9892.208623310118, 9916.405015699082, 9947.701568952943, 9963.352382095141, 9686.564104615309, 9754.9024509754, 9849.064338887794, 9856.950715246378, 9857.408555486694, 7324.2309557496765, 7392.55644661322, 7477.102747670315, 7487.401007919353, 7495.0, 5571.387147413862, 5575.944240557543, 5694.800681976111, 5736.8282284583365, 5759.94240057594, 9045.728628141167, 9310.068993100907, 9333.626654933998, 9335.766605834908, 9350.438973661601, 8853.60158792843, 9288.396254243453, 9443.575039123118, 9449.574769135543, 9469.47917864524, 6273.090401891792, 6491.350864913471, 6516.087747715418, 6558.540902136805, 6659.2008958925235, 7582.241775822374, 7596.08846938371, 7806.258405451473, 7883.84232315362, 7885.64514596833, 6732.528722989344, 6881.277465866212, 6963.756268530779, 7047.0, 7096.7516136934955, 6879.105716257055, 6890.345417185359, 6933.7226510939, 6992.30076992317, 7000.124984376953, 6474.514411419256, 6515.869682606227, 6516.934830651822, 6526.641034743135, 6653.600783952978, 4968.950310496849, 4971.080350135092, 4985.351904252569, 5000.649045902517, 5037.949620503748, 4729.716217026989, 4815.22956326986, 4913.901721965469, 4928.581070609039, 4999.45006049327], "value": 4229.784635134119, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [300.67076551176456, 309.82804543478363, 312.0855892235749, 317.95707579476766, 318.6383454778825, 4682.578567928886, 4789.2097803862325, 4842.443119041312, 4896.216605343146, 4949.985253023136, 4713.646476514258, 4797.1125341811785, 4810.927836082462, 4830.661853670244, 4841.370621819158, 3842.2699687059508, 3858.3023469673253, 3861.9806900965455, 3867.613238676138, 3901.141748815256, 3661.212839239563, 3673.320435719387, 3828.0, 3878.2825177342143, 3893.7469064510856, 3767.1147280389087, 3785.9053523661855, 3806.6574008339244, 3809.295280373126, 3810.2379524095154, 3797.3734333835023, 3798.9810050949704, 3810.7805502239016, 3820.9044773880596, 3832.80835958201, 3396.6942975132356, 3404.7446441516986, 3406.5401170841865, 3413.4026545354714, 3437.2609888873762, 4610.2854057621125, 4681.063787242531, 4690.788914498856, 4692.10849938514, 4720.268358404453, 4291.4850217973735, 4315.432317770921, 4342.717723347972, 4343.82624695015, 4352.934705979413, 4978.576820970222, 4985.825496107655, 4986.601071914238, 4995.975020124913, 4996.90006199874, 3595.280943811222, 3681.4845921571, 3692.8522859085606, 3693.8522459101605, 3716.8141592920247, 5139.12634852076, 5182.611304152166, 5191.377034755854, 5192.71440070796, 5195.818146364897, 3773.981130094332, 3779.848806047727, 3779.905502362463, 3783.375743002374, 3798.4682144499793, 3766.9434958475645, 3774.8490060397826, 3827.2154208387215, 3833.750806197588, 3840.4490678546013, 4264.893377665583, 4278.272693642089, 4292.59220374064, 4300.462442194726, 4303.548127446636, 4825.879353016133, 4932.506749325111, 4964.578010869044, 5001.199808030698, 5002.549770520671, 1295.9935200323937, 1330.9134906231257, 1347.1109068015062, 1349.8650134986424, 1349.9392527336292, 850.5024560631975, 850.6172222499899, 861.8147098373754, 892.9687460938836, 893.3567831161554, 3877.3602355611574, 3970.285348637273, 3976.423418604344, 3995.860144894915, 4031.6169963853386, 4521.61566266871, 4570.7257564546235, 4585.647234065958, 4594.46085561334, 4601.332806743004, 3939.4484772131923, 3949.980250098731, 3965.5241371035086, 3996.320625493615, 4000.8599699010397, 2296.9081236750344, 2422.8007136467563, 2460.6063029915126, 2463.4210960424284, 2468.0, 4310.762908040025, 4339.5660433956355, 4353.82584696615, 4374.147041326911, 4397.82307757662, 4675.5324467553655, 4704.388429504143, 4729.361536192639, 4743.833965811249, 4769.284607308931, 4056.249593825152, 4312.0, 4344.54382289855, 4348.63036641889, 4352.521222665504, 4554.772261386984, 4573.977130114328, 4599.356090147449, 4603.516630753723, 4672.883177920579, 4480.215962206666, 4547.3633691282585, 4570.200214962435, 4576.26779715244, 4589.5772310583825, 4120.0, 4374.278244089817, 4387.310885309243, 4427.760227136407, 4488.39406680094, 3486.546748922624, 3517.982410087933, 3522.260325331709, 3532.91167720809, 3556.2354093868908, 4576.679632425698, 4584.449866015966, 4666.650001249987, 5008.599312055099, 5042.268871013755, 5049.621278404061, 5092.872678182927, 5099.617528685438, 5107.795688172431, 5122.359705036871, 5067.391912970467, 5098.954714283637, 5102.193793413682, 5129.410117836496, 5156.587473002226, 4752.786124624331, 4980.551750342486, 4980.900381992412, 5009.7244651544515, 5012.398512178562, 5045.84862454127, 5067.746612669278, 5069.2902993581665, 5099.3370861787735, 5112.897742045064, 4968.602511799119, 4976.0, 4997.151054110002, 5007.349044624176, 5030.8239211627415], "value": 3696.874514954873, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [707.7239876448186, 713.7252157919202, 722.4112348436024, 735.6027745017691, 757.5681861339039, 12108.515659373625, 12895.0, 13933.512327068554, 14279.857201427983, 14282.0, 12642.810357844617, 12671.049671274644, 12738.235705857654, 12745.936270318658, 12754.936225318861, 766.0921807657916, 788.081884604438, 789.3211837819471, 791.0, 791.9485233459807, 631.3623240527078, 760.106874422554, 801.3629164813987, 804.3766081287021, 809.5102463009853, 843.4475418600827, 846.3990566697652, 849.133883438892, 850.0988951711206, 850.1158794853345, 654.8624788794359, 841.6801615386175, 842.4229402859031, 842.700841201377, 842.7303262955857, 575.1028395702717, 596.758312883283, 598.1775059293471, 599.7840777320162, 602.1148911100674, 13479.123856949365, 13482.19106853592, 13484.325783710776, 13508.527201547899, 13515.526956556572, 12481.812772808415, 12775.808362874564, 13052.934735326262, 13216.0, 13383.464661413533, 11708.833865734867, 11782.941085294604, 11823.586174483939, 12006.399680015964, 12075.516979320817, 4098.774567398792, 4149.83400663973, 4208.242516347056, 4222.0289333453175, 4271.081717430768, 60868.391316086716, 60891.39108608902, 60913.0, 60967.08549371763, 61052.0, 10005.19958403326, 10253.58985640566, 10280.383177009404, 10309.84535231972, 10335.586576537005, 19078.0, 19121.0, 19139.712904306445, 19139.904300478407, 19177.232910683695, 6537.444317233088, 6722.1261236039, 6773.0, 6894.827629309207, 6971.755988540478, 3596.9100772480897, 3611.1513794258326, 3618.475321078429, 3663.175785448253, 3688.8524459021874, 2791.3579876628487, 2863.0695024117244, 2880.7119288071026, 2884.0194333926565, 2886.942261154765, 474.5776259129378, 481.89639227566244, 489.37115806189587, 489.50070927653593, 496.88323244038344, 490.20341944340447, 493.91109600272296, 495.554001398744, 534.2920630165047, 561.4834352395724, 7846.411519135973, 7905.407094467938, 8024.117347091816, 8125.75622731319, 8243.546604936786, 463.7495752293791, 469.8519966210633, 540.3299908113911, 567.4297331182136, 577.7515668262687, 3757.1170774867883, 3826.7129965252716, 3857.1321452673487, 3878.864239751595, 3954.9011274717786, 95654.0, 95937.0, 96030.23818570908, 98023.50988245013, 99092.50453747685, 68147.31852681508, 70976.0, 70999.0, 80653.59673201713, 80898.0, 74009.6299518499, 74061.0, 74720.62639686876, 75071.0, 75136.62431687806, 8545.961557613735, 8721.389502734748, 8979.865302020344, 9004.59479323419, 9035.096490351176, 43037.0, 43735.0, 44189.77905110454, 44249.0, 45427.77286113548, 58702.412975869694, 60186.0, 60904.39095608987, 62791.372086278556, 63296.0, 10897.509612067317, 10935.781284374427, 11383.772324553296, 11414.543418263509, 11443.313401195956, 11605.30368177912, 12199.634010979686, 12710.682232944251, 12758.744825103631, 13274.668133296746, 12336.0, 12936.223826570436, 13058.673533161747, 13380.330983450984, 13538.0, 11386.430678465878, 11874.522559818703, 11945.07148231778, 11958.222715523463, 12006.049443720764, 12224.268345807988, 12528.185667931555, 12678.366081696062, 12691.682707932376, 12697.42861571213, 9495.572699228413, 9609.615615375307, 9865.358751681119, 10384.169266458815, 10399.844002340122, 9948.602055917681, 10185.694429167137, 10292.794144117226, 10624.628138015132, 10852.0], "value": 6606.253403143277, "unit": "score"}], "name": "dromaeo_css", "value": 6402.091246653344, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 108.0, 111.0, 114.0, 114.0, 112.0, 112.0, 112.0, 112.0, 112.0], "value": 111.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 128.0, 133.0, 177.0, 132.0, 140.0, 152.0, 136.0, 184.0, 127.0], "value": 147.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 161.0, 162.0, 162.0, 161.0, 160.0, 160.0, 161.0, 160.0], "value": 161.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 75.0, 102.0, 75.0, 76.0, 77.0, 76.0, 100.0, 75.0], "value": 80.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 93.0, 121.0, 86.0, 86.0, 85.0, 119.0, 85.0, 86.0, 135.0], "value": 98.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 118.0, 117.0, 117.0, 116.0, 117.0, 117.0, 116.0, 116.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 146.0, 147.0, 146.0, 147.0, 146.0, 145.0, 151.0, 146.0], "value": 146.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 95.0, 95.0, 96.0, 95.0, 95.0, 96.0, 95.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 62.0, 63.0, 63.0, 63.0, 62.0, 63.0, 62.0, 63.0], "value": 62.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 64.0, 64.0, 65.0, 63.0, 63.0, 65.0, 65.0, 64.0], "value": 64.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 89.0, 82.0, 83.0, 84.0, 90.0, 90.0, 117.0, 83.0], "value": 88.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 133.0, 141.0, 131.0, 140.0, 133.0, 130.0, 132.0, 151.0, 134.0], "value": 136.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 167.0, 168.0, 174.0, 173.0, 172.0, 166.0, 173.0, 165.0, 168.0], "value": 170.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 67.0, 67.0, 67.0, 71.0, 65.0, 67.0, 65.0, 66.0, 67.0], "value": 67.3, "unit": "score"}], "name": "kraken", "value": 1547.0, "alertThreshold": 2.0}]} 11:28:41 INFO - Return code: 0 11:28:41 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:28:41 INFO - # TBPL SUCCESS # 11:28:41 INFO - Running post-action listener: _resource_record_post_action 11:28:41 INFO - ##### 11:28:41 INFO - ##### Finished run-tests step (success) 11:28:41 INFO - ##### 11:28:41 INFO - Running post-run listener: _resource_record_post_run 11:28:41 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 200704; Write bytes: 327077888; Read time: 124; Write time: 246000 11:28:41 INFO - TinderboxPrint: CPU usage
13.2% 11:28:41 INFO - TinderboxPrint: I/O read bytes / time
200,704 / 124 11:28:41 INFO - TinderboxPrint: I/O write bytes / time
327,077,888 / 246,000 11:28:41 INFO - TinderboxPrint: CPU idle
8,306.1 (86.7%) 11:28:41 INFO - TinderboxPrint: CPU user
1,222.8 (12.8%) 11:28:41 INFO - TinderboxPrint: Swap in / out
0 / 0 11:28:41 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 40960; Write bytes: 43212800; Read time: 92; Write time: 11852 11:28:41 INFO - run-tests - Wall time: 1185s; CPU: 13.0%; Read bytes: 159744; Write bytes: 283865088; Read time: 32; Write time: 234148 11:28:42 INFO - Running post-run listener: _upload_blobber_files 11:28:42 INFO - Blob upload gear active. 11:28:42 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:28:42 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 11:28:42 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'] 11:28:42 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 11:28:42 INFO - (blobuploader) - INFO - Open directory for files ... 11:28:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:28:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:28:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:28:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:28:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:28:43 INFO - (blobuploader) - INFO - Done attempting. 11:28:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:28:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:28:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:28:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:28:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:28:44 INFO - (blobuploader) - INFO - Done attempting. 11:28:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:28:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:28:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:28:49 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:28:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:28:49 INFO - (blobuploader) - INFO - Done attempting. 11:28:49 INFO - (blobuploader) - INFO - Iteration through files over. 11:28:49 INFO - Return code: 0 11:28:49 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:28:49 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:28:49 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/016e58bf8e731da14f147e6b11c63fb36f24b3b12fd520352cfb1da09ca1190bba66a6ce338be5a5a3de2666fe23b84e5c4eac27a815b89df411ed3f1534ba50", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0352b3c35235aa8348e2fa1035d36e88daaf944727e091398dd1f96aa04b1583c365fdf41a8f181fdb5e5385d80135b29c59b370dcc931990c53420b460843ef", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/99381fb911731f566cce8951320af7e443a0c78062bcd4c4b147cbab584c7e6ae69c51e2edbec8b8fd296d3b0d9e862b3fe2cbba120c1e7cd73e05d6287757fd"} 11:28:49 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:28:49 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:28:49 INFO - Contents: 11:28:49 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/016e58bf8e731da14f147e6b11c63fb36f24b3b12fd520352cfb1da09ca1190bba66a6ce338be5a5a3de2666fe23b84e5c4eac27a815b89df411ed3f1534ba50", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0352b3c35235aa8348e2fa1035d36e88daaf944727e091398dd1f96aa04b1583c365fdf41a8f181fdb5e5385d80135b29c59b370dcc931990c53420b460843ef", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/99381fb911731f566cce8951320af7e443a0c78062bcd4c4b147cbab584c7e6ae69c51e2edbec8b8fd296d3b0d9e862b3fe2cbba120c1e7cd73e05d6287757fd"} 11:28:49 INFO - Running post-run listener: copy_logs_to_upload_dir 11:28:49 INFO - Copying logs to upload dir... 11:28:49 INFO - mkdir: /builds/slave/test/build/upload/logs 11:28:49 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1288.689759 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 28 secs) (at 2016-06-21 11:28:49.187018) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-21 11:28:49.190656) ========= 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=4ac8d263c7293b36a1be1aed000001be-1466531826.591108-350510343 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/016e58bf8e731da14f147e6b11c63fb36f24b3b12fd520352cfb1da09ca1190bba66a6ce338be5a5a3de2666fe23b84e5c4eac27a815b89df411ed3f1534ba50", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0352b3c35235aa8348e2fa1035d36e88daaf944727e091398dd1f96aa04b1583c365fdf41a8f181fdb5e5385d80135b29c59b370dcc931990c53420b460843ef", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/99381fb911731f566cce8951320af7e443a0c78062bcd4c4b147cbab584c7e6ae69c51e2edbec8b8fd296d3b0d9e862b3fe2cbba120c1e7cd73e05d6287757fd"} build_url:https://queue.taskcluster.net/v1/task/dNLmmIbSSc-iBbKMvjEwEw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011313 build_url: 'https://queue.taskcluster.net/v1/task/dNLmmIbSSc-iBbKMvjEwEw/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/016e58bf8e731da14f147e6b11c63fb36f24b3b12fd520352cfb1da09ca1190bba66a6ce338be5a5a3de2666fe23b84e5c4eac27a815b89df411ed3f1534ba50", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0352b3c35235aa8348e2fa1035d36e88daaf944727e091398dd1f96aa04b1583c365fdf41a8f181fdb5e5385d80135b29c59b370dcc931990c53420b460843ef", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/99381fb911731f566cce8951320af7e443a0c78062bcd4c4b147cbab584c7e6ae69c51e2edbec8b8fd296d3b0d9e862b3fe2cbba120c1e7cd73e05d6287757fd"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-21 11:28:49.215694) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 11:28:49.216003) ========= 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=4ac8d263c7293b36a1be1aed000001be-1466531826.591108-350510343 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004541 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-21 11:28:49.300013) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-21 11:28:49.300416) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-21 11:28:49.300686) ========= ========= Total master_lag: 0.36 =========