builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-043 starttime: 1466997244.62 results: success (0) buildid: 20160626173008 builduid: 1048c84d6b4745c3b323e55cfdf449ed revision: 110c7ad7d399d16b9c77940f766a26df5d90f881 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-26 20:14:04.624168) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-26 20:14:04.624680) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-26 20:14:04.625007) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-26 20:14:04.676559) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-26 20:14:04.676855) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=d2a8c569965ab8367867b893000001a1-1466995491.990502-64755123 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-26 20:14:05-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 221M=0s 2016-06-26 20:14:05 (221 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.131314 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-26 20:14:04.837101) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-26 20:14:04.837489) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=d2a8c569965ab8367867b893000001a1-1466995491.990502-64755123 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019560 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-26 20:14:04.892200) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-26 20:14:04.892656) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 110c7ad7d399d16b9c77940f766a26df5d90f881 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 110c7ad7d399d16b9c77940f766a26df5d90f881 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=d2a8c569965ab8367867b893000001a1-1466995491.990502-64755123 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-26 20:14:05,737 truncating revision to first 12 chars 2016-06-26 20:14:05,738 Setting DEBUG logging. 2016-06-26 20:14:05,738 attempt 1/10 2016-06-26 20:14:05,738 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/110c7ad7d399?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-26 20:14:06,181 unpacking tar archive at: fx-team-110c7ad7d399/testing/mozharness/ program finished with exit code 0 elapsedTime=0.791914 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-26 20:14:05.699221) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-26 20:14:05.699549) ========= script_repo_revision: 110c7ad7d399d16b9c77940f766a26df5d90f881 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-26 20:14:05.700016) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-26 20:14:05.700357) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-26 20:14:05.710979) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-06-26 20:14:05.711306) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=d2a8c569965ab8367867b893000001a1-1466995491.990502-64755123 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20:14:06 INFO - MultiFileLogger online at 20160626 20:14:06 in /builds/slave/test 20:14:06 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 20:14:06 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:14:06 INFO - {'append_to_log': False, 20:14:06 INFO - 'base_work_dir': '/builds/slave/test', 20:14:06 INFO - 'blob_upload_branch': 'Fx-Team', 20:14:06 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:14:06 INFO - 'branch': 'Fx-Team', 20:14:06 INFO - 'buildbot_json_path': 'buildprops.json', 20:14:06 INFO - 'config_files': ('talos/linux_config.py',), 20:14:06 INFO - 'default_actions': ('clobber', 20:14:06 INFO - 'read-buildbot-config', 20:14:06 INFO - 'download-and-extract', 20:14:06 INFO - 'populate-webroot', 20:14:06 INFO - 'create-virtualenv', 20:14:06 INFO - 'install', 20:14:06 INFO - 'run-tests'), 20:14:06 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:14:06 INFO - 'download_minidump_stackwalk': True, 20:14:06 INFO - 'download_symbols': 'ondemand', 20:14:06 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:14:06 INFO - 'tooltool.py': '/tools/tooltool.py', 20:14:06 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:14:06 INFO - '/tools/misc-python/virtualenv.py')}, 20:14:06 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:14:06 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:14:06 INFO - 'installer_path': 'installer.exe', 20:14:06 INFO - 'log_level': 'info', 20:14:06 INFO - 'log_name': 'talos', 20:14:06 INFO - 'log_to_console': True, 20:14:06 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 20:14:06 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 20:14:06 INFO - 'opt_config_files': (), 20:14:06 INFO - 'pip_index': False, 20:14:06 INFO - 'sps_profile': False, 20:14:06 INFO - 'sps_profile_interval': 0, 20:14:06 INFO - 'suite': 'dromaeojs', 20:14:06 INFO - 'system_bits': '32', 20:14:06 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:14:06 INFO - 'title': 'talos-linux64-ix-043', 20:14:06 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:14:06 INFO - 'use_talos_json': True, 20:14:06 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:14:06 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:14:06 INFO - 'work_dir': 'build'} 20:14:06 INFO - ##### 20:14:06 INFO - ##### Running clobber step. 20:14:06 INFO - ##### 20:14:06 INFO - Running pre-action listener: _resource_record_pre_action 20:14:06 INFO - Running main action method: clobber 20:14:06 INFO - rmtree: /builds/slave/test/build 20:14:06 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:14:07 INFO - Running post-action listener: _resource_record_post_action 20:14:07 INFO - ##### 20:14:07 INFO - ##### Finished clobber step (success) 20:14:07 INFO - ##### 20:14:07 INFO - ##### 20:14:07 INFO - ##### Running read-buildbot-config step. 20:14:07 INFO - ##### 20:14:07 INFO - Running pre-action listener: _resource_record_pre_action 20:14:07 INFO - Running main action method: read_buildbot_config 20:14:07 INFO - Using buildbot properties: 20:14:07 INFO - { 20:14:07 INFO - "project": "", 20:14:07 INFO - "product": "firefox", 20:14:07 INFO - "script_repo_revision": "production", 20:14:07 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 20:14:07 INFO - "repository": "", 20:14:07 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 20:14:07 INFO - "buildid": "20160626173008", 20:14:07 INFO - "pgo_build": "True", 20:14:07 INFO - "basedir": "/builds/slave/test", 20:14:07 INFO - "buildnumber": 834, 20:14:07 INFO - "slavename": "talos-linux64-ix-043", 20:14:07 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 20:14:07 INFO - "platform": "ubuntu64_hw", 20:14:07 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 20:14:07 INFO - "branch": "fx-team", 20:14:07 INFO - "repo_path": "integration/fx-team", 20:14:07 INFO - "revision": "110c7ad7d399d16b9c77940f766a26df5d90f881", 20:14:07 INFO - "stage_platform": "linux64-pgo", 20:14:07 INFO - "builduid": "1048c84d6b4745c3b323e55cfdf449ed", 20:14:07 INFO - "slavebuilddir": "test" 20:14:07 INFO - } 20:14:07 INFO - Found installer url https://queue.taskcluster.net/v1/task/IG3vjAsMQomR6u3qUUOzoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 20:14:07 INFO - Running post-action listener: _resource_record_post_action 20:14:07 INFO - ##### 20:14:07 INFO - ##### Finished read-buildbot-config step (success) 20:14:07 INFO - ##### 20:14:07 INFO - ##### 20:14:07 INFO - ##### Running download-and-extract step. 20:14:07 INFO - ##### 20:14:07 INFO - Running pre-action listener: _resource_record_pre_action 20:14:07 INFO - Running main action method: download_and_extract 20:14:07 INFO - mkdir: /builds/slave/test/build/tests 20:14:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:14:07 INFO - https://queue.taskcluster.net/v1/task/IG3vjAsMQomR6u3qUUOzoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 20:14:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IG3vjAsMQomR6u3qUUOzoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 20:14:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IG3vjAsMQomR6u3qUUOzoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 20:14:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IG3vjAsMQomR6u3qUUOzoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 20:14:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IG3vjAsMQomR6u3qUUOzoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 20:14:13 INFO - Downloaded 1361 bytes. 20:14:13 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 20:14:13 INFO - Using the following test package requirements: 20:14:13 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 20:14:13 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:14:13 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 20:14:13 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:14:13 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 20:14:13 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:14:13 INFO - u'jsshell-linux-x86_64.zip'], 20:14:13 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:14:13 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 20:14:13 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 20:14:13 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:14:13 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 20:14:13 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:14:13 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 20:14:13 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:14:13 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 20:14:13 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:14:13 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 20:14:13 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 20:14:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:14:13 INFO - https://queue.taskcluster.net/v1/task/IG3vjAsMQomR6u3qUUOzoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:14:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IG3vjAsMQomR6u3qUUOzoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 20:14:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IG3vjAsMQomR6u3qUUOzoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 20:14:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IG3vjAsMQomR6u3qUUOzoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 20:14:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IG3vjAsMQomR6u3qUUOzoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 20:14:16 INFO - Downloaded 24279422 bytes. 20:14:16 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 20:14:16 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 20:14:17 INFO - Return code: 0 20:14:17 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 20:14:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:14:17 INFO - https://queue.taskcluster.net/v1/task/IG3vjAsMQomR6u3qUUOzoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:14:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IG3vjAsMQomR6u3qUUOzoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 20:14:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IG3vjAsMQomR6u3qUUOzoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 20:14:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IG3vjAsMQomR6u3qUUOzoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 20:14:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IG3vjAsMQomR6u3qUUOzoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 20:14:20 INFO - Downloaded 24279422 bytes. 20:14:20 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 20:14:20 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 20:14:22 INFO - Return code: 0 20:14: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')]} 20:14:22 INFO - https://queue.taskcluster.net/v1/task/IG3vjAsMQomR6u3qUUOzoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 20:14:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IG3vjAsMQomR6u3qUUOzoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 20:14:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IG3vjAsMQomR6u3qUUOzoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 20:14:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IG3vjAsMQomR6u3qUUOzoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 20:14:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IG3vjAsMQomR6u3qUUOzoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 20:14:23 INFO - Downloaded 14405240 bytes. 20:14:23 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 20:14:23 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 20:14:23 INFO - Return code: 0 20:14: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')]} 20:14:23 INFO - https://queue.taskcluster.net/v1/task/IG3vjAsMQomR6u3qUUOzoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 20:14:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IG3vjAsMQomR6u3qUUOzoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 20:14:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IG3vjAsMQomR6u3qUUOzoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 20:14:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IG3vjAsMQomR6u3qUUOzoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 20:14:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/IG3vjAsMQomR6u3qUUOzoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 20:14:24 INFO - Downloaded 60158240 bytes. 20:14:24 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/IG3vjAsMQomR6u3qUUOzoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 20:14:24 INFO - mkdir: /builds/slave/test/properties 20:14:24 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:14:24 INFO - Writing to file /builds/slave/test/properties/build_url 20:14:24 INFO - Contents: 20:14:24 INFO - build_url:https://queue.taskcluster.net/v1/task/IG3vjAsMQomR6u3qUUOzoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 20:14:25 INFO - Running post-action listener: _resource_record_post_action 20:14:25 INFO - Running post-action listener: set_extra_try_arguments 20:14:25 INFO - ##### 20:14:25 INFO - ##### Finished download-and-extract step (success) 20:14:25 INFO - ##### 20:14:25 INFO - ##### 20:14:25 INFO - ##### Running populate-webroot step. 20:14:25 INFO - ##### 20:14:25 INFO - Running pre-action listener: _resource_record_pre_action 20:14:25 INFO - Running main action method: populate_webroot 20:14:25 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:14:25 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:14:25 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:14:25 INFO - '--tppagecycles', 20:14:25 INFO - '7'], 20:14:25 INFO - 'tests': ['tsvgm']}}, 20:14:25 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:14:25 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:14:25 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:14:25 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:14:25 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:14:25 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:14:25 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:14:25 INFO - 'talos_options': ['--disable-e10s'], 20:14:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:14:25 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:14:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:14:25 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:14:25 INFO - 'talos_options': ['--disable-e10s'], 20:14:25 INFO - 'tests': ['damp', 'tps']}, 20:14:25 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:14:25 INFO - 'tests': ['damp', 'tps']}, 20:14:25 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:14:25 INFO - 'tests': ['dromaeo_dom']}, 20:14:25 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:14:25 INFO - 'g4': {'talos_options': ['--disable-e10s'], 20:14:25 INFO - 'tests': ['basic_compositor_video']}, 20:14:25 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 20:14:25 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:14:25 INFO - 'tests': ['a11yr', 20:14:25 INFO - 'ts_paint', 20:14:25 INFO - 'tpaint', 20:14:25 INFO - 'sessionrestore', 20:14:25 INFO - 'sessionrestore_no_auto_restore', 20:14:25 INFO - 'tabpaint']}, 20:14:25 INFO - 'other-e10s': {'tests': ['a11yr', 20:14:25 INFO - 'ts_paint', 20:14:25 INFO - 'tpaint', 20:14:25 INFO - 'sessionrestore', 20:14:25 INFO - 'sessionrestore_no_auto_restore', 20:14:25 INFO - 'tabpaint']}, 20:14:25 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:14:25 INFO - 'ts_paint', 20:14:25 INFO - 'tpaint', 20:14:25 INFO - 'sessionrestore', 20:14:25 INFO - 'sessionrestore_no_auto_restore', 20:14:25 INFO - 'tabpaint']}, 20:14:25 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:14:25 INFO - 'ts_paint', 20:14:25 INFO - 'tpaint', 20:14:25 INFO - 'sessionrestore', 20:14:25 INFO - 'sessionrestore_no_auto_restore', 20:14:25 INFO - 'tabpaint']}, 20:14:25 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:14:25 INFO - 'tests': ['a11yr', 20:14:25 INFO - 'ts_paint', 20:14:25 INFO - 'tpaint', 20:14:25 INFO - 'sessionrestore', 20:14:25 INFO - 'sessionrestore_no_auto_restore', 20:14:25 INFO - 'tabpaint']}, 20:14:25 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:14:25 INFO - 'tests': ['a11yr', 20:14:25 INFO - 'ts_paint', 20:14:25 INFO - 'tpaint', 20:14:25 INFO - 'sessionrestore', 20:14:25 INFO - 'sessionrestore_no_auto_restore', 20:14:25 INFO - 'tabpaint']}, 20:14:25 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:14:25 INFO - 'tests': ['tsvgx', 20:14:25 INFO - 'tsvgr_opacity', 20:14:25 INFO - 'tart', 20:14:25 INFO - 'tscrollx', 20:14:25 INFO - 'cart']}, 20:14:25 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:14:25 INFO - 'tsvgr_opacity', 20:14:25 INFO - 'tart', 20:14:25 INFO - 'tscrollx', 20:14:25 INFO - 'cart']}, 20:14:25 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:14:25 INFO - 'talos_options': ['--disable-e10s'], 20:14:25 INFO - 'tests': ['tp5o']}, 20:14:25 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:14:25 INFO - 'tests': ['tp5o']}, 20:14:25 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:14:25 INFO - 'talos_options': ['--disable-e10s', 20:14:25 INFO - '--xperf_path', 20:14:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:14:25 INFO - 'tests': ['tp5n']}, 20:14:25 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:14:25 INFO - 'talos_options': ['--xperf_path', 20:14:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:14:25 INFO - 'tests': ['tp5n']}}, 20:14:25 INFO - 'talos.zip': {'path': '', 20:14:25 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:14:25 INFO - Running post-action listener: _resource_record_post_action 20:14:25 INFO - ##### 20:14:25 INFO - ##### Finished populate-webroot step (success) 20:14:25 INFO - ##### 20:14:25 INFO - ##### 20:14:25 INFO - ##### Running create-virtualenv step. 20:14:25 INFO - ##### 20:14:25 INFO - Running pre-action listener: _resource_record_pre_action 20:14:25 INFO - Running main action method: create_virtualenv 20:14:25 INFO - Creating virtualenv /builds/slave/test/build/venv 20:14:25 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 20:14:25 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:14:25 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:14:25 INFO - Using real prefix '/usr' 20:14:25 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:14:26 INFO - Installing distribute.............................................................................................................................................................................................done. 20:14:28 INFO - Installing pip.................done. 20:14:28 INFO - Return code: 0 20:14:28 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:14:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:14:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:14:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:14:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:14:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:14:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:14:28 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 0x7fb9a4a23f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd068a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdd1c40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe61710>, '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 0xe62610>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe62aa0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1466995491.990502-64755123', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:14:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 20:14:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 20:14:28 INFO - Using env: {'DISPLAY': ':0', 20:14:28 INFO - 'HOME': '/home/cltbld', 20:14:28 INFO - 'LANG': 'en_US.UTF-8', 20:14:28 INFO - 'LANGUAGE': 'en_US:en', 20:14:28 INFO - 'LOGNAME': 'cltbld', 20:14:28 INFO - 'MAIL': '/var/mail/cltbld', 20:14:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:14:28 INFO - 'MOZ_NO_REMOTE': '1', 20:14:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:14:28 INFO - 'NO_EM_RESTART': '1', 20:14:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:14:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:14:28 INFO - 'PWD': '/builds/slave/test', 20:14:28 INFO - 'SHELL': '/bin/bash', 20:14:28 INFO - 'SHLVL': '1', 20:14:28 INFO - 'TERM': 'linux', 20:14:28 INFO - 'TMOUT': '86400', 20:14:28 INFO - 'USER': 'cltbld', 20:14:28 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1466995491.990502-64755123', 20:14:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:14:28 INFO - '_': '/tools/buildbot/bin/python'} 20:14:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:14:28 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 20:14:28 INFO - Cleaning up... 20:14:28 INFO - Return code: 0 20:14:28 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 20:14:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:14:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:14:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:14:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:14:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:14:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:14:28 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 0x7fb9a4a23f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd068a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdd1c40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe61710>, '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 0xe62610>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe62aa0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1466995491.990502-64755123', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:14:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 20:14:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 20:14:28 INFO - Using env: {'DISPLAY': ':0', 20:14:28 INFO - 'HOME': '/home/cltbld', 20:14:28 INFO - 'LANG': 'en_US.UTF-8', 20:14:28 INFO - 'LANGUAGE': 'en_US:en', 20:14:28 INFO - 'LOGNAME': 'cltbld', 20:14:28 INFO - 'MAIL': '/var/mail/cltbld', 20:14:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:14:28 INFO - 'MOZ_NO_REMOTE': '1', 20:14:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:14:28 INFO - 'NO_EM_RESTART': '1', 20:14:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:14:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:14:28 INFO - 'PWD': '/builds/slave/test', 20:14:28 INFO - 'SHELL': '/bin/bash', 20:14:28 INFO - 'SHLVL': '1', 20:14:28 INFO - 'TERM': 'linux', 20:14:28 INFO - 'TMOUT': '86400', 20:14:28 INFO - 'USER': 'cltbld', 20:14:28 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1466995491.990502-64755123', 20:14:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:14:28 INFO - '_': '/tools/buildbot/bin/python'} 20:14:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:14:28 INFO - Downloading/unpacking psutil>=3.1.1 20:14:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:14:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:14:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:14:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:14:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:14:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:14:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:14:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:14:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:14:30 INFO - Installing collected packages: psutil 20:14:30 INFO - Running setup.py install for psutil 20:14:30 INFO - building 'psutil._psutil_linux' extension 20:14:30 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 20:14:30 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 20:14:30 INFO - building 'psutil._psutil_posix' extension 20:14:30 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 20:14:30 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 20:14:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:14:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:14:30 INFO - Successfully installed psutil 20:14:30 INFO - Cleaning up... 20:14:31 INFO - Return code: 0 20:14:31 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 20:14:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:14:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:14:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:14:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:14:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:14:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:14:31 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 0x7fb9a4a23f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd068a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdd1c40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe61710>, '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 0xe62610>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe62aa0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1466995491.990502-64755123', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:14:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 20:14:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 20:14:31 INFO - Using env: {'DISPLAY': ':0', 20:14:31 INFO - 'HOME': '/home/cltbld', 20:14:31 INFO - 'LANG': 'en_US.UTF-8', 20:14:31 INFO - 'LANGUAGE': 'en_US:en', 20:14:31 INFO - 'LOGNAME': 'cltbld', 20:14:31 INFO - 'MAIL': '/var/mail/cltbld', 20:14:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:14:31 INFO - 'MOZ_NO_REMOTE': '1', 20:14:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:14:31 INFO - 'NO_EM_RESTART': '1', 20:14:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:14:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:14:31 INFO - 'PWD': '/builds/slave/test', 20:14:31 INFO - 'SHELL': '/bin/bash', 20:14:31 INFO - 'SHLVL': '1', 20:14:31 INFO - 'TERM': 'linux', 20:14:31 INFO - 'TMOUT': '86400', 20:14:31 INFO - 'USER': 'cltbld', 20:14:31 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1466995491.990502-64755123', 20:14:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:14:31 INFO - '_': '/tools/buildbot/bin/python'} 20:14:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:14:31 INFO - Downloading/unpacking mozsystemmonitor==0.3 20:14:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:14:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:14:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:14:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:14:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:14:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:14:34 INFO - Downloading mozsystemmonitor-0.3.tar.gz 20:14:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:14:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 20:14:34 INFO - Installing collected packages: mozsystemmonitor 20:14:34 INFO - Running setup.py install for mozsystemmonitor 20:14:34 INFO - Successfully installed mozsystemmonitor 20:14:34 INFO - Cleaning up... 20:14:34 INFO - Return code: 0 20:14:34 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 20:14:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:14:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:14:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:14:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:14:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:14:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:14:34 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 0x7fb9a4a23f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd068a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdd1c40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe61710>, '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 0xe62610>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe62aa0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1466995491.990502-64755123', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:14:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 20:14:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 20:14:34 INFO - Using env: {'DISPLAY': ':0', 20:14:34 INFO - 'HOME': '/home/cltbld', 20:14:34 INFO - 'LANG': 'en_US.UTF-8', 20:14:34 INFO - 'LANGUAGE': 'en_US:en', 20:14:34 INFO - 'LOGNAME': 'cltbld', 20:14:34 INFO - 'MAIL': '/var/mail/cltbld', 20:14:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:14:34 INFO - 'MOZ_NO_REMOTE': '1', 20:14:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:14:34 INFO - 'NO_EM_RESTART': '1', 20:14:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:14:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:14:34 INFO - 'PWD': '/builds/slave/test', 20:14:34 INFO - 'SHELL': '/bin/bash', 20:14:34 INFO - 'SHLVL': '1', 20:14:34 INFO - 'TERM': 'linux', 20:14:34 INFO - 'TMOUT': '86400', 20:14:34 INFO - 'USER': 'cltbld', 20:14:34 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1466995491.990502-64755123', 20:14:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:14:34 INFO - '_': '/tools/buildbot/bin/python'} 20:14:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:14:34 INFO - Downloading/unpacking jsonschema==2.5.1 20:14: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 20:14: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 20:14: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 20:14: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 20:14: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 20:14: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 20:14:36 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:14:36 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 20:14:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:14:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:14:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:14:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:14:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:14:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:14:36 INFO - Downloading functools32-3.2.3-2.tar.gz 20:14:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:14:36 INFO - warning: no files found matching '*.txt' 20:14:36 INFO - no previously-included directories found matching 'build' 20:14:36 INFO - no previously-included directories found matching 'dist' 20:14:36 INFO - no previously-included directories found matching '.git*' 20:14:36 INFO - Installing collected packages: jsonschema, functools32 20:14:36 INFO - Running setup.py install for functools32 20:14:36 INFO - warning: no files found matching '*.txt' 20:14:36 INFO - no previously-included directories found matching 'build' 20:14:36 INFO - no previously-included directories found matching 'dist' 20:14:36 INFO - no previously-included directories found matching '.git*' 20:14:36 INFO - Successfully installed jsonschema functools32 20:14:36 INFO - Cleaning up... 20:14:36 INFO - Return code: 0 20:14:36 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:14:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:14:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:14:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:14:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:14:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:14:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:14:36 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 0x7fb9a4a23f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd068a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdd1c40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe61710>, '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 0xe62610>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe62aa0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1466995491.990502-64755123', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:14:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 20:14:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 20:14:36 INFO - Using env: {'DISPLAY': ':0', 20:14:36 INFO - 'HOME': '/home/cltbld', 20:14:36 INFO - 'LANG': 'en_US.UTF-8', 20:14:36 INFO - 'LANGUAGE': 'en_US:en', 20:14:36 INFO - 'LOGNAME': 'cltbld', 20:14:36 INFO - 'MAIL': '/var/mail/cltbld', 20:14:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:14:36 INFO - 'MOZ_NO_REMOTE': '1', 20:14:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:14:36 INFO - 'NO_EM_RESTART': '1', 20:14:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:14:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:14:36 INFO - 'PWD': '/builds/slave/test', 20:14:36 INFO - 'SHELL': '/bin/bash', 20:14:36 INFO - 'SHLVL': '1', 20:14:36 INFO - 'TERM': 'linux', 20:14:36 INFO - 'TMOUT': '86400', 20:14:36 INFO - 'USER': 'cltbld', 20:14:36 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1466995491.990502-64755123', 20:14:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:14:36 INFO - '_': '/tools/buildbot/bin/python'} 20:14:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:14:37 INFO - Downloading/unpacking blobuploader==1.2.4 20:14: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 20:14: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 20:14: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 20:14: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 20:14: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 20:14: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 20:14:38 INFO - Downloading blobuploader-1.2.4.tar.gz 20:14:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:14:39 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:14: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 20:14: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 20:14: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 20:14: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 20:14: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 20:14: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 20:14:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:14:39 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:14: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 20:14: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 20:14: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 20:14: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 20:14: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 20:14: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 20:14:39 INFO - Downloading docopt-0.6.1.tar.gz 20:14:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:14:39 INFO - Installing collected packages: blobuploader, requests, docopt 20:14:39 INFO - Running setup.py install for blobuploader 20:14:39 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:14:39 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:14:39 INFO - Running setup.py install for requests 20:14:40 INFO - Running setup.py install for docopt 20:14:40 INFO - Successfully installed blobuploader requests docopt 20:14:40 INFO - Cleaning up... 20:14:40 INFO - Return code: 0 20:14:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:14:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:14:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:14:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:14:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:14:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:14:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:14:40 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 0x7fb9a4a23f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd068a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdd1c40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe61710>, '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 0xe62610>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe62aa0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1466995491.990502-64755123', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:14:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 20:14:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 20:14:40 INFO - Using env: {'DISPLAY': ':0', 20:14:40 INFO - 'HOME': '/home/cltbld', 20:14:40 INFO - 'LANG': 'en_US.UTF-8', 20:14:40 INFO - 'LANGUAGE': 'en_US:en', 20:14:40 INFO - 'LOGNAME': 'cltbld', 20:14:40 INFO - 'MAIL': '/var/mail/cltbld', 20:14:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:14:40 INFO - 'MOZ_NO_REMOTE': '1', 20:14:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:14:40 INFO - 'NO_EM_RESTART': '1', 20:14:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:14:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:14:40 INFO - 'PWD': '/builds/slave/test', 20:14:40 INFO - 'SHELL': '/bin/bash', 20:14:40 INFO - 'SHLVL': '1', 20:14:40 INFO - 'TERM': 'linux', 20:14:40 INFO - 'TMOUT': '86400', 20:14:40 INFO - 'USER': 'cltbld', 20:14:40 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1466995491.990502-64755123', 20:14:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:14:40 INFO - '_': '/tools/buildbot/bin/python'} 20:14:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:14:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:14:40 INFO - Running setup.py (path:/tmp/pip-Erp4YN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:14:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:14:40 INFO - Running setup.py (path:/tmp/pip-UPANW8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:14:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:14:40 INFO - Running setup.py (path:/tmp/pip-RYd5Ky-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:14:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:14:40 INFO - Running setup.py (path:/tmp/pip-pKoLaY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:14:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:14:40 INFO - Running setup.py (path:/tmp/pip-v25pCS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:14:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:14:40 INFO - Running setup.py (path:/tmp/pip-ikzJPR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:14:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:14:40 INFO - Running setup.py (path:/tmp/pip-vwIOxX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:14:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:14:41 INFO - Running setup.py (path:/tmp/pip-bAo0Ys-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:14:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:14:41 INFO - Running setup.py (path:/tmp/pip-opW4OV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:14:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:14:41 INFO - Running setup.py (path:/tmp/pip-zkNaY9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:14:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:14:41 INFO - Running setup.py (path:/tmp/pip-g0Lyn0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:14:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:14:41 INFO - Running setup.py (path:/tmp/pip-e_Qs69-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:14:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:14:41 INFO - Running setup.py (path:/tmp/pip-1QrV0u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:14:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:14:41 INFO - Running setup.py (path:/tmp/pip-ByuVNV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:14:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:14:41 INFO - Running setup.py (path:/tmp/pip-kGSNE8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:14:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:14:41 INFO - Running setup.py (path:/tmp/pip-mdL9D_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:14:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:14:41 INFO - Running setup.py (path:/tmp/pip-vjI7cO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:14:41 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:14:41 INFO - Running setup.py install for manifestparser 20:14:41 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:14:41 INFO - Running setup.py install for mozcrash 20:14:41 INFO - Running setup.py install for mozdebug 20:14:42 INFO - Running setup.py install for mozdevice 20:14:42 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:14:42 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:14:42 INFO - Running setup.py install for mozfile 20:14:42 INFO - Running setup.py install for mozhttpd 20:14:42 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:14:42 INFO - Running setup.py install for mozinfo 20:14:42 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:14:42 INFO - Running setup.py install for mozInstall 20:14:42 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:14:42 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:14:42 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:14:42 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:14:42 INFO - Running setup.py install for mozleak 20:14:42 INFO - Running setup.py install for mozlog 20:14:42 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:14:42 INFO - Running setup.py install for moznetwork 20:14:42 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:14:42 INFO - Running setup.py install for mozprocess 20:14:42 INFO - Running setup.py install for mozprofile 20:14:43 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:14:43 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:14:43 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:14:43 INFO - Running setup.py install for mozrunner 20:14:43 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:14:43 INFO - Running setup.py install for mozscreenshot 20:14:43 INFO - Running setup.py install for moztest 20:14:43 INFO - Running setup.py install for mozversion 20:14:43 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:14:43 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:14:43 INFO - Cleaning up... 20:14:43 INFO - Return code: 0 20:14:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:14:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:14:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:14:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:14:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:14:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:14:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:14:43 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 0x7fb9a4a23f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd068a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdd1c40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe61710>, '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 0xe62610>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe62aa0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1466995491.990502-64755123', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:14:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 20:14:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 20:14:43 INFO - Using env: {'DISPLAY': ':0', 20:14:43 INFO - 'HOME': '/home/cltbld', 20:14:43 INFO - 'LANG': 'en_US.UTF-8', 20:14:43 INFO - 'LANGUAGE': 'en_US:en', 20:14:43 INFO - 'LOGNAME': 'cltbld', 20:14:43 INFO - 'MAIL': '/var/mail/cltbld', 20:14:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:14:43 INFO - 'MOZ_NO_REMOTE': '1', 20:14:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:14:43 INFO - 'NO_EM_RESTART': '1', 20:14:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:14:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:14:43 INFO - 'PWD': '/builds/slave/test', 20:14:43 INFO - 'SHELL': '/bin/bash', 20:14:43 INFO - 'SHLVL': '1', 20:14:43 INFO - 'TERM': 'linux', 20:14:43 INFO - 'TMOUT': '86400', 20:14:43 INFO - 'USER': 'cltbld', 20:14:43 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1466995491.990502-64755123', 20:14:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:14:43 INFO - '_': '/tools/buildbot/bin/python'} 20:14:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:14:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:14:43 INFO - Running setup.py (path:/tmp/pip-79QiVs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:14:43 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 20:14:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:14:43 INFO - Running setup.py (path:/tmp/pip-dqYEvo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:14:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 20:14:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:14:43 INFO - Running setup.py (path:/tmp/pip-byTDXA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:14:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 20:14:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:14:43 INFO - Running setup.py (path:/tmp/pip-d1iNeZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:14:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 20:14:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:14:44 INFO - Running setup.py (path:/tmp/pip-aAsGWF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:14:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 20:14:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:14:44 INFO - Running setup.py (path:/tmp/pip-TjcojO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:14:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 20:14:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:14:44 INFO - Running setup.py (path:/tmp/pip-EYKIRJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:14:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 20:14:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:14:44 INFO - Running setup.py (path:/tmp/pip-ZRrIpI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:14:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 20:14:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:14:44 INFO - Running setup.py (path:/tmp/pip-xV6PRR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:14:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 20:14:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:14:44 INFO - Running setup.py (path:/tmp/pip-xIFUE4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:14:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:14:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:14:44 INFO - Running setup.py (path:/tmp/pip-PikYPo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:14:44 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 20:14:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:14:44 INFO - Running setup.py (path:/tmp/pip-ALMELU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:14:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 20:14:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:14:44 INFO - Running setup.py (path:/tmp/pip-tjgvr4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:14:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 20:14:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:14:44 INFO - Running setup.py (path:/tmp/pip-gUiIzt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:14:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 20:14:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:14:44 INFO - Running setup.py (path:/tmp/pip-b7mXMy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:14:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 20:14:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:14:44 INFO - Running setup.py (path:/tmp/pip-5iO5Tv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:14:44 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 20:14:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:14:44 INFO - Running setup.py (path:/tmp/pip-BOiqRl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:14:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 20:14:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 20:14:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 20:14:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 20:14:44 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 20:14:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 20:14:44 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:14:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:14:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:14:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:14:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:14:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:14:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:14:46 INFO - Downloading blessings-1.6.tar.gz 20:14:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:14:46 INFO - Installing collected packages: blessings 20:14:46 INFO - Running setup.py install for blessings 20:14:47 INFO - Successfully installed blessings 20:14:47 INFO - Cleaning up... 20:14:47 INFO - Return code: 0 20:14:47 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:14:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:14:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:14:47 INFO - Reading from file tmpfile_stdout 20:14:47 INFO - Current package versions: 20:14:47 INFO - argparse == 1.2.1 20:14:47 INFO - blessings == 1.6 20:14:47 INFO - blobuploader == 1.2.4 20:14:47 INFO - docopt == 0.6.1 20:14:47 INFO - functools32 == 3.2.3-2 20:14:47 INFO - jsonschema == 2.5.1 20:14:47 INFO - manifestparser == 1.1 20:14:47 INFO - mozInstall == 1.12 20:14:47 INFO - mozcrash == 0.17 20:14:47 INFO - mozdebug == 0.1 20:14:47 INFO - mozdevice == 0.48 20:14:47 INFO - mozfile == 1.2 20:14:47 INFO - mozhttpd == 0.7 20:14:47 INFO - mozinfo == 0.9 20:14:47 INFO - mozleak == 0.1 20:14:47 INFO - mozlog == 3.2 20:14:47 INFO - moznetwork == 0.27 20:14:47 INFO - mozprocess == 0.22 20:14:47 INFO - mozprofile == 0.28 20:14:47 INFO - mozrunner == 6.11 20:14:47 INFO - mozscreenshot == 0.1 20:14:47 INFO - mozsystemmonitor == 0.3 20:14:47 INFO - moztest == 0.7 20:14:47 INFO - mozversion == 1.4 20:14:47 INFO - psutil == 3.1.1 20:14:47 INFO - requests == 1.2.3 20:14:47 INFO - wsgiref == 0.1.2 20:14:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:14:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:14:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:14:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:14:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:14:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:14:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:14:47 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 0x7fb9a4a23f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd068a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdd1c40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe61710>, '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 0xe62610>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe62aa0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1466995491.990502-64755123', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:14:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 20:14:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 20:14:47 INFO - Using env: {'DISPLAY': ':0', 20:14:47 INFO - 'HOME': '/home/cltbld', 20:14:47 INFO - 'LANG': 'en_US.UTF-8', 20:14:47 INFO - 'LANGUAGE': 'en_US:en', 20:14:47 INFO - 'LOGNAME': 'cltbld', 20:14:47 INFO - 'MAIL': '/var/mail/cltbld', 20:14:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:14:47 INFO - 'MOZ_NO_REMOTE': '1', 20:14:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:14:47 INFO - 'NO_EM_RESTART': '1', 20:14:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:14:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:14:47 INFO - 'PWD': '/builds/slave/test', 20:14:47 INFO - 'SHELL': '/bin/bash', 20:14:47 INFO - 'SHLVL': '1', 20:14:47 INFO - 'TERM': 'linux', 20:14:47 INFO - 'TMOUT': '86400', 20:14:47 INFO - 'USER': 'cltbld', 20:14:47 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1466995491.990502-64755123', 20:14:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:14:47 INFO - '_': '/tools/buildbot/bin/python'} 20:14:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:14:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 20:14:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 20:14:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 20:14:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 20:14:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 20:14:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 20:14:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 20:14:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 20:14:47 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 20:14:47 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 20:14:47 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 20:14:47 INFO - Cleaning up... 20:14:47 INFO - Return code: 0 20:14:47 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:14:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:14:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:14:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:14:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:14:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:14:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:14:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb9a4a23f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd068a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdd1c40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe61710>, '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 0xe62610>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe62aa0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1466995491.990502-64755123', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:14:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 20:14:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 20:14:47 INFO - Using env: {'DISPLAY': ':0', 20:14:47 INFO - 'HOME': '/home/cltbld', 20:14:47 INFO - 'LANG': 'en_US.UTF-8', 20:14:47 INFO - 'LANGUAGE': 'en_US:en', 20:14:47 INFO - 'LOGNAME': 'cltbld', 20:14:47 INFO - 'MAIL': '/var/mail/cltbld', 20:14:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:14:47 INFO - 'MOZ_NO_REMOTE': '1', 20:14:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:14:47 INFO - 'NO_EM_RESTART': '1', 20:14:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:14:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:14:47 INFO - 'PWD': '/builds/slave/test', 20:14:47 INFO - 'SHELL': '/bin/bash', 20:14:47 INFO - 'SHLVL': '1', 20:14:47 INFO - 'TERM': 'linux', 20:14:47 INFO - 'TMOUT': '86400', 20:14:47 INFO - 'USER': 'cltbld', 20:14:47 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1466995491.990502-64755123', 20:14:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:14:47 INFO - '_': '/tools/buildbot/bin/python'} 20:14:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:14:47 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 20:14:47 INFO - Cleaning up... 20:14:47 INFO - Return code: 0 20:14:47 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 20:14:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:14:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:14:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:14:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:14:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:14:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:14:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb9a4a23f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd068a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdd1c40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe61710>, '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 0xe62610>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe62aa0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1466995491.990502-64755123', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:14:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 20:14:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 20:14:47 INFO - Using env: {'DISPLAY': ':0', 20:14:47 INFO - 'HOME': '/home/cltbld', 20:14:47 INFO - 'LANG': 'en_US.UTF-8', 20:14:47 INFO - 'LANGUAGE': 'en_US:en', 20:14:47 INFO - 'LOGNAME': 'cltbld', 20:14:47 INFO - 'MAIL': '/var/mail/cltbld', 20:14:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:14:47 INFO - 'MOZ_NO_REMOTE': '1', 20:14:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:14:47 INFO - 'NO_EM_RESTART': '1', 20:14:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:14:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:14:47 INFO - 'PWD': '/builds/slave/test', 20:14:47 INFO - 'SHELL': '/bin/bash', 20:14:47 INFO - 'SHLVL': '1', 20:14:47 INFO - 'TERM': 'linux', 20:14:47 INFO - 'TMOUT': '86400', 20:14:47 INFO - 'USER': 'cltbld', 20:14:47 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1466995491.990502-64755123', 20:14:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:14:47 INFO - '_': '/tools/buildbot/bin/python'} 20:14:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:14:47 INFO - Downloading/unpacking flake8 20:14:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:14:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:14:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:14:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:14:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:14:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:14:49 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 20:14:49 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 20:14:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:14:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:14:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:14:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:14:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:14:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:14:50 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 20:14:50 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 20:14:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:14:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:14:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:14:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:14:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:14:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:14:50 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 20:14:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:14:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:14:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:14:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:14:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:14:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:14:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 20:14:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:14:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:14:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:14:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:14:50 INFO - no previously-included directories found matching 'docs/_build' 20:14:50 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 20:14:50 INFO - Running setup.py install for pep8 20:14:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:14:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:14:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:14:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:14:50 INFO - no previously-included directories found matching 'docs/_build' 20:14:50 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 20:14:50 INFO - Successfully installed flake8 mccabe pyflakes pep8 20:14:50 INFO - Cleaning up... 20:14:50 INFO - Return code: 0 20:14:50 INFO - Running post-action listener: _resource_record_post_action 20:14:50 INFO - Running post-action listener: _start_resource_monitoring 20:14:50 INFO - Starting resource monitoring. 20:14:50 INFO - ##### 20:14:50 INFO - ##### Finished create-virtualenv step (success) 20:14:50 INFO - ##### 20:14:50 INFO - ##### 20:14:50 INFO - ##### Running install step. 20:14:50 INFO - ##### 20:14:50 INFO - Running pre-action listener: _resource_record_pre_action 20:14:50 INFO - Running main action method: install 20:14:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:14:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:14:51 INFO - Reading from file tmpfile_stdout 20:14:51 INFO - Detecting whether we're running mozinstall >=1.0... 20:14:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:14:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:14:51 INFO - Reading from file tmpfile_stdout 20:14:51 INFO - Output received: 20:14:51 INFO - Usage: mozinstall [options] installer 20:14:51 INFO - Options: 20:14:51 INFO - -h, --help show this help message and exit 20:14:51 INFO - -d DEST, --destination=DEST 20:14:51 INFO - Directory to install application into. [default: 20:14:51 INFO - "/builds/slave/test"] 20:14:51 INFO - --app=APP Application being installed. [default: firefox] 20:14:51 INFO - mkdir: /builds/slave/test/build/application 20:14:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 20:14:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 20:15:08 INFO - Reading from file tmpfile_stdout 20:15:08 INFO - Output received: 20:15:08 INFO - /builds/slave/test/build/application/firefox/firefox 20:15:08 INFO - Running post-action listener: _resource_record_post_action 20:15:08 INFO - ##### 20:15:08 INFO - ##### Finished install step (success) 20:15:08 INFO - ##### 20:15:08 INFO - ##### 20:15:08 INFO - ##### Running run-tests step. 20:15:08 INFO - ##### 20:15:08 INFO - Running pre-action listener: _resource_record_pre_action 20:15:08 INFO - Running main action method: run_tests 20:15:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:15:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:15:08 INFO - Python 2.7.3 20:15:08 INFO - Return code: 0 20:15:08 INFO - grabbing minidump binary from tooltool 20:15:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:15:08 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 0xe61710>, '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 0xe62610>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe62aa0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:15:08 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 20:15:08 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 20:15:08 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 20:15:08 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:15:08 INFO - Return code: 0 20:15:08 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 20:15:08 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:15:08 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:15:08 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 20:15:08 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:15:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 20:15:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 20:15:09 INFO - Return code: 0 20:15:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IG3vjAsMQomR6u3qUUOzoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-043', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 20:15:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/IG3vjAsMQomR6u3qUUOzoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-043 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 20:15:09 INFO - Using env: {'DISPLAY': ':0', 20:15:09 INFO - 'HOME': '/home/cltbld', 20:15:09 INFO - 'LANG': 'en_US.UTF-8', 20:15:09 INFO - 'LANGUAGE': 'en_US:en', 20:15:09 INFO - 'LOGNAME': 'cltbld', 20:15:09 INFO - 'MAIL': '/var/mail/cltbld', 20:15:09 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:15:09 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 20:15:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:15:09 INFO - 'MOZ_NO_REMOTE': '1', 20:15:09 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:15:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:15:09 INFO - 'NO_EM_RESTART': '1', 20:15:09 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:15:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:15:09 INFO - 'PWD': '/builds/slave/test', 20:15:09 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:15:09 INFO - 'SHELL': '/bin/bash', 20:15:09 INFO - 'SHLVL': '1', 20:15:09 INFO - 'TERM': 'linux', 20:15:09 INFO - 'TMOUT': '86400', 20:15:09 INFO - 'USER': 'cltbld', 20:15:09 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1466995491.990502-64755123', 20:15:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:15:09 INFO - '_': '/tools/buildbot/bin/python'} 20:15:09 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IG3vjAsMQomR6u3qUUOzoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-043', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 20:15:09 INFO - mozversion application_buildid: 20160626173008 20:15:09 INFO - mozversion application_changeset: 110c7ad7d399d16b9c77940f766a26df5d90f881 20:15:09 INFO - mozversion application_display_name: Nightly 20:15:09 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:15:09 INFO - mozversion application_name: Firefox 20:15:09 INFO - mozversion application_remotingname: firefox 20:15:09 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 20:15:09 INFO - mozversion application_vendor: Mozilla 20:15:09 INFO - mozversion application_version: 50.0a1 20:15:09 INFO - mozversion platform_buildid: 20160626173008 20:15:09 INFO - mozversion platform_changeset: 110c7ad7d399d16b9c77940f766a26df5d90f881 20:15:09 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 20:15:09 INFO - mozversion platform_version: 50.0a1 20:15:09 INFO - using testdate: 1466997309 20:15:09 INFO - actual date: 1466997309 20:15:09 INFO - starting webserver on 'localhost:60164' 20:15:09 INFO - SUITE-START | Running 2 tests 20:15:09 INFO - TEST-START | dromaeo_css 20:15:09 INFO - operating with platform_type : linux_ 20:15:09 INFO - Initialising browser for dromaeo_css test... 20:15:09 INFO - TEST-INFO | started process 17847 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6CVmnh/profile http://localhost:60164/getInfo.html) 20:15:13 INFO - PROCESS | 17847 | __metrics Screen width/height:1600/1200 20:15:13 INFO - PROCESS | 17847 | colorDepth:24 20:15:13 INFO - PROCESS | 17847 | Browser inner width/height: 1024/697 20:15:13 INFO - PROCESS | 17847 | __metrics 20:15:14 INFO - PROCESS | 17847 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:15:15 INFO - TEST-INFO | 17847: exit 0 20:15:15 INFO - Browser initialized. 20:15:15 INFO - Running cycle 1/1 for dromaeo_css test... 20:15:15 INFO - TEST-INFO | started process 17932 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6CVmnh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:15:27 INFO - PROCESS | 17932 | RSS: Main: 173993984 20:15:27 INFO - PROCESS | 17932 | 20:16:18 INFO - PROCESS | 17932 | 1466997378248 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 20:18:27 INFO - PROCESS | 17932 | Cycle 1(1): loaded http://localhost:60164/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60164/tests/dromaeo/cssquery-ext.html) 20:18:28 INFO - PROCESS | 17932 | RSS: Main: 259895296 20:18:28 INFO - PROCESS | 17932 | 20:21:30 INFO - PROCESS | 17932 | Cycle 1(1): loaded http://localhost:60164/tests/dromaeo/cssquery-ext.html (next: http://localhost:60164/tests/dromaeo/cssquery-jquery.html) 20:21:31 INFO - PROCESS | 17932 | RSS: Main: 261238784 20:21:31 INFO - PROCESS | 17932 | 20:24:32 INFO - PROCESS | 17932 | Cycle 1(1): loaded http://localhost:60164/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60164/tests/dromaeo/cssquery-mootools.html) 20:24:33 INFO - PROCESS | 17932 | RSS: Main: 250761216 20:24:33 INFO - PROCESS | 17932 | 20:27:35 INFO - PROCESS | 17932 | Cycle 1(1): loaded http://localhost:60164/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60164/tests/dromaeo/cssquery-prototype.html) 20:27:36 INFO - PROCESS | 17932 | RSS: Main: 246542336 20:27:36 INFO - PROCESS | 17932 | 20:30:38 INFO - PROCESS | 17932 | Cycle 1(1): loaded http://localhost:60164/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60164/tests/dromaeo/cssquery-yui.html) 20:30:39 INFO - PROCESS | 17932 | RSS: Main: 234901504 20:30:39 INFO - PROCESS | 17932 | 20:33:41 INFO - PROCESS | 17932 | Cycle 1(1): loaded http://localhost:60164/tests/dromaeo/cssquery-yui.html (next: http://localhost:60164/tests/dromaeo/cssquery-dojo.html) 20:33:42 INFO - PROCESS | 17932 | RSS: Main: 299900928 20:33:42 INFO - PROCESS | 17932 | 20:33:42 INFO - PROCESS | 17932 | __start_tp_report 20:33:42 INFO - PROCESS | 17932 | _x_x_mozilla_page_load 20:33:42 INFO - PROCESS | 17932 | _x_x_mozilla_page_load_details 20:33:42 INFO - PROCESS | 17932 | |i|pagename|runs| 20:33:42 INFO - PROCESS | 17932 | |0;dojo.html;3031.0452207554617;3050.8474576271187;3053.0535533984466;3090.9690903090964;3111.564380986661;5169.663971841827;5240.109181439155;5242.528172464477;5313.203019547065;5354.009508240978;5281.63028587999;5317.9202311965355;5320.973395133029;5321.787128514855;5339.279197308362;4741.857744267661;4843.273508973647;4843.685160464576;4846.539578740014;5024.522670346311;4915.434725006617;4921.311016457681;4945.480724523927;4996.325496058022;5016;4746.810127594892;4774.689645173053;4788.377510923575;4834.178189707758;4836.951630483685;4756.239001759702;4757.452892917289;4759.738214398207;4775.5463230993;4858.17411040124;4778.880527986794;4805.471398146201;4818.445878723956;4829.7102173869325;4874.1713908635265;5199.376074871002;5216.9739151304;5286.101362768339;5298.337707786527;5348.491893270133;5651.9717401413145;5676.659400435987;5701.914471282934;5705.2012718219485;5727.284089488814;5761.971190144022;5774.047282198432;5784.363719990798;5786.594938354317;5787.565932555075;5251.842444726664;5355.250264962909;5409.675419474844;5416.8104116356135;5435.2934118564335;5925.525957923356;5984.850378740479;5985.431384018511;5991.4907232884825;5997.100434934795;5439.728013599383;5741.598088133874;5747.741351639186;5748.856278593069;5749.051406517961;5687.943120568824;5743.167240750068;5756.453136951983;5786.189933409326;5837.153612726216;5752.424757524298;5753.165790960371;5754.769809207669;5759;5765.654060756368;5546.473085056913;5623.128415095585;5777.508911742465;5781.710914454345;5788.363280039192;4322.178786030644;4326.502452218036;4346.608805207483;4386.978065109654;4389.802458889294;3871.070942973666;3884.9805750971063;3898.8050597470015;3899.1616802387057;3928.941065884014;5233.581313494911;5246.895062098813;5291.708956007456;5423.83728488146;5464.617476776588;5595.5523558116065;5634.211210430543;5641.012822756002;5641.605087643826;5666.093425052054;5316.441773613715;5317.30874986257;5317.760700768475;5319.46805319465;5327.866803329948;4800;4830.227163653799;4868.050730107595;4869.074875773592;4901.068796928572;5777.8555536111935;5855.473007429352;5858.06270996647;5869.207656966255;5924.348321684612;5693.231413759255;5695.800646977336;5704.3154821421695;5705.087186050212;5706.42935706426;5608.10270356741;5740.6268592541355;5786.623869448473;5850.0932355484965;5856.560757943256;5541.445855414427;5592.636478628876;5592.664440133605;5606.887862242814;5650.0677388232125;5671.773129074956;5708.600397972102;5713.428657134254;5720.914186287126;5725.456081672234;5439.728013599383;5491.890162196813;5516.779328826962;5564.304461942257;5565.276514053147;5564.054110801093;5566.916496252478;5567.359753628384;5569.359523654832;5570.944290557042;5443.129099344244;5472.945270547243;5495.175723641486;5496.477834605706;5549.139883318092;5457.126859702428;5537.889242215053;5578.2748242728185;5581.386047534849;5632.5493960482245;5440;5464.1257398816;5466.316710411199;5470.562355011669;5486.506214440719 20:33:42 INFO - PROCESS | 17932 | |1;ext.html;593.1517929361015;609.6159419565673;622.4149299658321;637.6206157336385;641.7946257197699;30270.848645756767;43037.35443968339;44101.77949110258;44117;44206.89482762929;45321.77339113308;45817.31274030884;45911.540884591144;45923.311150332775;46002.76998615002;8996.820063598723;9137.862932056025;9147.634094636207;9149.451032938045;9150.267978561733;8936.151065648754;9025.503597302146;9033.954830225872;9043.321750868678;9043.864342034842;9056.637734490612;9131.406458580204;9136.223421009223;9138.086191380875;9138.177564019237;9007.459552426842;9028;9036.051214622501;9057.682981095662;9065.274778017743;9036.367454278203;9114.817703645956;9115.270778337717;9117.042710515367;9120.498372589505;42427.57572424298;43169;43174;43240.78379608113;43268.13463730708;3602.1534939289245;3690;3696.6303369663087;3952.8616498422703;4304.3113101903855;31465;33180.668193318;33810.323793524236;33857.83071084654;34887.30225395478;4458.77706114693;4575.107853968478;4593.83921562747;4680.695754775928;4726.952730472685;345338;349464;351685;351704;353286;62778;63893;64018;64064;64071.359286406536;49043.509564904605;49365;49417;49467.010659787324;49682;17115.22981465837;17232.827671723124;17270.22283997223;17279.3952211672;17302.048387338564;13052.1516101455;13105.410256538478;13118;13145.73708525824;13151;18726.81273187278;20150.798492015187;20435.284765033153;20485.48786280325;20530.92036194553;6000.969995149996;7238.327372984653;7314.707411703579;7370.705171793068;7674.846503070019;941.2140862379989;1013.7313611892854;1020.5917632946881;1063.6968463987725;1110.539126262608;33152.50271245933;33296;33301.50047749286;33367.66632333694;33972.49041264383;1069.3690722473777;1093.3439936038471;1179.4574495731888;1211.54567037361;1227.8403807504967;17517.824821751874;17594.38419655306;17646.91176544109;17811.554711132325;17818;604030;617287;619278;619877;621593;59011;59699.70150149308;59715.70142149262;59738.70130649319;59757;1222.57821051737;1324.2385628263594;1374.3265799758046;1386.94452221912;1397.8462369139386;32680.182995425304;33744;33898.322033559685;34000.14999625029;34194.48708269428;50856.491435085176;51285;51310.48689513207;51315.743421282656;51438.48561514487;338271;339090;342660;343024;344602;37449.251014980095;42227;43415;43857.78071109624;44013.77993110142;48109.278360825316;48275.275870862664;49025.754871225414;49539;50098.749506252236;39714.60285397109;41394.58605413907;43136.35295470508;44180.337294939956;44234;40694;41360.37959430551;41818.16363672649;41837.79081104575;42552.361714573686;41761.58238417577;42612.36081458843;42800;42892.14215715606;42999.57000429956;36751.26497470089;37757.28945435797;37900.2419951605;37932.2413551733;38089;28180.472266670557;28989.855050725455;29211.415771684024;29313.85343073271;29428.411431771674 20:33:42 INFO - PROCESS | 17932 | |2;jquery.html;383.248832288714;386.58442174662247;387.24680496434434;394.0118104793317;409.45746885376883;14217.854055074675;16549.503514894543;18084.186211620476;19662.803371966274;19797.703034454476;15080.170590617512;15268;17938.551536211602;18271.817281827178;18294.359697410593;5388.245645609618;5760.9135862961875;5769.884602307951;5769.884602307951;5770.971145144268;3904.907626107319;5622.775088996435;5663.405342439047;5753.1370294455955;5755.856103597423;5974.103884417329;6325.936740632581;6326.715297811586;6331.746730130789;6336.493080553545;6253.999999999977;6263.906041409383;6313.715882785285;6322.114903913456;6367.8408039798915;5663.461971112738;5683.687397193153;5684.886302273972;5698.715064246812;5708.315002199721;21350.252741153985;21745;22547.77452225473;22791.77208227913;22798.65802012971;2156.2022051840763;2434.087217293515;2443.621238708003;2537.3656585853537;2590.171145233526;9808.411495310304;9870.555824987892;10061.094501494901;10087.7478063049;10628.681139565748;1763.3387479695114;1830.9542261443437;1855.1559040636478;1858.293848337623;1927.8554108441783;76986;79963.20036799675;80070.59964700197;80555.19444805535;81917.18082819156;10729.89270107289;10749.140068794477;10795.730106747395;11024;11258.718532036764;14892.404303827941;14920.850791491946;14982.925085374503;14983.101013939198;14999.100053996795;6768.120144381199;7643.503172293783;9461.952690236505;9827.459489728133;9856.112949834549;8190.5904704764525;8290.46112002718;8545.359098067545;8559.957200214083;8845.159709827556;8565.657373705106;8577.614007369682;8662.740117796477;8679.826403471896;8779.604917778715;3112.7198552130417;3197.920051998672;3297.4229509836164;3368.461046232591;3660.9816950915606;875.5884734174928;929.7210836749083;975.9170470509944;1045.7385653586603;1069.1019543583272;18238.27046918135;18365.357212497765;18416.907915460604;18919.243230270637;19490.5127371814;978.6183388478499;1000.9099181073593;1014.7564584499814;1062.3254233561745;1074.854894589236;8810.955945220232;10437;10709.08972737326;10861.1854110942;10869.565217391215;461932;465800;469296;475343;477825;89711;92920.53539732394;92962;93106.53446732859;93295;983.2281658897731;986.1075726467558;1002.754325190333;1002.7643503776607;1005.7485628592998;16406.917965410095;16660.833391666412;16921.323147073977;17119.828801711825;17360;40714.79642601768;40902.59097408988;41318.1736365265;41461;41624.16751664889;48302.300109529584;60006.39993600183;60644.69677651583;61031.69484152551;61348;11624.476898539417;12087.214331068453;12669.909464938552;12770.489180432678;13007;13471;13738.381772820047;13743.381547830171;13919.791203132163;13990.930045349709;11755.588554400554;11866.347350895438;11961.820572691242;12258.325792081521;12552.309622970824;11726.70683232926;12031.578894738643;12164.878351216728;12241.143119981873;12441.564545240873;11991.160618756603;12303.56937507183;12555.623331300076;12675.746485070431;12982.350882456029;12406.13157079032;12528.310942898228;12548.749025019632;12714.936425317814;12792.936035319764;8306.6677332906;8632.482051076704;9066.04806495335;12480.687982800502;12784.488620455078 20:33:42 INFO - PROCESS | 17932 | |3;mootools.html;1259.5213818748873;1460.437731473383;1479.3934486860387;1542.7068856917185;1730.5673581604592;8092.514449133057;8864.512451815148;9115.68095116671;9118.270538356932;9432.717018489438;8772.561371931393;8939.061398553156;8951.239144672694;8968.461892286467;8999.460032398061;1969.7537807774029;1997.7502812148482;1999.4101739986738;1999.6100760351737;2002.1991203518637;2189.474526113729;2195.560887822434;2197.3847322749657;2237.966430503544;2239.54089411671;2212.4468882779306;2222.677711731798;2227.498812767131;2238.2166241815316;2287.576798292313;2172.6089303925287;2174.1520806885246;2178.0743184146754;2178.0852042142337;2180.4221881201493;2101;2186.4424571734107;2195.2865318771305;2199.373178644079;2234.888255587214;9033.141851524095;9246.445213287157;9301.302402319785;9352.625894964192;9391.389559678599;5106;5209.557187639055;5210.557102646242;5210.66130701507;5214.634975551713;3240.990585836796;3341.3317336532546;3397.881074162417;3417.1627951152127;3418;1073.9194560407923;1087.9401632910187;1090.4765712457986;1113.8607674040745;1118.3737107219902;12816.949288113858;12845.807312890314;12846.743065138739;12902.54841080567;12917.935410322982;4369.4101296325225;4451.265541185668;4452.042810795694;4462.375267462493;4603.792829322689;9942.055504727039;9974.102330790118;9975.800483990279;9982.401055936667;9987.900120998696;5173.63784535079;5226.242194881797;5234.0840352938085;5235.083860324428;5236.973815130977;4406.669499787528;4478.552144785495;4862.562369386701;4868.732219727878;5022.874428139253;3748.325301445766;3776.263628592398;3861.5945325740954;3868.284367391985;3934.075492259317;1121.2991880074953;1139.3107170162098;1141.2695874640237;1153.140910022039;1154.163231657042;919.7056941778567;944.2398868910593;944.5891037398753;957.7318350861769;963.1909196275162;5776.711164441761;5822.3304320003745;5847.06446968483;5913.201717768046;5941.435563621449;438.88588966868207;445.60786507872865;446.22134375514287;456.80357446297745;459.0566386076578;4050.5139383274195;4110.897227569335;4142.565030671796;4265.3815196796295;4280.892977675583;11074;11625.76748465026;11630.709232269091;11640;11652.825207621892;11556.94221528887;11569.710757231136;11606.535738570532;11609.535618575332;11624.767504649859;8064.879026814485;8465.619047142893;8480.236778689825;8498.362622803192;8674.609642565974;6128.816135515942;6302.558820882494;6322.114903913363;6368.872622547616;6431.549791514549;10421.791564168523;10507.89492105069;10795.29830561011;10805.729856753644;10846.078083363003;10891.891081089088;10915.617953371593;10994.450277485934;11280.09759219277;11326.093912486816;8191.426600137933;8258.504489730636;8326.167383261867;8342.29090527312;8353;8475.279601233964;8759.781005474659;8805.559722014003;8878.778030549289;8885.777855553662;7988.281054705104;8012.439129260896;8021.598920053857;8068.273855353046;8323.791905202419;7902;7909.841803164019;7992.84014319722;8052.959735201286;8061.113277539584;7335.3398194160645;7416;7417.777466676009;7420.6660700269695;7423.665935033045;5099.107656160231;5147.187205363624;5188.457655748732;5310.946890531045;5313.787448502017;4815.22956327;4835.782389792538;4890.657653964331;4896.436909755424;4976.776045077908 20:33:42 INFO - PROCESS | 17932 | |4;prototype.html;316.8257458397882;319.2242849874804;324.4905498367564;327.3845171078372;327.43517432429064;5169.974150129249;5214.608904332176;5225.425203227652;5227.9738601307035;5250.894982100361;5194;5195.974020129904;5223.876866473707;5239.449857764937;5268.1834315681035;4045.6965727570405;4102.753834769908;4108.609682080205;4120.546739858628;4164.354525048607;4078.6125318094732;4090.2637525245445;4102.856400025999;4108.67130629549;4122.793860306988;4014.879553613396;4031.979840100795;4050.250703619825;4069.9186016279655;4080.1635664688815;3858.498395208605;3934.5081864766903;4046.433499310114;4056.898577535556;4063.1873625274766;3550;3557.217412169319;3562.5724913010345;3584.5698516177963;3589.6589823966942;5069.670471419346;5073.898522029539;5085;5102.872428189288;5136.510411980521;4388.824447022115;4452.243118669834;4527.1624749421135;4528.50186479487;4678.7660616969015;5343.812966546152;5344.225087362311;5356.91964620531;5359.651622644516;5368.70472124033;3840.865569705075;3853.479780229661;3855.61443855615;3855.9588910994157;3883.922321553553;5474.808381706621;5603.887922241533;5615.438456154393;5630.5495560355075;5668.943310566924;4026.2350153470748;4049;4056.634902858757;4065.1869626074313;4065.654419374386;4054.878353649336;4117.876463706094;4120.711550191458;4132.524759652619;4148.771817550064;4540.477845047796;4634.265783187868;4648.349231107648;4674.368960190399;4684.367610372624;5360.517553420133;5367.382750983609;5401.243825864382;5453.509184173444;5458.50873421386;1372.4647387518876;1397.4829313154198;1420.666143456287;1434.0965191929226;1435.4258296681412;885.1193062902324;920.5443305563789;922.5433410461865;932.5011119051275;938.474454305591;4618.49196588375;4645.767711614406;4671.696339737906;4673.359551853192;4701.95298047022;4912.828051018198;4912.975435122873;4940.777665005084;4947.960928205045;4960.156773348539;4704.764761761899;4710.599599034052;4717.95282047182;4751.287306903992;4941.48114447985;2948.2187220386613;2951.7638588913264;2958.275222570484;2973.658029326612;2995.7603391729044;5743.971280143573;5749.195112684228;5752.9424705753245;5756.827295181151;5770.278715160605;5572.773989722255;5740.6268592541355;5753.993051216021;5775.4983704236365;5813.651180929073;5668.234788303609;5751.1085781703905;5757.934782065331;5799.536037117021;5824.708764561755;5312.787488500417;5584.581156413204;5600.943990560042;5615.241942337732;5617.651763576794;5452.291202143696;5490.258815059916;5510.448955104457;5513.117901135799;5536.947979883809;5673.205751194919;5745.420009497421;5772.365039845529;5781.219535362672;5790.247267855152;3696.9815150924073;3933.822977965941;3966.662833659171;3974.6621537168508;3976.5426975896985;5487.094629386106;5515.696636685021;5558.777648893999;5564.360098588552;5567.944320556905;5320.44135365781;5370.758315875717;5398.514133727984;5415.729213539386;5427.3215848019;5198.518422249641;5384.353877534721;5422.322209723785;5497.422770609029;5499.450054994469;5256.264123022704;5274.525292723673;5299.761510731949;5319.654222475527;5321.201819727072;5234.214867769865;5249.031613145071;5427.864303392446;5431.891362172655;5502.422245664307;5304.204369344629;5310.150375939831;5326.334208223972;5338.092524270805;5344.438833922382 20:33:42 INFO - PROCESS | 17932 | |5;yui.html;773.6229511469585;798.9400794940381;813.3005615170952;833.3374966901315;833.7332053742805;15103.697926041472;16531.58671033225;16538.751918721213;16561.585960350996;16571.66856662869;14700.705985880302;14971;15039.24803759813;15126.243687815593;15163.92418037911;806.6974884418344;823.4071468542639;825.896762904637;829.854775414303;831.1231650608605;676.8307923019245;801.1107670485757;816.6406781016334;823.6046697585163;825.6078362777663;869.7912500999746;871.8082021955191;872.1888643561485;872.358816270041;873.0396563779823;706.8020954132851;860.3547339495378;860.4321148042293;860.5181098584782;861.9484229240317;605.0440304319209;622.7913648927615;629.7953165221276;630.7886857902608;634.5050860328951;13939.651508712263;13946.860531394657;13952;13968.930155349159;14013.509527166601;13146.86853131466;13522.729545409036;13632.113912595649;14090.013699041072;14173.503927362595;12360.258384496869;12601.243925364508;12629.494820207181;12674.176178548458;12833.743325133444;4374.58441448062;4499.527549607277;4558.658100642465;4581.404417425747;4599.5400459953735;71584.28415715828;72074.27925720728;72399;72611;72940.27059729389;10814.35113893169;10925.672229833117;10936;11126.404340847945;11209.495572699248;18095.185716642784;18196;18198.363057292932;18226.81773182278;18240.817591824176;8343;8672.392932494791;8848.513331766686;8848.867266990872;8898.73303800887;4793.376861008047;4801.18379875415;4922.606191504671;4980.9252861207115;5092.981403719271;3331.6501767314085;3387;3400.778949368283;3409.062507810372;3431.828408579611;594.3284088979512;598.8293336399105;599.2226032340049;605.0651743056987;610.1671218786413;576.7519966414399;616.5221952986382;627.3726273726273;651.3779340729592;688.2051230828401;9195.218406435528;9195.770105747277;9317.953410232905;9565.569549370155;9829.164521015651;654.711926752237;662.215274899246;665.5906617430245;668.5854770042605;699.0807088678372;4693.741844198602;4743.1225223333795;4797.4482934462285;4807.759612019385;4809.326694262806;103950;107647;107844.46077769561;109095.45452272688;112068;96572;97229;98182;98307;98353;53878.73060634672;56805;57479;82395.5880220595;85559;8958;8979.775505612412;9014.368994170345;9039.954800225956;9095.226905713089;49699.254511183084;49918.251226232365;50314;50395;50593.494065058876;43306.13387732165;46014.309785353915;52230.738846305525;72536.37318134178;73760;10941.781164376827;11137.944310278397;11186.440677966231;11199.272047316897;11560.6531804046;12253.816192756938;12509.812352814533;12584.40092667729;12628.936855315664;12994.545190918272;11478.368689721812;11589.536418543164;11624.360660163435;11774.52901883915;11860.881391185978;11270.718232043937;11468.770624587294;11531.654050378502;11561.768764624829;11693.298402095901;11493.597724079616;11669;12196.207246528948;12597;12642.115051946275;9864.35881667718;10007.749806254902;10049.196064314983;10219.7445063874;10453.111485523816;9677.37097088687;10106.7862540569;10277.383356998604;10283.177345812466;10342.32774869631 20:33:42 INFO - PROCESS | 17932 | __end_tp_report 20:33:42 INFO - PROCESS | 17932 | __start_cc_report 20:33:42 INFO - PROCESS | 17932 | _x_x_mozilla_cycle_collect,1005 20:33:42 INFO - PROCESS | 17932 | __end_cc_report 20:33:42 INFO - PROCESS | 17932 | __startTimestamp1466998422085__endTimestamp 20:33:42 INFO - PROCESS | 17932 | 20:33:42 INFO - PROCESS | 17932 | ------- Summary: start ------- 20:33:42 INFO - PROCESS | 17932 | Number of tests: 6 20:33:42 INFO - PROCESS | 17932 | 20:33:42 INFO - PROCESS | 17932 | [#0] dojo.html Cycles:165 Average:5287.48 Median:5470.56 stddev:606.89 (11.1%) stddev-sans-first:582.37 20:33:42 INFO - PROCESS | 17932 | Values: 3031.0 3050.8 3053.1 3091.0 3111.6 5169.7 5240.1 5242.5 5313.2 5354.0 5281.6 5317.9 5321.0 5321.8 5339.3 4741.9 4843.3 4843.7 4846.5 5024.5 4915.4 4921.3 4945.5 4996.3 5016.0 4746.8 4774.7 4788.4 4834.2 4837.0 4756.2 4757.5 4759.7 4775.5 4858.2 4778.9 4805.5 4818.4 4829.7 4874.2 5199.4 5217.0 5286.1 5298.3 5348.5 5652.0 5676.7 5701.9 5705.2 5727.3 5762.0 5774.0 5784.4 5786.6 5787.6 5251.8 5355.3 5409.7 5416.8 5435.3 5925.5 5984.9 5985.4 5991.5 5997.1 5439.7 5741.6 5747.7 5748.9 5749.1 5687.9 5743.2 5756.5 5786.2 5837.2 5752.4 5753.2 5754.8 5759.0 5765.7 5546.5 5623.1 5777.5 5781.7 5788.4 4322.2 4326.5 4346.6 4387.0 4389.8 3871.1 3885.0 3898.8 3899.2 3928.9 5233.6 5246.9 5291.7 5423.8 5464.6 5595.6 5634.2 5641.0 5641.6 5666.1 5316.4 5317.3 5317.8 5319.5 5327.9 4800.0 4830.2 4868.1 4869.1 4901.1 5777.9 5855.5 5858.1 5869.2 5924.3 5693.2 5695.8 5704.3 5705.1 5706.4 5608.1 5740.6 5786.6 5850.1 5856.6 5541.4 5592.6 5592.7 5606.9 5650.1 5671.8 5708.6 5713.4 5720.9 5725.5 5439.7 5491.9 5516.8 5564.3 5565.3 5564.1 5566.9 5567.4 5569.4 5570.9 5443.1 5472.9 5495.2 5496.5 5549.1 5457.1 5537.9 5578.3 5581.4 5632.5 5440.0 5464.1 5466.3 5470.6 5486.5 20:33:42 INFO - PROCESS | 17932 | 20:33:42 INFO - PROCESS | 17932 | [#1] ext.html Cycles:180 Average:60575.25 Median:23720.33 stddev:120810.07 (509.3%) stddev-sans-first:121065.04 20:33:42 INFO - PROCESS | 17932 | Values: 593.2 609.6 622.4 637.6 641.8 30270.8 43037.4 44101.8 44117.0 44206.9 45321.8 45817.3 45911.5 45923.3 46002.8 8996.8 9137.9 9147.6 9149.5 9150.3 8936.2 9025.5 9034.0 9043.3 9043.9 9056.6 9131.4 9136.2 9138.1 9138.2 9007.5 9028.0 9036.1 9057.7 9065.3 9036.4 9114.8 9115.3 9117.0 9120.5 42427.6 43169.0 43174.0 43240.8 43268.1 3602.2 3690.0 3696.6 3952.9 4304.3 31465.0 33180.7 33810.3 33857.8 34887.3 4458.8 4575.1 4593.8 4680.7 4727.0 345338.0 349464.0 351685.0 351704.0 353286.0 62778.0 63893.0 64018.0 64064.0 64071.4 49043.5 49365.0 49417.0 49467.0 49682.0 17115.2 17232.8 17270.2 17279.4 17302.0 13052.2 13105.4 13118.0 13145.7 13151.0 18726.8 20150.8 20435.3 20485.5 20530.9 6001.0 7238.3 7314.7 7370.7 7674.8 941.2 1013.7 1020.6 1063.7 1110.5 33152.5 33296.0 33301.5 33367.7 33972.5 1069.4 1093.3 1179.5 1211.5 1227.8 17517.8 17594.4 17646.9 17811.6 17818.0 604030.0 617287.0 619278.0 619877.0 621593.0 59011.0 59699.7 59715.7 59738.7 59757.0 1222.6 1324.2 1374.3 1386.9 1397.8 32680.2 33744.0 33898.3 34000.1 34194.5 50856.5 51285.0 51310.5 51315.7 51438.5 338271.0 339090.0 342660.0 343024.0 344602.0 37449.3 42227.0 43415.0 43857.8 44013.8 48109.3 48275.3 49025.8 49539.0 50098.7 39714.6 41394.6 43136.4 44180.3 44234.0 40694.0 41360.4 41818.2 41837.8 42552.4 41761.6 42612.4 42800.0 42892.1 42999.6 36751.3 37757.3 37900.2 37932.2 38089.0 28180.5 28989.9 29211.4 29313.9 29428.4 20:33:42 INFO - PROCESS | 17932 | 20:33:42 INFO - PROCESS | 17932 | [#2] jquery.html Cycles:180 Average:28679.34 Median:2490.49 stddev:77527.48 (3112.9%) stddev-sans-first:77715.85 20:33:42 INFO - PROCESS | 17932 | Values: 383.2 386.6 387.2 394.0 409.5 14217.9 16549.5 18084.2 19662.8 19797.7 15080.2 15268.0 17938.6 18271.8 18294.4 5388.2 5760.9 5769.9 5769.9 5771.0 3904.9 5622.8 5663.4 5753.1 5755.9 5974.1 6325.9 6326.7 6331.7 6336.5 6254.0 6263.9 6313.7 6322.1 6367.8 5663.5 5683.7 5684.9 5698.7 5708.3 21350.3 21745.0 22547.8 22791.8 22798.7 2156.2 2434.1 2443.6 2537.4 2590.2 9808.4 9870.6 10061.1 10087.7 10628.7 1763.3 1831.0 1855.2 1858.3 1927.9 76986.0 79963.2 80070.6 80555.2 81917.2 10729.9 10749.1 10795.7 11024.0 11258.7 14892.4 14920.9 14982.9 14983.1 14999.1 6768.1 7643.5 9462.0 9827.5 9856.1 8190.6 8290.5 8545.4 8560.0 8845.2 8565.7 8577.6 8662.7 8679.8 8779.6 3112.7 3197.9 3297.4 3368.5 3661.0 875.6 929.7 975.9 1045.7 1069.1 18238.3 18365.4 18416.9 18919.2 19490.5 978.6 1000.9 1014.8 1062.3 1074.9 8811.0 10437.0 10709.1 10861.2 10869.6 461932.0 465800.0 469296.0 475343.0 477825.0 89711.0 92920.5 92962.0 93106.5 93295.0 983.2 986.1 1002.8 1002.8 1005.7 16406.9 16660.8 16921.3 17119.8 17360.0 40714.8 40902.6 41318.2 41461.0 41624.2 48302.3 60006.4 60644.7 61031.7 61348.0 11624.5 12087.2 12669.9 12770.5 13007.0 13471.0 13738.4 13743.4 13919.8 13990.9 11755.6 11866.3 11961.8 12258.3 12552.3 11726.7 12031.6 12164.9 12241.1 12441.6 11991.2 12303.6 12555.6 12675.7 12982.4 12406.1 12528.3 12548.7 12714.9 12792.9 8306.7 8632.5 9066.0 12480.7 12784.5 20:33:42 INFO - PROCESS | 17932 | 20:33:42 INFO - PROCESS | 17932 | [#3] mootools.html Cycles:180 Average:5915.74 Median:2531.42 stddev:3544.58 (140.0%) stddev-sans-first:3537.25 20:33:42 INFO - PROCESS | 17932 | Values: 1259.5 1460.4 1479.4 1542.7 1730.6 8092.5 8864.5 9115.7 9118.3 9432.7 8772.6 8939.1 8951.2 8968.5 8999.5 1969.8 1997.8 1999.4 1999.6 2002.2 2189.5 2195.6 2197.4 2238.0 2239.5 2212.4 2222.7 2227.5 2238.2 2287.6 2172.6 2174.2 2178.1 2178.1 2180.4 2101.0 2186.4 2195.3 2199.4 2234.9 9033.1 9246.4 9301.3 9352.6 9391.4 5106.0 5209.6 5210.6 5210.7 5214.6 3241.0 3341.3 3397.9 3417.2 3418.0 1073.9 1087.9 1090.5 1113.9 1118.4 12816.9 12845.8 12846.7 12902.5 12917.9 4369.4 4451.3 4452.0 4462.4 4603.8 9942.1 9974.1 9975.8 9982.4 9987.9 5173.6 5226.2 5234.1 5235.1 5237.0 4406.7 4478.6 4862.6 4868.7 5022.9 3748.3 3776.3 3861.6 3868.3 3934.1 1121.3 1139.3 1141.3 1153.1 1154.2 919.7 944.2 944.6 957.7 963.2 5776.7 5822.3 5847.1 5913.2 5941.4 438.9 445.6 446.2 456.8 459.1 4050.5 4110.9 4142.6 4265.4 4280.9 11074.0 11625.8 11630.7 11640.0 11652.8 11556.9 11569.7 11606.5 11609.5 11624.8 8064.9 8465.6 8480.2 8498.4 8674.6 6128.8 6302.6 6322.1 6368.9 6431.5 10421.8 10507.9 10795.3 10805.7 10846.1 10891.9 10915.6 10994.5 11280.1 11326.1 8191.4 8258.5 8326.2 8342.3 8353.0 8475.3 8759.8 8805.6 8878.8 8885.8 7988.3 8012.4 8021.6 8068.3 8323.8 7902.0 7909.8 7992.8 8053.0 8061.1 7335.3 7416.0 7417.8 7420.7 7423.7 5099.1 5147.2 5188.5 5310.9 5313.8 4815.2 4835.8 4890.7 4896.4 4976.8 20:33:42 INFO - PROCESS | 17932 | 20:33:42 INFO - PROCESS | 17932 | [#4] prototype.html Cycles:180 Average:4531.82 Median:5181.99 stddev:1321.49 (25.5%) stddev-sans-first:1286.77 20:33:42 INFO - PROCESS | 17932 | Values: 316.8 319.2 324.5 327.4 327.4 5170.0 5214.6 5225.4 5228.0 5250.9 5194.0 5196.0 5223.9 5239.4 5268.2 4045.7 4102.8 4108.6 4120.5 4164.4 4078.6 4090.3 4102.9 4108.7 4122.8 4014.9 4032.0 4050.3 4069.9 4080.2 3858.5 3934.5 4046.4 4056.9 4063.2 3550.0 3557.2 3562.6 3584.6 3589.7 5069.7 5073.9 5085.0 5102.9 5136.5 4388.8 4452.2 4527.2 4528.5 4678.8 5343.8 5344.2 5356.9 5359.7 5368.7 3840.9 3853.5 3855.6 3856.0 3883.9 5474.8 5603.9 5615.4 5630.5 5668.9 4026.2 4049.0 4056.6 4065.2 4065.7 4054.9 4117.9 4120.7 4132.5 4148.8 4540.5 4634.3 4648.3 4674.4 4684.4 5360.5 5367.4 5401.2 5453.5 5458.5 1372.5 1397.5 1420.7 1434.1 1435.4 885.1 920.5 922.5 932.5 938.5 4618.5 4645.8 4671.7 4673.4 4702.0 4912.8 4913.0 4940.8 4948.0 4960.2 4704.8 4710.6 4718.0 4751.3 4941.5 2948.2 2951.8 2958.3 2973.7 2995.8 5744.0 5749.2 5752.9 5756.8 5770.3 5572.8 5740.6 5754.0 5775.5 5813.7 5668.2 5751.1 5757.9 5799.5 5824.7 5312.8 5584.6 5600.9 5615.2 5617.7 5452.3 5490.3 5510.4 5513.1 5536.9 5673.2 5745.4 5772.4 5781.2 5790.2 3697.0 3933.8 3966.7 3974.7 3976.5 5487.1 5515.7 5558.8 5564.4 5567.9 5320.4 5370.8 5398.5 5415.7 5427.3 5198.5 5384.4 5422.3 5497.4 5499.5 5256.3 5274.5 5299.8 5319.7 5321.2 5234.2 5249.0 5427.9 5431.9 5502.4 5304.2 5310.2 5326.3 5338.1 5344.4 20:33:42 INFO - PROCESS | 17932 | 20:33:42 INFO - PROCESS | 17932 | [#5] yui.html Cycles:180 Average:19018.43 Median:4808.54 stddev:27406.06 (569.9%) stddev-sans-first:27448.70 20:33:42 INFO - PROCESS | 17932 | Values: 773.6 798.9 813.3 833.3 833.7 15103.7 16531.6 16538.8 16561.6 16571.7 14700.7 14971.0 15039.2 15126.2 15163.9 806.7 823.4 825.9 829.9 831.1 676.8 801.1 816.6 823.6 825.6 869.8 871.8 872.2 872.4 873.0 706.8 860.4 860.4 860.5 861.9 605.0 622.8 629.8 630.8 634.5 13939.7 13946.9 13952.0 13968.9 14013.5 13146.9 13522.7 13632.1 14090.0 14173.5 12360.3 12601.2 12629.5 12674.2 12833.7 4374.6 4499.5 4558.7 4581.4 4599.5 71584.3 72074.3 72399.0 72611.0 72940.3 10814.4 10925.7 10936.0 11126.4 11209.5 18095.2 18196.0 18198.4 18226.8 18240.8 8343.0 8672.4 8848.5 8848.9 8898.7 4793.4 4801.2 4922.6 4980.9 5093.0 3331.7 3387.0 3400.8 3409.1 3431.8 594.3 598.8 599.2 605.1 610.2 576.8 616.5 627.4 651.4 688.2 9195.2 9195.8 9318.0 9565.6 9829.2 654.7 662.2 665.6 668.6 699.1 4693.7 4743.1 4797.4 4807.8 4809.3 103950.0 107647.0 107844.5 109095.5 112068.0 96572.0 97229.0 98182.0 98307.0 98353.0 53878.7 56805.0 57479.0 82395.6 85559.0 8958.0 8979.8 9014.4 9040.0 9095.2 49699.3 49918.3 50314.0 50395.0 50593.5 43306.1 46014.3 52230.7 72536.4 73760.0 10941.8 11137.9 11186.4 11199.3 11560.7 12253.8 12509.8 12584.4 12628.9 12994.5 11478.4 11589.5 11624.4 11774.5 11860.9 11270.7 11468.8 11531.7 11561.8 11693.3 11493.6 11669.0 12196.2 12597.0 12642.1 9864.4 10007.7 10049.2 10219.7 10453.1 9677.4 10106.8 10277.4 10283.2 10342.3 20:33:42 INFO - PROCESS | 17932 | -------- Summary: end -------- 20:33:42 INFO - PROCESS | 17932 | 20:33:42 INFO - TEST-INFO | 17932: exit 0 20:33:42 INFO - TEST-OK | dromaeo_css | took 1113396ms 20:33:42 INFO - TEST-START | kraken 20:33:42 INFO - operating with platform_type : linux_ 20:33:42 INFO - Initialising browser for kraken test... 20:33:42 INFO - TEST-INFO | started process 18119 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp24rFC6/profile http://localhost:60164/getInfo.html) 20:33:47 INFO - PROCESS | 18119 | __metrics Screen width/height:1600/1200 20:33:47 INFO - PROCESS | 18119 | colorDepth:24 20:33:47 INFO - PROCESS | 18119 | Browser inner width/height: 1024/697 20:33:47 INFO - PROCESS | 18119 | __metrics 20:33:47 INFO - PROCESS | 18119 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:33:48 INFO - PROCESS | 18119 | console.error: PushService: 20:33:48 INFO - PROCESS | 18119 | stateChangeProcessEnqueue: Error transitioning state 20:33:48 INFO - PROCESS | 18119 | UnknownError 20:33:48 INFO - TEST-INFO | 18119: exit 0 20:33:48 INFO - Browser initialized. 20:33:48 INFO - Running cycle 1/1 for kraken test... 20:33:48 INFO - TEST-INFO | started process 18203 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp24rFC6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:34:00 INFO - PROCESS | 18203 | RSS: Main: 174395392 20:34:00 INFO - PROCESS | 18203 | 20:34:03 INFO - PROCESS | 18203 | Cycle 1(1): loaded http://localhost:60164/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60164/tests/kraken/driver.html?testName=audio-beat-detection) 20:34:04 INFO - PROCESS | 18203 | RSS: Main: 231567360 20:34:04 INFO - PROCESS | 18203 | 20:34:06 INFO - PROCESS | 18203 | Cycle 1(1): loaded http://localhost:60164/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60164/tests/kraken/driver.html?testName=audio-dft) 20:34:07 INFO - PROCESS | 18203 | RSS: Main: 216588288 20:34:07 INFO - PROCESS | 18203 | 20:34:10 INFO - PROCESS | 18203 | Cycle 1(1): loaded http://localhost:60164/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60164/tests/kraken/driver.html?testName=audio-fft) 20:34:11 INFO - PROCESS | 18203 | RSS: Main: 286253056 20:34:11 INFO - PROCESS | 18203 | 20:34:13 INFO - PROCESS | 18203 | Cycle 1(1): loaded http://localhost:60164/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60164/tests/kraken/driver.html?testName=audio-oscillator) 20:34:13 INFO - PROCESS | 18203 | RSS: Main: 195887104 20:34:13 INFO - PROCESS | 18203 | 20:34:16 INFO - PROCESS | 18203 | Cycle 1(1): loaded http://localhost:60164/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60164/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:34:16 INFO - PROCESS | 18203 | RSS: Main: 200523776 20:34:16 INFO - PROCESS | 18203 | 20:34:19 INFO - PROCESS | 18203 | Cycle 1(1): loaded http://localhost:60164/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60164/tests/kraken/driver.html?testName=imaging-darkroom) 20:34:20 INFO - PROCESS | 18203 | RSS: Main: 235462656 20:34:20 INFO - PROCESS | 18203 | 20:34:23 INFO - PROCESS | 18203 | Cycle 1(1): loaded http://localhost:60164/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60164/tests/kraken/driver.html?testName=imaging-desaturate) 20:34:24 INFO - PROCESS | 18203 | RSS: Main: 237273088 20:34:24 INFO - PROCESS | 18203 | 20:34:27 INFO - PROCESS | 18203 | Cycle 1(1): loaded http://localhost:60164/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60164/tests/kraken/driver.html?testName=json-parse-financial) 20:34:27 INFO - PROCESS | 18203 | RSS: Main: 237756416 20:34:27 INFO - PROCESS | 18203 | 20:34:29 INFO - PROCESS | 18203 | Cycle 1(1): loaded http://localhost:60164/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60164/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:34:29 INFO - PROCESS | 18203 | RSS: Main: 225304576 20:34:29 INFO - PROCESS | 18203 | 20:34:31 INFO - PROCESS | 18203 | Cycle 1(1): loaded http://localhost:60164/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60164/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:34:32 INFO - PROCESS | 18203 | RSS: Main: 229986304 20:34:32 INFO - PROCESS | 18203 | 20:34:34 INFO - PROCESS | 18203 | Cycle 1(1): loaded http://localhost:60164/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60164/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:34:34 INFO - PROCESS | 18203 | RSS: Main: 235876352 20:34:34 INFO - PROCESS | 18203 | 20:34:37 INFO - PROCESS | 18203 | Cycle 1(1): loaded http://localhost:60164/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60164/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:34:38 INFO - PROCESS | 18203 | RSS: Main: 238047232 20:34:38 INFO - PROCESS | 18203 | 20:34:40 INFO - PROCESS | 18203 | Cycle 1(1): loaded http://localhost:60164/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60164/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:34:41 INFO - PROCESS | 18203 | RSS: Main: 234528768 20:34:41 INFO - PROCESS | 18203 | 20:34:43 INFO - PROCESS | 18203 | Cycle 1(1): loaded http://localhost:60164/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60164/tests/kraken/driver.html?testName=ai-astar) 20:34:43 INFO - PROCESS | 18203 | RSS: Main: 276918272 20:34:43 INFO - PROCESS | 18203 | 20:34:43 INFO - PROCESS | 18203 | __start_tp_report 20:34:43 INFO - PROCESS | 18203 | _x_x_mozilla_page_load 20:34:43 INFO - PROCESS | 18203 | _x_x_mozilla_page_load_details 20:34:43 INFO - PROCESS | 18203 | |i|pagename|runs| 20:34:43 INFO - PROCESS | 18203 | |0;ai-astar;100;111;110;110;111;109;109;111;109;110 20:34:43 INFO - PROCESS | 18203 | |1;audio-beat-detection;161;125;131;189;125;127;126;155;157;125 20:34:43 INFO - PROCESS | 18203 | |2;audio-dft;162;160;160;161;159;160;163;164;162;161 20:34:43 INFO - PROCESS | 18203 | |3;audio-fft;74;73;75;109;77;77;75;74;98;75 20:34:43 INFO - PROCESS | 18203 | |4;audio-oscillator;85;84;109;85;86;85;122;85;85;121 20:34:43 INFO - PROCESS | 18203 | |5;imaging-gaussian-blur;117;117;116;117;117;117;118;118;117;117 20:34:43 INFO - PROCESS | 18203 | |6;imaging-darkroom;146;147;146;147;147;145;146;146;150;146 20:34:43 INFO - PROCESS | 18203 | |7;imaging-desaturate;95;96;96;96;96;96;95;95;96;95 20:34:43 INFO - PROCESS | 18203 | |8;json-parse-financial;54;53;54;55;53;54;55;54;54;54 20:34:43 INFO - PROCESS | 18203 | |9;json-stringify-tinderbox;62;62;63;62;63;63;63;61;62;61 20:34:43 INFO - PROCESS | 18203 | |10;stanford-crypto-aes;78;78;82;82;77;80;81;80;89;81 20:34:43 INFO - PROCESS | 18203 | |11;stanford-crypto-ccm;123;134;121;125;132;126;121;124;133;141 20:34:43 INFO - PROCESS | 18203 | |12;stanford-crypto-pbkdf2;165;163;161;159;160;161;159;163;166;163 20:34:43 INFO - PROCESS | 18203 | |13;stanford-crypto-sha256-iterative;63;63;64;64;63;65;64;67;63;63 20:34:43 INFO - PROCESS | 18203 | __end_tp_report 20:34:43 INFO - PROCESS | 18203 | __start_cc_report 20:34:43 INFO - PROCESS | 18203 | _x_x_mozilla_cycle_collect,1650 20:34:43 INFO - PROCESS | 18203 | __end_cc_report 20:34:43 INFO - PROCESS | 18203 | __startTimestamp1466998483359__endTimestamp 20:34:43 INFO - PROCESS | 18203 | 20:34:43 INFO - PROCESS | 18203 | ------- Summary: start ------- 20:34:43 INFO - PROCESS | 18203 | Number of tests: 14 20:34:43 INFO - PROCESS | 18203 | 20:34:43 INFO - PROCESS | 18203 | [#0] ai-astar Cycles:10 Average:109.00 Median:110.00 stddev:3.27 (3.0%) stddev-sans-first:0.87 20:34:43 INFO - PROCESS | 18203 | Values: 100.0 111.0 110.0 110.0 111.0 109.0 109.0 111.0 109.0 110.0 20:34:43 INFO - PROCESS | 18203 | 20:34:43 INFO - PROCESS | 18203 | [#1] audio-beat-detection Cycles:10 Average:142.10 Median:143.00 stddev:22.19 (15.5%) stddev-sans-first:22.46 20:34:43 INFO - PROCESS | 18203 | Values: 161.0 125.0 131.0 189.0 125.0 127.0 126.0 155.0 157.0 125.0 20:34:43 INFO - PROCESS | 18203 | 20:34:43 INFO - PROCESS | 18203 | [#2] audio-dft Cycles:10 Average:161.20 Median:161.50 stddev:1.55 (1.0%) stddev-sans-first:1.62 20:34:43 INFO - PROCESS | 18203 | Values: 162.0 160.0 160.0 161.0 159.0 160.0 163.0 164.0 162.0 161.0 20:34:43 INFO - PROCESS | 18203 | 20:34:43 INFO - PROCESS | 18203 | [#3] audio-fft Cycles:10 Average:80.70 Median:75.00 stddev:12.36 (16.5%) stddev-sans-first:12.87 20:34:43 INFO - PROCESS | 18203 | Values: 74.0 73.0 75.0 109.0 77.0 77.0 75.0 74.0 98.0 75.0 20:34:43 INFO - PROCESS | 18203 | 20:34:43 INFO - PROCESS | 18203 | [#4] audio-oscillator Cycles:10 Average:94.70 Median:85.00 stddev:15.99 (18.8%) stddev-sans-first:16.57 20:34:43 INFO - PROCESS | 18203 | Values: 85.0 84.0 109.0 85.0 86.0 85.0 122.0 85.0 85.0 121.0 20:34:43 INFO - PROCESS | 18203 | 20:34:43 INFO - PROCESS | 18203 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 20:34:43 INFO - PROCESS | 18203 | Values: 117.0 117.0 116.0 117.0 117.0 117.0 118.0 118.0 117.0 117.0 20:34:43 INFO - PROCESS | 18203 | 20:34:43 INFO - PROCESS | 18203 | [#6] imaging-darkroom Cycles:10 Average:146.60 Median:146.50 stddev:1.35 (0.9%) stddev-sans-first:1.41 20:34:43 INFO - PROCESS | 18203 | Values: 146.0 147.0 146.0 147.0 147.0 145.0 146.0 146.0 150.0 146.0 20:34:43 INFO - PROCESS | 18203 | 20:34:43 INFO - PROCESS | 18203 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.52 (0.5%) stddev-sans-first:0.50 20:34:43 INFO - PROCESS | 18203 | Values: 95.0 96.0 96.0 96.0 96.0 96.0 95.0 95.0 96.0 95.0 20:34:43 INFO - PROCESS | 18203 | 20:34:43 INFO - PROCESS | 18203 | [#8] json-parse-financial Cycles:10 Average:54.00 Median:54.00 stddev:0.67 (1.2%) stddev-sans-first:0.71 20:34:43 INFO - PROCESS | 18203 | Values: 54.0 53.0 54.0 55.0 53.0 54.0 55.0 54.0 54.0 54.0 20:34:43 INFO - PROCESS | 18203 | 20:34:43 INFO - PROCESS | 18203 | [#9] json-stringify-tinderbox Cycles:10 Average:62.20 Median:62.50 stddev:0.79 (1.3%) stddev-sans-first:0.83 20:34:43 INFO - PROCESS | 18203 | Values: 62.0 62.0 63.0 62.0 63.0 63.0 63.0 61.0 62.0 61.0 20:34:43 INFO - PROCESS | 18203 | 20:34:43 INFO - PROCESS | 18203 | [#10] stanford-crypto-aes Cycles:10 Average:80.80 Median:81.00 stddev:3.36 (4.1%) stddev-sans-first:3.41 20:34:43 INFO - PROCESS | 18203 | Values: 78.0 78.0 82.0 82.0 77.0 80.0 81.0 80.0 89.0 81.0 20:34:43 INFO - PROCESS | 18203 | 20:34:43 INFO - PROCESS | 18203 | [#11] stanford-crypto-ccm Cycles:10 Average:128.00 Median:129.00 stddev:6.65 (5.2%) stddev-sans-first:6.80 20:34:43 INFO - PROCESS | 18203 | Values: 123.0 134.0 121.0 125.0 132.0 126.0 121.0 124.0 133.0 141.0 20:34:43 INFO - PROCESS | 18203 | 20:34:43 INFO - PROCESS | 18203 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.00 Median:163.00 stddev:2.40 (1.5%) stddev-sans-first:2.29 20:34:43 INFO - PROCESS | 18203 | Values: 165.0 163.0 161.0 159.0 160.0 161.0 159.0 163.0 166.0 163.0 20:34:43 INFO - PROCESS | 18203 | 20:34:43 INFO - PROCESS | 18203 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.90 Median:64.00 stddev:1.29 (2.0%) stddev-sans-first:1.32 20:34:43 INFO - PROCESS | 18203 | Values: 63.0 63.0 64.0 64.0 63.0 65.0 64.0 67.0 63.0 63.0 20:34:43 INFO - PROCESS | 18203 | -------- Summary: end -------- 20:34:43 INFO - PROCESS | 18203 | 20:34:44 INFO - TEST-INFO | 18203: exit 0 20:34:44 INFO - TEST-OK | kraken | took 61463ms 20:34:44 INFO - SUITE-END | took 1174s 20:34:44 INFO - Completed test suite (00:19:35) 20:34:44 INFO - javascript benchmark 20:34:44 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3031.0452207554617, 3050.8474576271187, 3053.0535533984466, 3090.9690903090964, 3111.564380986661, 5169.663971841827, 5240.109181439155, 5242.528172464477, 5313.203019547065, 5354.009508240978, 5281.63028587999, 5317.9202311965355, 5320.973395133029, 5321.787128514855, 5339.279197308362, 4741.857744267661, 4843.273508973647, 4843.685160464576, 4846.539578740014, 5024.522670346311, 4915.434725006617, 4921.311016457681, 4945.480724523927, 4996.325496058022, 5016.0, 4746.810127594892, 4774.689645173053, 4788.377510923575, 4834.178189707758, 4836.951630483685, 4756.239001759702, 4757.452892917289, 4759.738214398207, 4775.5463230993, 4858.17411040124, 4778.880527986794, 4805.471398146201, 4818.445878723956, 4829.7102173869325, 4874.1713908635265, 5199.376074871002, 5216.9739151304, 5286.101362768339, 5298.337707786527, 5348.491893270133, 5651.9717401413145, 5676.659400435987, 5701.914471282934, 5705.2012718219485, 5727.284089488814, 5761.971190144022, 5774.047282198432, 5784.363719990798, 5786.594938354317, 5787.565932555075, 5251.842444726664, 5355.250264962909, 5409.675419474844, 5416.8104116356135, 5435.2934118564335, 5925.525957923356, 5984.850378740479, 5985.431384018511, 5991.4907232884825, 5997.100434934795, 5439.728013599383, 5741.598088133874, 5747.741351639186, 5748.856278593069, 5749.051406517961, 5687.943120568824, 5743.167240750068, 5756.453136951983, 5786.189933409326, 5837.153612726216, 5752.424757524298, 5753.165790960371, 5754.769809207669, 5759.0, 5765.654060756368, 5546.473085056913, 5623.128415095585, 5777.508911742465, 5781.710914454345, 5788.363280039192, 4322.178786030644, 4326.502452218036, 4346.608805207483, 4386.978065109654, 4389.802458889294, 3871.070942973666, 3884.9805750971063, 3898.8050597470015, 3899.1616802387057, 3928.941065884014, 5233.581313494911, 5246.895062098813, 5291.708956007456, 5423.83728488146, 5464.617476776588, 5595.5523558116065, 5634.211210430543, 5641.012822756002, 5641.605087643826, 5666.093425052054, 5316.441773613715, 5317.30874986257, 5317.760700768475, 5319.46805319465, 5327.866803329948, 4800.0, 4830.227163653799, 4868.050730107595, 4869.074875773592, 4901.068796928572, 5777.8555536111935, 5855.473007429352, 5858.06270996647, 5869.207656966255, 5924.348321684612, 5693.231413759255, 5695.800646977336, 5704.3154821421695, 5705.087186050212, 5706.42935706426, 5608.10270356741, 5740.6268592541355, 5786.623869448473, 5850.0932355484965, 5856.560757943256, 5541.445855414427, 5592.636478628876, 5592.664440133605, 5606.887862242814, 5650.0677388232125, 5671.773129074956, 5708.600397972102, 5713.428657134254, 5720.914186287126, 5725.456081672234, 5439.728013599383, 5491.890162196813, 5516.779328826962, 5564.304461942257, 5565.276514053147, 5564.054110801093, 5566.916496252478, 5567.359753628384, 5569.359523654832, 5570.944290557042, 5443.129099344244, 5472.945270547243, 5495.175723641486, 5496.477834605706, 5549.139883318092, 5457.126859702428, 5537.889242215053, 5578.2748242728185, 5581.386047534849, 5632.5493960482245, 5440.0, 5464.1257398816, 5466.316710411199, 5470.562355011669, 5486.506214440719], "value": 5246.151352531419, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [593.1517929361015, 609.6159419565673, 622.4149299658321, 637.6206157336385, 641.7946257197699, 30270.848645756767, 43037.35443968339, 44101.77949110258, 44117.0, 44206.89482762929, 45321.77339113308, 45817.31274030884, 45911.540884591144, 45923.311150332775, 46002.76998615002, 8996.820063598723, 9137.862932056025, 9147.634094636207, 9149.451032938045, 9150.267978561733, 8936.151065648754, 9025.503597302146, 9033.954830225872, 9043.321750868678, 9043.864342034842, 9056.637734490612, 9131.406458580204, 9136.223421009223, 9138.086191380875, 9138.177564019237, 9007.459552426842, 9028.0, 9036.051214622501, 9057.682981095662, 9065.274778017743, 9036.367454278203, 9114.817703645956, 9115.270778337717, 9117.042710515367, 9120.498372589505, 42427.57572424298, 43169.0, 43174.0, 43240.78379608113, 43268.13463730708, 3602.1534939289245, 3690.0, 3696.6303369663087, 3952.8616498422703, 4304.3113101903855, 31465.0, 33180.668193318, 33810.323793524236, 33857.83071084654, 34887.30225395478, 4458.77706114693, 4575.107853968478, 4593.83921562747, 4680.695754775928, 4726.952730472685, 345338.0, 349464.0, 351685.0, 351704.0, 353286.0, 62778.0, 63893.0, 64018.0, 64064.0, 64071.359286406536, 49043.509564904605, 49365.0, 49417.0, 49467.010659787324, 49682.0, 17115.22981465837, 17232.827671723124, 17270.22283997223, 17279.3952211672, 17302.048387338564, 13052.1516101455, 13105.410256538478, 13118.0, 13145.73708525824, 13151.0, 18726.81273187278, 20150.798492015187, 20435.284765033153, 20485.48786280325, 20530.92036194553, 6000.969995149996, 7238.327372984653, 7314.707411703579, 7370.705171793068, 7674.846503070019, 941.2140862379989, 1013.7313611892854, 1020.5917632946881, 1063.6968463987725, 1110.539126262608, 33152.50271245933, 33296.0, 33301.50047749286, 33367.66632333694, 33972.49041264383, 1069.3690722473777, 1093.3439936038471, 1179.4574495731888, 1211.54567037361, 1227.8403807504967, 17517.824821751874, 17594.38419655306, 17646.91176544109, 17811.554711132325, 17818.0, 604030.0, 617287.0, 619278.0, 619877.0, 621593.0, 59011.0, 59699.70150149308, 59715.70142149262, 59738.70130649319, 59757.0, 1222.57821051737, 1324.2385628263594, 1374.3265799758046, 1386.94452221912, 1397.8462369139386, 32680.182995425304, 33744.0, 33898.322033559685, 34000.14999625029, 34194.48708269428, 50856.491435085176, 51285.0, 51310.48689513207, 51315.743421282656, 51438.48561514487, 338271.0, 339090.0, 342660.0, 343024.0, 344602.0, 37449.251014980095, 42227.0, 43415.0, 43857.78071109624, 44013.77993110142, 48109.278360825316, 48275.275870862664, 49025.754871225414, 49539.0, 50098.749506252236, 39714.60285397109, 41394.58605413907, 43136.35295470508, 44180.337294939956, 44234.0, 40694.0, 41360.37959430551, 41818.16363672649, 41837.79081104575, 42552.361714573686, 41761.58238417577, 42612.36081458843, 42800.0, 42892.14215715606, 42999.57000429956, 36751.26497470089, 37757.28945435797, 37900.2419951605, 37932.2413551733, 38089.0, 28180.472266670557, 28989.855050725455, 29211.415771684024, 29313.85343073271, 29428.411431771674], "value": 20682.889228680233, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [383.248832288714, 386.58442174662247, 387.24680496434434, 394.0118104793317, 409.45746885376883, 14217.854055074675, 16549.503514894543, 18084.186211620476, 19662.803371966274, 19797.703034454476, 15080.170590617512, 15268.0, 17938.551536211602, 18271.817281827178, 18294.359697410593, 5388.245645609618, 5760.9135862961875, 5769.884602307951, 5769.884602307951, 5770.971145144268, 3904.907626107319, 5622.775088996435, 5663.405342439047, 5753.1370294455955, 5755.856103597423, 5974.103884417329, 6325.936740632581, 6326.715297811586, 6331.746730130789, 6336.493080553545, 6253.999999999977, 6263.906041409383, 6313.715882785285, 6322.114903913456, 6367.8408039798915, 5663.461971112738, 5683.687397193153, 5684.886302273972, 5698.715064246812, 5708.315002199721, 21350.252741153985, 21745.0, 22547.77452225473, 22791.77208227913, 22798.65802012971, 2156.2022051840763, 2434.087217293515, 2443.621238708003, 2537.3656585853537, 2590.171145233526, 9808.411495310304, 9870.555824987892, 10061.094501494901, 10087.7478063049, 10628.681139565748, 1763.3387479695114, 1830.9542261443437, 1855.1559040636478, 1858.293848337623, 1927.8554108441783, 76986.0, 79963.20036799675, 80070.59964700197, 80555.19444805535, 81917.18082819156, 10729.89270107289, 10749.140068794477, 10795.730106747395, 11024.0, 11258.718532036764, 14892.404303827941, 14920.850791491946, 14982.925085374503, 14983.101013939198, 14999.100053996795, 6768.120144381199, 7643.503172293783, 9461.952690236505, 9827.459489728133, 9856.112949834549, 8190.5904704764525, 8290.46112002718, 8545.359098067545, 8559.957200214083, 8845.159709827556, 8565.657373705106, 8577.614007369682, 8662.740117796477, 8679.826403471896, 8779.604917778715, 3112.7198552130417, 3197.920051998672, 3297.4229509836164, 3368.461046232591, 3660.9816950915606, 875.5884734174928, 929.7210836749083, 975.9170470509944, 1045.7385653586603, 1069.1019543583272, 18238.27046918135, 18365.357212497765, 18416.907915460604, 18919.243230270637, 19490.5127371814, 978.6183388478499, 1000.9099181073593, 1014.7564584499814, 1062.3254233561745, 1074.854894589236, 8810.955945220232, 10437.0, 10709.08972737326, 10861.1854110942, 10869.565217391215, 461932.0, 465800.0, 469296.0, 475343.0, 477825.0, 89711.0, 92920.53539732394, 92962.0, 93106.53446732859, 93295.0, 983.2281658897731, 986.1075726467558, 1002.754325190333, 1002.7643503776607, 1005.7485628592998, 16406.917965410095, 16660.833391666412, 16921.323147073977, 17119.828801711825, 17360.0, 40714.79642601768, 40902.59097408988, 41318.1736365265, 41461.0, 41624.16751664889, 48302.300109529584, 60006.39993600183, 60644.69677651583, 61031.69484152551, 61348.0, 11624.476898539417, 12087.214331068453, 12669.909464938552, 12770.489180432678, 13007.0, 13471.0, 13738.381772820047, 13743.381547830171, 13919.791203132163, 13990.930045349709, 11755.588554400554, 11866.347350895438, 11961.820572691242, 12258.325792081521, 12552.309622970824, 11726.70683232926, 12031.578894738643, 12164.878351216728, 12241.143119981873, 12441.564545240873, 11991.160618756603, 12303.56937507183, 12555.623331300076, 12675.746485070431, 12982.350882456029, 12406.13157079032, 12528.310942898228, 12548.749025019632, 12714.936425317814, 12792.936035319764, 8306.6677332906, 8632.482051076704, 9066.04806495335, 12480.687982800502, 12784.488620455078], "value": 9680.978989812578, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1259.5213818748873, 1460.437731473383, 1479.3934486860387, 1542.7068856917185, 1730.5673581604592, 8092.514449133057, 8864.512451815148, 9115.68095116671, 9118.270538356932, 9432.717018489438, 8772.561371931393, 8939.061398553156, 8951.239144672694, 8968.461892286467, 8999.460032398061, 1969.7537807774029, 1997.7502812148482, 1999.4101739986738, 1999.6100760351737, 2002.1991203518637, 2189.474526113729, 2195.560887822434, 2197.3847322749657, 2237.966430503544, 2239.54089411671, 2212.4468882779306, 2222.677711731798, 2227.498812767131, 2238.2166241815316, 2287.576798292313, 2172.6089303925287, 2174.1520806885246, 2178.0743184146754, 2178.0852042142337, 2180.4221881201493, 2101.0, 2186.4424571734107, 2195.2865318771305, 2199.373178644079, 2234.888255587214, 9033.141851524095, 9246.445213287157, 9301.302402319785, 9352.625894964192, 9391.389559678599, 5106.0, 5209.557187639055, 5210.557102646242, 5210.66130701507, 5214.634975551713, 3240.990585836796, 3341.3317336532546, 3397.881074162417, 3417.1627951152127, 3418.0, 1073.9194560407923, 1087.9401632910187, 1090.4765712457986, 1113.8607674040745, 1118.3737107219902, 12816.949288113858, 12845.807312890314, 12846.743065138739, 12902.54841080567, 12917.935410322982, 4369.4101296325225, 4451.265541185668, 4452.042810795694, 4462.375267462493, 4603.792829322689, 9942.055504727039, 9974.102330790118, 9975.800483990279, 9982.401055936667, 9987.900120998696, 5173.63784535079, 5226.242194881797, 5234.0840352938085, 5235.083860324428, 5236.973815130977, 4406.669499787528, 4478.552144785495, 4862.562369386701, 4868.732219727878, 5022.874428139253, 3748.325301445766, 3776.263628592398, 3861.5945325740954, 3868.284367391985, 3934.075492259317, 1121.2991880074953, 1139.3107170162098, 1141.2695874640237, 1153.140910022039, 1154.163231657042, 919.7056941778567, 944.2398868910593, 944.5891037398753, 957.7318350861769, 963.1909196275162, 5776.711164441761, 5822.3304320003745, 5847.06446968483, 5913.201717768046, 5941.435563621449, 438.88588966868207, 445.60786507872865, 446.22134375514287, 456.80357446297745, 459.0566386076578, 4050.5139383274195, 4110.897227569335, 4142.565030671796, 4265.3815196796295, 4280.892977675583, 11074.0, 11625.76748465026, 11630.709232269091, 11640.0, 11652.825207621892, 11556.94221528887, 11569.710757231136, 11606.535738570532, 11609.535618575332, 11624.767504649859, 8064.879026814485, 8465.619047142893, 8480.236778689825, 8498.362622803192, 8674.609642565974, 6128.816135515942, 6302.558820882494, 6322.114903913363, 6368.872622547616, 6431.549791514549, 10421.791564168523, 10507.89492105069, 10795.29830561011, 10805.729856753644, 10846.078083363003, 10891.891081089088, 10915.617953371593, 10994.450277485934, 11280.09759219277, 11326.093912486816, 8191.426600137933, 8258.504489730636, 8326.167383261867, 8342.29090527312, 8353.0, 8475.279601233964, 8759.781005474659, 8805.559722014003, 8878.778030549289, 8885.777855553662, 7988.281054705104, 8012.439129260896, 8021.598920053857, 8068.273855353046, 8323.791905202419, 7902.0, 7909.841803164019, 7992.84014319722, 8052.959735201286, 8061.113277539584, 7335.3398194160645, 7416.0, 7417.777466676009, 7420.6660700269695, 7423.665935033045, 5099.107656160231, 5147.187205363624, 5188.457655748732, 5310.946890531045, 5313.787448502017, 4815.22956327, 4835.782389792538, 4890.657653964331, 4896.436909755424, 4976.776045077908], "value": 4546.916870289336, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [316.8257458397882, 319.2242849874804, 324.4905498367564, 327.3845171078372, 327.43517432429064, 5169.974150129249, 5214.608904332176, 5225.425203227652, 5227.9738601307035, 5250.894982100361, 5194.0, 5195.974020129904, 5223.876866473707, 5239.449857764937, 5268.1834315681035, 4045.6965727570405, 4102.753834769908, 4108.609682080205, 4120.546739858628, 4164.354525048607, 4078.6125318094732, 4090.2637525245445, 4102.856400025999, 4108.67130629549, 4122.793860306988, 4014.879553613396, 4031.979840100795, 4050.250703619825, 4069.9186016279655, 4080.1635664688815, 3858.498395208605, 3934.5081864766903, 4046.433499310114, 4056.898577535556, 4063.1873625274766, 3550.0, 3557.217412169319, 3562.5724913010345, 3584.5698516177963, 3589.6589823966942, 5069.670471419346, 5073.898522029539, 5085.0, 5102.872428189288, 5136.510411980521, 4388.824447022115, 4452.243118669834, 4527.1624749421135, 4528.50186479487, 4678.7660616969015, 5343.812966546152, 5344.225087362311, 5356.91964620531, 5359.651622644516, 5368.70472124033, 3840.865569705075, 3853.479780229661, 3855.61443855615, 3855.9588910994157, 3883.922321553553, 5474.808381706621, 5603.887922241533, 5615.438456154393, 5630.5495560355075, 5668.943310566924, 4026.2350153470748, 4049.0, 4056.634902858757, 4065.1869626074313, 4065.654419374386, 4054.878353649336, 4117.876463706094, 4120.711550191458, 4132.524759652619, 4148.771817550064, 4540.477845047796, 4634.265783187868, 4648.349231107648, 4674.368960190399, 4684.367610372624, 5360.517553420133, 5367.382750983609, 5401.243825864382, 5453.509184173444, 5458.50873421386, 1372.4647387518876, 1397.4829313154198, 1420.666143456287, 1434.0965191929226, 1435.4258296681412, 885.1193062902324, 920.5443305563789, 922.5433410461865, 932.5011119051275, 938.474454305591, 4618.49196588375, 4645.767711614406, 4671.696339737906, 4673.359551853192, 4701.95298047022, 4912.828051018198, 4912.975435122873, 4940.777665005084, 4947.960928205045, 4960.156773348539, 4704.764761761899, 4710.599599034052, 4717.95282047182, 4751.287306903992, 4941.48114447985, 2948.2187220386613, 2951.7638588913264, 2958.275222570484, 2973.658029326612, 2995.7603391729044, 5743.971280143573, 5749.195112684228, 5752.9424705753245, 5756.827295181151, 5770.278715160605, 5572.773989722255, 5740.6268592541355, 5753.993051216021, 5775.4983704236365, 5813.651180929073, 5668.234788303609, 5751.1085781703905, 5757.934782065331, 5799.536037117021, 5824.708764561755, 5312.787488500417, 5584.581156413204, 5600.943990560042, 5615.241942337732, 5617.651763576794, 5452.291202143696, 5490.258815059916, 5510.448955104457, 5513.117901135799, 5536.947979883809, 5673.205751194919, 5745.420009497421, 5772.365039845529, 5781.219535362672, 5790.247267855152, 3696.9815150924073, 3933.822977965941, 3966.662833659171, 3974.6621537168508, 3976.5426975896985, 5487.094629386106, 5515.696636685021, 5558.777648893999, 5564.360098588552, 5567.944320556905, 5320.44135365781, 5370.758315875717, 5398.514133727984, 5415.729213539386, 5427.3215848019, 5198.518422249641, 5384.353877534721, 5422.322209723785, 5497.422770609029, 5499.450054994469, 5256.264123022704, 5274.525292723673, 5299.761510731949, 5319.654222475527, 5321.201819727072, 5234.214867769865, 5249.031613145071, 5427.864303392446, 5431.891362172655, 5502.422245664307, 5304.204369344629, 5310.150375939831, 5326.334208223972, 5338.092524270805, 5344.438833922382], "value": 4112.5166887114265, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [773.6229511469585, 798.9400794940381, 813.3005615170952, 833.3374966901315, 833.7332053742805, 15103.697926041472, 16531.58671033225, 16538.751918721213, 16561.585960350996, 16571.66856662869, 14700.705985880302, 14971.0, 15039.24803759813, 15126.243687815593, 15163.92418037911, 806.6974884418344, 823.4071468542639, 825.896762904637, 829.854775414303, 831.1231650608605, 676.8307923019245, 801.1107670485757, 816.6406781016334, 823.6046697585163, 825.6078362777663, 869.7912500999746, 871.8082021955191, 872.1888643561485, 872.358816270041, 873.0396563779823, 706.8020954132851, 860.3547339495378, 860.4321148042293, 860.5181098584782, 861.9484229240317, 605.0440304319209, 622.7913648927615, 629.7953165221276, 630.7886857902608, 634.5050860328951, 13939.651508712263, 13946.860531394657, 13952.0, 13968.930155349159, 14013.509527166601, 13146.86853131466, 13522.729545409036, 13632.113912595649, 14090.013699041072, 14173.503927362595, 12360.258384496869, 12601.243925364508, 12629.494820207181, 12674.176178548458, 12833.743325133444, 4374.58441448062, 4499.527549607277, 4558.658100642465, 4581.404417425747, 4599.5400459953735, 71584.28415715828, 72074.27925720728, 72399.0, 72611.0, 72940.27059729389, 10814.35113893169, 10925.672229833117, 10936.0, 11126.404340847945, 11209.495572699248, 18095.185716642784, 18196.0, 18198.363057292932, 18226.81773182278, 18240.817591824176, 8343.0, 8672.392932494791, 8848.513331766686, 8848.867266990872, 8898.73303800887, 4793.376861008047, 4801.18379875415, 4922.606191504671, 4980.9252861207115, 5092.981403719271, 3331.6501767314085, 3387.0, 3400.778949368283, 3409.062507810372, 3431.828408579611, 594.3284088979512, 598.8293336399105, 599.2226032340049, 605.0651743056987, 610.1671218786413, 576.7519966414399, 616.5221952986382, 627.3726273726273, 651.3779340729592, 688.2051230828401, 9195.218406435528, 9195.770105747277, 9317.953410232905, 9565.569549370155, 9829.164521015651, 654.711926752237, 662.215274899246, 665.5906617430245, 668.5854770042605, 699.0807088678372, 4693.741844198602, 4743.1225223333795, 4797.4482934462285, 4807.759612019385, 4809.326694262806, 103950.0, 107647.0, 107844.46077769561, 109095.45452272688, 112068.0, 96572.0, 97229.0, 98182.0, 98307.0, 98353.0, 53878.73060634672, 56805.0, 57479.0, 82395.5880220595, 85559.0, 8958.0, 8979.775505612412, 9014.368994170345, 9039.954800225956, 9095.226905713089, 49699.254511183084, 49918.251226232365, 50314.0, 50395.0, 50593.494065058876, 43306.13387732165, 46014.309785353915, 52230.738846305525, 72536.37318134178, 73760.0, 10941.781164376827, 11137.944310278397, 11186.440677966231, 11199.272047316897, 11560.6531804046, 12253.816192756938, 12509.812352814533, 12584.40092667729, 12628.936855315664, 12994.545190918272, 11478.368689721812, 11589.536418543164, 11624.360660163435, 11774.52901883915, 11860.881391185978, 11270.718232043937, 11468.770624587294, 11531.654050378502, 11561.768764624829, 11693.298402095901, 11493.597724079616, 11669.0, 12196.207246528948, 12597.0, 12642.115051946275, 9864.35881667718, 10007.749806254902, 10049.196064314983, 10219.7445063874, 10453.111485523816, 9677.37097088687, 10106.7862540569, 10277.383356998604, 10283.177345812466, 10342.32774869631], "value": 7183.495874971854, "unit": "score"}], "name": "dromaeo_css", "value": 7215.451025508305, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 111.0, 110.0, 110.0, 111.0, 109.0, 109.0, 111.0, 109.0, 110.0], "value": 109.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 125.0, 131.0, 189.0, 125.0, 127.0, 126.0, 155.0, 157.0, 125.0], "value": 142.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 160.0, 160.0, 161.0, 159.0, 160.0, 163.0, 164.0, 162.0, 161.0], "value": 161.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 73.0, 75.0, 109.0, 77.0, 77.0, 75.0, 74.0, 98.0, 75.0], "value": 80.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 109.0, 85.0, 86.0, 85.0, 122.0, 85.0, 85.0, 121.0], "value": 94.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 118.0, 118.0, 117.0, 117.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 146.0, 147.0, 147.0, 145.0, 146.0, 146.0, 150.0, 146.0], "value": 146.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 96.0, 96.0, 96.0, 96.0, 95.0, 95.0, 96.0, 95.0], "value": 95.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 54.0, 55.0, 53.0, 54.0, 55.0, 54.0, 54.0, 54.0], "value": 54.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 63.0, 62.0, 63.0, 63.0, 63.0, 61.0, 62.0, 61.0], "value": 62.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 78.0, 82.0, 82.0, 77.0, 80.0, 81.0, 80.0, 89.0, 81.0], "value": 80.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 134.0, 121.0, 125.0, 132.0, 126.0, 121.0, 124.0, 133.0, 141.0], "value": 128.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 163.0, 161.0, 159.0, 160.0, 161.0, 159.0, 163.0, 166.0, 163.0], "value": 162.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 64.0, 64.0, 63.0, 65.0, 64.0, 67.0, 63.0, 63.0], "value": 63.9, "unit": "score"}], "name": "kraken", "value": 1497.9, "alertThreshold": 2.0}]} 20:34:44 INFO - Return code: 0 20:34:44 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 20:34:44 INFO - # TBPL SUCCESS # 20:34:44 INFO - Running post-action listener: _resource_record_post_action 20:34:44 INFO - ##### 20:34:44 INFO - ##### Finished run-tests step (success) 20:34:44 INFO - ##### 20:34:44 INFO - Running post-run listener: _resource_record_post_run 20:34:44 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 0; Write bytes: 551337984; Read time: 0; Write time: 461816 20:34:44 INFO - TinderboxPrint: CPU usage
13.1% 20:34:44 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 20:34:44 INFO - TinderboxPrint: I/O write bytes / time
551,337,984 / 461,816 20:34:44 INFO - TinderboxPrint: CPU idle
8,267.7 (86.8%) 20:34:44 INFO - TinderboxPrint: CPU user
1,204.0 (12.6%) 20:34:44 INFO - TinderboxPrint: Swap in / out
0 / 0 20:34:44 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 257077248; Read time: 0; Write time: 300812 20:34:44 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 0; Write bytes: 294260736; Read time: 0; Write time: 161004 20:34:45 INFO - Running post-run listener: _upload_blobber_files 20:34:45 INFO - Blob upload gear active. 20:34:45 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:34:45 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 20:34:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 20:34:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 20:34:45 INFO - (blobuploader) - INFO - Open directory for files ... 20:34:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:34:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:34:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:34:49 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:34:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:34:49 INFO - (blobuploader) - INFO - Done attempting. 20:34:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 20:34:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:34:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:34:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 20:34:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:34:50 INFO - (blobuploader) - INFO - Done attempting. 20:34:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 20:34:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:34:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:34:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 20:34:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:34:51 INFO - (blobuploader) - INFO - Done attempting. 20:34:51 INFO - (blobuploader) - INFO - Iteration through files over. 20:34:51 INFO - Return code: 0 20:34:51 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:34:51 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:34:51 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/00263bba1492b3d5a80b6a81081fea0ce3655379aae493a5650820b961a9148593c58b3ba52812ec3a28902fa1a3edf7bfa2c4c3defbdf104bb724dd54f0e8d6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7c15c18045204df272768ff8787486c9a3246769dcc3d11d7a4fdbee13696a6672177268808a39dca2de46c88ea24511775251f5242407161f9cf9440df91898", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/da50c239610b317388278d145f0f2dbfc862a04f4e65a1d943ffba282b3bdb419e08bf520330c30036bf7863a4048c5791e16ae0ea13083438d2246797931781"} 20:34:51 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:34:51 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:34:51 INFO - Contents: 20:34:51 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/00263bba1492b3d5a80b6a81081fea0ce3655379aae493a5650820b961a9148593c58b3ba52812ec3a28902fa1a3edf7bfa2c4c3defbdf104bb724dd54f0e8d6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7c15c18045204df272768ff8787486c9a3246769dcc3d11d7a4fdbee13696a6672177268808a39dca2de46c88ea24511775251f5242407161f9cf9440df91898", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/da50c239610b317388278d145f0f2dbfc862a04f4e65a1d943ffba282b3bdb419e08bf520330c30036bf7863a4048c5791e16ae0ea13083438d2246797931781"} 20:34:51 INFO - Running post-run listener: copy_logs_to_upload_dir 20:34:51 INFO - Copying logs to upload dir... 20:34:51 INFO - mkdir: /builds/slave/test/build/upload/logs 20:34:51 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1244.718796 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-06-26 20:34:50.448581) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-26 20:34:50.451675) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=d2a8c569965ab8367867b893000001a1-1466995491.990502-64755123 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/00263bba1492b3d5a80b6a81081fea0ce3655379aae493a5650820b961a9148593c58b3ba52812ec3a28902fa1a3edf7bfa2c4c3defbdf104bb724dd54f0e8d6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7c15c18045204df272768ff8787486c9a3246769dcc3d11d7a4fdbee13696a6672177268808a39dca2de46c88ea24511775251f5242407161f9cf9440df91898", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/da50c239610b317388278d145f0f2dbfc862a04f4e65a1d943ffba282b3bdb419e08bf520330c30036bf7863a4048c5791e16ae0ea13083438d2246797931781"} build_url:https://queue.taskcluster.net/v1/task/IG3vjAsMQomR6u3qUUOzoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011350 build_url: 'https://queue.taskcluster.net/v1/task/IG3vjAsMQomR6u3qUUOzoA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/00263bba1492b3d5a80b6a81081fea0ce3655379aae493a5650820b961a9148593c58b3ba52812ec3a28902fa1a3edf7bfa2c4c3defbdf104bb724dd54f0e8d6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7c15c18045204df272768ff8787486c9a3246769dcc3d11d7a4fdbee13696a6672177268808a39dca2de46c88ea24511775251f5242407161f9cf9440df91898", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/da50c239610b317388278d145f0f2dbfc862a04f4e65a1d943ffba282b3bdb419e08bf520330c30036bf7863a4048c5791e16ae0ea13083438d2246797931781"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-26 20:34:50.480510) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-26 20:34:50.480838) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=d2a8c569965ab8367867b893000001a1-1466995491.990502-64755123 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004469 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-26 20:34:50.566141) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-26 20:34:50.566910) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-26 20:34:50.567625) ========= ========= Total master_lag: 0.20 =========