builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-054 starttime: 1465973514.01 results: success (0) buildid: 20160614222226 builduid: c9a3dc141d074ca5a7cc8ef1f4c522fe revision: 53f5b5c289fba6ad82c675578cf1c548ae37f0c1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-14 23:51:54.013517) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-14 23:51:54.013987) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-14 23:51:54.014328) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-14 23:51:54.053413) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-14 23:51:54.053719) ========= 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=cbe409c6de289db6ac707de3000001d4-1465962338.785363-31806065 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-14 23:51:56-- 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% 58.8K=0.2s 2016-06-14 23:51:56 (58.8 KB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.305038 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-14 23:51:54.380449) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-14 23:51:54.380828) ========= 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=cbe409c6de289db6ac707de3000001d4-1465962338.785363-31806065 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015011 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-14 23:51:54.433554) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-14 23:51:54.433997) ========= 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=cbe409c6de289db6ac707de3000001d4-1465962338.785363-31806065 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-14 23:51:56,520 truncating revision to first 12 chars 2016-06-14 23:51:56,520 Setting DEBUG logging. 2016-06-14 23:51:56,520 attempt 1/10 2016-06-14 23:51:56,520 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:57,535 unpacking tar archive at: mozilla-central-53f5b5c289fb/testing/mozharness/ program finished with exit code 0 elapsedTime=1.358108 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-14 23:51:55.806262) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-14 23:51:55.806621) ========= script_repo_revision: 53f5b5c289fba6ad82c675578cf1c548ae37f0c1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-14 23:51:55.807126) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-14 23:51:55.807458) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-14 23:51:55.818135) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-06-14 23:51:55.818550) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=cbe409c6de289db6ac707de3000001d4-1465962338.785363-31806065 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 23:51:57 INFO - MultiFileLogger online at 20160614 23:51:57 in /builds/slave/test 23:51:57 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --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:57 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 23:51:57 INFO - {'append_to_log': False, 23:51:57 INFO - 'base_work_dir': '/builds/slave/test', 23:51:57 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 23:51:57 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 23:51:57 INFO - 'branch': 'Firefox-Non-PGO', 23:51:57 INFO - 'buildbot_json_path': 'buildprops.json', 23:51:57 INFO - 'config_files': ('talos/linux_config.py',), 23:51:57 INFO - 'default_actions': ('clobber', 23:51:57 INFO - 'read-buildbot-config', 23:51:57 INFO - 'download-and-extract', 23:51:57 INFO - 'populate-webroot', 23:51:57 INFO - 'create-virtualenv', 23:51:57 INFO - 'install', 23:51:57 INFO - 'run-tests'), 23:51:57 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 23:51:57 INFO - 'download_minidump_stackwalk': True, 23:51:57 INFO - 'download_symbols': 'ondemand', 23:51:57 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 23:51:57 INFO - 'tooltool.py': '/tools/tooltool.py', 23:51:57 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 23:51:57 INFO - '/tools/misc-python/virtualenv.py')}, 23:51:57 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 23:51:57 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 23:51:57 INFO - 'installer_path': 'installer.exe', 23:51:57 INFO - 'log_level': 'info', 23:51:57 INFO - 'log_name': 'talos', 23:51:57 INFO - 'log_to_console': True, 23:51:57 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 23:51:57 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 23:51:57 INFO - 'opt_config_files': (), 23:51:57 INFO - 'pip_index': False, 23:51:57 INFO - 'sps_profile': False, 23:51:57 INFO - 'sps_profile_interval': 0, 23:51:57 INFO - 'suite': 'dromaeojs-e10s', 23:51:57 INFO - 'system_bits': '32', 23:51:57 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 23:51:57 INFO - 'title': 'talos-linux64-ix-054', 23:51:57 INFO - 'tooltool_cache': '/builds/tooltool_cache', 23:51:57 INFO - 'use_talos_json': True, 23:51:57 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 23:51:57 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 23:51:57 INFO - 'work_dir': 'build'} 23:51:57 INFO - ##### 23:51:57 INFO - ##### Running clobber step. 23:51:57 INFO - ##### 23:51:57 INFO - Running pre-action listener: _resource_record_pre_action 23:51:57 INFO - Running main action method: clobber 23:51:57 INFO - rmtree: /builds/slave/test/build 23:51:58 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 23:51:58 INFO - Running post-action listener: _resource_record_post_action 23:51:58 INFO - ##### 23:51:58 INFO - ##### Finished clobber step (success) 23:51:58 INFO - ##### 23:51:58 INFO - ##### 23:51:58 INFO - ##### Running read-buildbot-config step. 23:51:58 INFO - ##### 23:51:58 INFO - Running pre-action listener: _resource_record_pre_action 23:51:58 INFO - Running main action method: read_buildbot_config 23:51:58 INFO - Using buildbot properties: 23:51:58 INFO - { 23:51:58 INFO - "project": "", 23:51:58 INFO - "product": "firefox", 23:51:58 INFO - "script_repo_revision": "production", 23:51:58 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 23:51:58 INFO - "repository": "", 23:51:58 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 23:51:58 INFO - "buildid": "20160614222226", 23:51:58 INFO - "pgo_build": "False", 23:51:58 INFO - "basedir": "/builds/slave/test", 23:51:58 INFO - "buildnumber": 83, 23:51:58 INFO - "slavename": "talos-linux64-ix-054", 23:51:58 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 23:51:58 INFO - "platform": "ubuntu64_hw", 23:51:58 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 23:51:58 INFO - "branch": "mozilla-central", 23:51:58 INFO - "repo_path": "mozilla-central", 23:51:58 INFO - "revision": "53f5b5c289fba6ad82c675578cf1c548ae37f0c1", 23:51:58 INFO - "stage_platform": "linux64", 23:51:58 INFO - "builduid": "c9a3dc141d074ca5a7cc8ef1f4c522fe", 23:51:58 INFO - "slavebuilddir": "test" 23:51:58 INFO - } 23:51:58 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:58 INFO - Running post-action listener: _resource_record_post_action 23:51:58 INFO - ##### 23:51:58 INFO - ##### Finished read-buildbot-config step (success) 23:51:58 INFO - ##### 23:51:58 INFO - ##### 23:51:58 INFO - ##### Running download-and-extract step. 23:51:58 INFO - ##### 23:51:58 INFO - Running pre-action listener: _resource_record_pre_action 23:51:58 INFO - Running main action method: download_and_extract 23:51:58 INFO - mkdir: /builds/slave/test/build/tests 23:51:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:51:58 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:58 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:58 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:58 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:58 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:52:00 INFO - Downloaded 1361 bytes. 23:52:00 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 23:52:00 INFO - Using the following test package requirements: 23:52:00 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 23:52:00 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:52:00 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 23:52:00 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:52:00 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 23:52:00 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:52:00 INFO - u'jsshell-linux-x86_64.zip'], 23:52:00 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:52:00 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 23:52:00 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 23:52:00 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:52:00 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 23:52:00 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:52:00 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 23:52:00 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:52:00 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 23:52:00 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:52:00 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 23:52:00 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 23:52:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:52:00 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:52:00 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:52:00 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:52:00 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:52:00 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:52:02 INFO - Downloaded 22653632 bytes. 23:52:02 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:52:02 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:52:03 INFO - Return code: 0 23:52:03 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: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 - 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:52:03 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:52:03 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:52:03 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:52:03 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:52:06 INFO - Downloaded 22653632 bytes. 23:52:07 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:52:07 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:52:08 INFO - Return code: 0 23:52:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:52:08 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:52:08 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:52:08 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:52:08 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:52:08 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:52:09 INFO - Downloaded 14405384 bytes. 23:52:09 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:52:09 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:52:09 INFO - Return code: 0 23:52:09 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:09 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:52:09 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:52:09 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:52:09 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:52:09 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:52:11 INFO - Downloaded 55401496 bytes. 23:52:11 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:52:11 INFO - mkdir: /builds/slave/test/properties 23:52:11 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 23:52:11 INFO - Writing to file /builds/slave/test/properties/build_url 23:52:11 INFO - Contents: 23:52:11 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:52:11 INFO - Running post-action listener: _resource_record_post_action 23:52:11 INFO - Running post-action listener: set_extra_try_arguments 23:52:11 INFO - ##### 23:52:11 INFO - ##### Finished download-and-extract step (success) 23:52:11 INFO - ##### 23:52:11 INFO - ##### 23:52:11 INFO - ##### Running populate-webroot step. 23:52:11 INFO - ##### 23:52:11 INFO - Running pre-action listener: _resource_record_pre_action 23:52:11 INFO - Running main action method: populate_webroot 23:52:11 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 23:52:11 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 23:52:11 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 23:52:11 INFO - '--tppagecycles', 23:52:11 INFO - '7'], 23:52:11 INFO - 'tests': ['tsvgm']}}, 23:52:11 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 23:52:11 INFO - 'tests': ['tresize', 'tcanvasmark']}, 23:52:11 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 23:52:11 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 23:52:11 INFO - 'tests': ['dromaeo_css', 'kraken']}, 23:52:11 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 23:52:11 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:52:11 INFO - 'talos_options': ['--disable-e10s'], 23:52:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:52:11 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:52:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:52:11 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:52:11 INFO - 'talos_options': ['--disable-e10s'], 23:52:11 INFO - 'tests': ['damp', 'tps']}, 23:52:11 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:52:11 INFO - 'tests': ['damp', 'tps']}, 23:52:11 INFO - 'g3': {'talos_options': ['--disable-e10s'], 23:52:11 INFO - 'tests': ['dromaeo_dom']}, 23:52:11 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 23:52:11 INFO - 'g4': {'talos_options': ['--disable-e10s'], 23:52:11 INFO - 'tests': ['basic_compositor_video']}, 23:52:11 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 23:52:11 INFO - 'other': {'talos_options': ['--disable-e10s'], 23:52:11 INFO - 'tests': ['a11yr', 23:52:11 INFO - 'ts_paint', 23:52:11 INFO - 'tpaint', 23:52:11 INFO - 'sessionrestore', 23:52:11 INFO - 'sessionrestore_no_auto_restore', 23:52:11 INFO - 'tabpaint']}, 23:52:11 INFO - 'other-e10s': {'tests': ['a11yr', 23:52:11 INFO - 'ts_paint', 23:52:11 INFO - 'tpaint', 23:52:11 INFO - 'sessionrestore', 23:52:11 INFO - 'sessionrestore_no_auto_restore', 23:52:11 INFO - 'tabpaint']}, 23:52:11 INFO - 'other-e10s_l64': {'tests': ['a11yr', 23:52:11 INFO - 'ts_paint', 23:52:11 INFO - 'tpaint', 23:52:11 INFO - 'sessionrestore', 23:52:11 INFO - 'sessionrestore_no_auto_restore', 23:52:11 INFO - 'tabpaint']}, 23:52:11 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 23:52:11 INFO - 'ts_paint', 23:52:11 INFO - 'tpaint', 23:52:11 INFO - 'sessionrestore', 23:52:11 INFO - 'sessionrestore_no_auto_restore', 23:52:11 INFO - 'tabpaint']}, 23:52:11 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 23:52:11 INFO - 'tests': ['a11yr', 23:52:11 INFO - 'ts_paint', 23:52:11 INFO - 'tpaint', 23:52:11 INFO - 'sessionrestore', 23:52:11 INFO - 'sessionrestore_no_auto_restore', 23:52:11 INFO - 'tabpaint']}, 23:52:11 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 23:52:11 INFO - 'tests': ['a11yr', 23:52:11 INFO - 'ts_paint', 23:52:11 INFO - 'tpaint', 23:52:11 INFO - 'sessionrestore', 23:52:11 INFO - 'sessionrestore_no_auto_restore', 23:52:11 INFO - 'tabpaint']}, 23:52:11 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 23:52:11 INFO - 'tests': ['tsvgx', 23:52:11 INFO - 'tsvgr_opacity', 23:52:11 INFO - 'tart', 23:52:11 INFO - 'tscrollx', 23:52:11 INFO - 'cart']}, 23:52:11 INFO - 'svgr-e10s': {'tests': ['tsvgx', 23:52:11 INFO - 'tsvgr_opacity', 23:52:11 INFO - 'tart', 23:52:11 INFO - 'tscrollx', 23:52:11 INFO - 'cart']}, 23:52:11 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:52:11 INFO - 'talos_options': ['--disable-e10s'], 23:52:11 INFO - 'tests': ['tp5o']}, 23:52:11 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:52:11 INFO - 'tests': ['tp5o']}, 23:52:11 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:52:11 INFO - 'talos_options': ['--disable-e10s', 23:52:11 INFO - '--xperf_path', 23:52:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:52:11 INFO - 'tests': ['tp5n']}, 23:52:11 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:52:11 INFO - 'talos_options': ['--xperf_path', 23:52:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:52:11 INFO - 'tests': ['tp5n']}}, 23:52:11 INFO - 'talos.zip': {'path': '', 23:52:11 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 23:52:11 INFO - Running post-action listener: _resource_record_post_action 23:52:11 INFO - ##### 23:52:11 INFO - ##### Finished populate-webroot step (success) 23:52:11 INFO - ##### 23:52:11 INFO - ##### 23:52:11 INFO - ##### Running create-virtualenv step. 23:52:11 INFO - ##### 23:52:11 INFO - Running pre-action listener: _resource_record_pre_action 23:52:11 INFO - Running main action method: create_virtualenv 23:52:11 INFO - Creating virtualenv /builds/slave/test/build/venv 23:52:11 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:52:11 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 23:52:12 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 23:52:12 INFO - Using real prefix '/usr' 23:52:12 INFO - New python executable in /builds/slave/test/build/venv/bin/python 23:52:12 INFO - Installing distribute.............................................................................................................................................................................................done. 23:52:14 INFO - Installing pip.................done. 23:52:14 INFO - Return code: 0 23:52:14 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 23:52:14 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:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:52:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:52:14 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:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:52:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:52:14 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 0x7fb7cb3eef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf5d450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfec2c0>, '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 0xfed1c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfed650>, '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': 'cbe409c6de289db6ac707de3000001d4-1465962338.785363-31806065', '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:14 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:52:14 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:52:14 INFO - Using env: {'DISPLAY': ':0', 23:52:14 INFO - 'HOME': '/home/cltbld', 23:52:14 INFO - 'LANG': 'en_US.UTF-8', 23:52:14 INFO - 'LANGUAGE': 'en_US:en', 23:52:14 INFO - 'LOGNAME': 'cltbld', 23:52:14 INFO - 'MAIL': '/var/mail/cltbld', 23:52:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:52:14 INFO - 'MOZ_NO_REMOTE': '1', 23:52:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:52:14 INFO - 'NO_EM_RESTART': '1', 23:52:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:52:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:52:14 INFO - 'PWD': '/builds/slave/test', 23:52:14 INFO - 'SHELL': '/bin/bash', 23:52:14 INFO - 'SHLVL': '1', 23:52:14 INFO - 'TERM': 'linux', 23:52:14 INFO - 'TMOUT': '86400', 23:52:14 INFO - 'USER': 'cltbld', 23:52:14 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1465962338.785363-31806065', 23:52:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:52:14 INFO - '_': '/tools/buildbot/bin/python'} 23:52:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:52:14 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:52:14 INFO - Cleaning up... 23:52:14 INFO - Return code: 0 23:52:14 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 23:52:14 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:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:52:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:52:14 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:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:52:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:52:14 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 0x7fb7cb3eef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf5d450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfec2c0>, '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 0xfed1c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfed650>, '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': 'cbe409c6de289db6ac707de3000001d4-1465962338.785363-31806065', '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:14 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:52:14 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:52:14 INFO - Using env: {'DISPLAY': ':0', 23:52:14 INFO - 'HOME': '/home/cltbld', 23:52:14 INFO - 'LANG': 'en_US.UTF-8', 23:52:14 INFO - 'LANGUAGE': 'en_US:en', 23:52:14 INFO - 'LOGNAME': 'cltbld', 23:52:14 INFO - 'MAIL': '/var/mail/cltbld', 23:52:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:52:14 INFO - 'MOZ_NO_REMOTE': '1', 23:52:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:52:14 INFO - 'NO_EM_RESTART': '1', 23:52:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:52:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:52:14 INFO - 'PWD': '/builds/slave/test', 23:52:14 INFO - 'SHELL': '/bin/bash', 23:52:14 INFO - 'SHLVL': '1', 23:52:14 INFO - 'TERM': 'linux', 23:52:14 INFO - 'TMOUT': '86400', 23:52:14 INFO - 'USER': 'cltbld', 23:52:14 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1465962338.785363-31806065', 23:52:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:52:14 INFO - '_': '/tools/buildbot/bin/python'} 23:52:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:52:14 INFO - Downloading/unpacking psutil>=3.1.1 23:52:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:52:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:52:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:52:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:52:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:52:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:52:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 23:52:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:52:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:52:16 INFO - Installing collected packages: psutil 23:52:16 INFO - Running setup.py install for psutil 23:52:17 INFO - building 'psutil._psutil_linux' extension 23:52:17 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:52:17 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:52:17 INFO - building 'psutil._psutil_posix' extension 23:52:17 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:52:17 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:52:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:52:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:52:17 INFO - Successfully installed psutil 23:52:17 INFO - Cleaning up... 23:52:17 INFO - Return code: 0 23:52:17 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 23:52:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:52:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:52:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:52:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:52:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:52:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:52:17 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 0x7fb7cb3eef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf5d450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfec2c0>, '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 0xfed1c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfed650>, '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': 'cbe409c6de289db6ac707de3000001d4-1465962338.785363-31806065', '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:17 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:52:17 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:52:17 INFO - Using env: {'DISPLAY': ':0', 23:52:17 INFO - 'HOME': '/home/cltbld', 23:52:17 INFO - 'LANG': 'en_US.UTF-8', 23:52:17 INFO - 'LANGUAGE': 'en_US:en', 23:52:17 INFO - 'LOGNAME': 'cltbld', 23:52:17 INFO - 'MAIL': '/var/mail/cltbld', 23:52:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:52:17 INFO - 'MOZ_NO_REMOTE': '1', 23:52:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:52:17 INFO - 'NO_EM_RESTART': '1', 23:52:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:52:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:52:17 INFO - 'PWD': '/builds/slave/test', 23:52:17 INFO - 'SHELL': '/bin/bash', 23:52:17 INFO - 'SHLVL': '1', 23:52:17 INFO - 'TERM': 'linux', 23:52:17 INFO - 'TMOUT': '86400', 23:52:17 INFO - 'USER': 'cltbld', 23:52:17 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1465962338.785363-31806065', 23:52:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:52:17 INFO - '_': '/tools/buildbot/bin/python'} 23:52:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:52:17 INFO - Downloading/unpacking mozsystemmonitor==0.3 23:52:17 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:17 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:17 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:17 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:17 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:17 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:19 INFO - Downloading mozsystemmonitor-0.3.tar.gz 23:52:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 23:52:19 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 23:52:19 INFO - Installing collected packages: mozsystemmonitor 23:52:19 INFO - Running setup.py install for mozsystemmonitor 23:52:19 INFO - Successfully installed mozsystemmonitor 23:52:19 INFO - Cleaning up... 23:52:19 INFO - Return code: 0 23:52:19 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 23:52:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:52:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:52:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:52:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:52:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:52:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:52:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fb7cb3eef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf5d450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfec2c0>, '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 0xfed1c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfed650>, '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': 'cbe409c6de289db6ac707de3000001d4-1465962338.785363-31806065', '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:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 23:52:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 23:52:19 INFO - Using env: {'DISPLAY': ':0', 23:52:19 INFO - 'HOME': '/home/cltbld', 23:52:19 INFO - 'LANG': 'en_US.UTF-8', 23:52:19 INFO - 'LANGUAGE': 'en_US:en', 23:52:19 INFO - 'LOGNAME': 'cltbld', 23:52:19 INFO - 'MAIL': '/var/mail/cltbld', 23:52:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:52:19 INFO - 'MOZ_NO_REMOTE': '1', 23:52:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:52:19 INFO - 'NO_EM_RESTART': '1', 23:52:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:52:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:52:19 INFO - 'PWD': '/builds/slave/test', 23:52:19 INFO - 'SHELL': '/bin/bash', 23:52:19 INFO - 'SHLVL': '1', 23:52:19 INFO - 'TERM': 'linux', 23:52:19 INFO - 'TMOUT': '86400', 23:52:19 INFO - 'USER': 'cltbld', 23:52:19 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1465962338.785363-31806065', 23:52:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:52:19 INFO - '_': '/tools/buildbot/bin/python'} 23:52:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:52:20 INFO - Downloading/unpacking jsonschema==2.5.1 23:52:20 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:20 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:20 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:20 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:20 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:20 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:21 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 23:52:21 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 23:52:21 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:21 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:21 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:21 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:21 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:21 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:22 INFO - Downloading functools32-3.2.3-2.tar.gz 23:52:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 23:52:22 INFO - warning: no files found matching '*.txt' 23:52:22 INFO - no previously-included directories found matching 'build' 23:52:22 INFO - no previously-included directories found matching 'dist' 23:52:22 INFO - no previously-included directories found matching '.git*' 23:52:22 INFO - Installing collected packages: jsonschema, functools32 23:52:22 INFO - Running setup.py install for functools32 23:52:22 INFO - warning: no files found matching '*.txt' 23:52:22 INFO - no previously-included directories found matching 'build' 23:52:22 INFO - no previously-included directories found matching 'dist' 23:52:22 INFO - no previously-included directories found matching '.git*' 23:52:22 INFO - Successfully installed jsonschema functools32 23:52:22 INFO - Cleaning up... 23:52:22 INFO - Return code: 0 23:52:22 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 23:52:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:52:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:52:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:52:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:52:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:52:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:52:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fb7cb3eef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf5d450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfec2c0>, '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 0xfed1c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfed650>, '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': 'cbe409c6de289db6ac707de3000001d4-1465962338.785363-31806065', '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:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 23:52:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 23:52:22 INFO - Using env: {'DISPLAY': ':0', 23:52:22 INFO - 'HOME': '/home/cltbld', 23:52:22 INFO - 'LANG': 'en_US.UTF-8', 23:52:22 INFO - 'LANGUAGE': 'en_US:en', 23:52:22 INFO - 'LOGNAME': 'cltbld', 23:52:22 INFO - 'MAIL': '/var/mail/cltbld', 23:52:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:52:22 INFO - 'MOZ_NO_REMOTE': '1', 23:52:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:52:22 INFO - 'NO_EM_RESTART': '1', 23:52:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:52:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:52:22 INFO - 'PWD': '/builds/slave/test', 23:52:22 INFO - 'SHELL': '/bin/bash', 23:52:22 INFO - 'SHLVL': '1', 23:52:22 INFO - 'TERM': 'linux', 23:52:22 INFO - 'TMOUT': '86400', 23:52:22 INFO - 'USER': 'cltbld', 23:52:22 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1465962338.785363-31806065', 23:52:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:52:22 INFO - '_': '/tools/buildbot/bin/python'} 23:52:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:52:22 INFO - Downloading/unpacking blobuploader==1.2.4 23:52:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:52:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:52:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:52:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:52:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:52:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:52:24 INFO - Downloading blobuploader-1.2.4.tar.gz 23:52:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 23:52:24 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 23:52:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:52:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:52:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:52:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:52:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:52:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:52:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 23:52:24 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 23:52:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:52:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:52:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:52:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:52:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:52:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:52:25 INFO - Downloading docopt-0.6.1.tar.gz 23:52:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 23:52:25 INFO - Installing collected packages: blobuploader, requests, docopt 23:52:25 INFO - Running setup.py install for blobuploader 23:52:25 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 23:52:25 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 23:52:25 INFO - Running setup.py install for requests 23:52:25 INFO - Running setup.py install for docopt 23:52:25 INFO - Successfully installed blobuploader requests docopt 23:52:25 INFO - Cleaning up... 23:52:25 INFO - Return code: 0 23:52:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:52:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:52:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:52:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:52:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:52:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:52:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:52:25 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 0x7fb7cb3eef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf5d450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfec2c0>, '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 0xfed1c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfed650>, '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': 'cbe409c6de289db6ac707de3000001d4-1465962338.785363-31806065', '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:25 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:52:25 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:52:25 INFO - Using env: {'DISPLAY': ':0', 23:52:25 INFO - 'HOME': '/home/cltbld', 23:52:25 INFO - 'LANG': 'en_US.UTF-8', 23:52:25 INFO - 'LANGUAGE': 'en_US:en', 23:52:25 INFO - 'LOGNAME': 'cltbld', 23:52:25 INFO - 'MAIL': '/var/mail/cltbld', 23:52:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:52:25 INFO - 'MOZ_NO_REMOTE': '1', 23:52:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:52:25 INFO - 'NO_EM_RESTART': '1', 23:52:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:52:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:52:25 INFO - 'PWD': '/builds/slave/test', 23:52:25 INFO - 'SHELL': '/bin/bash', 23:52:25 INFO - 'SHLVL': '1', 23:52:25 INFO - 'TERM': 'linux', 23:52:25 INFO - 'TMOUT': '86400', 23:52:25 INFO - 'USER': 'cltbld', 23:52:25 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1465962338.785363-31806065', 23:52:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:52:25 INFO - '_': '/tools/buildbot/bin/python'} 23:52:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:52:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:52:26 INFO - Running setup.py (path:/tmp/pip-s6KDbS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:52:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:52:26 INFO - Running setup.py (path:/tmp/pip-YSoSf7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:52:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:52:26 INFO - Running setup.py (path:/tmp/pip-05xNKw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:52:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:52:26 INFO - Running setup.py (path:/tmp/pip-39qt_M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:52:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:52:26 INFO - Running setup.py (path:/tmp/pip-w1GPDF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:52:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:52:26 INFO - Running setup.py (path:/tmp/pip-FDqYYc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:52:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:52:26 INFO - Running setup.py (path:/tmp/pip-3SmPsq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:52:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:52:26 INFO - Running setup.py (path:/tmp/pip-Y8a4IN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:52:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:52:26 INFO - Running setup.py (path:/tmp/pip-DjEj7p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:52:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:52:26 INFO - Running setup.py (path:/tmp/pip-OoqP3L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:52:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:52:26 INFO - Running setup.py (path:/tmp/pip-HgZvhQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:52:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:52:26 INFO - Running setup.py (path:/tmp/pip-so7_XG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:52:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:52:26 INFO - Running setup.py (path:/tmp/pip-bfWJhd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:52:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:52:26 INFO - Running setup.py (path:/tmp/pip-4vQYgK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:52:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:52:27 INFO - Running setup.py (path:/tmp/pip-alIAc9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:52:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:52:27 INFO - Running setup.py (path:/tmp/pip-AWkNnQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:52:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:52:27 INFO - Running setup.py (path:/tmp/pip-VGhOEK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:52:27 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 23:52:27 INFO - Running setup.py install for manifestparser 23:52:27 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 23:52:27 INFO - Running setup.py install for mozcrash 23:52:27 INFO - Running setup.py install for mozdebug 23:52:27 INFO - Running setup.py install for mozdevice 23:52:27 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 23:52:27 INFO - Installing dm script to /builds/slave/test/build/venv/bin 23:52:27 INFO - Running setup.py install for mozfile 23:52:27 INFO - Running setup.py install for mozhttpd 23:52:27 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 23:52:27 INFO - Running setup.py install for mozinfo 23:52:27 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 23:52:27 INFO - Running setup.py install for mozInstall 23:52:28 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 23:52:28 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 23:52:28 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 23:52:28 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 23:52:28 INFO - Running setup.py install for mozleak 23:52:28 INFO - Running setup.py install for mozlog 23:52:28 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 23:52:28 INFO - Running setup.py install for moznetwork 23:52:28 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 23:52:28 INFO - Running setup.py install for mozprocess 23:52:28 INFO - Running setup.py install for mozprofile 23:52:28 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 23:52:28 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 23:52:28 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 23:52:28 INFO - Running setup.py install for mozrunner 23:52:28 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 23:52:28 INFO - Running setup.py install for mozscreenshot 23:52:28 INFO - Running setup.py install for moztest 23:52:28 INFO - Running setup.py install for mozversion 23:52:29 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 23:52:29 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 23:52:29 INFO - Cleaning up... 23:52:29 INFO - Return code: 0 23:52:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:52: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:52:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:52:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:52: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:52:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:52:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:52:29 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 0x7fb7cb3eef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf5d450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfec2c0>, '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 0xfed1c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfed650>, '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': 'cbe409c6de289db6ac707de3000001d4-1465962338.785363-31806065', '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:29 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:52:29 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:52:29 INFO - Using env: {'DISPLAY': ':0', 23:52:29 INFO - 'HOME': '/home/cltbld', 23:52:29 INFO - 'LANG': 'en_US.UTF-8', 23:52:29 INFO - 'LANGUAGE': 'en_US:en', 23:52:29 INFO - 'LOGNAME': 'cltbld', 23:52:29 INFO - 'MAIL': '/var/mail/cltbld', 23:52:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:52:29 INFO - 'MOZ_NO_REMOTE': '1', 23:52:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:52:29 INFO - 'NO_EM_RESTART': '1', 23:52:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:52:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:52:29 INFO - 'PWD': '/builds/slave/test', 23:52:29 INFO - 'SHELL': '/bin/bash', 23:52:29 INFO - 'SHLVL': '1', 23:52:29 INFO - 'TERM': 'linux', 23:52:29 INFO - 'TMOUT': '86400', 23:52:29 INFO - 'USER': 'cltbld', 23:52:29 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1465962338.785363-31806065', 23:52:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:52:29 INFO - '_': '/tools/buildbot/bin/python'} 23:52:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:52:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:52:29 INFO - Running setup.py (path:/tmp/pip-dc0kgl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:52:29 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:52:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:52:29 INFO - Running setup.py (path:/tmp/pip-iIAHSJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:52:29 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:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:52:29 INFO - Running setup.py (path:/tmp/pip-fQQ2V3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:52:29 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:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:52:29 INFO - Running setup.py (path:/tmp/pip-uUbyoq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:52:29 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:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:52:29 INFO - Running setup.py (path:/tmp/pip-DWNNIU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:52:29 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:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:52:29 INFO - Running setup.py (path:/tmp/pip-IxnhKR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:52:29 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:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:52:29 INFO - Running setup.py (path:/tmp/pip-0celfJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:52:29 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:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:52:29 INFO - Running setup.py (path:/tmp/pip-RnaAGo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:52:29 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:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:52:29 INFO - Running setup.py (path:/tmp/pip-pQwFmC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:52:29 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:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:52:29 INFO - Running setup.py (path:/tmp/pip-15mjqA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:52:30 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:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:52:30 INFO - Running setup.py (path:/tmp/pip-aYlGqr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:52:30 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:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:52:30 INFO - Running setup.py (path:/tmp/pip-8k_rLU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:52:30 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:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:52:30 INFO - Running setup.py (path:/tmp/pip-cso9FZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:52:30 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:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:52:30 INFO - Running setup.py (path:/tmp/pip-E_kFgG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:52:30 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:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:52:30 INFO - Running setup.py (path:/tmp/pip-w9DHom-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:52:30 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:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:52:30 INFO - Running setup.py (path:/tmp/pip-BNYC8m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:52:30 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:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:52:30 INFO - Running setup.py (path:/tmp/pip-is5o_D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:52:30 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:30 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:30 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:30 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:30 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:30 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:30 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:52:30 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:30 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:30 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:30 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:30 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:30 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:32 INFO - Downloading blessings-1.6.tar.gz 23:52:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 23:52:32 INFO - Installing collected packages: blessings 23:52:32 INFO - Running setup.py install for blessings 23:52:32 INFO - Successfully installed blessings 23:52:32 INFO - Cleaning up... 23:52:32 INFO - Return code: 0 23:52:32 INFO - Done creating virtualenv /builds/slave/test/build/venv. 23:52:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:52:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:52:32 INFO - Reading from file tmpfile_stdout 23:52:32 INFO - Current package versions: 23:52:32 INFO - argparse == 1.2.1 23:52:32 INFO - blessings == 1.6 23:52:32 INFO - blobuploader == 1.2.4 23:52:32 INFO - docopt == 0.6.1 23:52:32 INFO - functools32 == 3.2.3-2 23:52:32 INFO - jsonschema == 2.5.1 23:52:32 INFO - manifestparser == 1.1 23:52:32 INFO - mozInstall == 1.12 23:52:32 INFO - mozcrash == 0.17 23:52:32 INFO - mozdebug == 0.1 23:52:32 INFO - mozdevice == 0.48 23:52:32 INFO - mozfile == 1.2 23:52:32 INFO - mozhttpd == 0.7 23:52:32 INFO - mozinfo == 0.9 23:52:32 INFO - mozleak == 0.1 23:52:32 INFO - mozlog == 3.2 23:52:32 INFO - moznetwork == 0.27 23:52:32 INFO - mozprocess == 0.22 23:52:32 INFO - mozprofile == 0.28 23:52:32 INFO - mozrunner == 6.11 23:52:32 INFO - mozscreenshot == 0.1 23:52:32 INFO - mozsystemmonitor == 0.3 23:52:32 INFO - moztest == 0.7 23:52:32 INFO - mozversion == 1.4 23:52:32 INFO - psutil == 3.1.1 23:52:32 INFO - requests == 1.2.3 23:52:32 INFO - wsgiref == 0.1.2 23:52:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:52: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:52:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:52:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:52: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:52:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:52:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:52:32 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 0x7fb7cb3eef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf5d450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfec2c0>, '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 0xfed1c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfed650>, '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': 'cbe409c6de289db6ac707de3000001d4-1465962338.785363-31806065', '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:32 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:32 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:32 INFO - Using env: {'DISPLAY': ':0', 23:52:32 INFO - 'HOME': '/home/cltbld', 23:52:32 INFO - 'LANG': 'en_US.UTF-8', 23:52:32 INFO - 'LANGUAGE': 'en_US:en', 23:52:32 INFO - 'LOGNAME': 'cltbld', 23:52:32 INFO - 'MAIL': '/var/mail/cltbld', 23:52:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:52:32 INFO - 'MOZ_NO_REMOTE': '1', 23:52:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:52:32 INFO - 'NO_EM_RESTART': '1', 23:52:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:52:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:52:32 INFO - 'PWD': '/builds/slave/test', 23:52:32 INFO - 'SHELL': '/bin/bash', 23:52:32 INFO - 'SHLVL': '1', 23:52:32 INFO - 'TERM': 'linux', 23:52:32 INFO - 'TMOUT': '86400', 23:52:32 INFO - 'USER': 'cltbld', 23:52:32 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1465962338.785363-31806065', 23:52:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:52:32 INFO - '_': '/tools/buildbot/bin/python'} 23:52:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:52:33 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:33 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:33 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:33 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:33 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:33 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:33 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:33 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:33 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:33 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:33 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:33 INFO - Cleaning up... 23:52:33 INFO - Return code: 0 23:52:33 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 23:52:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:52:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:52:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:52:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:52:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:52:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:52:33 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 0x7fb7cb3eef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf5d450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfec2c0>, '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 0xfed1c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfed650>, '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': 'cbe409c6de289db6ac707de3000001d4-1465962338.785363-31806065', '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:33 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:33 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:33 INFO - Using env: {'DISPLAY': ':0', 23:52:33 INFO - 'HOME': '/home/cltbld', 23:52:33 INFO - 'LANG': 'en_US.UTF-8', 23:52:33 INFO - 'LANGUAGE': 'en_US:en', 23:52:33 INFO - 'LOGNAME': 'cltbld', 23:52:33 INFO - 'MAIL': '/var/mail/cltbld', 23:52:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:52:33 INFO - 'MOZ_NO_REMOTE': '1', 23:52:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:52:33 INFO - 'NO_EM_RESTART': '1', 23:52:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:52:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:52:33 INFO - 'PWD': '/builds/slave/test', 23:52:33 INFO - 'SHELL': '/bin/bash', 23:52:33 INFO - 'SHLVL': '1', 23:52:33 INFO - 'TERM': 'linux', 23:52:33 INFO - 'TMOUT': '86400', 23:52:33 INFO - 'USER': 'cltbld', 23:52:33 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1465962338.785363-31806065', 23:52:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:52:33 INFO - '_': '/tools/buildbot/bin/python'} 23:52:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:52:33 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 23:52:33 INFO - Cleaning up... 23:52:33 INFO - Return code: 0 23:52:33 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 23:52:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:52:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:52:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:52:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:52:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:52:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:52:33 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 0x7fb7cb3eef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf5d450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfec2c0>, '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 0xfed1c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfed650>, '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': 'cbe409c6de289db6ac707de3000001d4-1465962338.785363-31806065', '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:33 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:33 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:33 INFO - Using env: {'DISPLAY': ':0', 23:52:33 INFO - 'HOME': '/home/cltbld', 23:52:33 INFO - 'LANG': 'en_US.UTF-8', 23:52:33 INFO - 'LANGUAGE': 'en_US:en', 23:52:33 INFO - 'LOGNAME': 'cltbld', 23:52:33 INFO - 'MAIL': '/var/mail/cltbld', 23:52:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:52:33 INFO - 'MOZ_NO_REMOTE': '1', 23:52:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:52:33 INFO - 'NO_EM_RESTART': '1', 23:52:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:52:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:52:33 INFO - 'PWD': '/builds/slave/test', 23:52:33 INFO - 'SHELL': '/bin/bash', 23:52:33 INFO - 'SHLVL': '1', 23:52:33 INFO - 'TERM': 'linux', 23:52:33 INFO - 'TMOUT': '86400', 23:52:33 INFO - 'USER': 'cltbld', 23:52:33 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1465962338.785363-31806065', 23:52:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:52:33 INFO - '_': '/tools/buildbot/bin/python'} 23:52:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:52:33 INFO - Downloading/unpacking flake8 23:52:33 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:33 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:33 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:33 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:33 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:33 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:35 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 23:52:35 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 23:52:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:52:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:52:35 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:35 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:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:52:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:52:35 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 23:52:35 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 23:52:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:52:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:52:35 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:35 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:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:52:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:52:35 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 23:52:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:52:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:52:35 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:35 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:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:52:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:52:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 23:52:36 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:52:36 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:52:36 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:52:36 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:52:36 INFO - no previously-included directories found matching 'docs/_build' 23:52:36 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 23:52:36 INFO - Running setup.py install for pep8 23:52:36 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:52:36 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:52:36 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:52:36 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:52:36 INFO - no previously-included directories found matching 'docs/_build' 23:52:36 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 23:52:36 INFO - Successfully installed flake8 mccabe pyflakes pep8 23:52:36 INFO - Cleaning up... 23:52:36 INFO - Return code: 0 23:52:36 INFO - Running post-action listener: _resource_record_post_action 23:52:36 INFO - Running post-action listener: _start_resource_monitoring 23:52:36 INFO - Starting resource monitoring. 23:52:36 INFO - ##### 23:52:36 INFO - ##### Finished create-virtualenv step (success) 23:52:36 INFO - ##### 23:52:36 INFO - ##### 23:52:36 INFO - ##### Running install step. 23:52:36 INFO - ##### 23:52:36 INFO - Running pre-action listener: _resource_record_pre_action 23:52:36 INFO - Running main action method: install 23:52:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:52:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:52:36 INFO - Reading from file tmpfile_stdout 23:52:36 INFO - Detecting whether we're running mozinstall >=1.0... 23:52:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 23:52:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 23:52:36 INFO - Reading from file tmpfile_stdout 23:52:36 INFO - Output received: 23:52:36 INFO - Usage: mozinstall [options] installer 23:52:36 INFO - Options: 23:52:36 INFO - -h, --help show this help message and exit 23:52:36 INFO - -d DEST, --destination=DEST 23:52:36 INFO - Directory to install application into. [default: 23:52:36 INFO - "/builds/slave/test"] 23:52:36 INFO - --app=APP Application being installed. [default: firefox] 23:52:36 INFO - mkdir: /builds/slave/test/build/application 23:52:36 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:36 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:52 INFO - Reading from file tmpfile_stdout 23:52:52 INFO - Output received: 23:52:52 INFO - /builds/slave/test/build/application/firefox/firefox 23:52:52 INFO - Running post-action listener: _resource_record_post_action 23:52:52 INFO - ##### 23:52:52 INFO - ##### Finished install step (success) 23:52:52 INFO - ##### 23:52:52 INFO - ##### 23:52:52 INFO - ##### Running run-tests step. 23:52:52 INFO - ##### 23:52:52 INFO - Running pre-action listener: _resource_record_pre_action 23:52:52 INFO - Running main action method: run_tests 23:52:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 23:52:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 23:52:52 INFO - Python 2.7.3 23:52:52 INFO - Return code: 0 23:52:52 INFO - grabbing minidump binary from tooltool 23:52: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:52:52 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 0xfec2c0>, '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 0xfed1c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xfed650>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 23:52:52 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:52 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:52 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:52 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 23:52:52 INFO - Return code: 0 23:52:52 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 23:52:52 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 23:52:52 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 23:52:52 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 23:52:52 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 23:52:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 23:52:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 23:52:53 INFO - Return code: 0 23:52:53 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-e10s', '--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-054', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 23:52:53 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-e10s --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-054 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 23:52:53 INFO - Using env: {'DISPLAY': ':0', 23:52:53 INFO - 'HOME': '/home/cltbld', 23:52:53 INFO - 'LANG': 'en_US.UTF-8', 23:52:53 INFO - 'LANGUAGE': 'en_US:en', 23:52:53 INFO - 'LOGNAME': 'cltbld', 23:52:53 INFO - 'MAIL': '/var/mail/cltbld', 23:52:53 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 23:52:53 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 23:52:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:52:53 INFO - 'MOZ_NO_REMOTE': '1', 23:52:53 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 23:52:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:52:53 INFO - 'NO_EM_RESTART': '1', 23:52:53 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:52:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:52:53 INFO - 'PWD': '/builds/slave/test', 23:52:53 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 23:52:53 INFO - 'SHELL': '/bin/bash', 23:52:53 INFO - 'SHLVL': '1', 23:52:53 INFO - 'TERM': 'linux', 23:52:53 INFO - 'TMOUT': '86400', 23:52:53 INFO - 'USER': 'cltbld', 23:52:53 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1465962338.785363-31806065', 23:52:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:52:53 INFO - '_': '/tools/buildbot/bin/python'} 23:52:53 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-e10s', '--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-054', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 23:52:53 INFO - mozversion application_buildid: 20160614222226 23:52:53 INFO - mozversion application_changeset: 53f5b5c289fba6ad82c675578cf1c548ae37f0c1 23:52:53 INFO - mozversion application_display_name: Nightly 23:52:53 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 23:52:53 INFO - mozversion application_name: Firefox 23:52:53 INFO - mozversion application_remotingname: firefox 23:52:53 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 23:52:53 INFO - mozversion application_vendor: Mozilla 23:52:53 INFO - mozversion application_version: 50.0a1 23:52:53 INFO - mozversion platform_buildid: 20160614222226 23:52:53 INFO - mozversion platform_changeset: 53f5b5c289fba6ad82c675578cf1c548ae37f0c1 23:52:53 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 23:52:53 INFO - mozversion platform_version: 50.0a1 23:52:53 INFO - using testdate: 1465973573 23:52:53 INFO - actual date: 1465973573 23:52:53 INFO - starting webserver on 'localhost:54161' 23:52:53 INFO - SUITE-START | Running 2 tests 23:52:53 INFO - TEST-START | dromaeo_css 23:52:53 INFO - operating with platform_type : linux_ 23:52:53 INFO - Initialising browser for dromaeo_css test... 23:52:53 INFO - TEST-INFO | started process 13988 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiL4vE4/profile http://localhost:54161/getInfo.html) 23:52:59 INFO - PROCESS | 13988 | __metrics Screen width/height:1600/1200 23:52:59 INFO - PROCESS | 13988 | colorDepth:24 23:52:59 INFO - PROCESS | 13988 | Browser inner width/height: 1024/697 23:52:59 INFO - PROCESS | 13988 | __metrics 23:52:59 ERROR - PROCESS | 13988 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 23:53:00 INFO - TEST-INFO | 13988: exit 0 23:53:00 INFO - Browser initialized. 23:53:00 INFO - Running cycle 1/1 for dromaeo_css test... 23:53:00 INFO - TEST-INFO | started process 14107 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiL4vE4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:53:12 INFO - PROCESS | 14107 | RSS: Main: 185753600 23:53:12 INFO - PROCESS | 14107 | 23:54:02 INFO - PROCESS | 14107 | 1465973642403 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:56:14 INFO - PROCESS | 14107 | Cycle 1(1): loaded http://localhost:54161/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54161/tests/dromaeo/cssquery-ext.html) 23:56:15 INFO - PROCESS | 14107 | RSS: Main: 189247488 23:56:15 INFO - PROCESS | 14107 | 23:59:17 INFO - PROCESS | 14107 | Cycle 1(1): loaded http://localhost:54161/tests/dromaeo/cssquery-ext.html (next: http://localhost:54161/tests/dromaeo/cssquery-jquery.html) 23:59:18 INFO - PROCESS | 14107 | RSS: Main: 187936768 23:59:18 INFO - PROCESS | 14107 | 00:02:20 INFO - PROCESS | 14107 | Cycle 1(1): loaded http://localhost:54161/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54161/tests/dromaeo/cssquery-mootools.html) 00:02:21 INFO - PROCESS | 14107 | RSS: Main: 186208256 00:02:21 INFO - PROCESS | 14107 | 00:05:22 INFO - PROCESS | 14107 | Cycle 1(1): loaded http://localhost:54161/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54161/tests/dromaeo/cssquery-prototype.html) 00:05:23 INFO - PROCESS | 14107 | RSS: Main: 188866560 00:05:23 INFO - PROCESS | 14107 | 00:08:26 INFO - PROCESS | 14107 | Cycle 1(1): loaded http://localhost:54161/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54161/tests/dromaeo/cssquery-yui.html) 00:08:26 INFO - PROCESS | 14107 | RSS: Main: 187777024 00:08:26 INFO - PROCESS | 14107 | 00:11:29 INFO - PROCESS | 14107 | Cycle 1(1): loaded http://localhost:54161/tests/dromaeo/cssquery-yui.html (next: http://localhost:54161/tests/dromaeo/cssquery-dojo.html) 00:11:29 INFO - PROCESS | 14107 | RSS: Main: 189263872 00:11:29 INFO - PROCESS | 14107 | 00:11:29 INFO - PROCESS | 14107 | __start_tp_report 00:11:29 INFO - PROCESS | 14107 | _x_x_mozilla_page_load 00:11:29 INFO - PROCESS | 14107 | _x_x_mozilla_page_load_details 00:11:29 INFO - PROCESS | 14107 | |i|pagename|runs| 00:11:29 INFO - PROCESS | 14107 | |0;dojo.html;2602;2658.8005899557534;2684.2752456836656;2692.9461410771773;2710.25467996301;4753.8811529711775;4760.738159401236;4795.952040479594;4819.3734814474155;4857.441394239663;4702.3416721659;4820.8553743387665;4831.975840120795;4879.926801097978;4899.167141585939;4410.62509686677;4432.689711720181;4519.3446950192365;4533.8413155539565;4541.023679908819;4219.831206751742;4501.707389019703;4522.253828118356;4577.130345234412;4582.7250364978045;4292.0772034012525;4409.559044095597;4421.712588681758;4454.28731402974;4496.145732310867;4419.094085712453;4428.557144285545;4469.217886869817;4496.595306422438;4521.84173553924;4431.689781715281;4459.777011149429;4467.486239082515;4490.663200259994;4496;4836.51634836517;4888.755562221874;4907.337509436216;4915.262710593403;4925.138100832376;5239.580833533346;5254.3169387979315;5254.343207099113;5258.1849813279005;5319.0957537218765;5009.348784657971;5224.059669259532;5310.9734451327495;5314.867128321785;5321.414644389114;4873.610111191097;4892.730899800546;4911.140550403737;4914;4961.131801934647;5391.622586418992;5393.568514518829;5403.783848646089;5405.054115529767;5463;4921.557059864629;5011.473795251519;5027.095122877917;5169.147090729987;5179.8446046618665;4944.752762361867;5139.229115632685;5147.716875571805;5159.17453207485;5197.610179236573;5004.674696144739;5064.4935506449065;5082.415522214918;5137.306463627438;5139.820106296336;4915.16442204826;5013.448520662724;5020.924686129711;5063.746812659426;5129.358830146231;4349.9130017399475;4365.803538840696;4372.191144638252;4407.184670835905;4407.493138289074;3795.8291876865605;3798.6581207691443;3814.0464883779055;3847.2305538891774;3884.9704828220542;4274.829006839754;4427.8228870844805;4433.490148632884;4499.34759459883;4501.819927202875;5125.513076257749;5178.456262092502;5180.7150606717;5193.3767947845745;5252.054630166606;4439.933400998988;4454.064646424223;4461.933071003938;4462.665300102505;4506;4487.977560112178;4646.535346465326;4646.535346465326;4668.369770080995;4714.080754252887;4853.6602437829715;4882.145624515695;4889.462159162418;4909.4354149273295;4916.950830491649;5031.471695471922;5211.5049070338255;5222.686638801684;5231.686098834082;5277.8416647500635;4774.355462012584;4799.232122860326;4809.591184749335;4830.806767729392;4837.298591704112;5040.974795126148;5059.696418214771;5064.366954130734;5087.058894104603;5114.590832733446;5121.820736274212;5124.282600436017;5140.537351638371;5145.250614790989;5160.664556803796;4841.491643377394;4915.557599816034;4985.850424487271;5052.595792336678;5104.2088476286235;4957.900841983068;4976.154053810933;4982.900341993212;4982.925256121089;5010.649254552146;4633.189191891473;4809.615230781459;4854.247591623304;4888.902221955612;4891.877703057452;4946.876328091683;5003.924941125959;5041.092603331289;5062;5123.948760512347;4925.45819959797;4950.356453661001;4952.529509696573;4952.603791696728;4959.70241785494 00:11:29 INFO - PROCESS | 14107 | |1;ext.html;546.1806963337852;570.4352690836072;586.3813676571222;590.5157770628084;591.6420565557835;28506.42987140256;40181.79909100454;41009.38485922714;41167.58832411679;44153.11693766123;41284;41304.58695413045;41775.58224417755;41780.37329440061;41791;7858.8035299117555;7952.960235198816;7986.121526632095;7993.240642138988;7994.680212791482;7801.687932482694;7880.763577092696;7882.172371900954;7899.368050555941;7906.644201010969;7923.524588524678;7989.440739148262;8003.639836207355;8003.799905002364;8010.919890801105;7847.882281765749;7875.212478752108;7881.487703299267;7898.170692077335;7918.564478953655;7887.250711182429;7967.322777563914;7983.441159118864;7993;7998.64006119726;39162.80418597917;39570.40644390336;39585.20829583392;39707.8014609928;39759.8012009941;3134.7962382445066;3266.657001014883;3272.2637406583567;3316.5688460499982;3364.49532570114;29122;29354.853225733947;29824.552631710543;29899.25251868699;30206.73449491275;3310.536524886518;3337.1990722226733;3350.2964377480516;3361.2605226850055;3370.7640465167447;247633;247732;248024;251188;252246.73876630684;32243.677563224537;54476.91046179054;54534.181987270225;54636.72681636566;54719.45280547144;32458.83770581179;34225.82887085548;34254.48618270728;34259.486107708406;34378.312433751686;13374.598762037154;13413.39639716215;13467.393967271497;13503.729925401436;13584.728305433837;10158.796824063626;10251.48742562869;10303.896961030443;10305.536250868729;10318.948405257926;7833.686652533949;7876.251756083163;7881.251281128284;7886.487378320506;7889;3116.719495245439;3130.0922732407803;3140.481820499592;3163.9525407118913;3186.7928584641922;882.9779255518534;911.3119594706087;940.8212439636447;968.5738275158908;1002.2232769603615;28760.424791504054;29163.854180728962;29518.262043448656;29556.556651650244;29931;882.1399135842502;932.5663566441638;949.5537097564134;960.8750862387984;976.2921881635757;14978.400863965537;15371.923140384226;15536.533903982898;15761.763573546406;16217.675646487005;404162;406254;409188;410291;410774;52983.470165298626;53054.46945530573;53069.73465132649;53152.73423632857;53387.46612533903;1143.4340001699213;1178.728892354746;1195.0081432410905;1210.5702475621204;1212.4422765527956;29064.418711625225;29420;30014.54978175373;30163.396732065674;30791.2302192447;44352.778236108614;45461.545384547055;45511.54488455206;45534.54465455435;45562.31656525221;351240;352057;352834;353169;353243;23301;25755.356116097246;26066.34834129162;26116.085936992113;26170.476590468465;40884.182316354105;41736;42162.156756864075;42266;42323.57676423196;34995.825020874734;35326.646733533365;35396.46905296371;35729.82135089308;35742.64257357497;35409.1147721309;35413.645863542064;35415;35449.645503544634;35621.82189089038;32419;32771.18072048218;35379.8158165756;36980.260394792494;37613.81193094017;30804.767809287376;31639.841800790848;32035.359292813548;32052;32517.34965300728;25821.6126758095;25946.481070378864;26288.34279143037;26458.206253812416;26521 00:11:29 INFO - PROCESS | 14107 | |2;jquery.html;369.3923495849328;370.24839575661406;371.4038967457231;383.5474140514192;391.9294526985141;15863.920680396597;16149.515514534552;16936.83063169368;16956.23696933638;16958;15830.208489575532;16392.180390980462;17080.658386832256;17210.311587536515;17240.56898577536;4957.157283261836;5138.563222126105;5175.974120129394;5181.222816577506;5189;3794.677452416534;5093.847184584469;5708.914366284509;6094.3905609438925;6095.05526643371;6026.0960855871535;6079.05774604937;6095.786647467339;6134.141220229171;6152.230971128609;4980.7758650860615;5306.230596563496;5322.973385133069;5365.356157261114;5420.91868621971;4999.250112483121;5108.386993560759;5138.460461651547;5139.383274007106;5191.2472691459525;12195.756084878252;12377.62867113988;12407.503699851995;16225.432109876216;20982.16071357144;1958.177565422526;2037.9592408151902;2055.9280425185198;2141.2826703054498;2326.1044497868274;8518.531480768555;8938.86591701125;9132.589033493508;9141.680041198526;9166;1679.2946962275873;1699.3627389728852;1704.1819926435257;1719.604490967072;1769.646070785848;67326;67703.66148169228;70279;71697.64151179262;73573;9900.900990989998;9912.306138570231;9953.651622193189;9992.900070999198;10097.091261786474;13560.864391356157;13595.728085438235;13597.52408665692;13674.111182773087;13679.726405471834;7080.468964827659;7102.857942841114;7149.89275160873;7205.855882882313;7210.13478382587;6755.864882702318;6761.492888033319;6827.658617069226;6865.176178858569;6933.0986971694365;4171.874843754692;4179.226843034048;4190.601892820177;4192.937105943352;4270.829166833292;1687.6287216812282;1690.5689049292353;1808.3038030358407;1825.6622524832683;1852.3331600623765;382.3423711216703;388.36890053662796;391.03219531658914;788.168482251219;839.5214727605206;10397.376157430426;10676.572937082585;10742.248042637097;10816.296940698829;10966.616168434066;400.40939614069015;414.06008361020315;417.78099741491735;418.7458561607943;419.3646625362578;5679.2333035040565;5856.941430585724;5873.442023007808;5876.882462350729;6009.729562169713;401109;409918;411352;417325;419859.60280794214;51150.23274650883;76949;79119;79191.60404197942;81167.5941620288;411.41784375109484;413.46662804981236;414.7780937198584;415.8895748351908;415.93345064789486;9929.255305851946;10008.749781255236;10239.385636861813;10269.84595231087;10305.74235644115;35896.28207435889;37329.81335093307;37786;37908.43137352997;38445.807770960964;52363.73818130885;52416.73791631017;52436.475635244686;52475.212871807715;52531.73734131305;7249;7286.781396558112;7389.704411823467;7465.738699145504;7565.2812982766545;10653.9467302663;10796.784064318512;10871.510782014986;11255.155863310121;11270;9752.756181095245;9779.559919803483;9901.50492475359;9927.751806204902;10247.48762561854;9681.273904457335;9877.160441362277;9995.800083998425;10279.7430064246;10311.278210525192;10307.690769276935;10384.37693738378;10392.532336044746;10480.109190718875;10489.475526223505;7239.131304243525;7345.118585769742;7458.888116678363;7650.693972241048;7744.109427415694;9286.674966376144;9547.952260238655;9789.118979291898;9801;9988.450635215133 00:11:29 INFO - PROCESS | 14107 | |3;mootools.html;1371.684512562111;1429.878460330872;1476.7637178051514;1664.741964995426;1674.8827582069246;7191.101112360955;7644.96177519113;7702.576358300298;8252.463589866662;8266.875996860044;7667.769966900988;7927.088384835745;7997.240262175084;8003.399745019133;8008.238187598719;2185.4099393163797;2248.6064938635755;2251.4146321956327;2251.909923603054;2255.5827171973156;2169.273293446697;2212.4468882779306;2227.7883601057956;2229.253200177934;2231.787980141884;2144.07804644003;2153.8815365154987;2163.9134434622597;2169.110664627503;2222.2666520048347;2085.35354040248;2088.185607613032;2096.1091536097097;2105.3683894831565;2107.3045894854736;2167.8077057618248;2195.549912267981;2201.1855613423136;2204.382772823612;2208.7128673272373;8050.5169689818795;8148.185181481805;8159.877601835978;8183.304419124382;8197.0573384061;4623.884402889921;4744.644151688637;4745.905081898377;4757.310190022462;4778.928316075262;2991.3269514359313;3064.310530130725;3245.789023713451;3252.9343866644613;3260.2990357073104;983.0759086458706;999.4253304349955;1006.2151521812998;1011.2040208822611;1037.061459379263;10864.674059778219;10888.67333979982;10890.074343680797;10892.891071089267;10942.17933654979;4325.697201195886;4451.243288640939;4456.777161141995;4480.484744254387;4557.134144512532;9222.95388523053;9323.067693230623;9340.906590934139;9364.484953327632;9382.296327775444;4819.1566475867285;4824;4831.661783675179;4848.8302909398;4852.8544143675745;3810.923781524354;4244.681648876347;4260.552641972548;4347.260965635849;4416.138852923649;3807.5621303550447;3843.5387753469763;3852;3897.629725176104;3972.066564357374;1159.5245949160803;1255.215490318551;1256.0956111599633;1257.8553466351304;1258.0627432562799;861.7673228228343;861.8264204587553;886.3219636977717;892.4912799704107;908.981820363589;5330.307060082165;5373.059714549938;5463.289772329572;5475.972620136953;5493.011257973523;399.1956208240398;407.87152047105064;407.90006448420326;409.70091832962106;409.94055861900455;3690.2066055797595;3779.6598306152578;3801.6768574671464;3815.103450689086;3836.156045669948;9532.714018579454;9787.608495660237;9945.353552019096;10003.549840257207;10014.098731114234;9871.40771553709;9922.305438619227;9944.35361701487;9973.650922217688;9980.500974951368;7524.322810947041;7571.734989275459;7574.621268936531;7589.316961473494;7633.847323053619;5475.972620136874;5481.945180548143;5553.250311207935;5598.384177740364;5687.289088863892;9255.583498742439;9400.905990940004;9425.434473931586;9475.905240947777;9509.144177024102;9299.395539289924;9365.29760267969;9402;9447.196988256075;9743.074407931235;6229.221347331583;6517.967410162919;6754.3921047106;6822.351876571916;6990.895136573057;7738.574378409016;7831.686732530863;7861.842763144591;7866.056073271244;7904.328132108835;6708.731650733916;6893.896591551031;6901.033855260368;6957.408620267334;7034;6604.042413850061;6631;6756.898646520208;6802.761903333359;6866.862662746617;6519.989401642753;6544.2474115475425;6612.867742645024;6648.135742353463;6649.03588979605;4753.83361582343;4757.238841785298;4779.617630589614;4783.402074740658;4828.95171048285;4803.543663351976;4804.2073057945045;4828.4688684244;4894.388201474816;4901.681390709592 00:11:29 INFO - PROCESS | 14107 | |4;prototype.html;296.39091666625086;298.79831113998046;302.4072817278136;303.3826163756755;303.8116367851932;5072.746362681865;5078.949210507893;5078.9746051269785;5116.948830511698;5122.488865784598;4990.800367985285;5034.8489545313605;5046.520580544851;5049.3435853339015;5051.388257395961;3664.853405863769;3790.9620903791024;3882.3400021996326;3886.9028274293087;3892.649661530462;3905.2384784966944;3917.2948869203533;3962.2471730371135;3968.4840970673918;3985.2228815381013;3939.4484772131923;3943.2310699413483;3946.0529472926432;3966.702497312713;3976.5029371328583;3832.0994566276904;3858.7684738915755;3892.8832135035996;3952.5454572724216;3952.604739526039;3395.5076513905346;3428.6228514863346;3445.448728203475;3446.758726889119;3461.3769521486124;4919.425783749201;4920.409550853885;4938.753062346904;4956.207006878882;4989.700617962898;4341.978290108529;4526.1626599078945;4526.207913615104;4533.433320834895;4536.138133754576;5233.947660523384;5254.947450525522;5262.921101174288;5264.368275806889;5295.523402893758;3795.3168429682646;3809.2000679857265;3815.1415931415486;3826.3877779555137;3830.084957521239;5392.649477783932;5547.889042219133;5592.356878958891;5600.215969764236;5660.830175094713;3843.9231215375535;3879.3017256893468;3881.146147847469;3882.592792468631;3901.1079626381184;3910.432987216838;3927.9410808837893;3927.9607203928167;3937.7440466369594;3939.468171796828;4443.933340999887;4487.394201782783;4487.730736155776;4501.369808226851;4511.616512596401;5186.507281808223;5301.443348448434;5321.175217841241;5321.414644389114;5340.866478338073;1347.2455424961856;1363.8704323089291;1372.84212315583;1373.7773381690304;1374.8006539051983;833.7540425574471;857.4212406625503;859.9957000214958;867.3624885708999;878.310526236901;4412.514623391425;4622.722636641813;4636.188666983265;4636.542632404831;4642.582167604932;5436.510714035756;5456.48163424474;5461.808836690697;5476.289236827795;5491.890162196733;4462.48681401643;4644.535546445396;4674.392328997276;4677.754677754629;4697.412823397075;2923.166897434221;2926.692697266799;2927.985360073186;2931.3404483991358;2942.9258320713216;5108.467459762057;5126.871828204325;5139.717315547681;5151.922721159186;5161.870953226125;5412.12908382451;5636.844446888378;5647.576431767634;5661.641206110587;5671.432856714296;5093.2105523643895;5136.640435169577;5160.690358578422;5164.056487801917;5174.534291913746;5467;5471.781128754806;5489.670619762827;5490.615656903979;5528;5028.396592408934;5337.332833395825;5357.19642053695;5367.785288588569;5432.674039557639;5185.144451165515;5205.817796377109;5209.426963034139;5246.081935661167;5246.898151388251;3813.0657988791813;3824.655780979725;3838.865639702597;3856.5179352580926;3873.806309684561;5158.432572417106;5449.100898351728;5532.75102620375;5562;5571.749271282721;5323.2167223980405;5332.626716129834;5348;5368.141097424394;5394.433584473731;5174.353205849269;5370.3287089113865;5375.946240537701;5384.246205531307;5405.324334458192;5108.9782043590685;5191.169412893919;5201.557867581298;5275.577953763766;5304.681719096867;5173.896522069613;5186.4035635902355;5372.355317361941;5378.381486129145;5383.946160538345;5209.505097015777;5224.164133738584;5244.921326180034;5255.634964266172;5262.763400508583 00:11:29 INFO - PROCESS | 14107 | |5;yui.html;666.4235436347558;709.265909783374;730.6638946084801;745.2621904314727;747.8653842308382;12253.693657658563;12324.63026109216;12348.197367171128;12448.81326780099;12459.750804983907;12626.431810568523;13076.673083172926;13079.934600326986;13086.869131308684;13094.148880322797;634.5653227539127;780.9687612495493;786.4259090863673;794.5629903553023;798.740409366958;781.9609019549029;785.9528428294292;787.0516028186022;787.4369825574713;788.4953629677011;802.2779498451412;806.822499050208;807.9192080791933;808.0626473290984;808.1474044882647;786.1116937860238;794.3367288314264;799.0451410564378;800.1638287989066;802.7150361621599;576.8327185116311;581.0557843504306;582.8746819433842;584.4827327814914;587.0079565534234;12089.274643521418;12133.696657583543;12244.938775306155;12251.632451026484;12355.196912200769;12160.452779624939;12563.732849731676;12874.227546347249;12886.162399444007;12962.351882405843;10366.533505992249;10566.313189642726;10647.201459890463;10651;10796.73008174794;3335;3336.5290510715513;3403.3363494118657;3410.36908171989;3441.0709108540555;61634.691826540584;61662;62798;64063.67968160176;64286;9607.087326703951;9655.324127311022;9820.852687209697;9887.653932112342;9918.950405247928;20057.899710501355;20157.59684806325;20189.293374732108;20219.393418197476;20363.592728145355;6909.343612356818;7101.431885449152;7108.324709152622;7236.855262894713;7265.309795569412;3565.750397472152;3770.4155855842387;3809.29528037314;3870.2646497165447;3879.1465877506903;2975.6726760056376;3033.317503561681;3039.4377040247623;3112.7354174894936;3117.3609410071335;508.4026269133753;512.6232219318798;513.9665921715076;521.2077641984239;524.1351769580223;556.9916451253234;599.1312596734753;605.9091136329586;612.4652960988637;614.1463365921372;7371.741989030358;7507.662155203029;7767.145613982458;7883.172266912006;8087.878681819778;489.681706890524;528.413461058225;558.9608727389044;571.7427157779016;577.5639392258818;3432.8626854925524;3636.472711456824;3681;3735.831887565066;3746.438034294823;89063;91876;91931.54034229786;92063.53968230115;93694.53152734193;81242;83930.16069839224;84389;84723.5763821177;84728.57635711782;44480.77759611246;45201.32198017032;45960.3105953411;51465.22802157971;77162.22837771663;7538.246175382418;7574.848503029798;7611.581363024865;7671.2712292332135;7728.8454230916195;38704.80647596744;42825.35761963635;42830.35754463623;43305.350419743096;43610.781946090065;63864.68067659632;65753.34246657664;66102.33897660962;66119.33880661325;66133;9691.826266067153;9808.117269445784;10354.637587684394;10579.62971296001;10606.469676516297;11162.330260184415;11303.208775385972;11558.711032224262;11631.302121872715;11720.413979301171;10278.280520363503;10436.895631043895;10575.62985295511;10640.733981650521;10646.254762166574;10581.735456613338;10608.52261648243;10680.946595266974;10696.518656660313;10782.622608208674;9677.806443870943;10058.849117263393;10218;10223.846642300223;10293.84559231597;8772.166644168794;8833.337499687677;8904.510251936206;9091.227245683926;9127.726168214964;8485.236328730443;8794.42836215644;8912.688055918012;8949.507777072324;9024.097590240923 00:11:29 INFO - PROCESS | 14107 | __end_tp_report 00:11:29 INFO - PROCESS | 14107 | __start_cc_report 00:11:29 INFO - PROCESS | 14107 | _x_x_mozilla_cycle_collect,405 00:11:29 INFO - PROCESS | 14107 | __end_cc_report 00:11:29 INFO - PROCESS | 14107 | __startTimestamp1465974689502__endTimestamp 00:11:29 INFO - PROCESS | 14107 | 00:11:29 INFO - PROCESS | 14107 | ------- Summary: start ------- 00:11:29 INFO - PROCESS | 14107 | Number of tests: 6 00:11:29 INFO - PROCESS | 14107 | 00:11:29 INFO - PROCESS | 14107 | [#0] dojo.html Cycles:165 Average:4770.10 Median:4899.17 stddev:504.66 (10.3%) stddev-sans-first:476.68 00:11:29 INFO - PROCESS | 14107 | Values: 2602.0 2658.8 2684.3 2692.9 2710.3 4753.9 4760.7 4796.0 4819.4 4857.4 4702.3 4820.9 4832.0 4879.9 4899.2 4410.6 4432.7 4519.3 4533.8 4541.0 4219.8 4501.7 4522.3 4577.1 4582.7 4292.1 4409.6 4421.7 4454.3 4496.1 4419.1 4428.6 4469.2 4496.6 4521.8 4431.7 4459.8 4467.5 4490.7 4496.0 4836.5 4888.8 4907.3 4915.3 4925.1 5239.6 5254.3 5254.3 5258.2 5319.1 5009.3 5224.1 5311.0 5314.9 5321.4 4873.6 4892.7 4911.1 4914.0 4961.1 5391.6 5393.6 5403.8 5405.1 5463.0 4921.6 5011.5 5027.1 5169.1 5179.8 4944.8 5139.2 5147.7 5159.2 5197.6 5004.7 5064.5 5082.4 5137.3 5139.8 4915.2 5013.4 5020.9 5063.7 5129.4 4349.9 4365.8 4372.2 4407.2 4407.5 3795.8 3798.7 3814.0 3847.2 3885.0 4274.8 4427.8 4433.5 4499.3 4501.8 5125.5 5178.5 5180.7 5193.4 5252.1 4439.9 4454.1 4461.9 4462.7 4506.0 4488.0 4646.5 4646.5 4668.4 4714.1 4853.7 4882.1 4889.5 4909.4 4917.0 5031.5 5211.5 5222.7 5231.7 5277.8 4774.4 4799.2 4809.6 4830.8 4837.3 5041.0 5059.7 5064.4 5087.1 5114.6 5121.8 5124.3 5140.5 5145.3 5160.7 4841.5 4915.6 4985.9 5052.6 5104.2 4957.9 4976.2 4982.9 4982.9 5010.6 4633.2 4809.6 4854.2 4888.9 4891.9 4946.9 5003.9 5041.1 5062.0 5123.9 4925.5 4950.4 4952.5 4952.6 4959.7 00:11:29 INFO - PROCESS | 14107 | 00:11:29 INFO - PROCESS | 14107 | [#1] ext.html Cycles:180 Average:48142.59 Median:35414.32 stddev:90695.96 (256.1%) stddev-sans-first:90879.98 00:11:29 INFO - PROCESS | 14107 | Values: 546.2 570.4 586.4 590.5 591.6 28506.4 40181.8 41009.4 41167.6 44153.1 41284.0 41304.6 41775.6 41780.4 41791.0 7858.8 7953.0 7986.1 7993.2 7994.7 7801.7 7880.8 7882.2 7899.4 7906.6 7923.5 7989.4 8003.6 8003.8 8010.9 7847.9 7875.2 7881.5 7898.2 7918.6 7887.3 7967.3 7983.4 7993.0 7998.6 39162.8 39570.4 39585.2 39707.8 39759.8 3134.8 3266.7 3272.3 3316.6 3364.5 29122.0 29354.9 29824.6 29899.3 30206.7 3310.5 3337.2 3350.3 3361.3 3370.8 247633.0 247732.0 248024.0 251188.0 252246.7 32243.7 54476.9 54534.2 54636.7 54719.5 32458.8 34225.8 34254.5 34259.5 34378.3 13374.6 13413.4 13467.4 13503.7 13584.7 10158.8 10251.5 10303.9 10305.5 10318.9 7833.7 7876.3 7881.3 7886.5 7889.0 3116.7 3130.1 3140.5 3164.0 3186.8 883.0 911.3 940.8 968.6 1002.2 28760.4 29163.9 29518.3 29556.6 29931.0 882.1 932.6 949.6 960.9 976.3 14978.4 15371.9 15536.5 15761.8 16217.7 404162.0 406254.0 409188.0 410291.0 410774.0 52983.5 53054.5 53069.7 53152.7 53387.5 1143.4 1178.7 1195.0 1210.6 1212.4 29064.4 29420.0 30014.5 30163.4 30791.2 44352.8 45461.5 45511.5 45534.5 45562.3 351240.0 352057.0 352834.0 353169.0 353243.0 23301.0 25755.4 26066.3 26116.1 26170.5 40884.2 41736.0 42162.2 42266.0 42323.6 34995.8 35326.6 35396.5 35729.8 35742.6 35409.1 35413.6 35415.0 35449.6 35621.8 32419.0 32771.2 35379.8 36980.3 37613.8 30804.8 31639.8 32035.4 32052.0 32517.3 25821.6 25946.5 26288.3 26458.2 26521.0 00:11:29 INFO - PROCESS | 14107 | 00:11:29 INFO - PROCESS | 14107 | [#2] jquery.html Cycles:180 Average:24203.63 Median:212065.22 stddev:68001.40 (32.1%) stddev-sans-first:68168.61 00:11:29 INFO - PROCESS | 14107 | Values: 369.4 370.2 371.4 383.5 391.9 15863.9 16149.5 16936.8 16956.2 16958.0 15830.2 16392.2 17080.7 17210.3 17240.6 4957.2 5138.6 5176.0 5181.2 5189.0 3794.7 5093.8 5708.9 6094.4 6095.1 6026.1 6079.1 6095.8 6134.1 6152.2 4980.8 5306.2 5323.0 5365.4 5420.9 4999.3 5108.4 5138.5 5139.4 5191.2 12195.8 12377.6 12407.5 16225.4 20982.2 1958.2 2038.0 2055.9 2141.3 2326.1 8518.5 8938.9 9132.6 9141.7 9166.0 1679.3 1699.4 1704.2 1719.6 1769.6 67326.0 67703.7 70279.0 71697.6 73573.0 9900.9 9912.3 9953.7 9992.9 10097.1 13560.9 13595.7 13597.5 13674.1 13679.7 7080.5 7102.9 7149.9 7205.9 7210.1 6755.9 6761.5 6827.7 6865.2 6933.1 4171.9 4179.2 4190.6 4192.9 4270.8 1687.6 1690.6 1808.3 1825.7 1852.3 382.3 388.4 391.0 788.2 839.5 10397.4 10676.6 10742.2 10816.3 10966.6 400.4 414.1 417.8 418.7 419.4 5679.2 5856.9 5873.4 5876.9 6009.7 401109.0 409918.0 411352.0 417325.0 419859.6 51150.2 76949.0 79119.0 79191.6 81167.6 411.4 413.5 414.8 415.9 415.9 9929.3 10008.7 10239.4 10269.8 10305.7 35896.3 37329.8 37786.0 37908.4 38445.8 52363.7 52416.7 52436.5 52475.2 52531.7 7249.0 7286.8 7389.7 7465.7 7565.3 10653.9 10796.8 10871.5 11255.2 11270.0 9752.8 9779.6 9901.5 9927.8 10247.5 9681.3 9877.2 9995.8 10279.7 10311.3 10307.7 10384.4 10392.5 10480.1 10489.5 7239.1 7345.1 7458.9 7650.7 7744.1 9286.7 9548.0 9789.1 9801.0 9988.5 00:11:29 INFO - PROCESS | 14107 | 00:11:29 INFO - PROCESS | 14107 | [#3] mootools.html Cycles:180 Average:5297.64 Median:4840.25 stddev:2983.28 (61.6%) stddev-sans-first:2977.06 00:11:29 INFO - PROCESS | 14107 | Values: 1371.7 1429.9 1476.8 1664.7 1674.9 7191.1 7645.0 7702.6 8252.5 8266.9 7667.8 7927.1 7997.2 8003.4 8008.2 2185.4 2248.6 2251.4 2251.9 2255.6 2169.3 2212.4 2227.8 2229.3 2231.8 2144.1 2153.9 2163.9 2169.1 2222.3 2085.4 2088.2 2096.1 2105.4 2107.3 2167.8 2195.5 2201.2 2204.4 2208.7 8050.5 8148.2 8159.9 8183.3 8197.1 4623.9 4744.6 4745.9 4757.3 4778.9 2991.3 3064.3 3245.8 3252.9 3260.3 983.1 999.4 1006.2 1011.2 1037.1 10864.7 10888.7 10890.1 10892.9 10942.2 4325.7 4451.2 4456.8 4480.5 4557.1 9223.0 9323.1 9340.9 9364.5 9382.3 4819.2 4824.0 4831.7 4848.8 4852.9 3810.9 4244.7 4260.6 4347.3 4416.1 3807.6 3843.5 3852.0 3897.6 3972.1 1159.5 1255.2 1256.1 1257.9 1258.1 861.8 861.8 886.3 892.5 909.0 5330.3 5373.1 5463.3 5476.0 5493.0 399.2 407.9 407.9 409.7 409.9 3690.2 3779.7 3801.7 3815.1 3836.2 9532.7 9787.6 9945.4 10003.5 10014.1 9871.4 9922.3 9944.4 9973.7 9980.5 7524.3 7571.7 7574.6 7589.3 7633.8 5476.0 5481.9 5553.3 5598.4 5687.3 9255.6 9400.9 9425.4 9475.9 9509.1 9299.4 9365.3 9402.0 9447.2 9743.1 6229.2 6518.0 6754.4 6822.4 6990.9 7738.6 7831.7 7861.8 7866.1 7904.3 6708.7 6893.9 6901.0 6957.4 7034.0 6604.0 6631.0 6756.9 6802.8 6866.9 6520.0 6544.2 6612.9 6648.1 6649.0 4753.8 4757.2 4779.6 4783.4 4829.0 4803.5 4804.2 4828.5 4894.4 4901.7 00:11:29 INFO - PROCESS | 14107 | 00:11:29 INFO - PROCESS | 14107 | [#4] prototype.html Cycles:180 Average:4406.68 Median:5062.07 stddev:1289.37 (25.5%) stddev-sans-first:1255.54 00:11:29 INFO - PROCESS | 14107 | Values: 296.4 298.8 302.4 303.4 303.8 5072.7 5078.9 5079.0 5116.9 5122.5 4990.8 5034.8 5046.5 5049.3 5051.4 3664.9 3791.0 3882.3 3886.9 3892.6 3905.2 3917.3 3962.2 3968.5 3985.2 3939.4 3943.2 3946.1 3966.7 3976.5 3832.1 3858.8 3892.9 3952.5 3952.6 3395.5 3428.6 3445.4 3446.8 3461.4 4919.4 4920.4 4938.8 4956.2 4989.7 4342.0 4526.2 4526.2 4533.4 4536.1 5233.9 5254.9 5262.9 5264.4 5295.5 3795.3 3809.2 3815.1 3826.4 3830.1 5392.6 5547.9 5592.4 5600.2 5660.8 3843.9 3879.3 3881.1 3882.6 3901.1 3910.4 3927.9 3928.0 3937.7 3939.5 4443.9 4487.4 4487.7 4501.4 4511.6 5186.5 5301.4 5321.2 5321.4 5340.9 1347.2 1363.9 1372.8 1373.8 1374.8 833.8 857.4 860.0 867.4 878.3 4412.5 4622.7 4636.2 4636.5 4642.6 5436.5 5456.5 5461.8 5476.3 5491.9 4462.5 4644.5 4674.4 4677.8 4697.4 2923.2 2926.7 2928.0 2931.3 2942.9 5108.5 5126.9 5139.7 5151.9 5161.9 5412.1 5636.8 5647.6 5661.6 5671.4 5093.2 5136.6 5160.7 5164.1 5174.5 5467.0 5471.8 5489.7 5490.6 5528.0 5028.4 5337.3 5357.2 5367.8 5432.7 5185.1 5205.8 5209.4 5246.1 5246.9 3813.1 3824.7 3838.9 3856.5 3873.8 5158.4 5449.1 5532.8 5562.0 5571.7 5323.2 5332.6 5348.0 5368.1 5394.4 5174.4 5370.3 5375.9 5384.2 5405.3 5109.0 5191.2 5201.6 5275.6 5304.7 5173.9 5186.4 5372.4 5378.4 5383.9 5209.5 5224.2 5244.9 5255.6 5262.8 00:11:29 INFO - PROCESS | 14107 | 00:11:29 INFO - PROCESS | 14107 | [#5] yui.html Cycles:180 Average:16754.38 Median:574.29 stddev:23941.74 (4168.9%) stddev-sans-first:23978.42 00:11:29 INFO - PROCESS | 14107 | Values: 666.4 709.3 730.7 745.3 747.9 12253.7 12324.6 12348.2 12448.8 12459.8 12626.4 13076.7 13079.9 13086.9 13094.1 634.6 781.0 786.4 794.6 798.7 782.0 786.0 787.1 787.4 788.5 802.3 806.8 807.9 808.1 808.1 786.1 794.3 799.0 800.2 802.7 576.8 581.1 582.9 584.5 587.0 12089.3 12133.7 12244.9 12251.6 12355.2 12160.5 12563.7 12874.2 12886.2 12962.4 10366.5 10566.3 10647.2 10651.0 10796.7 3335.0 3336.5 3403.3 3410.4 3441.1 61634.7 61662.0 62798.0 64063.7 64286.0 9607.1 9655.3 9820.9 9887.7 9919.0 20057.9 20157.6 20189.3 20219.4 20363.6 6909.3 7101.4 7108.3 7236.9 7265.3 3565.8 3770.4 3809.3 3870.3 3879.1 2975.7 3033.3 3039.4 3112.7 3117.4 508.4 512.6 514.0 521.2 524.1 557.0 599.1 605.9 612.5 614.1 7371.7 7507.7 7767.1 7883.2 8087.9 489.7 528.4 559.0 571.7 577.6 3432.9 3636.5 3681.0 3735.8 3746.4 89063.0 91876.0 91931.5 92063.5 93694.5 81242.0 83930.2 84389.0 84723.6 84728.6 44480.8 45201.3 45960.3 51465.2 77162.2 7538.2 7574.8 7611.6 7671.3 7728.8 38704.8 42825.4 42830.4 43305.4 43610.8 63864.7 65753.3 66102.3 66119.3 66133.0 9691.8 9808.1 10354.6 10579.6 10606.5 11162.3 11303.2 11558.7 11631.3 11720.4 10278.3 10436.9 10575.6 10640.7 10646.3 10581.7 10608.5 10680.9 10696.5 10782.6 9677.8 10058.8 10218.0 10223.8 10293.8 8772.2 8833.3 8904.5 9091.2 9127.7 8485.2 8794.4 8912.7 8949.5 9024.1 00:11:29 INFO - PROCESS | 14107 | -------- Summary: end -------- 00:11:29 INFO - PROCESS | 14107 | 00:11:30 INFO - TEST-INFO | 14107: exit 0 00:11:30 INFO - TEST-OK | dromaeo_css | took 1116350ms 00:11:30 INFO - TEST-START | kraken 00:11:30 INFO - operating with platform_type : linux_ 00:11:30 INFO - Initialising browser for kraken test... 00:11:30 INFO - TEST-INFO | started process 14343 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpppBmAX/profile http://localhost:54161/getInfo.html) 00:11:35 INFO - PROCESS | 14343 | __metrics Screen width/height:1600/1200 00:11:35 INFO - PROCESS | 14343 | colorDepth:24 00:11:35 INFO - PROCESS | 14343 | Browser inner width/height: 1024/697 00:11:35 INFO - PROCESS | 14343 | __metrics 00:11:36 ERROR - PROCESS | 14343 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2947: TypeError: this.tabs is undefined 00:11:37 INFO - TEST-INFO | 14343: exit 0 00:11:37 INFO - Browser initialized. 00:11:37 INFO - Running cycle 1/1 for kraken test... 00:11:37 INFO - TEST-INFO | started process 14462 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpppBmAX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:11:49 INFO - PROCESS | 14462 | RSS: Main: 186445824 00:11:49 INFO - PROCESS | 14462 | 00:11:51 INFO - PROCESS | 14462 | Cycle 1(1): loaded http://localhost:54161/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54161/tests/kraken/driver.html?testName=audio-beat-detection) 00:11:52 INFO - PROCESS | 14462 | RSS: Main: 190898176 00:11:52 INFO - PROCESS | 14462 | 00:11:55 INFO - PROCESS | 14462 | Cycle 1(1): loaded http://localhost:54161/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54161/tests/kraken/driver.html?testName=audio-dft) 00:11:56 INFO - PROCESS | 14462 | RSS: Main: 190246912 00:11:56 INFO - PROCESS | 14462 | 00:11:59 INFO - PROCESS | 14462 | Cycle 1(1): loaded http://localhost:54161/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54161/tests/kraken/driver.html?testName=audio-fft) 00:11:59 INFO - PROCESS | 14462 | RSS: Main: 186155008 00:11:59 INFO - PROCESS | 14462 | 00:12:01 INFO - PROCESS | 14462 | Cycle 1(1): loaded http://localhost:54161/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54161/tests/kraken/driver.html?testName=audio-oscillator) 00:12:02 INFO - PROCESS | 14462 | RSS: Main: 186617856 00:12:02 INFO - PROCESS | 14462 | 00:12:04 INFO - PROCESS | 14462 | Cycle 1(1): loaded http://localhost:54161/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54161/tests/kraken/driver.html?testName=imaging-gaussian-blur) 00:12:05 INFO - PROCESS | 14462 | RSS: Main: 187187200 00:12:05 INFO - PROCESS | 14462 | 00:12:08 INFO - PROCESS | 14462 | Cycle 1(1): loaded http://localhost:54161/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54161/tests/kraken/driver.html?testName=imaging-darkroom) 00:12:09 INFO - PROCESS | 14462 | RSS: Main: 186953728 00:12:09 INFO - PROCESS | 14462 | 00:12:12 INFO - PROCESS | 14462 | Cycle 1(1): loaded http://localhost:54161/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54161/tests/kraken/driver.html?testName=imaging-desaturate) 00:12:13 INFO - PROCESS | 14462 | RSS: Main: 184786944 00:12:13 INFO - PROCESS | 14462 | 00:12:16 INFO - PROCESS | 14462 | Cycle 1(1): loaded http://localhost:54161/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54161/tests/kraken/driver.html?testName=json-parse-financial) 00:12:17 INFO - PROCESS | 14462 | RSS: Main: 185823232 00:12:17 INFO - PROCESS | 14462 | 00:12:18 INFO - PROCESS | 14462 | Cycle 1(1): loaded http://localhost:54161/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54161/tests/kraken/driver.html?testName=json-stringify-tinderbox) 00:12:19 INFO - PROCESS | 14462 | RSS: Main: 186204160 00:12:19 INFO - PROCESS | 14462 | 00:12:21 INFO - PROCESS | 14462 | Cycle 1(1): loaded http://localhost:54161/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54161/tests/kraken/driver.html?testName=stanford-crypto-aes) 00:12:21 INFO - PROCESS | 14462 | RSS: Main: 186281984 00:12:21 INFO - PROCESS | 14462 | 00:12:24 INFO - PROCESS | 14462 | Cycle 1(1): loaded http://localhost:54161/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54161/tests/kraken/driver.html?testName=stanford-crypto-ccm) 00:12:24 INFO - PROCESS | 14462 | RSS: Main: 186593280 00:12:24 INFO - PROCESS | 14462 | 00:12:27 INFO - PROCESS | 14462 | Cycle 1(1): loaded http://localhost:54161/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54161/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 00:12:28 INFO - PROCESS | 14462 | RSS: Main: 186966016 00:12:28 INFO - PROCESS | 14462 | 00:12:31 INFO - PROCESS | 14462 | Cycle 1(1): loaded http://localhost:54161/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54161/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 00:12:31 INFO - PROCESS | 14462 | RSS: Main: 186937344 00:12:31 INFO - PROCESS | 14462 | 00:12:33 INFO - PROCESS | 14462 | Cycle 1(1): loaded http://localhost:54161/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54161/tests/kraken/driver.html?testName=ai-astar) 00:12:33 INFO - PROCESS | 14462 | RSS: Main: 188190720 00:12:33 INFO - PROCESS | 14462 | 00:12:33 INFO - PROCESS | 14462 | __start_tp_report 00:12:33 INFO - PROCESS | 14462 | _x_x_mozilla_page_load 00:12:33 INFO - PROCESS | 14462 | _x_x_mozilla_page_load_details 00:12:33 INFO - PROCESS | 14462 | |i|pagename|runs| 00:12:33 INFO - PROCESS | 14462 | |0;ai-astar;115;109;113;113;113;114;113;112;114;113 00:12:33 INFO - PROCESS | 14462 | |1;audio-beat-detection;154;132;160;205;132;161;165;133;201;134 00:12:33 INFO - PROCESS | 14462 | |2;audio-dft;163;165;177;163;164;163;163;163;163;163 00:12:33 INFO - PROCESS | 14462 | |3;audio-fft;76;76;77;151;75;78;77;76;163;77 00:12:33 INFO - PROCESS | 14462 | |4;audio-oscillator;87;87;138;87;87;88;127;87;85;138 00:12:34 INFO - PROCESS | 14462 | |5;imaging-gaussian-blur;118;118;118;118;118;117;118;118;117;118 00:12:34 INFO - PROCESS | 14462 | |6;imaging-darkroom;147;147;148;146;148;149;147;147;147;148 00:12:34 INFO - PROCESS | 14462 | |7;imaging-desaturate;96;95;96;96;96;96;96;96;96;96 00:12:34 INFO - PROCESS | 14462 | |8;json-parse-financial;63;69;65;62;63;65;64;65;65;64 00:12:34 INFO - PROCESS | 14462 | |9;json-stringify-tinderbox;69;65;66;65;65;66;67;66;67;66 00:12:34 INFO - PROCESS | 14462 | |10;stanford-crypto-aes;92;85;88;90;88;86;86;87;108;85 00:12:34 INFO - PROCESS | 14462 | |11;stanford-crypto-ccm;146;139;142;137;137;130;142;140;150;152 00:12:34 INFO - PROCESS | 14462 | |12;stanford-crypto-pbkdf2;178;170;168;168;171;170;167;176;173;176 00:12:34 INFO - PROCESS | 14462 | |13;stanford-crypto-sha256-iterative;68;69;69;68;70;70;71;68;68;68 00:12:34 INFO - PROCESS | 14462 | __end_tp_report 00:12:34 INFO - PROCESS | 14462 | __start_cc_report 00:12:34 INFO - PROCESS | 14462 | _x_x_mozilla_cycle_collect,1012 00:12:34 INFO - PROCESS | 14462 | __end_cc_report 00:12:34 INFO - PROCESS | 14462 | __startTimestamp1465974753995__endTimestamp 00:12:34 INFO - PROCESS | 14462 | 00:12:34 INFO - PROCESS | 14462 | ------- Summary: start ------- 00:12:34 INFO - PROCESS | 14462 | Number of tests: 14 00:12:34 INFO - PROCESS | 14462 | 00:12:34 INFO - PROCESS | 14462 | [#0] ai-astar Cycles:10 Average:112.90 Median:113.00 stddev:1.60 (1.4%) stddev-sans-first:1.50 00:12:34 INFO - PROCESS | 14462 | Values: 115.0 109.0 113.0 113.0 113.0 114.0 113.0 112.0 114.0 113.0 00:12:34 INFO - PROCESS | 14462 | 00:12:34 INFO - PROCESS | 14462 | [#1] audio-beat-detection Cycles:10 Average:157.70 Median:160.50 stddev:27.26 (17.0%) stddev-sans-first:28.88 00:12:34 INFO - PROCESS | 14462 | Values: 154.0 132.0 160.0 205.0 132.0 161.0 165.0 133.0 201.0 134.0 00:12:34 INFO - PROCESS | 14462 | 00:12:34 INFO - PROCESS | 14462 | [#2] audio-dft Cycles:10 Average:164.70 Median:163.00 stddev:4.37 (2.7%) stddev-sans-first:4.59 00:12:34 INFO - PROCESS | 14462 | Values: 163.0 165.0 177.0 163.0 164.0 163.0 163.0 163.0 163.0 163.0 00:12:34 INFO - PROCESS | 14462 | 00:12:34 INFO - PROCESS | 14462 | [#3] audio-fft Cycles:10 Average:92.60 Median:76.50 stddev:34.07 (44.5%) stddev-sans-first:35.60 00:12:34 INFO - PROCESS | 14462 | Values: 76.0 76.0 77.0 151.0 75.0 78.0 77.0 76.0 163.0 77.0 00:12:34 INFO - PROCESS | 14462 | 00:12:34 INFO - PROCESS | 14462 | [#4] audio-oscillator Cycles:10 Average:101.10 Median:87.00 stddev:23.14 (26.6%) stddev-sans-first:23.97 00:12:34 INFO - PROCESS | 14462 | Values: 87.0 87.0 138.0 87.0 87.0 88.0 127.0 87.0 85.0 138.0 00:12:34 INFO - PROCESS | 14462 | 00:12:34 INFO - PROCESS | 14462 | [#5] imaging-gaussian-blur Cycles:10 Average:117.80 Median:118.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 00:12:34 INFO - PROCESS | 14462 | Values: 118.0 118.0 118.0 118.0 118.0 117.0 118.0 118.0 117.0 118.0 00:12:34 INFO - PROCESS | 14462 | 00:12:34 INFO - PROCESS | 14462 | [#6] imaging-darkroom Cycles:10 Average:147.40 Median:147.50 stddev:0.84 (0.6%) stddev-sans-first:0.88 00:12:34 INFO - PROCESS | 14462 | Values: 147.0 147.0 148.0 146.0 148.0 149.0 147.0 147.0 147.0 148.0 00:12:34 INFO - PROCESS | 14462 | 00:12:34 INFO - PROCESS | 14462 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 00:12:34 INFO - PROCESS | 14462 | Values: 96.0 95.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 00:12:34 INFO - PROCESS | 14462 | 00:12:34 INFO - PROCESS | 14462 | [#8] json-parse-financial Cycles:10 Average:64.50 Median:65.00 stddev:1.90 (2.9%) stddev-sans-first:1.94 00:12:34 INFO - PROCESS | 14462 | Values: 63.0 69.0 65.0 62.0 63.0 65.0 64.0 65.0 65.0 64.0 00:12:34 INFO - PROCESS | 14462 | 00:12:34 INFO - PROCESS | 14462 | [#9] json-stringify-tinderbox Cycles:10 Average:66.20 Median:66.00 stddev:1.23 (1.9%) stddev-sans-first:0.78 00:12:34 INFO - PROCESS | 14462 | Values: 69.0 65.0 66.0 65.0 65.0 66.0 67.0 66.0 67.0 66.0 00:12:34 INFO - PROCESS | 14462 | 00:12:34 INFO - PROCESS | 14462 | [#10] stanford-crypto-aes Cycles:10 Average:89.50 Median:87.50 stddev:6.87 (7.8%) stddev-sans-first:7.22 00:12:34 INFO - PROCESS | 14462 | Values: 92.0 85.0 88.0 90.0 88.0 86.0 86.0 87.0 108.0 85.0 00:12:34 INFO - PROCESS | 14462 | 00:12:34 INFO - PROCESS | 14462 | [#11] stanford-crypto-ccm Cycles:10 Average:141.50 Median:142.00 stddev:6.54 (4.6%) stddev-sans-first:6.73 00:12:34 INFO - PROCESS | 14462 | Values: 146.0 139.0 142.0 137.0 137.0 130.0 142.0 140.0 150.0 152.0 00:12:34 INFO - PROCESS | 14462 | 00:12:34 INFO - PROCESS | 14462 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.70 Median:172.00 stddev:3.86 (2.2%) stddev-sans-first:3.35 00:12:34 INFO - PROCESS | 14462 | Values: 178.0 170.0 168.0 168.0 171.0 170.0 167.0 176.0 173.0 176.0 00:12:34 INFO - PROCESS | 14462 | 00:12:34 INFO - PROCESS | 14462 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.90 Median:69.00 stddev:1.10 (1.6%) stddev-sans-first:1.12 00:12:34 INFO - PROCESS | 14462 | Values: 68.0 69.0 69.0 68.0 70.0 70.0 71.0 68.0 68.0 68.0 00:12:34 INFO - PROCESS | 14462 | -------- Summary: end -------- 00:12:34 INFO - PROCESS | 14462 | 00:12:35 INFO - TEST-INFO | 14462: exit 0 00:12:35 INFO - TEST-OK | kraken | took 64917ms 00:12:35 INFO - SUITE-END | took 1181s 00:12:35 INFO - Completed test suite (00:19:41) 00:12:35 INFO - javascript benchmark 00:12:35 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6285.785305593646, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2602.0, 2658.8005899557534, 2684.2752456836656, 2692.9461410771773, 2710.25467996301, 4753.8811529711775, 4760.738159401236, 4795.952040479594, 4819.3734814474155, 4857.441394239663, 4702.3416721659, 4820.8553743387665, 4831.975840120795, 4879.926801097978, 4899.167141585939, 4410.62509686677, 4432.689711720181, 4519.3446950192365, 4533.8413155539565, 4541.023679908819, 4219.831206751742, 4501.707389019703, 4522.253828118356, 4577.130345234412, 4582.7250364978045, 4292.0772034012525, 4409.559044095597, 4421.712588681758, 4454.28731402974, 4496.145732310867, 4419.094085712453, 4428.557144285545, 4469.217886869817, 4496.595306422438, 4521.84173553924, 4431.689781715281, 4459.777011149429, 4467.486239082515, 4490.663200259994, 4496.0, 4836.51634836517, 4888.755562221874, 4907.337509436216, 4915.262710593403, 4925.138100832376, 5239.580833533346, 5254.3169387979315, 5254.343207099113, 5258.1849813279005, 5319.0957537218765, 5009.348784657971, 5224.059669259532, 5310.9734451327495, 5314.867128321785, 5321.414644389114, 4873.610111191097, 4892.730899800546, 4911.140550403737, 4914.0, 4961.131801934647, 5391.622586418992, 5393.568514518829, 5403.783848646089, 5405.054115529767, 5463.0, 4921.557059864629, 5011.473795251519, 5027.095122877917, 5169.147090729987, 5179.8446046618665, 4944.752762361867, 5139.229115632685, 5147.716875571805, 5159.17453207485, 5197.610179236573, 5004.674696144739, 5064.4935506449065, 5082.415522214918, 5137.306463627438, 5139.820106296336, 4915.16442204826, 5013.448520662724, 5020.924686129711, 5063.746812659426, 5129.358830146231, 4349.9130017399475, 4365.803538840696, 4372.191144638252, 4407.184670835905, 4407.493138289074, 3795.8291876865605, 3798.6581207691443, 3814.0464883779055, 3847.2305538891774, 3884.9704828220542, 4274.829006839754, 4427.8228870844805, 4433.490148632884, 4499.34759459883, 4501.819927202875, 5125.513076257749, 5178.456262092502, 5180.7150606717, 5193.3767947845745, 5252.054630166606, 4439.933400998988, 4454.064646424223, 4461.933071003938, 4462.665300102505, 4506.0, 4487.977560112178, 4646.535346465326, 4646.535346465326, 4668.369770080995, 4714.080754252887, 4853.6602437829715, 4882.145624515695, 4889.462159162418, 4909.4354149273295, 4916.950830491649, 5031.471695471922, 5211.5049070338255, 5222.686638801684, 5231.686098834082, 5277.8416647500635, 4774.355462012584, 4799.232122860326, 4809.591184749335, 4830.806767729392, 4837.298591704112, 5040.974795126148, 5059.696418214771, 5064.366954130734, 5087.058894104603, 5114.590832733446, 5121.820736274212, 5124.282600436017, 5140.537351638371, 5145.250614790989, 5160.664556803796, 4841.491643377394, 4915.557599816034, 4985.850424487271, 5052.595792336678, 5104.2088476286235, 4957.900841983068, 4976.154053810933, 4982.900341993212, 4982.925256121089, 5010.649254552146, 4633.189191891473, 4809.615230781459, 4854.247591623304, 4888.902221955612, 4891.877703057452, 4946.876328091683, 5003.924941125959, 5041.092603331289, 5062.0, 5123.948760512347, 4925.45819959797, 4950.356453661001, 4952.529509696573, 4952.603791696728, 4959.70241785494], "value": 4737.645554691291, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [546.1806963337852, 570.4352690836072, 586.3813676571222, 590.5157770628084, 591.6420565557835, 28506.42987140256, 40181.79909100454, 41009.38485922714, 41167.58832411679, 44153.11693766123, 41284.0, 41304.58695413045, 41775.58224417755, 41780.37329440061, 41791.0, 7858.8035299117555, 7952.960235198816, 7986.121526632095, 7993.240642138988, 7994.680212791482, 7801.687932482694, 7880.763577092696, 7882.172371900954, 7899.368050555941, 7906.644201010969, 7923.524588524678, 7989.440739148262, 8003.639836207355, 8003.799905002364, 8010.919890801105, 7847.882281765749, 7875.212478752108, 7881.487703299267, 7898.170692077335, 7918.564478953655, 7887.250711182429, 7967.322777563914, 7983.441159118864, 7993.0, 7998.64006119726, 39162.80418597917, 39570.40644390336, 39585.20829583392, 39707.8014609928, 39759.8012009941, 3134.7962382445066, 3266.657001014883, 3272.2637406583567, 3316.5688460499982, 3364.49532570114, 29122.0, 29354.853225733947, 29824.552631710543, 29899.25251868699, 30206.73449491275, 3310.536524886518, 3337.1990722226733, 3350.2964377480516, 3361.2605226850055, 3370.7640465167447, 247633.0, 247732.0, 248024.0, 251188.0, 252246.73876630684, 32243.677563224537, 54476.91046179054, 54534.181987270225, 54636.72681636566, 54719.45280547144, 32458.83770581179, 34225.82887085548, 34254.48618270728, 34259.486107708406, 34378.312433751686, 13374.598762037154, 13413.39639716215, 13467.393967271497, 13503.729925401436, 13584.728305433837, 10158.796824063626, 10251.48742562869, 10303.896961030443, 10305.536250868729, 10318.948405257926, 7833.686652533949, 7876.251756083163, 7881.251281128284, 7886.487378320506, 7889.0, 3116.719495245439, 3130.0922732407803, 3140.481820499592, 3163.9525407118913, 3186.7928584641922, 882.9779255518534, 911.3119594706087, 940.8212439636447, 968.5738275158908, 1002.2232769603615, 28760.424791504054, 29163.854180728962, 29518.262043448656, 29556.556651650244, 29931.0, 882.1399135842502, 932.5663566441638, 949.5537097564134, 960.8750862387984, 976.2921881635757, 14978.400863965537, 15371.923140384226, 15536.533903982898, 15761.763573546406, 16217.675646487005, 404162.0, 406254.0, 409188.0, 410291.0, 410774.0, 52983.470165298626, 53054.46945530573, 53069.73465132649, 53152.73423632857, 53387.46612533903, 1143.4340001699213, 1178.728892354746, 1195.0081432410905, 1210.5702475621204, 1212.4422765527956, 29064.418711625225, 29420.0, 30014.54978175373, 30163.396732065674, 30791.2302192447, 44352.778236108614, 45461.545384547055, 45511.54488455206, 45534.54465455435, 45562.31656525221, 351240.0, 352057.0, 352834.0, 353169.0, 353243.0, 23301.0, 25755.356116097246, 26066.34834129162, 26116.085936992113, 26170.476590468465, 40884.182316354105, 41736.0, 42162.156756864075, 42266.0, 42323.57676423196, 34995.825020874734, 35326.646733533365, 35396.46905296371, 35729.82135089308, 35742.64257357497, 35409.1147721309, 35413.645863542064, 35415.0, 35449.645503544634, 35621.82189089038, 32419.0, 32771.18072048218, 35379.8158165756, 36980.260394792494, 37613.81193094017, 30804.767809287376, 31639.841800790848, 32035.359292813548, 32052.0, 32517.34965300728, 25821.6126758095, 25946.481070378864, 26288.34279143037, 26458.206253812416, 26521.0], "value": 16714.948173481607, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [369.3923495849328, 370.24839575661406, 371.4038967457231, 383.5474140514192, 391.9294526985141, 15863.920680396597, 16149.515514534552, 16936.83063169368, 16956.23696933638, 16958.0, 15830.208489575532, 16392.180390980462, 17080.658386832256, 17210.311587536515, 17240.56898577536, 4957.157283261836, 5138.563222126105, 5175.974120129394, 5181.222816577506, 5189.0, 3794.677452416534, 5093.847184584469, 5708.914366284509, 6094.3905609438925, 6095.05526643371, 6026.0960855871535, 6079.05774604937, 6095.786647467339, 6134.141220229171, 6152.230971128609, 4980.7758650860615, 5306.230596563496, 5322.973385133069, 5365.356157261114, 5420.91868621971, 4999.250112483121, 5108.386993560759, 5138.460461651547, 5139.383274007106, 5191.2472691459525, 12195.756084878252, 12377.62867113988, 12407.503699851995, 16225.432109876216, 20982.16071357144, 1958.177565422526, 2037.9592408151902, 2055.9280425185198, 2141.2826703054498, 2326.1044497868274, 8518.531480768555, 8938.86591701125, 9132.589033493508, 9141.680041198526, 9166.0, 1679.2946962275873, 1699.3627389728852, 1704.1819926435257, 1719.604490967072, 1769.646070785848, 67326.0, 67703.66148169228, 70279.0, 71697.64151179262, 73573.0, 9900.900990989998, 9912.306138570231, 9953.651622193189, 9992.900070999198, 10097.091261786474, 13560.864391356157, 13595.728085438235, 13597.52408665692, 13674.111182773087, 13679.726405471834, 7080.468964827659, 7102.857942841114, 7149.89275160873, 7205.855882882313, 7210.13478382587, 6755.864882702318, 6761.492888033319, 6827.658617069226, 6865.176178858569, 6933.0986971694365, 4171.874843754692, 4179.226843034048, 4190.601892820177, 4192.937105943352, 4270.829166833292, 1687.6287216812282, 1690.5689049292353, 1808.3038030358407, 1825.6622524832683, 1852.3331600623765, 382.3423711216703, 388.36890053662796, 391.03219531658914, 788.168482251219, 839.5214727605206, 10397.376157430426, 10676.572937082585, 10742.248042637097, 10816.296940698829, 10966.616168434066, 400.40939614069015, 414.06008361020315, 417.78099741491735, 418.7458561607943, 419.3646625362578, 5679.2333035040565, 5856.941430585724, 5873.442023007808, 5876.882462350729, 6009.729562169713, 401109.0, 409918.0, 411352.0, 417325.0, 419859.60280794214, 51150.23274650883, 76949.0, 79119.0, 79191.60404197942, 81167.5941620288, 411.41784375109484, 413.46662804981236, 414.7780937198584, 415.8895748351908, 415.93345064789486, 9929.255305851946, 10008.749781255236, 10239.385636861813, 10269.84595231087, 10305.74235644115, 35896.28207435889, 37329.81335093307, 37786.0, 37908.43137352997, 38445.807770960964, 52363.73818130885, 52416.73791631017, 52436.475635244686, 52475.212871807715, 52531.73734131305, 7249.0, 7286.781396558112, 7389.704411823467, 7465.738699145504, 7565.2812982766545, 10653.9467302663, 10796.784064318512, 10871.510782014986, 11255.155863310121, 11270.0, 9752.756181095245, 9779.559919803483, 9901.50492475359, 9927.751806204902, 10247.48762561854, 9681.273904457335, 9877.160441362277, 9995.800083998425, 10279.7430064246, 10311.278210525192, 10307.690769276935, 10384.37693738378, 10392.532336044746, 10480.109190718875, 10489.475526223505, 7239.131304243525, 7345.118585769742, 7458.888116678363, 7650.693972241048, 7744.109427415694, 9286.674966376144, 9547.952260238655, 9789.118979291898, 9801.0, 9988.450635215133], "value": 7377.861766022659, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1371.684512562111, 1429.878460330872, 1476.7637178051514, 1664.741964995426, 1674.8827582069246, 7191.101112360955, 7644.96177519113, 7702.576358300298, 8252.463589866662, 8266.875996860044, 7667.769966900988, 7927.088384835745, 7997.240262175084, 8003.399745019133, 8008.238187598719, 2185.4099393163797, 2248.6064938635755, 2251.4146321956327, 2251.909923603054, 2255.5827171973156, 2169.273293446697, 2212.4468882779306, 2227.7883601057956, 2229.253200177934, 2231.787980141884, 2144.07804644003, 2153.8815365154987, 2163.9134434622597, 2169.110664627503, 2222.2666520048347, 2085.35354040248, 2088.185607613032, 2096.1091536097097, 2105.3683894831565, 2107.3045894854736, 2167.8077057618248, 2195.549912267981, 2201.1855613423136, 2204.382772823612, 2208.7128673272373, 8050.5169689818795, 8148.185181481805, 8159.877601835978, 8183.304419124382, 8197.0573384061, 4623.884402889921, 4744.644151688637, 4745.905081898377, 4757.310190022462, 4778.928316075262, 2991.3269514359313, 3064.310530130725, 3245.789023713451, 3252.9343866644613, 3260.2990357073104, 983.0759086458706, 999.4253304349955, 1006.2151521812998, 1011.2040208822611, 1037.061459379263, 10864.674059778219, 10888.67333979982, 10890.074343680797, 10892.891071089267, 10942.17933654979, 4325.697201195886, 4451.243288640939, 4456.777161141995, 4480.484744254387, 4557.134144512532, 9222.95388523053, 9323.067693230623, 9340.906590934139, 9364.484953327632, 9382.296327775444, 4819.1566475867285, 4824.0, 4831.661783675179, 4848.8302909398, 4852.8544143675745, 3810.923781524354, 4244.681648876347, 4260.552641972548, 4347.260965635849, 4416.138852923649, 3807.5621303550447, 3843.5387753469763, 3852.0, 3897.629725176104, 3972.066564357374, 1159.5245949160803, 1255.215490318551, 1256.0956111599633, 1257.8553466351304, 1258.0627432562799, 861.7673228228343, 861.8264204587553, 886.3219636977717, 892.4912799704107, 908.981820363589, 5330.307060082165, 5373.059714549938, 5463.289772329572, 5475.972620136953, 5493.011257973523, 399.1956208240398, 407.87152047105064, 407.90006448420326, 409.70091832962106, 409.94055861900455, 3690.2066055797595, 3779.6598306152578, 3801.6768574671464, 3815.103450689086, 3836.156045669948, 9532.714018579454, 9787.608495660237, 9945.353552019096, 10003.549840257207, 10014.098731114234, 9871.40771553709, 9922.305438619227, 9944.35361701487, 9973.650922217688, 9980.500974951368, 7524.322810947041, 7571.734989275459, 7574.621268936531, 7589.316961473494, 7633.847323053619, 5475.972620136874, 5481.945180548143, 5553.250311207935, 5598.384177740364, 5687.289088863892, 9255.583498742439, 9400.905990940004, 9425.434473931586, 9475.905240947777, 9509.144177024102, 9299.395539289924, 9365.29760267969, 9402.0, 9447.196988256075, 9743.074407931235, 6229.221347331583, 6517.967410162919, 6754.3921047106, 6822.351876571916, 6990.895136573057, 7738.574378409016, 7831.686732530863, 7861.842763144591, 7866.056073271244, 7904.328132108835, 6708.731650733916, 6893.896591551031, 6901.033855260368, 6957.408620267334, 7034.0, 6604.042413850061, 6631.0, 6756.898646520208, 6802.761903333359, 6866.862662746617, 6519.989401642753, 6544.2474115475425, 6612.867742645024, 6648.135742353463, 6649.03588979605, 4753.83361582343, 4757.238841785298, 4779.617630589614, 4783.402074740658, 4828.95171048285, 4803.543663351976, 4804.2073057945045, 4828.4688684244, 4894.388201474816, 4901.681390709592], "value": 4192.123405795974, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [296.39091666625086, 298.79831113998046, 302.4072817278136, 303.3826163756755, 303.8116367851932, 5072.746362681865, 5078.949210507893, 5078.9746051269785, 5116.948830511698, 5122.488865784598, 4990.800367985285, 5034.8489545313605, 5046.520580544851, 5049.3435853339015, 5051.388257395961, 3664.853405863769, 3790.9620903791024, 3882.3400021996326, 3886.9028274293087, 3892.649661530462, 3905.2384784966944, 3917.2948869203533, 3962.2471730371135, 3968.4840970673918, 3985.2228815381013, 3939.4484772131923, 3943.2310699413483, 3946.0529472926432, 3966.702497312713, 3976.5029371328583, 3832.0994566276904, 3858.7684738915755, 3892.8832135035996, 3952.5454572724216, 3952.604739526039, 3395.5076513905346, 3428.6228514863346, 3445.448728203475, 3446.758726889119, 3461.3769521486124, 4919.425783749201, 4920.409550853885, 4938.753062346904, 4956.207006878882, 4989.700617962898, 4341.978290108529, 4526.1626599078945, 4526.207913615104, 4533.433320834895, 4536.138133754576, 5233.947660523384, 5254.947450525522, 5262.921101174288, 5264.368275806889, 5295.523402893758, 3795.3168429682646, 3809.2000679857265, 3815.1415931415486, 3826.3877779555137, 3830.084957521239, 5392.649477783932, 5547.889042219133, 5592.356878958891, 5600.215969764236, 5660.830175094713, 3843.9231215375535, 3879.3017256893468, 3881.146147847469, 3882.592792468631, 3901.1079626381184, 3910.432987216838, 3927.9410808837893, 3927.9607203928167, 3937.7440466369594, 3939.468171796828, 4443.933340999887, 4487.394201782783, 4487.730736155776, 4501.369808226851, 4511.616512596401, 5186.507281808223, 5301.443348448434, 5321.175217841241, 5321.414644389114, 5340.866478338073, 1347.2455424961856, 1363.8704323089291, 1372.84212315583, 1373.7773381690304, 1374.8006539051983, 833.7540425574471, 857.4212406625503, 859.9957000214958, 867.3624885708999, 878.310526236901, 4412.514623391425, 4622.722636641813, 4636.188666983265, 4636.542632404831, 4642.582167604932, 5436.510714035756, 5456.48163424474, 5461.808836690697, 5476.289236827795, 5491.890162196733, 4462.48681401643, 4644.535546445396, 4674.392328997276, 4677.754677754629, 4697.412823397075, 2923.166897434221, 2926.692697266799, 2927.985360073186, 2931.3404483991358, 2942.9258320713216, 5108.467459762057, 5126.871828204325, 5139.717315547681, 5151.922721159186, 5161.870953226125, 5412.12908382451, 5636.844446888378, 5647.576431767634, 5661.641206110587, 5671.432856714296, 5093.2105523643895, 5136.640435169577, 5160.690358578422, 5164.056487801917, 5174.534291913746, 5467.0, 5471.781128754806, 5489.670619762827, 5490.615656903979, 5528.0, 5028.396592408934, 5337.332833395825, 5357.19642053695, 5367.785288588569, 5432.674039557639, 5185.144451165515, 5205.817796377109, 5209.426963034139, 5246.081935661167, 5246.898151388251, 3813.0657988791813, 3824.655780979725, 3838.865639702597, 3856.5179352580926, 3873.806309684561, 5158.432572417106, 5449.100898351728, 5532.75102620375, 5562.0, 5571.749271282721, 5323.2167223980405, 5332.626716129834, 5348.0, 5368.141097424394, 5394.433584473731, 5174.353205849269, 5370.3287089113865, 5375.946240537701, 5384.246205531307, 5405.324334458192, 5108.9782043590685, 5191.169412893919, 5201.557867581298, 5275.577953763766, 5304.681719096867, 5173.896522069613, 5186.4035635902355, 5372.355317361941, 5378.381486129145, 5383.946160538345, 5209.505097015777, 5224.164133738584, 5244.921326180034, 5255.634964266172, 5262.763400508583], "value": 3990.6146268537304, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [666.4235436347558, 709.265909783374, 730.6638946084801, 745.2621904314727, 747.8653842308382, 12253.693657658563, 12324.63026109216, 12348.197367171128, 12448.81326780099, 12459.750804983907, 12626.431810568523, 13076.673083172926, 13079.934600326986, 13086.869131308684, 13094.148880322797, 634.5653227539127, 780.9687612495493, 786.4259090863673, 794.5629903553023, 798.740409366958, 781.9609019549029, 785.9528428294292, 787.0516028186022, 787.4369825574713, 788.4953629677011, 802.2779498451412, 806.822499050208, 807.9192080791933, 808.0626473290984, 808.1474044882647, 786.1116937860238, 794.3367288314264, 799.0451410564378, 800.1638287989066, 802.7150361621599, 576.8327185116311, 581.0557843504306, 582.8746819433842, 584.4827327814914, 587.0079565534234, 12089.274643521418, 12133.696657583543, 12244.938775306155, 12251.632451026484, 12355.196912200769, 12160.452779624939, 12563.732849731676, 12874.227546347249, 12886.162399444007, 12962.351882405843, 10366.533505992249, 10566.313189642726, 10647.201459890463, 10651.0, 10796.73008174794, 3335.0, 3336.5290510715513, 3403.3363494118657, 3410.36908171989, 3441.0709108540555, 61634.691826540584, 61662.0, 62798.0, 64063.67968160176, 64286.0, 9607.087326703951, 9655.324127311022, 9820.852687209697, 9887.653932112342, 9918.950405247928, 20057.899710501355, 20157.59684806325, 20189.293374732108, 20219.393418197476, 20363.592728145355, 6909.343612356818, 7101.431885449152, 7108.324709152622, 7236.855262894713, 7265.309795569412, 3565.750397472152, 3770.4155855842387, 3809.29528037314, 3870.2646497165447, 3879.1465877506903, 2975.6726760056376, 3033.317503561681, 3039.4377040247623, 3112.7354174894936, 3117.3609410071335, 508.4026269133753, 512.6232219318798, 513.9665921715076, 521.2077641984239, 524.1351769580223, 556.9916451253234, 599.1312596734753, 605.9091136329586, 612.4652960988637, 614.1463365921372, 7371.741989030358, 7507.662155203029, 7767.145613982458, 7883.172266912006, 8087.878681819778, 489.681706890524, 528.413461058225, 558.9608727389044, 571.7427157779016, 577.5639392258818, 3432.8626854925524, 3636.472711456824, 3681.0, 3735.831887565066, 3746.438034294823, 89063.0, 91876.0, 91931.54034229786, 92063.53968230115, 93694.53152734193, 81242.0, 83930.16069839224, 84389.0, 84723.5763821177, 84728.57635711782, 44480.77759611246, 45201.32198017032, 45960.3105953411, 51465.22802157971, 77162.22837771663, 7538.246175382418, 7574.848503029798, 7611.581363024865, 7671.2712292332135, 7728.8454230916195, 38704.80647596744, 42825.35761963635, 42830.35754463623, 43305.350419743096, 43610.781946090065, 63864.68067659632, 65753.34246657664, 66102.33897660962, 66119.33880661325, 66133.0, 9691.826266067153, 9808.117269445784, 10354.637587684394, 10579.62971296001, 10606.469676516297, 11162.330260184415, 11303.208775385972, 11558.711032224262, 11631.302121872715, 11720.413979301171, 10278.280520363503, 10436.895631043895, 10575.62985295511, 10640.733981650521, 10646.254762166574, 10581.735456613338, 10608.52261648243, 10680.946595266974, 10696.518656660313, 10782.622608208674, 9677.806443870943, 10058.849117263393, 10218.0, 10223.846642300223, 10293.84559231597, 8772.166644168794, 8833.337499687677, 8904.510251936206, 9091.227245683926, 9127.726168214964, 8485.236328730443, 8794.42836215644, 8912.688055918012, 8949.507777072324, 9024.097590240923], "value": 6310.185006641879, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1592.4, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 109.0, 113.0, 113.0, 113.0, 114.0, 113.0, 112.0, 114.0, 113.0], "value": 112.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 132.0, 160.0, 205.0, 132.0, 161.0, 165.0, 133.0, 201.0, 134.0], "value": 157.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 165.0, 177.0, 163.0, 164.0, 163.0, 163.0, 163.0, 163.0, 163.0], "value": 164.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 77.0, 151.0, 75.0, 78.0, 77.0, 76.0, 163.0, 77.0], "value": 92.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 87.0, 138.0, 87.0, 87.0, 88.0, 127.0, 87.0, 85.0, 138.0], "value": 101.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 118.0, 118.0, 118.0, 117.0, 118.0, 118.0, 117.0, 118.0], "value": 117.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 148.0, 146.0, 148.0, 149.0, 147.0, 147.0, 147.0, 148.0], "value": 147.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0], "value": 95.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 69.0, 65.0, 62.0, 63.0, 65.0, 64.0, 65.0, 65.0, 64.0], "value": 64.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 65.0, 66.0, 65.0, 65.0, 66.0, 67.0, 66.0, 67.0, 66.0], "value": 66.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 85.0, 88.0, 90.0, 88.0, 86.0, 86.0, 87.0, 108.0, 85.0], "value": 89.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 139.0, 142.0, 137.0, 137.0, 130.0, 142.0, 140.0, 150.0, 152.0], "value": 141.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [178.0, 170.0, 168.0, 168.0, 171.0, 170.0, 167.0, 176.0, 173.0, 176.0], "value": 171.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 69.0, 69.0, 68.0, 70.0, 70.0, 71.0, 68.0, 68.0, 68.0], "value": 68.9, "unit": "score"}]}]} 00:12:35 INFO - Return code: 0 00:12:35 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 00:12:35 ERROR - # TBPL SUCCESS # 00:12:35 INFO - Running post-action listener: _resource_record_post_action 00:12:35 INFO - ##### 00:12:35 INFO - ##### Finished run-tests step (success) 00:12:35 INFO - ##### 00:12:35 INFO - Running post-run listener: _resource_record_post_run 00:12:35 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 0; Write bytes: 543092736; Read time: 0; Write time: 487376 00:12:35 INFO - TinderboxPrint: CPU usage
13.4% 00:12:35 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 00:12:35 INFO - TinderboxPrint: I/O write bytes / time
543,092,736 / 487,376 00:12:35 INFO - TinderboxPrint: CPU idle
8,277.6 (86.5%) 00:12:35 INFO - TinderboxPrint: CPU user
1,232.3 (12.9%) 00:12:35 INFO - TinderboxPrint: Swap in / out
0 / 0 00:12:35 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 244998144; Read time: 0; Write time: 313628 00:12:35 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 0; Write bytes: 297508864; Read time: 0; Write time: 173744 00:12:36 INFO - Running post-run listener: _upload_blobber_files 00:12:36 INFO - Blob upload gear active. 00:12:36 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 00:12:36 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:36 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:36 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:36 INFO - (blobuploader) - INFO - Open directory for files ... 00:12:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 00:12:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:12:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:12:43 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 00:12:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:12:43 INFO - (blobuploader) - INFO - Done attempting. 00:12:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 00:12:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:12:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:12:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 00:12:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:12:44 INFO - (blobuploader) - INFO - Done attempting. 00:12:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 00:12:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:12:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:12:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 00:12:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:12:44 INFO - (blobuploader) - INFO - Done attempting. 00:12:44 INFO - (blobuploader) - INFO - Iteration through files over. 00:12:44 INFO - Return code: 0 00:12:44 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 00:12:44 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 00:12:44 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1b59f51788b39a126457021563e3ee01a4f07ef85046eb8f97893011a45c5c9c2ef256501311b0150ec65eeaac27a0fab57b7bb11f3a7e5ead8e144551529c24", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1545ef1f718509c955dad7962fab78988ca60283a7f6a11949c742d4dbdb6009cd2dd2521f08ddac9a3c21b9a628e1bb4c0013418c2602cfab5cfc024fc2d7c1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/40715269e44646771d21d8435fae627dea46687d899fc5ebc29d3ba0d6a85b4cf93bd5376cdcb9d5b2749c5e9284dcf68b3e92eba0a50d8b34351ac9defeab9a"} 00:12:44 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 00:12:44 INFO - Writing to file /builds/slave/test/properties/blobber_files 00:12:44 INFO - Contents: 00:12:44 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1b59f51788b39a126457021563e3ee01a4f07ef85046eb8f97893011a45c5c9c2ef256501311b0150ec65eeaac27a0fab57b7bb11f3a7e5ead8e144551529c24", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1545ef1f718509c955dad7962fab78988ca60283a7f6a11949c742d4dbdb6009cd2dd2521f08ddac9a3c21b9a628e1bb4c0013418c2602cfab5cfc024fc2d7c1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/40715269e44646771d21d8435fae627dea46687d899fc5ebc29d3ba0d6a85b4cf93bd5376cdcb9d5b2749c5e9284dcf68b3e92eba0a50d8b34351ac9defeab9a"} 00:12:44 INFO - Running post-run listener: copy_logs_to_upload_dir 00:12:44 INFO - Copying logs to upload dir... 00:12:44 INFO - mkdir: /builds/slave/test/build/upload/logs 00:12:44 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1246.848336 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-06-15 00:12:42.683832) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-15 00:12:42.687863) ========= 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=cbe409c6de289db6ac707de3000001d4-1465962338.785363-31806065 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1b59f51788b39a126457021563e3ee01a4f07ef85046eb8f97893011a45c5c9c2ef256501311b0150ec65eeaac27a0fab57b7bb11f3a7e5ead8e144551529c24", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1545ef1f718509c955dad7962fab78988ca60283a7f6a11949c742d4dbdb6009cd2dd2521f08ddac9a3c21b9a628e1bb4c0013418c2602cfab5cfc024fc2d7c1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/40715269e44646771d21d8435fae627dea46687d899fc5ebc29d3ba0d6a85b4cf93bd5376cdcb9d5b2749c5e9284dcf68b3e92eba0a50d8b34351ac9defeab9a"} 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.011327 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-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1b59f51788b39a126457021563e3ee01a4f07ef85046eb8f97893011a45c5c9c2ef256501311b0150ec65eeaac27a0fab57b7bb11f3a7e5ead8e144551529c24", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1545ef1f718509c955dad7962fab78988ca60283a7f6a11949c742d4dbdb6009cd2dd2521f08ddac9a3c21b9a628e1bb4c0013418c2602cfab5cfc024fc2d7c1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/40715269e44646771d21d8435fae627dea46687d899fc5ebc29d3ba0d6a85b4cf93bd5376cdcb9d5b2749c5e9284dcf68b3e92eba0a50d8b34351ac9defeab9a"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-15 00:12:42.714811) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-15 00:12:42.715201) ========= 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=cbe409c6de289db6ac707de3000001d4-1465962338.785363-31806065 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:42.799542) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-15 00:12:42.799946) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-15 00:12:42.800295) ========= ========= Total master_lag: 0.19 =========