builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-040 starttime: 1465973485.39 results: success (0) buildid: 20160614222226 builduid: c9a3dc141d074ca5a7cc8ef1f4c522fe revision: 53f5b5c289fba6ad82c675578cf1c548ae37f0c1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-14 23:51:25.389717) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-14 23:51:25.390317) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-14 23:51:25.390845) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-14 23:51:25.418258) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-14 23:51:25.418594) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1465973295.699516-957453322 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-14 23:51:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 51.1M=0s 2016-06-14 23:51:25 (51.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.114706 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-14 23:51:25.547154) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-14 23:51:25.547481) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1465973295.699516-957453322 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019359 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-14 23:51:25.597526) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-14 23:51:25.597909) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 53f5b5c289fba6ad82c675578cf1c548ae37f0c1 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 53f5b5c289fba6ad82c675578cf1c548ae37f0c1 --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=9e0dfe3369c33a1556e63f89000001d8-1465973295.699516-957453322 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-14 23:51:25,875 truncating revision to first 12 chars 2016-06-14 23:51:25,875 Setting DEBUG logging. 2016-06-14 23:51:25,875 attempt 1/10 2016-06-14 23:51:25,876 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/53f5b5c289fb?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-14 23:51:26,738 unpacking tar archive at: mozilla-central-53f5b5c289fb/testing/mozharness/ program finished with exit code 0 elapsedTime=1.264146 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-14 23:51:26.875364) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-14 23:51:26.875704) ========= script_repo_revision: 53f5b5c289fba6ad82c675578cf1c548ae37f0c1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-14 23:51:26.876111) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-14 23:51:26.876380) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-14 23:51:26.884920) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-06-14 23:51:26.885357) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9e0dfe3369c33a1556e63f89000001d8-1465973295.699516-957453322 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 23:51:27 INFO - MultiFileLogger online at 20160614 23:51:27 in /builds/slave/test 23:51:27 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 23:51:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 23:51:27 INFO - {'append_to_log': False, 23:51:27 INFO - 'base_work_dir': '/builds/slave/test', 23:51:27 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 23:51:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 23:51:27 INFO - 'branch': 'Firefox-Non-PGO', 23:51:27 INFO - 'buildbot_json_path': 'buildprops.json', 23:51:27 INFO - 'config_files': ('talos/linux_config.py',), 23:51:27 INFO - 'default_actions': ('clobber', 23:51:27 INFO - 'read-buildbot-config', 23:51:27 INFO - 'download-and-extract', 23:51:27 INFO - 'populate-webroot', 23:51:27 INFO - 'create-virtualenv', 23:51:27 INFO - 'install', 23:51:27 INFO - 'run-tests'), 23:51:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 23:51:27 INFO - 'download_minidump_stackwalk': True, 23:51:27 INFO - 'download_symbols': 'ondemand', 23:51:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 23:51:27 INFO - 'tooltool.py': '/tools/tooltool.py', 23:51:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 23:51:27 INFO - '/tools/misc-python/virtualenv.py')}, 23:51:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 23:51:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 23:51:27 INFO - 'installer_path': 'installer.exe', 23:51:27 INFO - 'log_level': 'info', 23:51:27 INFO - 'log_name': 'talos', 23:51:27 INFO - 'log_to_console': True, 23:51:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 23:51:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 23:51:27 INFO - 'opt_config_files': (), 23:51:27 INFO - 'pip_index': False, 23:51:27 INFO - 'sps_profile': False, 23:51:27 INFO - 'sps_profile_interval': 0, 23:51:27 INFO - 'suite': 'dromaeojs', 23:51:27 INFO - 'system_bits': '32', 23:51:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 23:51:27 INFO - 'title': 'talos-linux64-ix-040', 23:51:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 23:51:27 INFO - 'use_talos_json': True, 23:51:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 23:51:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 23:51:27 INFO - 'work_dir': 'build'} 23:51:27 INFO - ##### 23:51:27 INFO - ##### Running clobber step. 23:51:27 INFO - ##### 23:51:27 INFO - Running pre-action listener: _resource_record_pre_action 23:51:27 INFO - Running main action method: clobber 23:51:27 INFO - rmtree: /builds/slave/test/build 23:51:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 23:51:27 INFO - Running post-action listener: _resource_record_post_action 23:51:27 INFO - ##### 23:51:27 INFO - ##### Finished clobber step (success) 23:51:27 INFO - ##### 23:51:27 INFO - ##### 23:51:27 INFO - ##### Running read-buildbot-config step. 23:51:27 INFO - ##### 23:51:27 INFO - Running pre-action listener: _resource_record_pre_action 23:51:27 INFO - Running main action method: read_buildbot_config 23:51:27 INFO - Using buildbot properties: 23:51:27 INFO - { 23:51:27 INFO - "project": "", 23:51:27 INFO - "product": "firefox", 23:51:27 INFO - "script_repo_revision": "production", 23:51:27 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 23:51:27 INFO - "repository": "", 23:51:27 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 23:51:27 INFO - "buildid": "20160614222226", 23:51:27 INFO - "pgo_build": "False", 23:51:27 INFO - "basedir": "/builds/slave/test", 23:51:27 INFO - "buildnumber": 115, 23:51:27 INFO - "slavename": "talos-linux64-ix-040", 23:51:27 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 23:51:27 INFO - "platform": "ubuntu64_hw", 23:51:27 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 23:51:27 INFO - "branch": "mozilla-central", 23:51:27 INFO - "repo_path": "mozilla-central", 23:51:27 INFO - "revision": "53f5b5c289fba6ad82c675578cf1c548ae37f0c1", 23:51:27 INFO - "stage_platform": "linux64", 23:51:27 INFO - "builduid": "c9a3dc141d074ca5a7cc8ef1f4c522fe", 23:51:27 INFO - "slavebuilddir": "test" 23:51:27 INFO - } 23:51:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/bOcn7TF7Rum_9S3M7li9oQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 23:51:27 INFO - Running post-action listener: _resource_record_post_action 23:51:27 INFO - ##### 23:51:27 INFO - ##### Finished read-buildbot-config step (success) 23:51:27 INFO - ##### 23:51:27 INFO - ##### 23:51:27 INFO - ##### Running download-and-extract step. 23:51:27 INFO - ##### 23:51:27 INFO - Running pre-action listener: _resource_record_pre_action 23:51:27 INFO - Running main action method: download_and_extract 23:51:27 INFO - mkdir: /builds/slave/test/build/tests 23:51:27 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')]} 23:51:27 INFO - https://queue.taskcluster.net/v1/task/bOcn7TF7Rum_9S3M7li9oQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 23:51:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bOcn7TF7Rum_9S3M7li9oQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 23:51:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bOcn7TF7Rum_9S3M7li9oQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 23:51:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bOcn7TF7Rum_9S3M7li9oQ/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 23:51:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bOcn7TF7Rum_9S3M7li9oQ/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 23:51:29 INFO - Downloaded 1361 bytes. 23:51:29 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 23:51:29 INFO - Using the following test package requirements: 23:51:29 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 23:51:29 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:51:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 23:51:29 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:51:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 23:51:29 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:51:29 INFO - u'jsshell-linux-x86_64.zip'], 23:51:29 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:51:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 23:51:29 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 23:51:29 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:51:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 23:51:29 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:51:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 23:51:29 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:51:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 23:51:29 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:51:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 23:51:29 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 23:51:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:51:29 INFO - https://queue.taskcluster.net/v1/task/bOcn7TF7Rum_9S3M7li9oQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:51:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bOcn7TF7Rum_9S3M7li9oQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 23:51:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bOcn7TF7Rum_9S3M7li9oQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 23:51:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bOcn7TF7Rum_9S3M7li9oQ/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 23:51:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bOcn7TF7Rum_9S3M7li9oQ/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 23:51:31 INFO - Downloaded 22653632 bytes. 23:51:31 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'] 23:51:31 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 23:51:32 INFO - Return code: 0 23:51:32 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 23:51:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:51:32 INFO - https://queue.taskcluster.net/v1/task/bOcn7TF7Rum_9S3M7li9oQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:51:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bOcn7TF7Rum_9S3M7li9oQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 23:51:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bOcn7TF7Rum_9S3M7li9oQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 23:51:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bOcn7TF7Rum_9S3M7li9oQ/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 23:51:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bOcn7TF7Rum_9S3M7li9oQ/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 23:51:34 INFO - Downloaded 22653632 bytes. 23:51:34 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 23:51:34 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 23:51:35 INFO - Return code: 0 23:51:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:51:35 INFO - https://queue.taskcluster.net/v1/task/bOcn7TF7Rum_9S3M7li9oQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 23:51:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bOcn7TF7Rum_9S3M7li9oQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 23:51:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bOcn7TF7Rum_9S3M7li9oQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 23:51:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bOcn7TF7Rum_9S3M7li9oQ/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 23:51:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bOcn7TF7Rum_9S3M7li9oQ/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 23:51:36 INFO - Downloaded 14405384 bytes. 23:51:36 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'] 23:51:36 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 23:51:37 INFO - Return code: 0 23:51:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:51:37 INFO - https://queue.taskcluster.net/v1/task/bOcn7TF7Rum_9S3M7li9oQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 23:51:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bOcn7TF7Rum_9S3M7li9oQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 23:51:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bOcn7TF7Rum_9S3M7li9oQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 23:51:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bOcn7TF7Rum_9S3M7li9oQ/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 23:51:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bOcn7TF7Rum_9S3M7li9oQ/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 23:51:41 INFO - Downloaded 55401496 bytes. 23:51:41 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bOcn7TF7Rum_9S3M7li9oQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 23:51:41 INFO - mkdir: /builds/slave/test/properties 23:51:41 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 23:51:41 INFO - Writing to file /builds/slave/test/properties/build_url 23:51:41 INFO - Contents: 23:51:41 INFO - build_url:https://queue.taskcluster.net/v1/task/bOcn7TF7Rum_9S3M7li9oQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 23:51:42 INFO - Running post-action listener: _resource_record_post_action 23:51:42 INFO - Running post-action listener: set_extra_try_arguments 23:51:42 INFO - ##### 23:51:42 INFO - ##### Finished download-and-extract step (success) 23:51:42 INFO - ##### 23:51:42 INFO - ##### 23:51:42 INFO - ##### Running populate-webroot step. 23:51:42 INFO - ##### 23:51:42 INFO - Running pre-action listener: _resource_record_pre_action 23:51:42 INFO - Running main action method: populate_webroot 23:51:42 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 23:51:42 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 23:51:42 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 23:51:42 INFO - '--tppagecycles', 23:51:42 INFO - '7'], 23:51:42 INFO - 'tests': ['tsvgm']}}, 23:51:42 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 23:51:42 INFO - 'tests': ['tresize', 'tcanvasmark']}, 23:51:42 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 23:51:42 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 23:51:42 INFO - 'tests': ['dromaeo_css', 'kraken']}, 23:51:42 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 23:51:42 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:51:42 INFO - 'talos_options': ['--disable-e10s'], 23:51:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:51:42 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:51:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:51:42 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:51:42 INFO - 'talos_options': ['--disable-e10s'], 23:51:42 INFO - 'tests': ['damp', 'tps']}, 23:51:42 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:51:42 INFO - 'tests': ['damp', 'tps']}, 23:51:42 INFO - 'g3': {'talos_options': ['--disable-e10s'], 23:51:42 INFO - 'tests': ['dromaeo_dom']}, 23:51:42 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 23:51:42 INFO - 'g4': {'talos_options': ['--disable-e10s'], 23:51:42 INFO - 'tests': ['basic_compositor_video']}, 23:51:42 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 23:51:42 INFO - 'other': {'talos_options': ['--disable-e10s'], 23:51:42 INFO - 'tests': ['a11yr', 23:51:42 INFO - 'ts_paint', 23:51:42 INFO - 'tpaint', 23:51:42 INFO - 'sessionrestore', 23:51:42 INFO - 'sessionrestore_no_auto_restore', 23:51:42 INFO - 'tabpaint']}, 23:51:42 INFO - 'other-e10s': {'tests': ['a11yr', 23:51:42 INFO - 'ts_paint', 23:51:42 INFO - 'tpaint', 23:51:42 INFO - 'sessionrestore', 23:51:42 INFO - 'sessionrestore_no_auto_restore', 23:51:42 INFO - 'tabpaint']}, 23:51:42 INFO - 'other-e10s_l64': {'tests': ['a11yr', 23:51:42 INFO - 'ts_paint', 23:51:42 INFO - 'tpaint', 23:51:42 INFO - 'sessionrestore', 23:51:42 INFO - 'sessionrestore_no_auto_restore', 23:51:42 INFO - 'tabpaint']}, 23:51:42 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 23:51:42 INFO - 'ts_paint', 23:51:42 INFO - 'tpaint', 23:51:42 INFO - 'sessionrestore', 23:51:42 INFO - 'sessionrestore_no_auto_restore', 23:51:42 INFO - 'tabpaint']}, 23:51:42 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 23:51:42 INFO - 'tests': ['a11yr', 23:51:42 INFO - 'ts_paint', 23:51:42 INFO - 'tpaint', 23:51:42 INFO - 'sessionrestore', 23:51:42 INFO - 'sessionrestore_no_auto_restore', 23:51:42 INFO - 'tabpaint']}, 23:51:42 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 23:51:42 INFO - 'tests': ['a11yr', 23:51:42 INFO - 'ts_paint', 23:51:42 INFO - 'tpaint', 23:51:42 INFO - 'sessionrestore', 23:51:42 INFO - 'sessionrestore_no_auto_restore', 23:51:42 INFO - 'tabpaint']}, 23:51:42 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 23:51:42 INFO - 'tests': ['tsvgx', 23:51:42 INFO - 'tsvgr_opacity', 23:51:42 INFO - 'tart', 23:51:42 INFO - 'tscrollx', 23:51:42 INFO - 'cart']}, 23:51:42 INFO - 'svgr-e10s': {'tests': ['tsvgx', 23:51:42 INFO - 'tsvgr_opacity', 23:51:42 INFO - 'tart', 23:51:42 INFO - 'tscrollx', 23:51:42 INFO - 'cart']}, 23:51:42 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:51:42 INFO - 'talos_options': ['--disable-e10s'], 23:51:42 INFO - 'tests': ['tp5o']}, 23:51:42 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:51:42 INFO - 'tests': ['tp5o']}, 23:51:42 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:51:42 INFO - 'talos_options': ['--disable-e10s', 23:51:42 INFO - '--xperf_path', 23:51:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:51:42 INFO - 'tests': ['tp5n']}, 23:51:42 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:51:42 INFO - 'talos_options': ['--xperf_path', 23:51:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:51:42 INFO - 'tests': ['tp5n']}}, 23:51:42 INFO - 'talos.zip': {'path': '', 23:51:42 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 23:51:42 INFO - Running post-action listener: _resource_record_post_action 23:51:42 INFO - ##### 23:51:42 INFO - ##### Finished populate-webroot step (success) 23:51:42 INFO - ##### 23:51:42 INFO - ##### 23:51:42 INFO - ##### Running create-virtualenv step. 23:51:42 INFO - ##### 23:51:42 INFO - Running pre-action listener: _resource_record_pre_action 23:51:42 INFO - Running main action method: create_virtualenv 23:51:42 INFO - Creating virtualenv /builds/slave/test/build/venv 23:51:42 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 23:51:42 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 23:51:42 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 23:51:42 INFO - Using real prefix '/usr' 23:51:42 INFO - New python executable in /builds/slave/test/build/venv/bin/python 23:51:43 INFO - Installing distribute.............................................................................................................................................................................................done. 23:51:45 INFO - Installing pip.................done. 23:51:45 INFO - Return code: 0 23:51:45 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 23:51:45 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')]} 23:51:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:51:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:51:45 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')]} 23:51:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:51:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:51:45 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 0x7f4573d5cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cdd350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d6c1c0>, '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 0x1d6d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d6d550>, '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': '9e0dfe3369c33a1556e63f89000001d8-1465973295.699516-957453322', '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 23:51:45 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 23:51:45 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 23:51:45 INFO - Using env: {'DISPLAY': ':0', 23:51:45 INFO - 'HOME': '/home/cltbld', 23:51:45 INFO - 'LANG': 'en_US.UTF-8', 23:51:45 INFO - 'LANGUAGE': 'en_US:en', 23:51:45 INFO - 'LOGNAME': 'cltbld', 23:51:45 INFO - 'MAIL': '/var/mail/cltbld', 23:51:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:51:45 INFO - 'MOZ_NO_REMOTE': '1', 23:51:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:51:45 INFO - 'NO_EM_RESTART': '1', 23:51:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:51:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:51:45 INFO - 'PWD': '/builds/slave/test', 23:51:45 INFO - 'SHELL': '/bin/bash', 23:51:45 INFO - 'SHLVL': '1', 23:51:45 INFO - 'TERM': 'linux', 23:51:45 INFO - 'TMOUT': '86400', 23:51:45 INFO - 'USER': 'cltbld', 23:51:45 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1465973295.699516-957453322', 23:51:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:51:45 INFO - '_': '/tools/buildbot/bin/python'} 23:51:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:51:45 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 23:51:45 INFO - Cleaning up... 23:51:45 INFO - Return code: 0 23:51:45 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 23:51:45 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')]} 23:51:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:51:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:51:45 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')]} 23:51:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:51:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:51:45 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 0x7f4573d5cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cdd350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d6c1c0>, '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 0x1d6d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d6d550>, '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': '9e0dfe3369c33a1556e63f89000001d8-1465973295.699516-957453322', '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 23:51:45 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 23:51:45 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 23:51:45 INFO - Using env: {'DISPLAY': ':0', 23:51:45 INFO - 'HOME': '/home/cltbld', 23:51:45 INFO - 'LANG': 'en_US.UTF-8', 23:51:45 INFO - 'LANGUAGE': 'en_US:en', 23:51:45 INFO - 'LOGNAME': 'cltbld', 23:51:45 INFO - 'MAIL': '/var/mail/cltbld', 23:51:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:51:45 INFO - 'MOZ_NO_REMOTE': '1', 23:51:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:51:45 INFO - 'NO_EM_RESTART': '1', 23:51:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:51:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:51:45 INFO - 'PWD': '/builds/slave/test', 23:51:45 INFO - 'SHELL': '/bin/bash', 23:51:45 INFO - 'SHLVL': '1', 23:51:45 INFO - 'TERM': 'linux', 23:51:45 INFO - 'TMOUT': '86400', 23:51:45 INFO - 'USER': 'cltbld', 23:51:45 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1465973295.699516-957453322', 23:51:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:51:45 INFO - '_': '/tools/buildbot/bin/python'} 23:51:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:51:45 INFO - Downloading/unpacking psutil>=3.1.1 23:51:45 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 23:51:45 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 23:51:45 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 23:51:45 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 23:51:45 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 23:51:45 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 23:51:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 23:51:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:51:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:51:47 INFO - Installing collected packages: psutil 23:51:47 INFO - Running setup.py install for psutil 23:51:47 INFO - building 'psutil._psutil_linux' extension 23:51:47 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 23:51:47 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 23:51:47 INFO - building 'psutil._psutil_posix' extension 23:51:47 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 23:51:47 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 23:51:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:51:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:51:48 INFO - Successfully installed psutil 23:51:48 INFO - Cleaning up... 23:51:48 INFO - Return code: 0 23:51:48 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 23:51:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:51:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:51:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:51:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:51:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:51:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:51:48 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 0x7f4573d5cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cdd350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d6c1c0>, '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 0x1d6d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d6d550>, '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': '9e0dfe3369c33a1556e63f89000001d8-1465973295.699516-957453322', '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 23:51:48 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 23:51:48 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 23:51:48 INFO - Using env: {'DISPLAY': ':0', 23:51:48 INFO - 'HOME': '/home/cltbld', 23:51:48 INFO - 'LANG': 'en_US.UTF-8', 23:51:48 INFO - 'LANGUAGE': 'en_US:en', 23:51:48 INFO - 'LOGNAME': 'cltbld', 23:51:48 INFO - 'MAIL': '/var/mail/cltbld', 23:51:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:51:48 INFO - 'MOZ_NO_REMOTE': '1', 23:51:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:51:48 INFO - 'NO_EM_RESTART': '1', 23:51:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:51:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:51:48 INFO - 'PWD': '/builds/slave/test', 23:51:48 INFO - 'SHELL': '/bin/bash', 23:51:48 INFO - 'SHLVL': '1', 23:51:48 INFO - 'TERM': 'linux', 23:51:48 INFO - 'TMOUT': '86400', 23:51:48 INFO - 'USER': 'cltbld', 23:51:48 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1465973295.699516-957453322', 23:51:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:51:48 INFO - '_': '/tools/buildbot/bin/python'} 23:51:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:51:48 INFO - Downloading/unpacking mozsystemmonitor==0.3 23:51:48 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 23:51:48 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 23:51:48 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 23:51:48 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 23:51:48 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 23:51:48 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 23:51:50 INFO - Downloading mozsystemmonitor-0.3.tar.gz 23:51:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 23:51:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 23:51:50 INFO - Installing collected packages: mozsystemmonitor 23:51:50 INFO - Running setup.py install for mozsystemmonitor 23:51:50 INFO - Successfully installed mozsystemmonitor 23:51:50 INFO - Cleaning up... 23:51:50 INFO - Return code: 0 23:51:50 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 23:51:50 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')]} 23:51:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:51:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:51:50 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')]} 23:51:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:51:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:51:50 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 0x7f4573d5cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cdd350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d6c1c0>, '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 0x1d6d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d6d550>, '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': '9e0dfe3369c33a1556e63f89000001d8-1465973295.699516-957453322', '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 23:51:50 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 23:51:50 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 23:51:50 INFO - Using env: {'DISPLAY': ':0', 23:51:50 INFO - 'HOME': '/home/cltbld', 23:51:50 INFO - 'LANG': 'en_US.UTF-8', 23:51:50 INFO - 'LANGUAGE': 'en_US:en', 23:51:50 INFO - 'LOGNAME': 'cltbld', 23:51:50 INFO - 'MAIL': '/var/mail/cltbld', 23:51:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:51:50 INFO - 'MOZ_NO_REMOTE': '1', 23:51:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:51:50 INFO - 'NO_EM_RESTART': '1', 23:51:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:51:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:51:50 INFO - 'PWD': '/builds/slave/test', 23:51:50 INFO - 'SHELL': '/bin/bash', 23:51:50 INFO - 'SHLVL': '1', 23:51:50 INFO - 'TERM': 'linux', 23:51:50 INFO - 'TMOUT': '86400', 23:51:50 INFO - 'USER': 'cltbld', 23:51:50 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1465973295.699516-957453322', 23:51:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:51:50 INFO - '_': '/tools/buildbot/bin/python'} 23:51:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:51:50 INFO - Downloading/unpacking jsonschema==2.5.1 23:51: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 23:51: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 23:51: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 23:51: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 23:51: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 23:51: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 23:51:52 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 23:51:52 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 23:51:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:51:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:51:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:51:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:51:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:51:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:51:52 INFO - Downloading functools32-3.2.3-2.tar.gz 23:51:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 23:51:52 INFO - warning: no files found matching '*.txt' 23:51:52 INFO - no previously-included directories found matching 'build' 23:51:52 INFO - no previously-included directories found matching 'dist' 23:51:52 INFO - no previously-included directories found matching '.git*' 23:51:52 INFO - Installing collected packages: jsonschema, functools32 23:51:52 INFO - Running setup.py install for functools32 23:51:52 INFO - warning: no files found matching '*.txt' 23:51:52 INFO - no previously-included directories found matching 'build' 23:51:52 INFO - no previously-included directories found matching 'dist' 23:51:52 INFO - no previously-included directories found matching '.git*' 23:51:52 INFO - Successfully installed jsonschema functools32 23:51:52 INFO - Cleaning up... 23:51:52 INFO - Return code: 0 23:51:52 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 23:51:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:51:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:51:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:51:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:51:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:51:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:51:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4573d5cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cdd350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d6c1c0>, '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 0x1d6d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d6d550>, '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': '9e0dfe3369c33a1556e63f89000001d8-1465973295.699516-957453322', '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 23:51:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 23:51:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 23:51:52 INFO - Using env: {'DISPLAY': ':0', 23:51:52 INFO - 'HOME': '/home/cltbld', 23:51:52 INFO - 'LANG': 'en_US.UTF-8', 23:51:52 INFO - 'LANGUAGE': 'en_US:en', 23:51:52 INFO - 'LOGNAME': 'cltbld', 23:51:52 INFO - 'MAIL': '/var/mail/cltbld', 23:51:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:51:52 INFO - 'MOZ_NO_REMOTE': '1', 23:51:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:51:52 INFO - 'NO_EM_RESTART': '1', 23:51:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:51:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:51:52 INFO - 'PWD': '/builds/slave/test', 23:51:52 INFO - 'SHELL': '/bin/bash', 23:51:52 INFO - 'SHLVL': '1', 23:51:52 INFO - 'TERM': 'linux', 23:51:52 INFO - 'TMOUT': '86400', 23:51:52 INFO - 'USER': 'cltbld', 23:51:52 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1465973295.699516-957453322', 23:51:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:51:52 INFO - '_': '/tools/buildbot/bin/python'} 23:51:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:51:53 INFO - Downloading/unpacking blobuploader==1.2.4 23:51:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:51:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:51:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:51:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:51:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:51:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:51:54 INFO - Downloading blobuploader-1.2.4.tar.gz 23:51:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 23:51:55 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 23:51:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:51:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:51:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:51:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:51:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:51:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:51:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 23:51:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 23:51:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:51:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:51:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:51:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:51:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:51:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:51:55 INFO - Downloading docopt-0.6.1.tar.gz 23:51:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 23:51:55 INFO - Installing collected packages: blobuploader, requests, docopt 23:51:55 INFO - Running setup.py install for blobuploader 23:51:55 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 23:51:55 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 23:51:55 INFO - Running setup.py install for requests 23:51:56 INFO - Running setup.py install for docopt 23:51:56 INFO - Successfully installed blobuploader requests docopt 23:51:56 INFO - Cleaning up... 23:51:56 INFO - Return code: 0 23:51:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:51:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:51:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:51:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:51:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:51:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:51:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:51:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4573d5cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cdd350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d6c1c0>, '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 0x1d6d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d6d550>, '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': '9e0dfe3369c33a1556e63f89000001d8-1465973295.699516-957453322', '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 23:51:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 23:51:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 23:51:56 INFO - Using env: {'DISPLAY': ':0', 23:51:56 INFO - 'HOME': '/home/cltbld', 23:51:56 INFO - 'LANG': 'en_US.UTF-8', 23:51:56 INFO - 'LANGUAGE': 'en_US:en', 23:51:56 INFO - 'LOGNAME': 'cltbld', 23:51:56 INFO - 'MAIL': '/var/mail/cltbld', 23:51:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:51:56 INFO - 'MOZ_NO_REMOTE': '1', 23:51:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:51:56 INFO - 'NO_EM_RESTART': '1', 23:51:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:51:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:51:56 INFO - 'PWD': '/builds/slave/test', 23:51:56 INFO - 'SHELL': '/bin/bash', 23:51:56 INFO - 'SHLVL': '1', 23:51:56 INFO - 'TERM': 'linux', 23:51:56 INFO - 'TMOUT': '86400', 23:51:56 INFO - 'USER': 'cltbld', 23:51:56 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1465973295.699516-957453322', 23:51:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:51:56 INFO - '_': '/tools/buildbot/bin/python'} 23:51:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:51:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:51:56 INFO - Running setup.py (path:/tmp/pip-fkK1Bc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:51:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:51:56 INFO - Running setup.py (path:/tmp/pip-5FKz5r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:51:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:51:56 INFO - Running setup.py (path:/tmp/pip-rPZChM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:51:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:51:56 INFO - Running setup.py (path:/tmp/pip-T2FUgx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:51:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:51:56 INFO - Running setup.py (path:/tmp/pip-idWGf8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:51:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:51:57 INFO - Running setup.py (path:/tmp/pip-1HqIwS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:51:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:51:57 INFO - Running setup.py (path:/tmp/pip-9_At7w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:51:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:51:57 INFO - Running setup.py (path:/tmp/pip-chYhyj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:51:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:51:57 INFO - Running setup.py (path:/tmp/pip-p5HoR7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:51:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:51:57 INFO - Running setup.py (path:/tmp/pip-_kXsKZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:51:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:51:57 INFO - Running setup.py (path:/tmp/pip-qvTIsG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:51:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:51:57 INFO - Running setup.py (path:/tmp/pip-Hnh4JO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:51:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:51:57 INFO - Running setup.py (path:/tmp/pip-vWlybW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:51:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:51:57 INFO - Running setup.py (path:/tmp/pip-iNEADO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:51:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:51:57 INFO - Running setup.py (path:/tmp/pip-mp0LqT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:51:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:51:57 INFO - Running setup.py (path:/tmp/pip-0hInSf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:51:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:51:57 INFO - Running setup.py (path:/tmp/pip-HKIrnQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:51:57 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 23:51:57 INFO - Running setup.py install for manifestparser 23:51:57 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 23:51:57 INFO - Running setup.py install for mozcrash 23:51:58 INFO - Running setup.py install for mozdebug 23:51:58 INFO - Running setup.py install for mozdevice 23:51:58 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 23:51:58 INFO - Installing dm script to /builds/slave/test/build/venv/bin 23:51:58 INFO - Running setup.py install for mozfile 23:51:58 INFO - Running setup.py install for mozhttpd 23:51:58 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 23:51:58 INFO - Running setup.py install for mozinfo 23:51:58 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 23:51:58 INFO - Running setup.py install for mozInstall 23:51:58 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 23:51:58 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 23:51:58 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 23:51:58 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 23:51:58 INFO - Running setup.py install for mozleak 23:51:58 INFO - Running setup.py install for mozlog 23:51:58 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 23:51:58 INFO - Running setup.py install for moznetwork 23:51:58 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 23:51:58 INFO - Running setup.py install for mozprocess 23:51:59 INFO - Running setup.py install for mozprofile 23:51:59 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 23:51:59 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 23:51:59 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 23:51:59 INFO - Running setup.py install for mozrunner 23:51:59 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 23:51:59 INFO - Running setup.py install for mozscreenshot 23:51:59 INFO - Running setup.py install for moztest 23:51:59 INFO - Running setup.py install for mozversion 23:51:59 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 23:51:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 23:51:59 INFO - Cleaning up... 23:51:59 INFO - Return code: 0 23:51:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:51:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:51:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:51:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:51:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:51:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:51:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:51:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4573d5cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cdd350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d6c1c0>, '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 0x1d6d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d6d550>, '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': '9e0dfe3369c33a1556e63f89000001d8-1465973295.699516-957453322', '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 23:51:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 23:51:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 23:51:59 INFO - Using env: {'DISPLAY': ':0', 23:51:59 INFO - 'HOME': '/home/cltbld', 23:51:59 INFO - 'LANG': 'en_US.UTF-8', 23:51:59 INFO - 'LANGUAGE': 'en_US:en', 23:51:59 INFO - 'LOGNAME': 'cltbld', 23:51:59 INFO - 'MAIL': '/var/mail/cltbld', 23:51:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:51:59 INFO - 'MOZ_NO_REMOTE': '1', 23:51:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:51:59 INFO - 'NO_EM_RESTART': '1', 23:51:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:51:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:51:59 INFO - 'PWD': '/builds/slave/test', 23:51:59 INFO - 'SHELL': '/bin/bash', 23:51:59 INFO - 'SHLVL': '1', 23:51:59 INFO - 'TERM': 'linux', 23:51:59 INFO - 'TMOUT': '86400', 23:51:59 INFO - 'USER': 'cltbld', 23:51:59 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1465973295.699516-957453322', 23:51:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:51:59 INFO - '_': '/tools/buildbot/bin/python'} 23:51:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:51:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:51:59 INFO - Running setup.py (path:/tmp/pip-t7478X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:51:59 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 23:51:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:51:59 INFO - Running setup.py (path:/tmp/pip-HtwSzD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:52:00 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)) 23:52:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:52:00 INFO - Running setup.py (path:/tmp/pip-dUF210-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:52:00 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)) 23:52:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:52:00 INFO - Running setup.py (path:/tmp/pip-hqPLby-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:52:00 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)) 23:52:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:52:00 INFO - Running setup.py (path:/tmp/pip-cnNEJy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:52:00 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)) 23:52:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:52:00 INFO - Running setup.py (path:/tmp/pip-zqmzYS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:52:00 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)) 23:52:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:52:00 INFO - Running setup.py (path:/tmp/pip-gpWILD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:52:00 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)) 23:52:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:52:00 INFO - Running setup.py (path:/tmp/pip-t1pGKM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:52:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 23:52:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:52:00 INFO - Running setup.py (path:/tmp/pip-53coLb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:52:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 23:52:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:52:00 INFO - Running setup.py (path:/tmp/pip-NK5XLW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:52:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:52:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:52:00 INFO - Running setup.py (path:/tmp/pip-a9BBxO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:52:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 23:52:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:52:00 INFO - Running setup.py (path:/tmp/pip-ZYvnIe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:52:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 23:52:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:52:00 INFO - Running setup.py (path:/tmp/pip-hjLGkT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:52:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 23:52:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:52:00 INFO - Running setup.py (path:/tmp/pip-8UfUuX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:52:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 23:52:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:52:00 INFO - Running setup.py (path:/tmp/pip-MaTwyW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:52:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 23:52:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:52:00 INFO - Running setup.py (path:/tmp/pip-q8UDdC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:52:01 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)) 23:52:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:52:01 INFO - Running setup.py (path:/tmp/pip-hCSDoj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:52:01 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)) 23:52:01 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)) 23:52:01 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)) 23:52:01 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)) 23:52:01 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)) 23:52:01 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)) 23:52:01 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:52:01 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 23:52:01 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 23:52:01 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 23:52:01 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 23:52:01 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 23:52:01 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 23:52:03 INFO - Downloading blessings-1.6.tar.gz 23:52:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 23:52:03 INFO - Installing collected packages: blessings 23:52:03 INFO - Running setup.py install for blessings 23:52:03 INFO - Successfully installed blessings 23:52:03 INFO - Cleaning up... 23:52:03 INFO - Return code: 0 23:52:03 INFO - Done creating virtualenv /builds/slave/test/build/venv. 23:52:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:52:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:52:03 INFO - Reading from file tmpfile_stdout 23:52:03 INFO - Current package versions: 23:52:03 INFO - argparse == 1.2.1 23:52:03 INFO - blessings == 1.6 23:52:03 INFO - blobuploader == 1.2.4 23:52:03 INFO - docopt == 0.6.1 23:52:03 INFO - functools32 == 3.2.3-2 23:52:03 INFO - jsonschema == 2.5.1 23:52:03 INFO - manifestparser == 1.1 23:52:03 INFO - mozInstall == 1.12 23:52:03 INFO - mozcrash == 0.17 23:52:03 INFO - mozdebug == 0.1 23:52:03 INFO - mozdevice == 0.48 23:52:03 INFO - mozfile == 1.2 23:52:03 INFO - mozhttpd == 0.7 23:52:03 INFO - mozinfo == 0.9 23:52:03 INFO - mozleak == 0.1 23:52:03 INFO - mozlog == 3.2 23:52:03 INFO - moznetwork == 0.27 23:52:03 INFO - mozprocess == 0.22 23:52:03 INFO - mozprofile == 0.28 23:52:03 INFO - mozrunner == 6.11 23:52:03 INFO - mozscreenshot == 0.1 23:52:03 INFO - mozsystemmonitor == 0.3 23:52:03 INFO - moztest == 0.7 23:52:03 INFO - mozversion == 1.4 23:52:03 INFO - psutil == 3.1.1 23:52:03 INFO - requests == 1.2.3 23:52:03 INFO - wsgiref == 0.1.2 23:52:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:52:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:52:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:52:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:52:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:52:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:52:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:52:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4573d5cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cdd350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d6c1c0>, '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 0x1d6d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d6d550>, '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': '9e0dfe3369c33a1556e63f89000001d8-1465973295.699516-957453322', '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 23:52:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 23:52:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 23:52:03 INFO - Using env: {'DISPLAY': ':0', 23:52:03 INFO - 'HOME': '/home/cltbld', 23:52:03 INFO - 'LANG': 'en_US.UTF-8', 23:52:03 INFO - 'LANGUAGE': 'en_US:en', 23:52:03 INFO - 'LOGNAME': 'cltbld', 23:52:03 INFO - 'MAIL': '/var/mail/cltbld', 23:52:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:52:03 INFO - 'MOZ_NO_REMOTE': '1', 23:52:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:52:03 INFO - 'NO_EM_RESTART': '1', 23:52:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:52:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:52:03 INFO - 'PWD': '/builds/slave/test', 23:52:03 INFO - 'SHELL': '/bin/bash', 23:52:03 INFO - 'SHLVL': '1', 23:52:03 INFO - 'TERM': 'linux', 23:52:03 INFO - 'TMOUT': '86400', 23:52:03 INFO - 'USER': 'cltbld', 23:52:03 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1465973295.699516-957453322', 23:52:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:52:03 INFO - '_': '/tools/buildbot/bin/python'} 23:52:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:52:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 23:52:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 23:52:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 23:52:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 23:52:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 23:52:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 23:52:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 23:52:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 23:52:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 23:52:03 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 23:52:03 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 23:52:03 INFO - Cleaning up... 23:52:03 INFO - Return code: 0 23:52:03 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 23:52:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:52:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:52:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:52:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:52:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:52:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:52:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4573d5cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cdd350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d6c1c0>, '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 0x1d6d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d6d550>, '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': '9e0dfe3369c33a1556e63f89000001d8-1465973295.699516-957453322', '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 23:52:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 23:52:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 23:52:03 INFO - Using env: {'DISPLAY': ':0', 23:52:03 INFO - 'HOME': '/home/cltbld', 23:52:03 INFO - 'LANG': 'en_US.UTF-8', 23:52:03 INFO - 'LANGUAGE': 'en_US:en', 23:52:03 INFO - 'LOGNAME': 'cltbld', 23:52:03 INFO - 'MAIL': '/var/mail/cltbld', 23:52:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:52:03 INFO - 'MOZ_NO_REMOTE': '1', 23:52:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:52:03 INFO - 'NO_EM_RESTART': '1', 23:52:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:52:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:52:03 INFO - 'PWD': '/builds/slave/test', 23:52:03 INFO - 'SHELL': '/bin/bash', 23:52:03 INFO - 'SHLVL': '1', 23:52:03 INFO - 'TERM': 'linux', 23:52:03 INFO - 'TMOUT': '86400', 23:52:03 INFO - 'USER': 'cltbld', 23:52:03 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1465973295.699516-957453322', 23:52:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:52:03 INFO - '_': '/tools/buildbot/bin/python'} 23:52:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:52:03 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 23:52:03 INFO - Cleaning up... 23:52:03 INFO - Return code: 0 23:52:03 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 23:52:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:52:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:52:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:52:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:52:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:52:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:52:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4573d5cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cdd350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d6c1c0>, '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 0x1d6d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d6d550>, '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': '9e0dfe3369c33a1556e63f89000001d8-1465973295.699516-957453322', '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 23:52:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 23:52:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 23:52:03 INFO - Using env: {'DISPLAY': ':0', 23:52:03 INFO - 'HOME': '/home/cltbld', 23:52:03 INFO - 'LANG': 'en_US.UTF-8', 23:52:03 INFO - 'LANGUAGE': 'en_US:en', 23:52:03 INFO - 'LOGNAME': 'cltbld', 23:52:03 INFO - 'MAIL': '/var/mail/cltbld', 23:52:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:52:03 INFO - 'MOZ_NO_REMOTE': '1', 23:52:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:52:03 INFO - 'NO_EM_RESTART': '1', 23:52:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:52:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:52:03 INFO - 'PWD': '/builds/slave/test', 23:52:03 INFO - 'SHELL': '/bin/bash', 23:52:03 INFO - 'SHLVL': '1', 23:52:03 INFO - 'TERM': 'linux', 23:52:03 INFO - 'TMOUT': '86400', 23:52:03 INFO - 'USER': 'cltbld', 23:52:03 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1465973295.699516-957453322', 23:52:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:52:03 INFO - '_': '/tools/buildbot/bin/python'} 23:52:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:52:04 INFO - Downloading/unpacking flake8 23:52:04 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 23:52:04 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 23:52:04 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 23:52:04 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 23:52:04 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 23:52:04 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 23:52:06 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 23:52:06 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 23:52:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:52:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:52:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:52:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:52:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:52:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:52:06 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 23:52:06 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 23:52:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:52:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:52:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:52:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:52:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:52:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:52:06 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 23:52:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:52:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:52:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:52:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:52:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:52:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:52:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 23:52:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:52:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:52:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:52:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:52:07 INFO - no previously-included directories found matching 'docs/_build' 23:52:07 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 23:52:07 INFO - Running setup.py install for pep8 23:52:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:52:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:52:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:52:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:52:07 INFO - no previously-included directories found matching 'docs/_build' 23:52:07 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 23:52:07 INFO - Successfully installed flake8 mccabe pyflakes pep8 23:52:07 INFO - Cleaning up... 23:52:07 INFO - Return code: 0 23:52:07 INFO - Running post-action listener: _resource_record_post_action 23:52:07 INFO - Running post-action listener: _start_resource_monitoring 23:52:07 INFO - Starting resource monitoring. 23:52:07 INFO - ##### 23:52:07 INFO - ##### Finished create-virtualenv step (success) 23:52:07 INFO - ##### 23:52:07 INFO - ##### 23:52:07 INFO - ##### Running install step. 23:52:07 INFO - ##### 23:52:07 INFO - Running pre-action listener: _resource_record_pre_action 23:52:07 INFO - Running main action method: install 23:52:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:52:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:52:07 INFO - Reading from file tmpfile_stdout 23:52:07 INFO - Detecting whether we're running mozinstall >=1.0... 23:52:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 23:52:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 23:52:07 INFO - Reading from file tmpfile_stdout 23:52:07 INFO - Output received: 23:52:07 INFO - Usage: mozinstall [options] installer 23:52:07 INFO - Options: 23:52:07 INFO - -h, --help show this help message and exit 23:52:07 INFO - -d DEST, --destination=DEST 23:52:07 INFO - Directory to install application into. [default: 23:52:07 INFO - "/builds/slave/test"] 23:52:07 INFO - --app=APP Application being installed. [default: firefox] 23:52:07 INFO - mkdir: /builds/slave/test/build/application 23:52:07 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'] 23:52:07 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 23:52:23 INFO - Reading from file tmpfile_stdout 23:52:23 INFO - Output received: 23:52:23 INFO - /builds/slave/test/build/application/firefox/firefox 23:52:23 INFO - Running post-action listener: _resource_record_post_action 23:52:23 INFO - ##### 23:52:23 INFO - ##### Finished install step (success) 23:52:23 INFO - ##### 23:52:23 INFO - ##### 23:52:23 INFO - ##### Running run-tests step. 23:52:23 INFO - ##### 23:52:23 INFO - Running pre-action listener: _resource_record_pre_action 23:52:23 INFO - Running main action method: run_tests 23:52:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 23:52:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 23:52:23 INFO - Python 2.7.3 23:52:23 INFO - Return code: 0 23:52:23 INFO - grabbing minidump binary from tooltool 23:52: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')]} 23:52:23 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 0x1d6c1c0>, '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 0x1d6d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d6d550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 23:52:23 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 23:52:23 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 23:52:23 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 23:52:23 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 23:52:23 INFO - Return code: 0 23:52:23 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 23:52:23 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 23:52:23 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 23:52:23 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 23:52:23 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 23:52:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 23:52:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 23:52:24 INFO - Return code: 0 23:52:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bOcn7TF7Rum_9S3M7li9oQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-040', '--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 23:52:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/bOcn7TF7Rum_9S3M7li9oQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-040 --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 23:52:24 INFO - Using env: {'DISPLAY': ':0', 23:52:24 INFO - 'HOME': '/home/cltbld', 23:52:24 INFO - 'LANG': 'en_US.UTF-8', 23:52:24 INFO - 'LANGUAGE': 'en_US:en', 23:52:24 INFO - 'LOGNAME': 'cltbld', 23:52:24 INFO - 'MAIL': '/var/mail/cltbld', 23:52:24 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 23:52:24 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 23:52:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:52:24 INFO - 'MOZ_NO_REMOTE': '1', 23:52:24 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 23:52:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:52:24 INFO - 'NO_EM_RESTART': '1', 23:52:24 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:52:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:52:24 INFO - 'PWD': '/builds/slave/test', 23:52:24 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 23:52:24 INFO - 'SHELL': '/bin/bash', 23:52:24 INFO - 'SHLVL': '1', 23:52:24 INFO - 'TERM': 'linux', 23:52:24 INFO - 'TMOUT': '86400', 23:52:24 INFO - 'USER': 'cltbld', 23:52:24 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1465973295.699516-957453322', 23:52:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:52:24 INFO - '_': '/tools/buildbot/bin/python'} 23:52:24 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bOcn7TF7Rum_9S3M7li9oQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-040', '--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 23:52:24 INFO - mozversion application_buildid: 20160614222226 23:52:24 INFO - mozversion application_changeset: 53f5b5c289fba6ad82c675578cf1c548ae37f0c1 23:52:24 INFO - mozversion application_display_name: Nightly 23:52:24 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 23:52:24 INFO - mozversion application_name: Firefox 23:52:24 INFO - mozversion application_remotingname: firefox 23:52:24 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 23:52:24 INFO - mozversion application_vendor: Mozilla 23:52:24 INFO - mozversion application_version: 50.0a1 23:52:24 INFO - mozversion platform_buildid: 20160614222226 23:52:24 INFO - mozversion platform_changeset: 53f5b5c289fba6ad82c675578cf1c548ae37f0c1 23:52:24 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 23:52:24 INFO - mozversion platform_version: 50.0a1 23:52:24 INFO - using testdate: 1465973544 23:52:24 INFO - actual date: 1465973544 23:52:24 INFO - starting webserver on 'localhost:43243' 23:52:24 INFO - SUITE-START | Running 2 tests 23:52:24 INFO - TEST-START | dromaeo_css 23:52:24 INFO - operating with platform_type : linux_ 23:52:24 INFO - Initialising browser for dromaeo_css test... 23:52:24 INFO - TEST-INFO | started process 16619 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLP1LbE/profile http://localhost:43243/getInfo.html) 23:52:29 INFO - PROCESS | 16619 | __metrics Screen width/height:1600/1200 23:52:29 INFO - PROCESS | 16619 | colorDepth:24 23:52:29 INFO - PROCESS | 16619 | Browser inner width/height: 1024/697 23:52:29 INFO - PROCESS | 16619 | __metrics 23:52:30 INFO - PROCESS | 16619 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 23:52:30 INFO - PROCESS | 16619 | console.error: PushService: 23:52:30 INFO - PROCESS | 16619 | stateChangeProcessEnqueue: Error transitioning state 23:52:30 INFO - PROCESS | 16619 | UnknownError 23:52:31 INFO - TEST-INFO | 16619: exit 0 23:52:31 INFO - Browser initialized. 23:52:31 INFO - Running cycle 1/1 for dromaeo_css test... 23:52:31 INFO - TEST-INFO | started process 16699 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLP1LbE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:52:43 INFO - PROCESS | 16699 | RSS: Main: 175542272 23:52:43 INFO - PROCESS | 16699 | 23:53:35 INFO - PROCESS | 16699 | 1465973615080 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] 23:55:47 INFO - PROCESS | 16699 | Cycle 1(1): loaded http://localhost:43243/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43243/tests/dromaeo/cssquery-ext.html) 23:55:48 INFO - PROCESS | 16699 | RSS: Main: 283480064 23:55:48 INFO - PROCESS | 16699 | 23:58:50 INFO - PROCESS | 16699 | Cycle 1(1): loaded http://localhost:43243/tests/dromaeo/cssquery-ext.html (next: http://localhost:43243/tests/dromaeo/cssquery-jquery.html) 23:58:51 INFO - PROCESS | 16699 | RSS: Main: 255442944 23:58:51 INFO - PROCESS | 16699 | 00:01:53 INFO - PROCESS | 16699 | Cycle 1(1): loaded http://localhost:43243/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43243/tests/dromaeo/cssquery-mootools.html) 00:01:54 INFO - PROCESS | 16699 | RSS: Main: 251473920 00:01:54 INFO - PROCESS | 16699 | 00:04:56 INFO - PROCESS | 16699 | Cycle 1(1): loaded http://localhost:43243/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43243/tests/dromaeo/cssquery-prototype.html) 00:04:57 INFO - PROCESS | 16699 | RSS: Main: 261410816 00:04:57 INFO - PROCESS | 16699 | 00:08:00 INFO - PROCESS | 16699 | Cycle 1(1): loaded http://localhost:43243/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43243/tests/dromaeo/cssquery-yui.html) 00:08:00 INFO - PROCESS | 16699 | RSS: Main: 235601920 00:08:00 INFO - PROCESS | 16699 | 00:11:03 INFO - PROCESS | 16699 | Cycle 1(1): loaded http://localhost:43243/tests/dromaeo/cssquery-yui.html (next: http://localhost:43243/tests/dromaeo/cssquery-dojo.html) 00:11:03 INFO - PROCESS | 16699 | RSS: Main: 306151424 00:11:03 INFO - PROCESS | 16699 | 00:11:03 INFO - PROCESS | 16699 | __start_tp_report 00:11:03 INFO - PROCESS | 16699 | _x_x_mozilla_page_load 00:11:03 INFO - PROCESS | 16699 | _x_x_mozilla_page_load_details 00:11:03 INFO - PROCESS | 16699 | |i|pagename|runs| 00:11:03 INFO - PROCESS | 16699 | |0;dojo.html;2588.9999999999995;2610.9086181983635;2636.28820218541;2641.247244535308;2646.1003258891974;4620.099080679269;4692.319613656018;4702.224133018052;4790.305405716169;4856.951430485694;4621.838235661752;4673.813047478096;4694.0142570060325;4720.976395118028;4746.0507898420365;4350.54319296474;4373.300271956487;4419.160359531695;4431.26884064129;4432.3794668746405;4376.659143558791;4437.134758722051;4468.486124095738;4469.620082293009;4505.662075344362;4473.977630111861;4494.033782736711;4517.774111294439;4531.501534831166;4537.2286711259;4315.093830295642;4350.6736994725525;4361.781910904474;4435.201663700533;4482.350059241425;4268.829246830123;4270.295401258789;4313.460817397825;4315.784210789479;4367;4759.4764575896625;4767.666263361566;4767.976160119178;4775.761211939389;4776.188048031843;4883.731394773286;5037.722925239111;5054.014467178901;5070.315507406527;5125.615578831603;5211.24436956643;5212.1921102228835;5218.504242096995;5232.058229518685;5238.188080847474;4852.927206091911;4872.951270487285;4878.975605122023;4883.951160488421;4884.877878053077;5015.799368025311;5292.417834038252;5341.145416733381;5349.679019258779;5363.892722145613;5126.897462050738;5130.076586214517;5134.8973020540125;5146.125158722951;5148.330717006766;5170.741462926914;5174.275601415805;5189.299444575009;5190.896182076337;5192.5586325162785;4886.902261954741;4982.601391888713;5019.121653710586;5027.698338099653;5039.697618142924;4985.351904252424;5005.849824505271;5013.473585273494;5032.370953630796;5054.9241761373605;4129.318662420667;4298.978505107517;4300;4302.720323178984;4355.216061109031;3645.872394466181;3733.6826369758874;3753.418220175877;3769.208466222069;3807.3146833569667;4344.630706389992;4356.302991521405;4359.716618419792;4402.691811573159;4406.5593440655675;4989.600831933437;5101.7704203310195;5107.055194788976;5111.437741848394;5161.4322424533275;4367.934480982788;4397.428334316583;4406.933895991563;4409.757463339547;4410.647148228134;4616.95383046172;4635.2120139576355;4638.675292729544;4673.7429441381055;4691.882702932454;4681.929771053505;4758.928616070831;4862.80548778052;4867.342908707279;4868.805247790048;5071.746412679425;5115.18157094863;5123.410807757155;5189.740512974412;5190.844274671615;4820.566149046603;4827.517248275285;4830.637702172281;4831.178699621143;4863.392075990501;4898.804047838046;5048.495150484922;5049.2173713074535;5050.444451110301;5105.719185444687;5119.769610367617;5193.714345711022;5202.921956170585;5209.114450543492;5252.737363131904;5040.218766091261;5051.318072060225;5058.595312375075;5061;5110.182370820651;4843.104025755247;4908.803647854189;4940.456549779593;5052.191649336089;5067.087924173684;4861.878453038702;4877.658563900635;4899.461059283405;4902.950970490249;4903.926441103315;5000.749962501933;5005.6996580205305;5010.098182327216;5011.072951503984;5043.571296439697;4795.568398844121;4878.414590249193;4929.137400954747;4937.28409380645;4937.5556199942175 00:11:03 INFO - PROCESS | 16699 | |1;ext.html;538.3798102806724;577.445652173913;582.0774073094145;594.6669864875672;600.3126420248815;29037;38629.22741545167;39774.40338394926;39924.600753992454;43242.56757432425;39923.40114898272;40368.79815600918;40442.797786011026;40446.59553404465;40459;7545.396368290551;7914.960425197881;8061.435699501038;8061.9193808061755;10055.798884022315;9853.162481189072;10238.129758970497;10266.691999240034;10268.691939241835;10273.486325683685;10258.179345652366;10289.382637041765;10294.279400441972;10310.278280520366;10314.845277320808;7534.133574638932;10003;10212.489375531231;10262.7434314142;10273.743156421075;10050.341693620543;10080.69757907264;10110.89889101107;10154.136898363648;10167.135793457564;37777.43333849994;38018.619813801786;38103.237935241414;38106.61893381058;38245.80877095597;2870.8851645934137;3221.855016524262;3249.46383846665;3368.9326213475592;3677.0991107178643;28927;29451.558226626617;29475.70524294751;29697.851510742523;30780.692193078008;3492.7729697569575;3532.6643968822923;3540.274243780019;3546.2552863898354;3570.6607872252093;252973;253039;253060;253790;254184;50532.747336263084;50629.493705063214;50816.98366032659;50854.491455085714;50856.23715644268;32594.674053259638;33242.66757332444;33374.66625333716;35606;53319.73340133274;15269.389224430899;15485.148316842457;15502.069875807487;15504.379824806882;15510.767338489932;9418.62325506972;11586.536538538532;11737.589184378676;11760.294382337088;12134.817977730165;17919.820801792077;17990.5502362442;18043.639127217382;18079.54801129956;18197.45407637773;6966.338197871194;7106.92893071073;7163;7268.23683513234;7287.854242915112;810.8702607582759;841.5918279634373;915.7527467583849;958.3914214473859;999.0509016434416;27634.723652763616;28056.579151312748;28079.298017549725;28370;28579.428411431654;967.0764419979043;976.8339382305026;1001.8096561653263;1012.0486742462209;1015.4821041269006;14758.704825903422;14815;14970.176640284672;15128;15290.617734556503;394776;400067;401953;402360;402939;47355.052898942515;47771.28343074857;47777.761111194915;47833.76083119562;47960.5203947956;1089.727568107973;1152.389233706137;1174.8883856033663;1192.5706745571588;1204.3978010994504;27642;28043.57934631023;29091.563626545194;29201.269968250963;29357;39879.40180897347;40259.79870100631;40266.798666006485;40293.19413611653;40303;287129;288070;290156;290777;291071;22127;23892.402689932194;24821.751782481944;24912.62631060572;26057.869710651325;40707;40971.590284096776;41018.79490602528;41243.1751364965;41975;34926.30147396987;34974;35135.82432087823;35242.823785881934;35768.64231357653;34318.31363372769;34764.47853282253;35016;35034.82482587571;35429.645703542636;34107.82946085254;34116;34658.48012279767;34903.12742181466;34950.82524587361;30779.84610076935;31898.84050579732;31922;31970.36059278848;31989;24566.631500527863;24653;24742.876285619175;24960.251192464257;25203.243902682214 00:11:03 INFO - PROCESS | 16699 | |2;jquery.html;369.696848584161;371.1852483798064;377.2398616787174;382.72826293331735;382.77033779732164;15739.134347610876;16925.830741692578;17924.193411296492;17960.55098622535;17964;15401.614959626015;15935.84064159361;15954.361825526965;15972.281247343868;15979.360825566964;4961.950380496194;5183.015227106856;5229.477052294759;5239.292695486099;5239.502247286502;3666.5966743658178;3861.362875125601;5156.484351564833;5783.5951483396175;6122.47958923492;6161.322254551996;6163.537734669895;6176.38236176381;6192.195014648112;6196.504279657639;5923.5853490255695;6111.724972376232;6124.203853499062;6134.631922084644;6137.17148184996;3323.3353329333986;4989.201727723546;5291.021161085211;5314.4951229633125;5327.706976116312;20682.17271309146;21234;21249.468763280885;21443.57112857734;21515.569688606298;1968.881867087965;1998.6302534031252;2006.7993200679962;2170.218721260345;2282.9086836526517;11887.167898247126;12378.319192444502;12445.128840981135;12733.172343797716;12884.291363974977;1718.2353852535628;1736.6266252755718;1819.4632583387931;1829.9908500457545;1965.7444532210864;67042.66478667624;67727.66136169288;68715.3128468719;71789.28210717878;72109.6394518024;9727.07592778685;9766.46284454362;9886.703398898044;10109.797804043877;10257.281990260759;13592.320383980761;13747.862521374658;13757.10578812374;13780.586582402544;13785.862141378659;7233.132024157029;7242.601656908921;7250.347468727734;7270.091238595176;7491.587962661997;6349.174607301022;6472.579282346633;6579.901301480481;7165.140183177948;7358.889616655754;4325.41606883073;4335.501417337046;4337.587929146726;4344.630706389992;4448.221561226837;1713.7086695261835;1725.2322716391336;1796.694561924476;1818.2181661885252;1822.0616382562991;804.3846457460048;816.7059858450953;857.9871301930476;929.4051806843626;932.9533523323806;16608.169591520375;16801.747973780402;16897.239624216938;16968.57578560546;17017.82982170187;842.1536355962219;862.288611895189;878.6529320918202;929.7071422502025;955.8518429643416;8934.329925255503;9676.854847177297;9764.121229089416;9768.462734549668;9828.262880284008;421569;425546;426033;426846;426927;82072.58963705144;86230.56884715536;86856.565717171;87887;88627.11372886189;907.832051070554;927.6363745294407;945.4374647085111;953.9141477266941;958.8657587937695;15692.529224123295;15825.68348633044;15913.68172636564;16086.919565402099;16639.66720665556;29591.26021849471;33794.34516536062;36123.63876361308;36246.45630315495;36291.81854090712;46224;52014.73992630164;52444.47555524549;52464.7376763129;52717;7525.473216874766;7550.584717840571;7565.508241964475;7713.961430192813;7789.298963093349;10676.306040107369;11124.777504450027;11151.832722509007;11294.209405341548;11465.484053217458;9730.75673108178;9933.453660048766;10008.749781255527;10096.444695541815;10339.896601033894;9448.574814133242;9658.661946831828;9783.168430683472;9856.112949834549;9918.107370336704;10097.343672661253;10428.843567346648;10599.417032063311;10691.30506517074;10770.946145269223;7596.658150383357;7627.199144089791;7643.808904777425;7710.383169346326;7849.489783164305;4941.75291235444;8921.866172007554;9585.185259253041;10035.648752293635;10299 00:11:03 INFO - PROCESS | 16699 | |3;mootools.html;1368.828896387951;1399.2863639543832;1501.5270189890184;1670.356912588653;1706.522173791338;7679.500832445894;8179.79550511236;8262.339012878963;8270.627821748021;8274.296684781793;7033.613151276678;7575.545467271968;7852.568108754016;7855.8821617675785;8079;2241.1819685814644;2269.7616750241236;2271.284545368212;2271.432141964509;2275.340151356105;2195.319450970196;2240.607893618618;2249.4376405898524;2251.808596269319;2251.966220506694;1928.7878333383317;1992.5417154054576;1993.0732209522569;2005.5287007553213;2180.9781902180935;2223.3885681437655;2266.9546609067893;2268.104098880941;2273.090763694519;2276.7267927848598;2191.375457994464;2202.922897698573;2204.8015678588845;2207.061998650567;2229.977700222993;7876.212378762135;7911.248431399008;7934.365250779923;7937.960310198412;7944.801379965547;4451.688381813275;4567.040921406476;4570.040291538781;4572;4595.586397224232;3014.3820516794003;3039.1642298367906;3060.8775648974015;3093.9535906961414;3108.4870996285586;965.5510187762654;979.8530220466915;1016.5273147986222;1022.5091955861154;1035.177034257767;11225.831612525737;11237.438128093645;11243.550257989753;11244.325340479598;11273.436328183558;4157.064660451374;4284.400183974246;4352.978235108868;4354.738715677069;4362.8909277267685;9502.619895204114;9551.665691700757;9553;9560.760980975392;9570.856437153448;4567.862964111082;4584.404027476474;4588.105319462739;4590.747508886977;4593.035462552834;4159.10579225468;4208.747475151501;4308.763018033976;4312.913741725148;4340.544242854518;3784.924301513954;3803.5245594300713;3857.324968130566;3896.2597106550234;3951.585083566184;1201.801702719059;1203.8735932727113;1214.1622280626339;1214.9817752733716;1226.0804396702474;825.2613910550144;845.2097289034772;847.8431490174338;855.6791203298762;878.8662625213531;5325.174597937326;5368.8389348319615;5382.111951527954;5395.676259424368;5405.945940540623;407.4824972285181;420.31278859065037;422.52254951904763;426.53081610228503;428.8520460441143;3433;3779.3008293465796;3815.4849095372324;3834.654881060718;3843.2889915365745;9332.95333523328;9722.173615242642;9778.41329520231;9916.057974492413;9925.255605829592;9754.95122524397;9785.510724463747;9796.902030979742;9812.165965892837;9825.459599722084;7467.813304667427;7480.214577469287;7575.166731659513;7576.659050342748;7588.734394296173;5238;5297.788088476418;5310.8141215057285;5374.3013408256675;5389.0299746046085;8985.730428087169;9129.817403651758;9171.266298696222;9172.495512746864;9214.308926830381;8973.474509333559;9243.306751993761;9263.722088337361;9405.529723513933;9406.623735050522;6750;6792.830179245559;6804.82987925286;6827.249002609609;6860.416864566568;7100.680469378994;7416.110066792019;7441.293077157661;7451;7454.776356709307;6611.768588099393;6686.498512611671;6692.464602831859;6776.728930842908;6879.965600171967;6445.935540644534;6603;6619.106420633346;6717;6718;6368.904466432915;6399.04014397844;6439.67801609927;6444.7744328948265;6460.160179176677;4622.699524531029;4820.39745031871;4845.466998630219;4850.811551169986;4854.854354369375;4780.641451891052;4801.207800712843;4805.639577031807;4819.638527110411;4902.60779137661 00:11:03 INFO - PROCESS | 16699 | |4;prototype.html;298.5477002341452;303.45075413501564;306.2008158705776;306.23135928818675;306.8971894415371;4862.124817532843;4862.350019239514;4898.975505122474;4906.607471402288;4920.557149856512;4764.403924685226;4827.324174615556;4844.200706883369;4866.099771542267;4867.464578896327;3621.7826930384263;3737;3747.3067482515685;3824.8470061197518;3866.2460820140086;3788.8295026723727;3822.617738226183;3823.3309170895122;3828.1386687995255;3859.591249194038;3627.927441451169;3803.847846086167;3813.599572044937;3815.0080978945534;3818.599047100056;3622.855085796565;3788.2612890486366;3804.068003339186;3805.923881522354;3813.904652383685;3361.0757041813695;3362.3947689415895;3374.088995971074;3374.7300215982664;3394.8642054317797;4746.457401344577;4764.904701905943;4775.403074615673;4786.473487916326;4800.279958006327;4265.146970605861;4367.628751556122;4384.780760961971;4405.713628614129;4408.40486534317;5021.6735912165595;5052.343195384577;5052.646314757969;5087.872803179913;5100.413452452941;3661.5789184243886;3683.7605555638797;3702.38910579754;3709.666130048309;3721.702263818888;5188.429272779991;5271.785849943033;5306.389765176977;5336.332958380202;5357.303550538405;3714.257148570297;3717.981410092986;3738.3084129436143;3739.7569158004644;3751.8874433767032;3779.905502362463;3786.4320351947426;3786.962130378716;3796.962030379661;3810.961890381116;4331.047169622678;4338.739675619473;4346.9347959780625;4347.891302717394;4355.128974205171;4841.515848415131;5008.223725322581;5016.874578135576;5021.548060674557;5051.924221136685;1269.397036407699;1295.9676008099873;1300.4798080767769;1312.6193403912757;1321.1742660836976;864.3992425264506;870.1602953150241;888.5246393179618;897.2866571076011;904.0597778310615;4345.304751239786;4369.890752731207;4481.170983368087;4486.730796152241;4524.117797029613;5248.737563121828;5263.868133405977;5276.1821917602065;5282.735863206901;5289.444608316148;4222.501012140708;4425.933610995773;4480.731156130642;4489.371487991683;4502.324651302265;2773.0433000614757;2787.8569786387484;2788.8426303083993;2795.3850152966315;2816.845073520935;4908.386451693538;4913.901721965541;4938.950610493921;4955.157623204064;5011.223260394645;5069.746512674352;5386.407495175527;5393.379761327497;5405.702686352289;5430.511253987082;4959.611308833532;4969.180085285887;4971.875703107451;4976.900461990812;4989.326440930573;5263.73681315925;5282.656627319212;5304;5318.335208098988;5329;4853.878653033702;5153.3815942087185;5164.948350516447;5169.121249387688;5170.819021334235;4896.914943585518;4912.557869791736;4925.729084900365;4955.058538877602;4959.429665588504;3642.562892452923;3671.9265614688093;3680.190358121209;3682.484452176644;3700.389435743072;5104.41299250591;5246.685198888079;5255.737213139404;5273.393559740679;5298.470152984671;5089.9745501272255;5091.516305950929;5099.184130539096;5142.408623008252;5147.639665223398;5056.949430505648;5124.205748109049;5125.898381663649;5133.8716532087;5155.381354237516;4755.167845626932;4866.48901865299;4873.239851095415;4998.725070121178;5010.3737032870895;5024.447310795883;5139.563137133386;5155.705710958588;5169.508896654812;5174;5064.848054558369;5073.7716802743225;5105.132127538253;5111;5111.361079865017 00:11:03 INFO - PROCESS | 16699 | |5;yui.html;639.3912835630626;671.4863129705773;693.109354479494;697.6442014572566;745.1170363119702;12015.519379224832;12757.553485628005;13272.46910123595;13342.332883355843;13368.131071480348;14062.085964412332;14288.78566821496;14331.71336573268;14353.641158971031;14355.78466323006;628.7987843889935;768.9653965571534;789.8064974081329;798.876174193001;799.8520273749346;790.1426951757351;794.6185830801219;800.7877912353202;800.9559474228915;804.3806269172734;828.6436832162168;835.7701632051173;836.2682652678906;836.7531578184451;837.3217693668117;651.2900937977627;800.7197480881645;814.8818421328874;832.2260297922929;834.4200780457585;610.7434877351523;611.5230120506012;611.7338957553478;612.5558969746943;614.8124821929309;13406.262655553941;13413.061085724003;13416.86583134166;13471.124376915566;13478.932605337008;11649.126315526284;11768.529258829636;12180.576676506538;12215;12481.75036499274;11483.25358851672;11541.711457213552;11572.537098516133;11660.183787134903;11738;4150.584941505856;4151.481064866892;4154.688398370135;4351.434313539251;4356.586124318184;61825;63035.36964630341;63073.369266307665;63973.360266397205;64255.67872160609;9389.90610093904;9486.430814151036;9678.128968392879;9776.332977673168;9938.751531211778;19103.713444298348;19107;19157.904210478857;19166.137523811463;19194.424167274723;6465.3857883501;6562.081308616797;6566.5403421760975;6669.566478178903;6727.360900714424;3465.5321531593418;3539.3275277697153;3578.624244454347;3640.199156185688;3652;2914.082064149786;3011.472992226352;3018.2001769531093;3018.3661431099713;3019.879204831826;501.2105933155295;510.9335786347825;511.4246472718192;512.6513970500096;527.4224723927293;471.3942583779826;507.6496519258754;526.3762441506826;577.4831525784483;592.3099588978791;7615.923840761632;7910.534904262154;8070.838583228303;8116.88960870178;8195;530.6683322923172;557.8925832223034;574.379669956446;580.4717706886713;606.4178388746765;3325.7838240514775;3673.2653469306247;3812.2566099610863;3894.922101557953;3901.5708272090046;91347;92253;92862.53568732113;93325;93904.53047734717;80197;80600.19399806044;81600.59199703964;81974;82038.58980705058;72585.6370718143;74778;74780.72474403318;75272.62363688256;76895;6526.771562995273;6643.966780166068;6794.660266986532;6868.690908909011;6908.965455172692;41853.372199417645;42158.504290278135;43937.34093988657;44054.33918491161;44983.32525012062;55421;64878.35121648723;65335.346646532926;65585.67207163933;65910;9419;9419.811603768023;9520.285978551776;9527.333086683866;9624.66313679018;11342.149338799789;11364.488598013275;11839.408029598659;11965.04279657608;11983.34091624969;9707.66023189185;9931.553080111267;9932.304738668225;10154.695359139238;10261.02520260574;9857.704268871945;9921.454320012468;10164.085232329126;10548.736281592715;10676.519556619816;9599.664011759554;9746.853797192905;9933.453660048766;9948.45283509414;10661.89338106609;8441.153469217945;8695.21951996193;8962.283017358464;9017.188453039258;9119.407238529475;8256.711015114442;8258.215469530385;8330.541820199947;8639.6976105836;8768.517731524827 00:11:03 INFO - PROCESS | 16699 | __end_tp_report 00:11:03 INFO - PROCESS | 16699 | __start_cc_report 00:11:03 INFO - PROCESS | 16699 | _x_x_mozilla_cycle_collect,986 00:11:03 INFO - PROCESS | 16699 | __end_cc_report 00:11:03 INFO - PROCESS | 16699 | __startTimestamp1465974663908__endTimestamp 00:11:03 INFO - PROCESS | 16699 | 00:11:03 INFO - PROCESS | 16699 | ------- Summary: start ------- 00:11:03 INFO - PROCESS | 16699 | Number of tests: 6 00:11:03 INFO - PROCESS | 16699 | 00:11:03 INFO - PROCESS | 16699 | [#0] dojo.html Cycles:165 Average:4726.73 Median:4867.34 stddev:511.13 (10.5%) stddev-sans-first:484.40 00:11:03 INFO - PROCESS | 16699 | Values: 2589.0 2610.9 2636.3 2641.2 2646.1 4620.1 4692.3 4702.2 4790.3 4857.0 4621.8 4673.8 4694.0 4721.0 4746.1 4350.5 4373.3 4419.2 4431.3 4432.4 4376.7 4437.1 4468.5 4469.6 4505.7 4474.0 4494.0 4517.8 4531.5 4537.2 4315.1 4350.7 4361.8 4435.2 4482.4 4268.8 4270.3 4313.5 4315.8 4367.0 4759.5 4767.7 4768.0 4775.8 4776.2 4883.7 5037.7 5054.0 5070.3 5125.6 5211.2 5212.2 5218.5 5232.1 5238.2 4852.9 4873.0 4879.0 4884.0 4884.9 5015.8 5292.4 5341.1 5349.7 5363.9 5126.9 5130.1 5134.9 5146.1 5148.3 5170.7 5174.3 5189.3 5190.9 5192.6 4886.9 4982.6 5019.1 5027.7 5039.7 4985.4 5005.8 5013.5 5032.4 5054.9 4129.3 4299.0 4300.0 4302.7 4355.2 3645.9 3733.7 3753.4 3769.2 3807.3 4344.6 4356.3 4359.7 4402.7 4406.6 4989.6 5101.8 5107.1 5111.4 5161.4 4367.9 4397.4 4406.9 4409.8 4410.6 4617.0 4635.2 4638.7 4673.7 4691.9 4681.9 4758.9 4862.8 4867.3 4868.8 5071.7 5115.2 5123.4 5189.7 5190.8 4820.6 4827.5 4830.6 4831.2 4863.4 4898.8 5048.5 5049.2 5050.4 5105.7 5119.8 5193.7 5202.9 5209.1 5252.7 5040.2 5051.3 5058.6 5061.0 5110.2 4843.1 4908.8 4940.5 5052.2 5067.1 4861.9 4877.7 4899.5 4903.0 4903.9 5000.7 5005.7 5010.1 5011.1 5043.6 4795.6 4878.4 4929.1 4937.3 4937.6 00:11:03 INFO - PROCESS | 16699 | 00:11:03 INFO - PROCESS | 16699 | [#1] ext.html Cycles:180 Average:46536.38 Median:32918.67 stddev:84299.43 (256.1%) stddev-sans-first:84465.16 00:11:03 INFO - PROCESS | 16699 | Values: 538.4 577.4 582.1 594.7 600.3 29037.0 38629.2 39774.4 39924.6 43242.6 39923.4 40368.8 40442.8 40446.6 40459.0 7545.4 7915.0 8061.4 8061.9 10055.8 9853.2 10238.1 10266.7 10268.7 10273.5 10258.2 10289.4 10294.3 10310.3 10314.8 7534.1 10003.0 10212.5 10262.7 10273.7 10050.3 10080.7 10110.9 10154.1 10167.1 37777.4 38018.6 38103.2 38106.6 38245.8 2870.9 3221.9 3249.5 3368.9 3677.1 28927.0 29451.6 29475.7 29697.9 30780.7 3492.8 3532.7 3540.3 3546.3 3570.7 252973.0 253039.0 253060.0 253790.0 254184.0 50532.7 50629.5 50817.0 50854.5 50856.2 32594.7 33242.7 33374.7 35606.0 53319.7 15269.4 15485.1 15502.1 15504.4 15510.8 9418.6 11586.5 11737.6 11760.3 12134.8 17919.8 17990.6 18043.6 18079.5 18197.5 6966.3 7106.9 7163.0 7268.2 7287.9 810.9 841.6 915.8 958.4 999.1 27634.7 28056.6 28079.3 28370.0 28579.4 967.1 976.8 1001.8 1012.0 1015.5 14758.7 14815.0 14970.2 15128.0 15290.6 394776.0 400067.0 401953.0 402360.0 402939.0 47355.1 47771.3 47777.8 47833.8 47960.5 1089.7 1152.4 1174.9 1192.6 1204.4 27642.0 28043.6 29091.6 29201.3 29357.0 39879.4 40259.8 40266.8 40293.2 40303.0 287129.0 288070.0 290156.0 290777.0 291071.0 22127.0 23892.4 24821.8 24912.6 26057.9 40707.0 40971.6 41018.8 41243.2 41975.0 34926.3 34974.0 35135.8 35242.8 35768.6 34318.3 34764.5 35016.0 35034.8 35429.6 34107.8 34116.0 34658.5 34903.1 34950.8 30779.8 31898.8 31922.0 31970.4 31989.0 24566.6 24653.0 24742.9 24960.3 25203.2 00:11:03 INFO - PROCESS | 16699 | 00:11:03 INFO - PROCESS | 16699 | [#2] jquery.html Cycles:180 Average:25546.35 Median:25582.88 stddev:70226.49 (274.5%) stddev-sans-first:70398.05 00:11:03 INFO - PROCESS | 16699 | Values: 369.7 371.2 377.2 382.7 382.8 15739.1 16925.8 17924.2 17960.6 17964.0 15401.6 15935.8 15954.4 15972.3 15979.4 4962.0 5183.0 5229.5 5239.3 5239.5 3666.6 3861.4 5156.5 5783.6 6122.5 6161.3 6163.5 6176.4 6192.2 6196.5 5923.6 6111.7 6124.2 6134.6 6137.2 3323.3 4989.2 5291.0 5314.5 5327.7 20682.2 21234.0 21249.5 21443.6 21515.6 1968.9 1998.6 2006.8 2170.2 2282.9 11887.2 12378.3 12445.1 12733.2 12884.3 1718.2 1736.6 1819.5 1830.0 1965.7 67042.7 67727.7 68715.3 71789.3 72109.6 9727.1 9766.5 9886.7 10109.8 10257.3 13592.3 13747.9 13757.1 13780.6 13785.9 7233.1 7242.6 7250.3 7270.1 7491.6 6349.2 6472.6 6579.9 7165.1 7358.9 4325.4 4335.5 4337.6 4344.6 4448.2 1713.7 1725.2 1796.7 1818.2 1822.1 804.4 816.7 858.0 929.4 933.0 16608.2 16801.7 16897.2 16968.6 17017.8 842.2 862.3 878.7 929.7 955.9 8934.3 9676.9 9764.1 9768.5 9828.3 421569.0 425546.0 426033.0 426846.0 426927.0 82072.6 86230.6 86856.6 87887.0 88627.1 907.8 927.6 945.4 953.9 958.9 15692.5 15825.7 15913.7 16086.9 16639.7 29591.3 33794.3 36123.6 36246.5 36291.8 46224.0 52014.7 52444.5 52464.7 52717.0 7525.5 7550.6 7565.5 7714.0 7789.3 10676.3 11124.8 11151.8 11294.2 11465.5 9730.8 9933.5 10008.7 10096.4 10339.9 9448.6 9658.7 9783.2 9856.1 9918.1 10097.3 10428.8 10599.4 10691.3 10770.9 7596.7 7627.2 7643.8 7710.4 7849.5 4941.8 8921.9 9585.2 10035.6 10299.0 00:11:03 INFO - PROCESS | 16699 | 00:11:03 INFO - PROCESS | 16699 | [#3] mootools.html Cycles:180 Average:5239.88 Median:4852.83 stddev:2967.84 (61.2%) stddev-sans-first:2961.91 00:11:03 INFO - PROCESS | 16699 | Values: 1368.8 1399.3 1501.5 1670.4 1706.5 7679.5 8179.8 8262.3 8270.6 8274.3 7033.6 7575.5 7852.6 7855.9 8079.0 2241.2 2269.8 2271.3 2271.4 2275.3 2195.3 2240.6 2249.4 2251.8 2252.0 1928.8 1992.5 1993.1 2005.5 2181.0 2223.4 2267.0 2268.1 2273.1 2276.7 2191.4 2202.9 2204.8 2207.1 2230.0 7876.2 7911.2 7934.4 7938.0 7944.8 4451.7 4567.0 4570.0 4572.0 4595.6 3014.4 3039.2 3060.9 3094.0 3108.5 965.6 979.9 1016.5 1022.5 1035.2 11225.8 11237.4 11243.6 11244.3 11273.4 4157.1 4284.4 4353.0 4354.7 4362.9 9502.6 9551.7 9553.0 9560.8 9570.9 4567.9 4584.4 4588.1 4590.7 4593.0 4159.1 4208.7 4308.8 4312.9 4340.5 3784.9 3803.5 3857.3 3896.3 3951.6 1201.8 1203.9 1214.2 1215.0 1226.1 825.3 845.2 847.8 855.7 878.9 5325.2 5368.8 5382.1 5395.7 5405.9 407.5 420.3 422.5 426.5 428.9 3433.0 3779.3 3815.5 3834.7 3843.3 9333.0 9722.2 9778.4 9916.1 9925.3 9755.0 9785.5 9796.9 9812.2 9825.5 7467.8 7480.2 7575.2 7576.7 7588.7 5238.0 5297.8 5310.8 5374.3 5389.0 8985.7 9129.8 9171.3 9172.5 9214.3 8973.5 9243.3 9263.7 9405.5 9406.6 6750.0 6792.8 6804.8 6827.2 6860.4 7100.7 7416.1 7441.3 7451.0 7454.8 6611.8 6686.5 6692.5 6776.7 6880.0 6445.9 6603.0 6619.1 6717.0 6718.0 6368.9 6399.0 6439.7 6444.8 6460.2 4622.7 4820.4 4845.5 4850.8 4854.9 4780.6 4801.2 4805.6 4819.6 4902.6 00:11:03 INFO - PROCESS | 16699 | 00:11:03 INFO - PROCESS | 16699 | [#4] prototype.html Cycles:180 Average:4237.54 Median:4858.00 stddev:1227.05 (25.3%) stddev-sans-first:1194.35 00:11:03 INFO - PROCESS | 16699 | Values: 298.5 303.5 306.2 306.2 306.9 4862.1 4862.4 4899.0 4906.6 4920.6 4764.4 4827.3 4844.2 4866.1 4867.5 3621.8 3737.0 3747.3 3824.8 3866.2 3788.8 3822.6 3823.3 3828.1 3859.6 3627.9 3803.8 3813.6 3815.0 3818.6 3622.9 3788.3 3804.1 3805.9 3813.9 3361.1 3362.4 3374.1 3374.7 3394.9 4746.5 4764.9 4775.4 4786.5 4800.3 4265.1 4367.6 4384.8 4405.7 4408.4 5021.7 5052.3 5052.6 5087.9 5100.4 3661.6 3683.8 3702.4 3709.7 3721.7 5188.4 5271.8 5306.4 5336.3 5357.3 3714.3 3718.0 3738.3 3739.8 3751.9 3779.9 3786.4 3787.0 3797.0 3811.0 4331.0 4338.7 4346.9 4347.9 4355.1 4841.5 5008.2 5016.9 5021.5 5051.9 1269.4 1296.0 1300.5 1312.6 1321.2 864.4 870.2 888.5 897.3 904.1 4345.3 4369.9 4481.2 4486.7 4524.1 5248.7 5263.9 5276.2 5282.7 5289.4 4222.5 4425.9 4480.7 4489.4 4502.3 2773.0 2787.9 2788.8 2795.4 2816.8 4908.4 4913.9 4939.0 4955.2 5011.2 5069.7 5386.4 5393.4 5405.7 5430.5 4959.6 4969.2 4971.9 4976.9 4989.3 5263.7 5282.7 5304.0 5318.3 5329.0 4853.9 5153.4 5164.9 5169.1 5170.8 4896.9 4912.6 4925.7 4955.1 4959.4 3642.6 3671.9 3680.2 3682.5 3700.4 5104.4 5246.7 5255.7 5273.4 5298.5 5090.0 5091.5 5099.2 5142.4 5147.6 5056.9 5124.2 5125.9 5133.9 5155.4 4755.2 4866.5 4873.2 4998.7 5010.4 5024.4 5139.6 5155.7 5169.5 5174.0 5064.8 5073.8 5105.1 5111.0 5111.4 00:11:03 INFO - PROCESS | 16699 | 00:11:03 INFO - PROCESS | 16699 | [#5] yui.html Cycles:180 Average:17297.86 Median:31856.38 stddev:24874.24 (78.1%) stddev-sans-first:24912.57 00:11:03 INFO - PROCESS | 16699 | Values: 639.4 671.5 693.1 697.6 745.1 12015.5 12757.6 13272.5 13342.3 13368.1 14062.1 14288.8 14331.7 14353.6 14355.8 628.8 769.0 789.8 798.9 799.9 790.1 794.6 800.8 801.0 804.4 828.6 835.8 836.3 836.8 837.3 651.3 800.7 814.9 832.2 834.4 610.7 611.5 611.7 612.6 614.8 13406.3 13413.1 13416.9 13471.1 13478.9 11649.1 11768.5 12180.6 12215.0 12481.8 11483.3 11541.7 11572.5 11660.2 11738.0 4150.6 4151.5 4154.7 4351.4 4356.6 61825.0 63035.4 63073.4 63973.4 64255.7 9389.9 9486.4 9678.1 9776.3 9938.8 19103.7 19107.0 19157.9 19166.1 19194.4 6465.4 6562.1 6566.5 6669.6 6727.4 3465.5 3539.3 3578.6 3640.2 3652.0 2914.1 3011.5 3018.2 3018.4 3019.9 501.2 510.9 511.4 512.7 527.4 471.4 507.6 526.4 577.5 592.3 7615.9 7910.5 8070.8 8116.9 8195.0 530.7 557.9 574.4 580.5 606.4 3325.8 3673.3 3812.3 3894.9 3901.6 91347.0 92253.0 92862.5 93325.0 93904.5 80197.0 80600.2 81600.6 81974.0 82038.6 72585.6 74778.0 74780.7 75272.6 76895.0 6526.8 6644.0 6794.7 6868.7 6909.0 41853.4 42158.5 43937.3 44054.3 44983.3 55421.0 64878.4 65335.3 65585.7 65910.0 9419.0 9419.8 9520.3 9527.3 9624.7 11342.1 11364.5 11839.4 11965.0 11983.3 9707.7 9931.6 9932.3 10154.7 10261.0 9857.7 9921.5 10164.1 10548.7 10676.5 9599.7 9746.9 9933.5 9948.5 10661.9 8441.2 8695.2 8962.3 9017.2 9119.4 8256.7 8258.2 8330.5 8639.7 8768.5 00:11:03 INFO - PROCESS | 16699 | -------- Summary: end -------- 00:11:03 INFO - PROCESS | 16699 | 00:11:04 INFO - TEST-INFO | 16699: exit 0 00:11:04 INFO - TEST-OK | dromaeo_css | took 1120009ms 00:11:04 INFO - TEST-START | kraken 00:11:04 INFO - operating with platform_type : linux_ 00:11:04 INFO - Initialising browser for kraken test... 00:11:04 INFO - TEST-INFO | started process 16874 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpl0eE0j/profile http://localhost:43243/getInfo.html) 00:11:09 INFO - PROCESS | 16874 | __metrics Screen width/height:1600/1200 00:11:09 INFO - PROCESS | 16874 | colorDepth:24 00:11:09 INFO - PROCESS | 16874 | Browser inner width/height: 1024/697 00:11:09 INFO - PROCESS | 16874 | __metrics 00:11:10 INFO - PROCESS | 16874 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 00:11:10 INFO - PROCESS | 16874 | console.error: PushService: 00:11:10 INFO - PROCESS | 16874 | stateChangeProcessEnqueue: Error transitioning state 00:11:10 INFO - PROCESS | 16874 | UnknownError 00:11:11 INFO - TEST-INFO | 16874: exit 0 00:11:11 INFO - Browser initialized. 00:11:11 INFO - Running cycle 1/1 for kraken test... 00:11:11 INFO - TEST-INFO | started process 16955 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpl0eE0j/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:11:23 INFO - PROCESS | 16955 | RSS: Main: 174919680 00:11:23 INFO - PROCESS | 16955 | 00:11:25 INFO - PROCESS | 16955 | Cycle 1(1): loaded http://localhost:43243/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43243/tests/kraken/driver.html?testName=audio-beat-detection) 00:11:26 INFO - PROCESS | 16955 | RSS: Main: 233832448 00:11:26 INFO - PROCESS | 16955 | 00:11:29 INFO - PROCESS | 16955 | Cycle 1(1): loaded http://localhost:43243/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43243/tests/kraken/driver.html?testName=audio-dft) 00:11:30 INFO - PROCESS | 16955 | RSS: Main: 221593600 00:11:30 INFO - PROCESS | 16955 | 00:11:33 INFO - PROCESS | 16955 | Cycle 1(1): loaded http://localhost:43243/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43243/tests/kraken/driver.html?testName=audio-fft) 00:11:34 INFO - PROCESS | 16955 | RSS: Main: 288735232 00:11:34 INFO - PROCESS | 16955 | 00:11:36 INFO - PROCESS | 16955 | Cycle 1(1): loaded http://localhost:43243/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43243/tests/kraken/driver.html?testName=audio-oscillator) 00:11:36 INFO - PROCESS | 16955 | RSS: Main: 199106560 00:11:36 INFO - PROCESS | 16955 | 00:11:39 INFO - PROCESS | 16955 | Cycle 1(1): loaded http://localhost:43243/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43243/tests/kraken/driver.html?testName=imaging-gaussian-blur) 00:11:39 INFO - PROCESS | 16955 | RSS: Main: 202551296 00:11:39 INFO - PROCESS | 16955 | 00:11:42 INFO - PROCESS | 16955 | Cycle 1(1): loaded http://localhost:43243/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43243/tests/kraken/driver.html?testName=imaging-darkroom) 00:11:43 INFO - PROCESS | 16955 | RSS: Main: 238739456 00:11:43 INFO - PROCESS | 16955 | 00:11:47 INFO - PROCESS | 16955 | Cycle 1(1): loaded http://localhost:43243/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43243/tests/kraken/driver.html?testName=imaging-desaturate) 00:11:47 INFO - PROCESS | 16955 | RSS: Main: 234999808 00:11:47 INFO - PROCESS | 16955 | 00:11:50 INFO - PROCESS | 16955 | Cycle 1(1): loaded http://localhost:43243/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43243/tests/kraken/driver.html?testName=json-parse-financial) 00:11:51 INFO - PROCESS | 16955 | RSS: Main: 237793280 00:11:51 INFO - PROCESS | 16955 | 00:11:52 INFO - PROCESS | 16955 | Cycle 1(1): loaded http://localhost:43243/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43243/tests/kraken/driver.html?testName=json-stringify-tinderbox) 00:11:53 INFO - PROCESS | 16955 | RSS: Main: 225091584 00:11:53 INFO - PROCESS | 16955 | 00:11:55 INFO - PROCESS | 16955 | Cycle 1(1): loaded http://localhost:43243/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43243/tests/kraken/driver.html?testName=stanford-crypto-aes) 00:11:56 INFO - PROCESS | 16955 | RSS: Main: 230703104 00:11:56 INFO - PROCESS | 16955 | 00:11:58 INFO - PROCESS | 16955 | Cycle 1(1): loaded http://localhost:43243/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43243/tests/kraken/driver.html?testName=stanford-crypto-ccm) 00:11:58 INFO - PROCESS | 16955 | RSS: Main: 237645824 00:11:58 INFO - PROCESS | 16955 | 00:12:01 INFO - PROCESS | 16955 | Cycle 1(1): loaded http://localhost:43243/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43243/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 00:12:02 INFO - PROCESS | 16955 | RSS: Main: 239460352 00:12:02 INFO - PROCESS | 16955 | 00:12:05 INFO - PROCESS | 16955 | Cycle 1(1): loaded http://localhost:43243/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43243/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 00:12:05 INFO - PROCESS | 16955 | RSS: Main: 241246208 00:12:05 INFO - PROCESS | 16955 | 00:12:07 INFO - PROCESS | 16955 | Cycle 1(1): loaded http://localhost:43243/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43243/tests/kraken/driver.html?testName=ai-astar) 00:12:07 INFO - PROCESS | 16955 | RSS: Main: 285274112 00:12:07 INFO - PROCESS | 16955 | 00:12:07 INFO - PROCESS | 16955 | __start_tp_report 00:12:07 INFO - PROCESS | 16955 | _x_x_mozilla_page_load 00:12:07 INFO - PROCESS | 16955 | _x_x_mozilla_page_load_details 00:12:07 INFO - PROCESS | 16955 | |i|pagename|runs| 00:12:07 INFO - PROCESS | 16955 | |0;ai-astar;112;106;112;113;112;111;112;113;112;112 00:12:07 INFO - PROCESS | 16955 | |1;audio-beat-detection;168;138;137;176;138;162;162;131;185;135 00:12:07 INFO - PROCESS | 16955 | |2;audio-dft;160;159;162;160;161;161;161;161;161;162 00:12:07 INFO - PROCESS | 16955 | |3;audio-fft;76;77;77;125;76;78;75;75;99;76 00:12:07 INFO - PROCESS | 16955 | |4;audio-oscillator;86;88;115;85;86;87;119;86;86;131 00:12:07 INFO - PROCESS | 16955 | |5;imaging-gaussian-blur;117;117;118;117;118;117;117;119;118;117 00:12:07 INFO - PROCESS | 16955 | |6;imaging-darkroom;146;146;146;146;146;147;147;147;146;146 00:12:07 INFO - PROCESS | 16955 | |7;imaging-desaturate;94;95;95;95;95;95;95;94;95;95 00:12:07 INFO - PROCESS | 16955 | |8;json-parse-financial;64;65;63;64;64;70;64;65;65;63 00:12:07 INFO - PROCESS | 16955 | |9;json-stringify-tinderbox;66;66;65;65;65;66;65;65;66;67 00:12:07 INFO - PROCESS | 16955 | |10;stanford-crypto-aes;89;82;82;82;86;84;93;84;117;83 00:12:07 INFO - PROCESS | 16955 | |11;stanford-crypto-ccm;133;131;133;134;130;129;131;137;136;146 00:12:07 INFO - PROCESS | 16955 | |12;stanford-crypto-pbkdf2;169;173;176;175;169;170;171;175;168;166 00:12:07 INFO - PROCESS | 16955 | |13;stanford-crypto-sha256-iterative;69;67;67;67;66;66;68;69;67;65 00:12:07 INFO - PROCESS | 16955 | __end_tp_report 00:12:07 INFO - PROCESS | 16955 | __start_cc_report 00:12:07 INFO - PROCESS | 16955 | _x_x_mozilla_cycle_collect,1941 00:12:07 INFO - PROCESS | 16955 | __end_cc_report 00:12:07 INFO - PROCESS | 16955 | __startTimestamp1465974727835__endTimestamp 00:12:07 INFO - PROCESS | 16955 | 00:12:07 INFO - PROCESS | 16955 | ------- Summary: start ------- 00:12:07 INFO - PROCESS | 16955 | Number of tests: 14 00:12:07 INFO - PROCESS | 16955 | 00:12:07 INFO - PROCESS | 16955 | [#0] ai-astar Cycles:10 Average:111.50 Median:112.00 stddev:2.01 (1.8%) stddev-sans-first:2.13 00:12:07 INFO - PROCESS | 16955 | Values: 112.0 106.0 112.0 113.0 112.0 111.0 112.0 113.0 112.0 112.0 00:12:07 INFO - PROCESS | 16955 | 00:12:07 INFO - PROCESS | 16955 | [#1] audio-beat-detection Cycles:10 Average:153.20 Median:162.00 stddev:19.59 (12.1%) stddev-sans-first:20.03 00:12:07 INFO - PROCESS | 16955 | Values: 168.0 138.0 137.0 176.0 138.0 162.0 162.0 131.0 185.0 135.0 00:12:07 INFO - PROCESS | 16955 | 00:12:07 INFO - PROCESS | 16955 | [#2] audio-dft Cycles:10 Average:160.80 Median:161.00 stddev:0.92 (0.6%) stddev-sans-first:0.93 00:12:07 INFO - PROCESS | 16955 | Values: 160.0 159.0 162.0 160.0 161.0 161.0 161.0 161.0 161.0 162.0 00:12:07 INFO - PROCESS | 16955 | 00:12:07 INFO - PROCESS | 16955 | [#3] audio-fft Cycles:10 Average:83.40 Median:76.50 stddev:16.30 (21.3%) stddev-sans-first:17.06 00:12:07 INFO - PROCESS | 16955 | Values: 76.0 77.0 77.0 125.0 76.0 78.0 75.0 75.0 99.0 76.0 00:12:07 INFO - PROCESS | 16955 | 00:12:07 INFO - PROCESS | 16955 | [#4] audio-oscillator Cycles:10 Average:96.90 Median:86.00 stddev:17.55 (20.4%) stddev-sans-first:18.17 00:12:07 INFO - PROCESS | 16955 | Values: 86.0 88.0 115.0 85.0 86.0 87.0 119.0 86.0 86.0 131.0 00:12:07 INFO - PROCESS | 16955 | 00:12:07 INFO - PROCESS | 16955 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:117.50 stddev:0.71 (0.6%) stddev-sans-first:0.73 00:12:07 INFO - PROCESS | 16955 | Values: 117.0 117.0 118.0 117.0 118.0 117.0 117.0 119.0 118.0 117.0 00:12:07 INFO - PROCESS | 16955 | 00:12:07 INFO - PROCESS | 16955 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 00:12:07 INFO - PROCESS | 16955 | Values: 146.0 146.0 146.0 146.0 146.0 147.0 147.0 147.0 146.0 146.0 00:12:07 INFO - PROCESS | 16955 | 00:12:07 INFO - PROCESS | 16955 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 00:12:07 INFO - PROCESS | 16955 | Values: 94.0 95.0 95.0 95.0 95.0 95.0 95.0 94.0 95.0 95.0 00:12:07 INFO - PROCESS | 16955 | 00:12:07 INFO - PROCESS | 16955 | [#8] json-parse-financial Cycles:10 Average:64.70 Median:64.50 stddev:2.00 (3.1%) stddev-sans-first:2.11 00:12:07 INFO - PROCESS | 16955 | Values: 64.0 65.0 63.0 64.0 64.0 70.0 64.0 65.0 65.0 63.0 00:12:07 INFO - PROCESS | 16955 | 00:12:07 INFO - PROCESS | 16955 | [#9] json-stringify-tinderbox Cycles:10 Average:65.60 Median:66.00 stddev:0.70 (1.1%) stddev-sans-first:0.73 00:12:07 INFO - PROCESS | 16955 | Values: 66.0 66.0 65.0 65.0 65.0 66.0 65.0 65.0 66.0 67.0 00:12:07 INFO - PROCESS | 16955 | 00:12:07 INFO - PROCESS | 16955 | [#10] stanford-crypto-aes Cycles:10 Average:88.20 Median:84.00 stddev:10.73 (12.8%) stddev-sans-first:11.37 00:12:07 INFO - PROCESS | 16955 | Values: 89.0 82.0 82.0 82.0 86.0 84.0 93.0 84.0 117.0 83.0 00:12:07 INFO - PROCESS | 16955 | 00:12:07 INFO - PROCESS | 16955 | [#11] stanford-crypto-ccm Cycles:10 Average:134.00 Median:133.50 stddev:4.92 (3.7%) stddev-sans-first:5.21 00:12:07 INFO - PROCESS | 16955 | Values: 133.0 131.0 133.0 134.0 130.0 129.0 131.0 137.0 136.0 146.0 00:12:07 INFO - PROCESS | 16955 | 00:12:07 INFO - PROCESS | 16955 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.20 Median:172.00 stddev:3.39 (2.0%) stddev-sans-first:3.50 00:12:07 INFO - PROCESS | 16955 | Values: 169.0 173.0 176.0 175.0 169.0 170.0 171.0 175.0 168.0 166.0 00:12:07 INFO - PROCESS | 16955 | 00:12:07 INFO - PROCESS | 16955 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.10 Median:67.00 stddev:1.29 (1.9%) stddev-sans-first:1.17 00:12:07 INFO - PROCESS | 16955 | Values: 69.0 67.0 67.0 67.0 66.0 66.0 68.0 69.0 67.0 65.0 00:12:07 INFO - PROCESS | 16955 | -------- Summary: end -------- 00:12:07 INFO - PROCESS | 16955 | 00:12:08 INFO - TEST-INFO | 16955: exit 0 00:12:08 INFO - TEST-OK | kraken | took 64103ms 00:12:08 INFO - SUITE-END | took 1184s 00:12:08 INFO - Completed test suite (00:19:44) 00:12:08 INFO - javascript benchmark 00:12:09 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2588.9999999999995, 2610.9086181983635, 2636.28820218541, 2641.247244535308, 2646.1003258891974, 4620.099080679269, 4692.319613656018, 4702.224133018052, 4790.305405716169, 4856.951430485694, 4621.838235661752, 4673.813047478096, 4694.0142570060325, 4720.976395118028, 4746.0507898420365, 4350.54319296474, 4373.300271956487, 4419.160359531695, 4431.26884064129, 4432.3794668746405, 4376.659143558791, 4437.134758722051, 4468.486124095738, 4469.620082293009, 4505.662075344362, 4473.977630111861, 4494.033782736711, 4517.774111294439, 4531.501534831166, 4537.2286711259, 4315.093830295642, 4350.6736994725525, 4361.781910904474, 4435.201663700533, 4482.350059241425, 4268.829246830123, 4270.295401258789, 4313.460817397825, 4315.784210789479, 4367.0, 4759.4764575896625, 4767.666263361566, 4767.976160119178, 4775.761211939389, 4776.188048031843, 4883.731394773286, 5037.722925239111, 5054.014467178901, 5070.315507406527, 5125.615578831603, 5211.24436956643, 5212.1921102228835, 5218.504242096995, 5232.058229518685, 5238.188080847474, 4852.927206091911, 4872.951270487285, 4878.975605122023, 4883.951160488421, 4884.877878053077, 5015.799368025311, 5292.417834038252, 5341.145416733381, 5349.679019258779, 5363.892722145613, 5126.897462050738, 5130.076586214517, 5134.8973020540125, 5146.125158722951, 5148.330717006766, 5170.741462926914, 5174.275601415805, 5189.299444575009, 5190.896182076337, 5192.5586325162785, 4886.902261954741, 4982.601391888713, 5019.121653710586, 5027.698338099653, 5039.697618142924, 4985.351904252424, 5005.849824505271, 5013.473585273494, 5032.370953630796, 5054.9241761373605, 4129.318662420667, 4298.978505107517, 4300.0, 4302.720323178984, 4355.216061109031, 3645.872394466181, 3733.6826369758874, 3753.418220175877, 3769.208466222069, 3807.3146833569667, 4344.630706389992, 4356.302991521405, 4359.716618419792, 4402.691811573159, 4406.5593440655675, 4989.600831933437, 5101.7704203310195, 5107.055194788976, 5111.437741848394, 5161.4322424533275, 4367.934480982788, 4397.428334316583, 4406.933895991563, 4409.757463339547, 4410.647148228134, 4616.95383046172, 4635.2120139576355, 4638.675292729544, 4673.7429441381055, 4691.882702932454, 4681.929771053505, 4758.928616070831, 4862.80548778052, 4867.342908707279, 4868.805247790048, 5071.746412679425, 5115.18157094863, 5123.410807757155, 5189.740512974412, 5190.844274671615, 4820.566149046603, 4827.517248275285, 4830.637702172281, 4831.178699621143, 4863.392075990501, 4898.804047838046, 5048.495150484922, 5049.2173713074535, 5050.444451110301, 5105.719185444687, 5119.769610367617, 5193.714345711022, 5202.921956170585, 5209.114450543492, 5252.737363131904, 5040.218766091261, 5051.318072060225, 5058.595312375075, 5061.0, 5110.182370820651, 4843.104025755247, 4908.803647854189, 4940.456549779593, 5052.191649336089, 5067.087924173684, 4861.878453038702, 4877.658563900635, 4899.461059283405, 4902.950970490249, 4903.926441103315, 5000.749962501933, 5005.6996580205305, 5010.098182327216, 5011.072951503984, 5043.571296439697, 4795.568398844121, 4878.414590249193, 4929.137400954747, 4937.28409380645, 4937.5556199942175], "value": 4692.946867901646, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [538.3798102806724, 577.445652173913, 582.0774073094145, 594.6669864875672, 600.3126420248815, 29037.0, 38629.22741545167, 39774.40338394926, 39924.600753992454, 43242.56757432425, 39923.40114898272, 40368.79815600918, 40442.797786011026, 40446.59553404465, 40459.0, 7545.396368290551, 7914.960425197881, 8061.435699501038, 8061.9193808061755, 10055.798884022315, 9853.162481189072, 10238.129758970497, 10266.691999240034, 10268.691939241835, 10273.486325683685, 10258.179345652366, 10289.382637041765, 10294.279400441972, 10310.278280520366, 10314.845277320808, 7534.133574638932, 10003.0, 10212.489375531231, 10262.7434314142, 10273.743156421075, 10050.341693620543, 10080.69757907264, 10110.89889101107, 10154.136898363648, 10167.135793457564, 37777.43333849994, 38018.619813801786, 38103.237935241414, 38106.61893381058, 38245.80877095597, 2870.8851645934137, 3221.855016524262, 3249.46383846665, 3368.9326213475592, 3677.0991107178643, 28927.0, 29451.558226626617, 29475.70524294751, 29697.851510742523, 30780.692193078008, 3492.7729697569575, 3532.6643968822923, 3540.274243780019, 3546.2552863898354, 3570.6607872252093, 252973.0, 253039.0, 253060.0, 253790.0, 254184.0, 50532.747336263084, 50629.493705063214, 50816.98366032659, 50854.491455085714, 50856.23715644268, 32594.674053259638, 33242.66757332444, 33374.66625333716, 35606.0, 53319.73340133274, 15269.389224430899, 15485.148316842457, 15502.069875807487, 15504.379824806882, 15510.767338489932, 9418.62325506972, 11586.536538538532, 11737.589184378676, 11760.294382337088, 12134.817977730165, 17919.820801792077, 17990.5502362442, 18043.639127217382, 18079.54801129956, 18197.45407637773, 6966.338197871194, 7106.92893071073, 7163.0, 7268.23683513234, 7287.854242915112, 810.8702607582759, 841.5918279634373, 915.7527467583849, 958.3914214473859, 999.0509016434416, 27634.723652763616, 28056.579151312748, 28079.298017549725, 28370.0, 28579.428411431654, 967.0764419979043, 976.8339382305026, 1001.8096561653263, 1012.0486742462209, 1015.4821041269006, 14758.704825903422, 14815.0, 14970.176640284672, 15128.0, 15290.617734556503, 394776.0, 400067.0, 401953.0, 402360.0, 402939.0, 47355.052898942515, 47771.28343074857, 47777.761111194915, 47833.76083119562, 47960.5203947956, 1089.727568107973, 1152.389233706137, 1174.8883856033663, 1192.5706745571588, 1204.3978010994504, 27642.0, 28043.57934631023, 29091.563626545194, 29201.269968250963, 29357.0, 39879.40180897347, 40259.79870100631, 40266.798666006485, 40293.19413611653, 40303.0, 287129.0, 288070.0, 290156.0, 290777.0, 291071.0, 22127.0, 23892.402689932194, 24821.751782481944, 24912.62631060572, 26057.869710651325, 40707.0, 40971.590284096776, 41018.79490602528, 41243.1751364965, 41975.0, 34926.30147396987, 34974.0, 35135.82432087823, 35242.823785881934, 35768.64231357653, 34318.31363372769, 34764.47853282253, 35016.0, 35034.82482587571, 35429.645703542636, 34107.82946085254, 34116.0, 34658.48012279767, 34903.12742181466, 34950.82524587361, 30779.84610076935, 31898.84050579732, 31922.0, 31970.36059278848, 31989.0, 24566.631500527863, 24653.0, 24742.876285619175, 24960.251192464257, 25203.243902682214], "value": 17797.45518494925, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [369.696848584161, 371.1852483798064, 377.2398616787174, 382.72826293331735, 382.77033779732164, 15739.134347610876, 16925.830741692578, 17924.193411296492, 17960.55098622535, 17964.0, 15401.614959626015, 15935.84064159361, 15954.361825526965, 15972.281247343868, 15979.360825566964, 4961.950380496194, 5183.015227106856, 5229.477052294759, 5239.292695486099, 5239.502247286502, 3666.5966743658178, 3861.362875125601, 5156.484351564833, 5783.5951483396175, 6122.47958923492, 6161.322254551996, 6163.537734669895, 6176.38236176381, 6192.195014648112, 6196.504279657639, 5923.5853490255695, 6111.724972376232, 6124.203853499062, 6134.631922084644, 6137.17148184996, 3323.3353329333986, 4989.201727723546, 5291.021161085211, 5314.4951229633125, 5327.706976116312, 20682.17271309146, 21234.0, 21249.468763280885, 21443.57112857734, 21515.569688606298, 1968.881867087965, 1998.6302534031252, 2006.7993200679962, 2170.218721260345, 2282.9086836526517, 11887.167898247126, 12378.319192444502, 12445.128840981135, 12733.172343797716, 12884.291363974977, 1718.2353852535628, 1736.6266252755718, 1819.4632583387931, 1829.9908500457545, 1965.7444532210864, 67042.66478667624, 67727.66136169288, 68715.3128468719, 71789.28210717878, 72109.6394518024, 9727.07592778685, 9766.46284454362, 9886.703398898044, 10109.797804043877, 10257.281990260759, 13592.320383980761, 13747.862521374658, 13757.10578812374, 13780.586582402544, 13785.862141378659, 7233.132024157029, 7242.601656908921, 7250.347468727734, 7270.091238595176, 7491.587962661997, 6349.174607301022, 6472.579282346633, 6579.901301480481, 7165.140183177948, 7358.889616655754, 4325.41606883073, 4335.501417337046, 4337.587929146726, 4344.630706389992, 4448.221561226837, 1713.7086695261835, 1725.2322716391336, 1796.694561924476, 1818.2181661885252, 1822.0616382562991, 804.3846457460048, 816.7059858450953, 857.9871301930476, 929.4051806843626, 932.9533523323806, 16608.169591520375, 16801.747973780402, 16897.239624216938, 16968.57578560546, 17017.82982170187, 842.1536355962219, 862.288611895189, 878.6529320918202, 929.7071422502025, 955.8518429643416, 8934.329925255503, 9676.854847177297, 9764.121229089416, 9768.462734549668, 9828.262880284008, 421569.0, 425546.0, 426033.0, 426846.0, 426927.0, 82072.58963705144, 86230.56884715536, 86856.565717171, 87887.0, 88627.11372886189, 907.832051070554, 927.6363745294407, 945.4374647085111, 953.9141477266941, 958.8657587937695, 15692.529224123295, 15825.68348633044, 15913.68172636564, 16086.919565402099, 16639.66720665556, 29591.26021849471, 33794.34516536062, 36123.63876361308, 36246.45630315495, 36291.81854090712, 46224.0, 52014.73992630164, 52444.47555524549, 52464.7376763129, 52717.0, 7525.473216874766, 7550.584717840571, 7565.508241964475, 7713.961430192813, 7789.298963093349, 10676.306040107369, 11124.777504450027, 11151.832722509007, 11294.209405341548, 11465.484053217458, 9730.75673108178, 9933.453660048766, 10008.749781255527, 10096.444695541815, 10339.896601033894, 9448.574814133242, 9658.661946831828, 9783.168430683472, 9856.112949834549, 9918.107370336704, 10097.343672661253, 10428.843567346648, 10599.417032063311, 10691.30506517074, 10770.946145269223, 7596.658150383357, 7627.199144089791, 7643.808904777425, 7710.383169346326, 7849.489783164305, 4941.75291235444, 8921.866172007554, 9585.185259253041, 10035.648752293635, 10299.0], "value": 8306.797488386803, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1368.828896387951, 1399.2863639543832, 1501.5270189890184, 1670.356912588653, 1706.522173791338, 7679.500832445894, 8179.79550511236, 8262.339012878963, 8270.627821748021, 8274.296684781793, 7033.613151276678, 7575.545467271968, 7852.568108754016, 7855.8821617675785, 8079.0, 2241.1819685814644, 2269.7616750241236, 2271.284545368212, 2271.432141964509, 2275.340151356105, 2195.319450970196, 2240.607893618618, 2249.4376405898524, 2251.808596269319, 2251.966220506694, 1928.7878333383317, 1992.5417154054576, 1993.0732209522569, 2005.5287007553213, 2180.9781902180935, 2223.3885681437655, 2266.9546609067893, 2268.104098880941, 2273.090763694519, 2276.7267927848598, 2191.375457994464, 2202.922897698573, 2204.8015678588845, 2207.061998650567, 2229.977700222993, 7876.212378762135, 7911.248431399008, 7934.365250779923, 7937.960310198412, 7944.801379965547, 4451.688381813275, 4567.040921406476, 4570.040291538781, 4572.0, 4595.586397224232, 3014.3820516794003, 3039.1642298367906, 3060.8775648974015, 3093.9535906961414, 3108.4870996285586, 965.5510187762654, 979.8530220466915, 1016.5273147986222, 1022.5091955861154, 1035.177034257767, 11225.831612525737, 11237.438128093645, 11243.550257989753, 11244.325340479598, 11273.436328183558, 4157.064660451374, 4284.400183974246, 4352.978235108868, 4354.738715677069, 4362.8909277267685, 9502.619895204114, 9551.665691700757, 9553.0, 9560.760980975392, 9570.856437153448, 4567.862964111082, 4584.404027476474, 4588.105319462739, 4590.747508886977, 4593.035462552834, 4159.10579225468, 4208.747475151501, 4308.763018033976, 4312.913741725148, 4340.544242854518, 3784.924301513954, 3803.5245594300713, 3857.324968130566, 3896.2597106550234, 3951.585083566184, 1201.801702719059, 1203.8735932727113, 1214.1622280626339, 1214.9817752733716, 1226.0804396702474, 825.2613910550144, 845.2097289034772, 847.8431490174338, 855.6791203298762, 878.8662625213531, 5325.174597937326, 5368.8389348319615, 5382.111951527954, 5395.676259424368, 5405.945940540623, 407.4824972285181, 420.31278859065037, 422.52254951904763, 426.53081610228503, 428.8520460441143, 3433.0, 3779.3008293465796, 3815.4849095372324, 3834.654881060718, 3843.2889915365745, 9332.95333523328, 9722.173615242642, 9778.41329520231, 9916.057974492413, 9925.255605829592, 9754.95122524397, 9785.510724463747, 9796.902030979742, 9812.165965892837, 9825.459599722084, 7467.813304667427, 7480.214577469287, 7575.166731659513, 7576.659050342748, 7588.734394296173, 5238.0, 5297.788088476418, 5310.8141215057285, 5374.3013408256675, 5389.0299746046085, 8985.730428087169, 9129.817403651758, 9171.266298696222, 9172.495512746864, 9214.308926830381, 8973.474509333559, 9243.306751993761, 9263.722088337361, 9405.529723513933, 9406.623735050522, 6750.0, 6792.830179245559, 6804.82987925286, 6827.249002609609, 6860.416864566568, 7100.680469378994, 7416.110066792019, 7441.293077157661, 7451.0, 7454.776356709307, 6611.768588099393, 6686.498512611671, 6692.464602831859, 6776.728930842908, 6879.965600171967, 6445.935540644534, 6603.0, 6619.106420633346, 6717.0, 6718.0, 6368.904466432915, 6399.04014397844, 6439.67801609927, 6444.7744328948265, 6460.160179176677, 4622.699524531029, 4820.39745031871, 4845.466998630219, 4850.811551169986, 4854.854354369375, 4780.641451891052, 4801.207800712843, 4805.639577031807, 4819.638527110411, 4902.60779137661], "value": 4150.14448600048, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [298.5477002341452, 303.45075413501564, 306.2008158705776, 306.23135928818675, 306.8971894415371, 4862.124817532843, 4862.350019239514, 4898.975505122474, 4906.607471402288, 4920.557149856512, 4764.403924685226, 4827.324174615556, 4844.200706883369, 4866.099771542267, 4867.464578896327, 3621.7826930384263, 3737.0, 3747.3067482515685, 3824.8470061197518, 3866.2460820140086, 3788.8295026723727, 3822.617738226183, 3823.3309170895122, 3828.1386687995255, 3859.591249194038, 3627.927441451169, 3803.847846086167, 3813.599572044937, 3815.0080978945534, 3818.599047100056, 3622.855085796565, 3788.2612890486366, 3804.068003339186, 3805.923881522354, 3813.904652383685, 3361.0757041813695, 3362.3947689415895, 3374.088995971074, 3374.7300215982664, 3394.8642054317797, 4746.457401344577, 4764.904701905943, 4775.403074615673, 4786.473487916326, 4800.279958006327, 4265.146970605861, 4367.628751556122, 4384.780760961971, 4405.713628614129, 4408.40486534317, 5021.6735912165595, 5052.343195384577, 5052.646314757969, 5087.872803179913, 5100.413452452941, 3661.5789184243886, 3683.7605555638797, 3702.38910579754, 3709.666130048309, 3721.702263818888, 5188.429272779991, 5271.785849943033, 5306.389765176977, 5336.332958380202, 5357.303550538405, 3714.257148570297, 3717.981410092986, 3738.3084129436143, 3739.7569158004644, 3751.8874433767032, 3779.905502362463, 3786.4320351947426, 3786.962130378716, 3796.962030379661, 3810.961890381116, 4331.047169622678, 4338.739675619473, 4346.9347959780625, 4347.891302717394, 4355.128974205171, 4841.515848415131, 5008.223725322581, 5016.874578135576, 5021.548060674557, 5051.924221136685, 1269.397036407699, 1295.9676008099873, 1300.4798080767769, 1312.6193403912757, 1321.1742660836976, 864.3992425264506, 870.1602953150241, 888.5246393179618, 897.2866571076011, 904.0597778310615, 4345.304751239786, 4369.890752731207, 4481.170983368087, 4486.730796152241, 4524.117797029613, 5248.737563121828, 5263.868133405977, 5276.1821917602065, 5282.735863206901, 5289.444608316148, 4222.501012140708, 4425.933610995773, 4480.731156130642, 4489.371487991683, 4502.324651302265, 2773.0433000614757, 2787.8569786387484, 2788.8426303083993, 2795.3850152966315, 2816.845073520935, 4908.386451693538, 4913.901721965541, 4938.950610493921, 4955.157623204064, 5011.223260394645, 5069.746512674352, 5386.407495175527, 5393.379761327497, 5405.702686352289, 5430.511253987082, 4959.611308833532, 4969.180085285887, 4971.875703107451, 4976.900461990812, 4989.326440930573, 5263.73681315925, 5282.656627319212, 5304.0, 5318.335208098988, 5329.0, 4853.878653033702, 5153.3815942087185, 5164.948350516447, 5169.121249387688, 5170.819021334235, 4896.914943585518, 4912.557869791736, 4925.729084900365, 4955.058538877602, 4959.429665588504, 3642.562892452923, 3671.9265614688093, 3680.190358121209, 3682.484452176644, 3700.389435743072, 5104.41299250591, 5246.685198888079, 5255.737213139404, 5273.393559740679, 5298.470152984671, 5089.9745501272255, 5091.516305950929, 5099.184130539096, 5142.408623008252, 5147.639665223398, 5056.949430505648, 5124.205748109049, 5125.898381663649, 5133.8716532087, 5155.381354237516, 4755.167845626932, 4866.48901865299, 4873.239851095415, 4998.725070121178, 5010.3737032870895, 5024.447310795883, 5139.563137133386, 5155.705710958588, 5169.508896654812, 5174.0, 5064.848054558369, 5073.7716802743225, 5105.132127538253, 5111.0, 5111.361079865017], "value": 3849.2676638270736, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [639.3912835630626, 671.4863129705773, 693.109354479494, 697.6442014572566, 745.1170363119702, 12015.519379224832, 12757.553485628005, 13272.46910123595, 13342.332883355843, 13368.131071480348, 14062.085964412332, 14288.78566821496, 14331.71336573268, 14353.641158971031, 14355.78466323006, 628.7987843889935, 768.9653965571534, 789.8064974081329, 798.876174193001, 799.8520273749346, 790.1426951757351, 794.6185830801219, 800.7877912353202, 800.9559474228915, 804.3806269172734, 828.6436832162168, 835.7701632051173, 836.2682652678906, 836.7531578184451, 837.3217693668117, 651.2900937977627, 800.7197480881645, 814.8818421328874, 832.2260297922929, 834.4200780457585, 610.7434877351523, 611.5230120506012, 611.7338957553478, 612.5558969746943, 614.8124821929309, 13406.262655553941, 13413.061085724003, 13416.86583134166, 13471.124376915566, 13478.932605337008, 11649.126315526284, 11768.529258829636, 12180.576676506538, 12215.0, 12481.75036499274, 11483.25358851672, 11541.711457213552, 11572.537098516133, 11660.183787134903, 11738.0, 4150.584941505856, 4151.481064866892, 4154.688398370135, 4351.434313539251, 4356.586124318184, 61825.0, 63035.36964630341, 63073.369266307665, 63973.360266397205, 64255.67872160609, 9389.90610093904, 9486.430814151036, 9678.128968392879, 9776.332977673168, 9938.751531211778, 19103.713444298348, 19107.0, 19157.904210478857, 19166.137523811463, 19194.424167274723, 6465.3857883501, 6562.081308616797, 6566.5403421760975, 6669.566478178903, 6727.360900714424, 3465.5321531593418, 3539.3275277697153, 3578.624244454347, 3640.199156185688, 3652.0, 2914.082064149786, 3011.472992226352, 3018.2001769531093, 3018.3661431099713, 3019.879204831826, 501.2105933155295, 510.9335786347825, 511.4246472718192, 512.6513970500096, 527.4224723927293, 471.3942583779826, 507.6496519258754, 526.3762441506826, 577.4831525784483, 592.3099588978791, 7615.923840761632, 7910.534904262154, 8070.838583228303, 8116.88960870178, 8195.0, 530.6683322923172, 557.8925832223034, 574.379669956446, 580.4717706886713, 606.4178388746765, 3325.7838240514775, 3673.2653469306247, 3812.2566099610863, 3894.922101557953, 3901.5708272090046, 91347.0, 92253.0, 92862.53568732113, 93325.0, 93904.53047734717, 80197.0, 80600.19399806044, 81600.59199703964, 81974.0, 82038.58980705058, 72585.6370718143, 74778.0, 74780.72474403318, 75272.62363688256, 76895.0, 6526.771562995273, 6643.966780166068, 6794.660266986532, 6868.690908909011, 6908.965455172692, 41853.372199417645, 42158.504290278135, 43937.34093988657, 44054.33918491161, 44983.32525012062, 55421.0, 64878.35121648723, 65335.346646532926, 65585.67207163933, 65910.0, 9419.0, 9419.811603768023, 9520.285978551776, 9527.333086683866, 9624.66313679018, 11342.149338799789, 11364.488598013275, 11839.408029598659, 11965.04279657608, 11983.34091624969, 9707.66023189185, 9931.553080111267, 9932.304738668225, 10154.695359139238, 10261.02520260574, 9857.704268871945, 9921.454320012468, 10164.085232329126, 10548.736281592715, 10676.519556619816, 9599.664011759554, 9746.853797192905, 9933.453660048766, 9948.45283509414, 10661.89338106609, 8441.153469217945, 8695.21951996193, 8962.283017358464, 9017.188453039258, 9119.407238529475, 8256.711015114442, 8258.215469530385, 8330.541820199947, 8639.6976105836, 8768.517731524827], "value": 6362.139540561119, "unit": "score"}], "name": "dromaeo_css", "value": 6427.694182517981, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 106.0, 112.0, 113.0, 112.0, 111.0, 112.0, 113.0, 112.0, 112.0], "value": 111.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 138.0, 137.0, 176.0, 138.0, 162.0, 162.0, 131.0, 185.0, 135.0], "value": 153.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 159.0, 162.0, 160.0, 161.0, 161.0, 161.0, 161.0, 161.0, 162.0], "value": 160.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 77.0, 125.0, 76.0, 78.0, 75.0, 75.0, 99.0, 76.0], "value": 83.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 88.0, 115.0, 85.0, 86.0, 87.0, 119.0, 86.0, 86.0, 131.0], "value": 96.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 118.0, 117.0, 118.0, 117.0, 117.0, 119.0, 118.0, 117.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 146.0, 147.0, 147.0, 147.0, 146.0, 146.0], "value": 146.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 63.0, 64.0, 64.0, 70.0, 64.0, 65.0, 65.0, 63.0], "value": 64.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 65.0, 65.0, 65.0, 66.0, 65.0, 65.0, 66.0, 67.0], "value": 65.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 82.0, 82.0, 82.0, 86.0, 84.0, 93.0, 84.0, 117.0, 83.0], "value": 88.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 131.0, 133.0, 134.0, 130.0, 129.0, 131.0, 137.0, 136.0, 146.0], "value": 134.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 173.0, 176.0, 175.0, 169.0, 170.0, 171.0, 175.0, 168.0, 166.0], "value": 171.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 67.0, 67.0, 67.0, 66.0, 66.0, 68.0, 69.0, 67.0, 65.0], "value": 67.1, "unit": "score"}], "name": "kraken", "value": 1555.1999999999998, "alertThreshold": 2.0}]} 00:12:09 INFO - Return code: 0 00:12:09 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 00:12:09 INFO - # TBPL SUCCESS # 00:12:09 INFO - Running post-action listener: _resource_record_post_action 00:12:09 INFO - ##### 00:12:09 INFO - ##### Finished run-tests step (success) 00:12:09 INFO - ##### 00:12:09 INFO - Running post-run listener: _resource_record_post_run 00:12:09 INFO - Total resource usage - Wall time: 1201s; CPU: 13.0%; Read bytes: 0; Write bytes: 405626880; Read time: 0; Write time: 248908 00:12:09 INFO - TinderboxPrint: CPU usage
13.1% 00:12:09 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 00:12:09 INFO - TinderboxPrint: I/O write bytes / time
405,626,880 / 248,908 00:12:09 INFO - TinderboxPrint: CPU idle
8,326.2 (86.9%) 00:12:09 INFO - TinderboxPrint: CPU user
1,213.1 (12.7%) 00:12:09 INFO - TinderboxPrint: Swap in / out
0 / 0 00:12:09 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 113704960; Read time: 0; Write time: 95196 00:12:09 INFO - run-tests - Wall time: 1186s; CPU: 13.0%; Read bytes: 0; Write bytes: 286687232; Read time: 0; Write time: 153436 00:12:09 INFO - Running post-run listener: _upload_blobber_files 00:12:09 INFO - Blob upload gear active. 00:12:09 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 00:12:09 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 00:12:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 00:12:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 00:12:10 INFO - (blobuploader) - INFO - Open directory for files ... 00:12:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 00:12:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:12:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:12:14 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 00:12:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:12:14 INFO - (blobuploader) - INFO - Done attempting. 00:12:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 00:12:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:12:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:12:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 00:12:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:12:15 INFO - (blobuploader) - INFO - Done attempting. 00:12:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 00:12:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:12:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:12:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 00:12:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:12:16 INFO - (blobuploader) - INFO - Done attempting. 00:12:16 INFO - (blobuploader) - INFO - Iteration through files over. 00:12:16 INFO - Return code: 0 00:12:16 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 00:12:16 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 00:12:16 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/10cd3311fe481f921c7ab82ed6731620ea61a164d6d81b7f115234958ecd0ef577a18bbfc3bf2c0b90e1db9fcfa1b043213981f1c89478acaf434362f632b396", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0f1e7c3434815054c665d03f5f5bf880c740e28e4e3c7ff2102c6bf629ce3e83065a916dbf47bf9e08a2ba618fc3ddd5e63abf7263a040f9f29215c3c2d4f163", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0585ac6dd4d162ac9b64531c931923ad3ccb6f86927e35f3fc5c1a20216aa4fcba7c615d4946b8d7ff963e3d61270ee6e81473c397cf168d2ec10b8276de509b"} 00:12:16 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 00:12:16 INFO - Writing to file /builds/slave/test/properties/blobber_files 00:12:16 INFO - Contents: 00:12:16 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/10cd3311fe481f921c7ab82ed6731620ea61a164d6d81b7f115234958ecd0ef577a18bbfc3bf2c0b90e1db9fcfa1b043213981f1c89478acaf434362f632b396", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0f1e7c3434815054c665d03f5f5bf880c740e28e4e3c7ff2102c6bf629ce3e83065a916dbf47bf9e08a2ba618fc3ddd5e63abf7263a040f9f29215c3c2d4f163", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0585ac6dd4d162ac9b64531c931923ad3ccb6f86927e35f3fc5c1a20216aa4fcba7c615d4946b8d7ff963e3d61270ee6e81473c397cf168d2ec10b8276de509b"} 00:12:16 INFO - Running post-run listener: copy_logs_to_upload_dir 00:12:16 INFO - Copying logs to upload dir... 00:12:16 INFO - mkdir: /builds/slave/test/build/upload/logs 00:12:16 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1249.450338 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-06-15 00:12:16.357574) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-15 00:12:16.361009) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1465973295.699516-957453322 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/10cd3311fe481f921c7ab82ed6731620ea61a164d6d81b7f115234958ecd0ef577a18bbfc3bf2c0b90e1db9fcfa1b043213981f1c89478acaf434362f632b396", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0f1e7c3434815054c665d03f5f5bf880c740e28e4e3c7ff2102c6bf629ce3e83065a916dbf47bf9e08a2ba618fc3ddd5e63abf7263a040f9f29215c3c2d4f163", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0585ac6dd4d162ac9b64531c931923ad3ccb6f86927e35f3fc5c1a20216aa4fcba7c615d4946b8d7ff963e3d61270ee6e81473c397cf168d2ec10b8276de509b"} build_url:https://queue.taskcluster.net/v1/task/bOcn7TF7Rum_9S3M7li9oQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011382 build_url: 'https://queue.taskcluster.net/v1/task/bOcn7TF7Rum_9S3M7li9oQ/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/Firefox-Non-PGO/sha512/10cd3311fe481f921c7ab82ed6731620ea61a164d6d81b7f115234958ecd0ef577a18bbfc3bf2c0b90e1db9fcfa1b043213981f1c89478acaf434362f632b396", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0f1e7c3434815054c665d03f5f5bf880c740e28e4e3c7ff2102c6bf629ce3e83065a916dbf47bf9e08a2ba618fc3ddd5e63abf7263a040f9f29215c3c2d4f163", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0585ac6dd4d162ac9b64531c931923ad3ccb6f86927e35f3fc5c1a20216aa4fcba7c615d4946b8d7ff963e3d61270ee6e81473c397cf168d2ec10b8276de509b"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-15 00:12:16.386902) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-15 00:12:16.387248) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1465973295.699516-957453322 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004529 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-15 00:12:16.469741) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-15 00:12:16.470112) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-15 00:12:16.470436) ========= ========= Total master_lag: 0.17 =========