builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-027 starttime: 1465275567.64 results: success (0) buildid: 20160606185231 builduid: f359dc7d886f4554ba310876d5db52b4 revision: 580436387d62e0a40fcc781832c3291858121816 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-06 21:59:27.643486) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-06 21:59:27.644317) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-06 21:59:27.644717) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-06 21:59:27.676779) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 21:59:27.677280) ========= 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=1f5564757af27664ca02d71f000001b0-1465275104.890256-2033184417 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-06 21:59:27-- 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% 37.8M=0s 2016-06-06 21:59:28 (37.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.112117 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 21:59:27.804979) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 21:59:27.805303) ========= 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=1f5564757af27664ca02d71f000001b0-1465275104.890256-2033184417 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016422 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 21:59:27.854496) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 21:59:27.854862) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 580436387d62e0a40fcc781832c3291858121816 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 580436387d62e0a40fcc781832c3291858121816 --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=1f5564757af27664ca02d71f000001b0-1465275104.890256-2033184417 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-06 21:59:28,198 truncating revision to first 12 chars 2016-06-06 21:59:28,198 Setting DEBUG logging. 2016-06-06 21:59:28,198 attempt 1/10 2016-06-06 21:59:28,198 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/580436387d62?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-06 21:59:28,502 unpacking tar archive at: fx-team-580436387d62/testing/mozharness/ program finished with exit code 0 elapsedTime=0.626191 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 21:59:28.495300) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-06 21:59:28.495708) ========= script_repo_revision: 580436387d62e0a40fcc781832c3291858121816 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-06 21:59:28.496227) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-06 21:59:28.496591) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-06 21:59:28.506303) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-06-06 21:59:28.506653) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=1f5564757af27664ca02d71f000001b0-1465275104.890256-2033184417 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 21:59:28 INFO - MultiFileLogger online at 20160606 21:59:28 in /builds/slave/test 21:59:28 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 21:59:28 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:59:28 INFO - {'append_to_log': False, 21:59:28 INFO - 'base_work_dir': '/builds/slave/test', 21:59:28 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 21:59:28 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:59:28 INFO - 'branch': 'Fx-Team-Non-PGO', 21:59:28 INFO - 'buildbot_json_path': 'buildprops.json', 21:59:28 INFO - 'config_files': ('talos/linux_config.py',), 21:59:28 INFO - 'default_actions': ('clobber', 21:59:28 INFO - 'read-buildbot-config', 21:59:28 INFO - 'download-and-extract', 21:59:28 INFO - 'populate-webroot', 21:59:28 INFO - 'create-virtualenv', 21:59:28 INFO - 'install', 21:59:28 INFO - 'run-tests'), 21:59:28 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:59:28 INFO - 'download_minidump_stackwalk': True, 21:59:28 INFO - 'download_symbols': 'ondemand', 21:59:28 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:59:28 INFO - 'tooltool.py': '/tools/tooltool.py', 21:59:28 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:59:28 INFO - '/tools/misc-python/virtualenv.py')}, 21:59:28 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:59:28 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:59:28 INFO - 'installer_path': 'installer.exe', 21:59:28 INFO - 'log_level': 'info', 21:59:28 INFO - 'log_name': 'talos', 21:59:28 INFO - 'log_to_console': True, 21:59:28 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 21:59:28 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 21:59:28 INFO - 'opt_config_files': (), 21:59:28 INFO - 'pip_index': False, 21:59:28 INFO - 'sps_profile': False, 21:59:28 INFO - 'sps_profile_interval': 0, 21:59:28 INFO - 'suite': 'dromaeojs-e10s', 21:59:28 INFO - 'system_bits': '32', 21:59:28 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:59:28 INFO - 'title': 'talos-linux64-ix-027', 21:59:28 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:59:28 INFO - 'use_talos_json': True, 21:59:28 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:59:28 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:59:28 INFO - 'work_dir': 'build'} 21:59:28 INFO - ##### 21:59:28 INFO - ##### Running clobber step. 21:59:28 INFO - ##### 21:59:28 INFO - Running pre-action listener: _resource_record_pre_action 21:59:28 INFO - Running main action method: clobber 21:59:28 INFO - rmtree: /builds/slave/test/build 21:59:28 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:59:29 INFO - Running post-action listener: _resource_record_post_action 21:59:29 INFO - ##### 21:59:29 INFO - ##### Finished clobber step (success) 21:59:29 INFO - ##### 21:59:29 INFO - ##### 21:59:29 INFO - ##### Running read-buildbot-config step. 21:59:29 INFO - ##### 21:59:29 INFO - Running pre-action listener: _resource_record_pre_action 21:59:29 INFO - Running main action method: read_buildbot_config 21:59:29 INFO - Using buildbot properties: 21:59:29 INFO - { 21:59:29 INFO - "project": "", 21:59:29 INFO - "product": "firefox", 21:59:29 INFO - "script_repo_revision": "production", 21:59:29 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 21:59:29 INFO - "repository": "", 21:59:29 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 21:59:29 INFO - "buildid": "20160606185231", 21:59:29 INFO - "pgo_build": "False", 21:59:29 INFO - "basedir": "/builds/slave/test", 21:59:29 INFO - "buildnumber": 1560, 21:59:29 INFO - "slavename": "talos-linux64-ix-027", 21:59:29 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 21:59:29 INFO - "platform": "ubuntu64_hw", 21:59:29 INFO - "scheduler": "tests-fx-team-linux64-talos", 21:59:29 INFO - "branch": "fx-team", 21:59:29 INFO - "repo_path": "integration/fx-team", 21:59:29 INFO - "revision": "580436387d62e0a40fcc781832c3291858121816", 21:59:29 INFO - "stage_platform": "linux64", 21:59:29 INFO - "builduid": "f359dc7d886f4554ba310876d5db52b4", 21:59:29 INFO - "slavebuilddir": "test" 21:59:29 INFO - } 21:59:29 INFO - Found installer url https://queue.taskcluster.net/v1/task/AiMBPPaXQoKsDvTd41gqUQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 21:59:29 INFO - Running post-action listener: _resource_record_post_action 21:59:29 INFO - ##### 21:59:29 INFO - ##### Finished read-buildbot-config step (success) 21:59:29 INFO - ##### 21:59:29 INFO - ##### 21:59:29 INFO - ##### Running download-and-extract step. 21:59:29 INFO - ##### 21:59:29 INFO - Running pre-action listener: _resource_record_pre_action 21:59:29 INFO - Running main action method: download_and_extract 21:59:29 INFO - mkdir: /builds/slave/test/build/tests 21:59: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')]} 21:59:29 INFO - https://queue.taskcluster.net/v1/task/AiMBPPaXQoKsDvTd41gqUQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 21:59:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AiMBPPaXQoKsDvTd41gqUQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 21:59:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AiMBPPaXQoKsDvTd41gqUQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 21:59:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AiMBPPaXQoKsDvTd41gqUQ/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 21:59:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AiMBPPaXQoKsDvTd41gqUQ/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 21:59:30 INFO - Downloaded 1361 bytes. 21:59:30 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 21:59:30 INFO - Using the following test package requirements: 21:59:30 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 21:59:30 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 21:59:30 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 21:59:30 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 21:59:30 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 21:59:30 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 21:59:30 INFO - u'jsshell-linux-x86_64.zip'], 21:59:30 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 21:59:30 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 21:59:30 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 21:59:30 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 21:59:30 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 21:59:30 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 21:59:30 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 21:59:30 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 21:59:30 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 21:59:30 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 21:59:30 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 21:59:30 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 21:59:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:59:30 INFO - https://queue.taskcluster.net/v1/task/AiMBPPaXQoKsDvTd41gqUQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 21:59:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AiMBPPaXQoKsDvTd41gqUQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 21:59:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AiMBPPaXQoKsDvTd41gqUQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 21:59:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AiMBPPaXQoKsDvTd41gqUQ/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 21:59:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AiMBPPaXQoKsDvTd41gqUQ/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 21:59:31 INFO - Downloaded 22871435 bytes. 21:59:31 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 21:59:31 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 21:59:32 INFO - Return code: 0 21:59:32 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 21:59: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')]} 21:59:32 INFO - https://queue.taskcluster.net/v1/task/AiMBPPaXQoKsDvTd41gqUQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 21:59:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AiMBPPaXQoKsDvTd41gqUQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 21:59:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AiMBPPaXQoKsDvTd41gqUQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 21:59:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AiMBPPaXQoKsDvTd41gqUQ/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 21:59:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AiMBPPaXQoKsDvTd41gqUQ/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 21:59:33 INFO - Downloaded 22871435 bytes. 21:59:33 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'] 21:59:33 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 21:59:35 INFO - Return code: 0 21:59:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:59:35 INFO - https://queue.taskcluster.net/v1/task/AiMBPPaXQoKsDvTd41gqUQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 21:59:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AiMBPPaXQoKsDvTd41gqUQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 21:59:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AiMBPPaXQoKsDvTd41gqUQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 21:59:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AiMBPPaXQoKsDvTd41gqUQ/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 21:59:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AiMBPPaXQoKsDvTd41gqUQ/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 21:59:37 INFO - Downloaded 10833369 bytes. 21:59:37 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'] 21:59:37 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 21:59:37 INFO - Return code: 0 21:59:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:59:37 INFO - https://queue.taskcluster.net/v1/task/AiMBPPaXQoKsDvTd41gqUQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 21:59:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AiMBPPaXQoKsDvTd41gqUQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 21:59:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AiMBPPaXQoKsDvTd41gqUQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 21:59:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AiMBPPaXQoKsDvTd41gqUQ/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 21:59:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AiMBPPaXQoKsDvTd41gqUQ/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 21:59:40 INFO - Downloaded 55204191 bytes. 21:59:40 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/AiMBPPaXQoKsDvTd41gqUQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 21:59:40 INFO - mkdir: /builds/slave/test/properties 21:59:40 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:59:40 INFO - Writing to file /builds/slave/test/properties/build_url 21:59:40 INFO - Contents: 21:59:40 INFO - build_url:https://queue.taskcluster.net/v1/task/AiMBPPaXQoKsDvTd41gqUQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 21:59:41 INFO - Running post-action listener: _resource_record_post_action 21:59:41 INFO - Running post-action listener: set_extra_try_arguments 21:59:41 INFO - ##### 21:59:41 INFO - ##### Finished download-and-extract step (success) 21:59:41 INFO - ##### 21:59:41 INFO - ##### 21:59:41 INFO - ##### Running populate-webroot step. 21:59:41 INFO - ##### 21:59:41 INFO - Running pre-action listener: _resource_record_pre_action 21:59:41 INFO - Running main action method: populate_webroot 21:59:41 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:59:41 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:59:41 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:59:41 INFO - '--tppagecycles', 21:59:41 INFO - '7'], 21:59:41 INFO - 'tests': ['tsvgm']}}, 21:59:41 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 21:59:41 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:59:41 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 21:59:41 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 21:59:41 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:59:41 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 21:59:41 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:59:41 INFO - 'talos_options': ['--disable-e10s'], 21:59:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:59:41 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:59:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:59:41 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:59:41 INFO - 'talos_options': ['--disable-e10s'], 21:59:41 INFO - 'tests': ['damp', 'tps']}, 21:59:41 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:59:41 INFO - 'tests': ['damp', 'tps']}, 21:59:41 INFO - 'g3': {'talos_options': ['--disable-e10s'], 21:59:41 INFO - 'tests': ['dromaeo_dom']}, 21:59:41 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:59:41 INFO - 'other': {'talos_options': ['--disable-e10s'], 21:59:41 INFO - 'tests': ['a11yr', 21:59:41 INFO - 'ts_paint', 21:59:41 INFO - 'tpaint', 21:59:41 INFO - 'sessionrestore', 21:59:41 INFO - 'sessionrestore_no_auto_restore', 21:59:41 INFO - 'tabpaint']}, 21:59:41 INFO - 'other-e10s': {'tests': ['a11yr', 21:59:41 INFO - 'ts_paint', 21:59:41 INFO - 'tpaint', 21:59:41 INFO - 'sessionrestore', 21:59:41 INFO - 'sessionrestore_no_auto_restore', 21:59:41 INFO - 'tabpaint']}, 21:59:41 INFO - 'other-e10s_l64': {'tests': ['a11yr', 21:59:41 INFO - 'ts_paint', 21:59:41 INFO - 'tpaint', 21:59:41 INFO - 'sessionrestore', 21:59:41 INFO - 'sessionrestore_no_auto_restore', 21:59:41 INFO - 'tabpaint']}, 21:59:41 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 21:59:41 INFO - 'ts_paint', 21:59:41 INFO - 'tpaint', 21:59:41 INFO - 'sessionrestore', 21:59:41 INFO - 'sessionrestore_no_auto_restore', 21:59:41 INFO - 'tabpaint']}, 21:59:41 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 21:59:41 INFO - 'tests': ['a11yr', 21:59:41 INFO - 'ts_paint', 21:59:41 INFO - 'tpaint', 21:59:41 INFO - 'sessionrestore', 21:59:41 INFO - 'sessionrestore_no_auto_restore', 21:59:41 INFO - 'tabpaint']}, 21:59:41 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 21:59:41 INFO - 'tests': ['a11yr', 21:59:41 INFO - 'ts_paint', 21:59:41 INFO - 'tpaint', 21:59:41 INFO - 'sessionrestore', 21:59:41 INFO - 'sessionrestore_no_auto_restore', 21:59:41 INFO - 'tabpaint']}, 21:59:41 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 21:59:41 INFO - 'tests': ['tsvgx', 21:59:41 INFO - 'tsvgr_opacity', 21:59:41 INFO - 'tart', 21:59:41 INFO - 'tscrollx', 21:59:41 INFO - 'cart']}, 21:59:41 INFO - 'svgr-e10s': {'tests': ['tsvgx', 21:59:41 INFO - 'tsvgr_opacity', 21:59:41 INFO - 'tart', 21:59:41 INFO - 'tscrollx', 21:59:41 INFO - 'cart']}, 21:59:41 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:59:41 INFO - 'talos_options': ['--disable-e10s'], 21:59:41 INFO - 'tests': ['tp5o']}, 21:59:41 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:59:41 INFO - 'tests': ['tp5o']}, 21:59:41 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:59:41 INFO - 'talos_options': ['--disable-e10s', 21:59:41 INFO - '--xperf_path', 21:59:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:59:41 INFO - 'tests': ['tp5n']}, 21:59:41 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:59:41 INFO - 'talos_options': ['--xperf_path', 21:59:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:59:41 INFO - 'tests': ['tp5n']}}, 21:59:41 INFO - 'talos.zip': {'path': '', 21:59:41 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:59:41 INFO - Running post-action listener: _resource_record_post_action 21:59:41 INFO - ##### 21:59:41 INFO - ##### Finished populate-webroot step (success) 21:59:41 INFO - ##### 21:59:41 INFO - ##### 21:59:41 INFO - ##### Running create-virtualenv step. 21:59:41 INFO - ##### 21:59:41 INFO - Running pre-action listener: _resource_record_pre_action 21:59:41 INFO - Running main action method: create_virtualenv 21:59:41 INFO - Creating virtualenv /builds/slave/test/build/venv 21:59:41 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 21:59:41 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:59:41 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:59:41 INFO - Using real prefix '/usr' 21:59:41 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:59:42 INFO - Installing distribute.............................................................................................................................................................................................done. 21:59:43 INFO - Installing pip.................done. 21:59:44 INFO - Return code: 0 21:59:44 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:59:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:59:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:59:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:59:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:59:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd505bfff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a028a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2acd350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b5c1c0>, '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 0x2b5d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b5d550>, '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': '1f5564757af27664ca02d71f000001b0-1465275104.890256-2033184417', '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 21:59:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 21:59:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 21:59:44 INFO - Using env: {'DISPLAY': ':0', 21:59:44 INFO - 'HOME': '/home/cltbld', 21:59:44 INFO - 'LANG': 'en_US.UTF-8', 21:59:44 INFO - 'LANGUAGE': 'en_US:en', 21:59:44 INFO - 'LOGNAME': 'cltbld', 21:59:44 INFO - 'MAIL': '/var/mail/cltbld', 21:59:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:59:44 INFO - 'MOZ_NO_REMOTE': '1', 21:59:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:59:44 INFO - 'NO_EM_RESTART': '1', 21:59:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:59:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:59:44 INFO - 'PWD': '/builds/slave/test', 21:59:44 INFO - 'SHELL': '/bin/bash', 21:59:44 INFO - 'SHLVL': '1', 21:59:44 INFO - 'TERM': 'linux', 21:59:44 INFO - 'TMOUT': '86400', 21:59:44 INFO - 'USER': 'cltbld', 21:59:44 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1465275104.890256-2033184417', 21:59:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:59:44 INFO - '_': '/tools/buildbot/bin/python'} 21:59:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:59:44 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 21:59:44 INFO - Cleaning up... 21:59:44 INFO - Return code: 0 21:59:44 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 21:59:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:59:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:59:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:59:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:59:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd505bfff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a028a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2acd350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b5c1c0>, '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 0x2b5d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b5d550>, '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': '1f5564757af27664ca02d71f000001b0-1465275104.890256-2033184417', '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 21:59:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 21:59:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 21:59:44 INFO - Using env: {'DISPLAY': ':0', 21:59:44 INFO - 'HOME': '/home/cltbld', 21:59:44 INFO - 'LANG': 'en_US.UTF-8', 21:59:44 INFO - 'LANGUAGE': 'en_US:en', 21:59:44 INFO - 'LOGNAME': 'cltbld', 21:59:44 INFO - 'MAIL': '/var/mail/cltbld', 21:59:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:59:44 INFO - 'MOZ_NO_REMOTE': '1', 21:59:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:59:44 INFO - 'NO_EM_RESTART': '1', 21:59:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:59:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:59:44 INFO - 'PWD': '/builds/slave/test', 21:59:44 INFO - 'SHELL': '/bin/bash', 21:59:44 INFO - 'SHLVL': '1', 21:59:44 INFO - 'TERM': 'linux', 21:59:44 INFO - 'TMOUT': '86400', 21:59:44 INFO - 'USER': 'cltbld', 21:59:44 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1465275104.890256-2033184417', 21:59:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:59:44 INFO - '_': '/tools/buildbot/bin/python'} 21:59:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:59:44 INFO - Downloading/unpacking psutil>=3.1.1 21:59:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:59:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:59:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:59:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:59:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:59:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:59:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:59:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:59:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:59:46 INFO - Installing collected packages: psutil 21:59:46 INFO - Running setup.py install for psutil 21:59:46 INFO - building 'psutil._psutil_linux' extension 21:59:46 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 21:59:46 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 21:59:46 INFO - building 'psutil._psutil_posix' extension 21:59:46 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 21:59:46 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 21:59:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:59:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:59:46 INFO - Successfully installed psutil 21:59:46 INFO - Cleaning up... 21:59:46 INFO - Return code: 0 21:59:46 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 21:59:46 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')]} 21:59:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:59:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59:46 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')]} 21:59:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:59:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59:46 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 0x7fd505bfff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a028a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2acd350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b5c1c0>, '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 0x2b5d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b5d550>, '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': '1f5564757af27664ca02d71f000001b0-1465275104.890256-2033184417', '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 21:59:46 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 21:59:46 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 21:59:47 INFO - Using env: {'DISPLAY': ':0', 21:59:47 INFO - 'HOME': '/home/cltbld', 21:59:47 INFO - 'LANG': 'en_US.UTF-8', 21:59:47 INFO - 'LANGUAGE': 'en_US:en', 21:59:47 INFO - 'LOGNAME': 'cltbld', 21:59:47 INFO - 'MAIL': '/var/mail/cltbld', 21:59:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:59:47 INFO - 'MOZ_NO_REMOTE': '1', 21:59:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:59:47 INFO - 'NO_EM_RESTART': '1', 21:59:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:59:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:59:47 INFO - 'PWD': '/builds/slave/test', 21:59:47 INFO - 'SHELL': '/bin/bash', 21:59:47 INFO - 'SHLVL': '1', 21:59:47 INFO - 'TERM': 'linux', 21:59:47 INFO - 'TMOUT': '86400', 21:59:47 INFO - 'USER': 'cltbld', 21:59:47 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1465275104.890256-2033184417', 21:59:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:59:47 INFO - '_': '/tools/buildbot/bin/python'} 21:59:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:59:47 INFO - Downloading/unpacking mozsystemmonitor==0.3 21:59:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:59:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:59:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:59:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:59:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:59:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:59:49 INFO - Downloading mozsystemmonitor-0.3.tar.gz 21:59:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:59:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 21:59:49 INFO - Installing collected packages: mozsystemmonitor 21:59:49 INFO - Running setup.py install for mozsystemmonitor 21:59:49 INFO - Successfully installed mozsystemmonitor 21:59:49 INFO - Cleaning up... 21:59:49 INFO - Return code: 0 21:59:49 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 21:59:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:59:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:59:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:59:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:59:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd505bfff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a028a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2acd350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b5c1c0>, '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 0x2b5d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b5d550>, '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': '1f5564757af27664ca02d71f000001b0-1465275104.890256-2033184417', '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 21:59:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 21:59:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 21:59:49 INFO - Using env: {'DISPLAY': ':0', 21:59:49 INFO - 'HOME': '/home/cltbld', 21:59:49 INFO - 'LANG': 'en_US.UTF-8', 21:59:49 INFO - 'LANGUAGE': 'en_US:en', 21:59:49 INFO - 'LOGNAME': 'cltbld', 21:59:49 INFO - 'MAIL': '/var/mail/cltbld', 21:59:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:59:49 INFO - 'MOZ_NO_REMOTE': '1', 21:59:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:59:49 INFO - 'NO_EM_RESTART': '1', 21:59:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:59:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:59:49 INFO - 'PWD': '/builds/slave/test', 21:59:49 INFO - 'SHELL': '/bin/bash', 21:59:49 INFO - 'SHLVL': '1', 21:59:49 INFO - 'TERM': 'linux', 21:59:49 INFO - 'TMOUT': '86400', 21:59:49 INFO - 'USER': 'cltbld', 21:59:49 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1465275104.890256-2033184417', 21:59:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:59:49 INFO - '_': '/tools/buildbot/bin/python'} 21:59:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:59:49 INFO - Downloading/unpacking jsonschema==2.5.1 21:59:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:59:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:59:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:59:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:59:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:59:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:59:51 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:59:51 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 21:59:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:59:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:59:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:59:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:59:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:59:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:59:51 INFO - Downloading functools32-3.2.3-2.tar.gz 21:59:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:59:51 INFO - warning: no files found matching '*.txt' 21:59:51 INFO - no previously-included directories found matching 'build' 21:59:51 INFO - no previously-included directories found matching 'dist' 21:59:51 INFO - no previously-included directories found matching '.git*' 21:59:51 INFO - Installing collected packages: jsonschema, functools32 21:59:51 INFO - Running setup.py install for functools32 21:59:51 INFO - warning: no files found matching '*.txt' 21:59:51 INFO - no previously-included directories found matching 'build' 21:59:51 INFO - no previously-included directories found matching 'dist' 21:59:51 INFO - no previously-included directories found matching '.git*' 21:59:51 INFO - Successfully installed jsonschema functools32 21:59:51 INFO - Cleaning up... 21:59:51 INFO - Return code: 0 21:59:51 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:59:51 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')]} 21:59:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:59:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59:51 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')]} 21:59:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:59:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59:51 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 0x7fd505bfff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a028a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2acd350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b5c1c0>, '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 0x2b5d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b5d550>, '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': '1f5564757af27664ca02d71f000001b0-1465275104.890256-2033184417', '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 21:59:51 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 21:59:51 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 21:59:51 INFO - Using env: {'DISPLAY': ':0', 21:59:51 INFO - 'HOME': '/home/cltbld', 21:59:51 INFO - 'LANG': 'en_US.UTF-8', 21:59:51 INFO - 'LANGUAGE': 'en_US:en', 21:59:51 INFO - 'LOGNAME': 'cltbld', 21:59:51 INFO - 'MAIL': '/var/mail/cltbld', 21:59:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:59:51 INFO - 'MOZ_NO_REMOTE': '1', 21:59:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:59:51 INFO - 'NO_EM_RESTART': '1', 21:59:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:59:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:59:51 INFO - 'PWD': '/builds/slave/test', 21:59:51 INFO - 'SHELL': '/bin/bash', 21:59:51 INFO - 'SHLVL': '1', 21:59:51 INFO - 'TERM': 'linux', 21:59:51 INFO - 'TMOUT': '86400', 21:59:51 INFO - 'USER': 'cltbld', 21:59:51 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1465275104.890256-2033184417', 21:59:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:59:51 INFO - '_': '/tools/buildbot/bin/python'} 21:59:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:59:52 INFO - Downloading/unpacking blobuploader==1.2.4 21:59:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:59:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:59:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:59:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:59:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:59:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:59:53 INFO - Downloading blobuploader-1.2.4.tar.gz 21:59:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:59:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:59:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:59:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:59:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:59:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:59:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:59:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:59:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:59:54 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:59:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:59:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:59:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:59:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:59:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:59:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:59:54 INFO - Downloading docopt-0.6.1.tar.gz 21:59:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:59:54 INFO - Installing collected packages: blobuploader, requests, docopt 21:59:54 INFO - Running setup.py install for blobuploader 21:59:54 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:59:54 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:59:54 INFO - Running setup.py install for requests 21:59:55 INFO - Running setup.py install for docopt 21:59:55 INFO - Successfully installed blobuploader requests docopt 21:59:55 INFO - Cleaning up... 21:59:55 INFO - Return code: 0 21:59:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:59:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:59:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:59:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:59:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:59:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59:55 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 0x7fd505bfff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a028a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2acd350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b5c1c0>, '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 0x2b5d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b5d550>, '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': '1f5564757af27664ca02d71f000001b0-1465275104.890256-2033184417', '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 21:59:55 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 21:59:55 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 21:59:55 INFO - Using env: {'DISPLAY': ':0', 21:59:55 INFO - 'HOME': '/home/cltbld', 21:59:55 INFO - 'LANG': 'en_US.UTF-8', 21:59:55 INFO - 'LANGUAGE': 'en_US:en', 21:59:55 INFO - 'LOGNAME': 'cltbld', 21:59:55 INFO - 'MAIL': '/var/mail/cltbld', 21:59:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:59:55 INFO - 'MOZ_NO_REMOTE': '1', 21:59:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:59:55 INFO - 'NO_EM_RESTART': '1', 21:59:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:59:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:59:55 INFO - 'PWD': '/builds/slave/test', 21:59:55 INFO - 'SHELL': '/bin/bash', 21:59:55 INFO - 'SHLVL': '1', 21:59:55 INFO - 'TERM': 'linux', 21:59:55 INFO - 'TMOUT': '86400', 21:59:55 INFO - 'USER': 'cltbld', 21:59:55 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1465275104.890256-2033184417', 21:59:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:59:55 INFO - '_': '/tools/buildbot/bin/python'} 21:59:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:59:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:59:55 INFO - Running setup.py (path:/tmp/pip-xq9W5A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:59:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:59:55 INFO - Running setup.py (path:/tmp/pip-IFOXI4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:59:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:59:55 INFO - Running setup.py (path:/tmp/pip-xw_iIo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:59:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:59:55 INFO - Running setup.py (path:/tmp/pip-32NnFw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:59:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:59:55 INFO - Running setup.py (path:/tmp/pip-r5JxFS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:59:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:59:55 INFO - Running setup.py (path:/tmp/pip-BpfzHP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:59:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:59:55 INFO - Running setup.py (path:/tmp/pip-qERT6e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:59:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:59:56 INFO - Running setup.py (path:/tmp/pip-Z95z33-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:59:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:59:56 INFO - Running setup.py (path:/tmp/pip-lk8WYh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:59:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:59:56 INFO - Running setup.py (path:/tmp/pip-30lMsE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:59:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:59:56 INFO - Running setup.py (path:/tmp/pip-I7Vf4d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:59:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:59:56 INFO - Running setup.py (path:/tmp/pip-SrjEQI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:59:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:59:56 INFO - Running setup.py (path:/tmp/pip-0mtf5k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:59:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:59:56 INFO - Running setup.py (path:/tmp/pip-UgZM79-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:59:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:59:56 INFO - Running setup.py (path:/tmp/pip-w0iAEX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:59:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:59:56 INFO - Running setup.py (path:/tmp/pip-QaV_Rv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:59:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:59:56 INFO - Running setup.py (path:/tmp/pip-hIXHk7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:59:56 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:59:56 INFO - Running setup.py install for manifestparser 21:59:56 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:59:56 INFO - Running setup.py install for mozcrash 21:59:56 INFO - Running setup.py install for mozdebug 21:59:57 INFO - Running setup.py install for mozdevice 21:59:57 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 21:59:57 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:59:57 INFO - Running setup.py install for mozfile 21:59:57 INFO - Running setup.py install for mozhttpd 21:59:57 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:59:57 INFO - Running setup.py install for mozinfo 21:59:57 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:59:57 INFO - Running setup.py install for mozInstall 21:59:57 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:59:57 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:59:57 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:59:57 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:59:57 INFO - Running setup.py install for mozleak 21:59:57 INFO - Running setup.py install for mozlog 21:59:57 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:59:57 INFO - Running setup.py install for moznetwork 21:59:57 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:59:57 INFO - Running setup.py install for mozprocess 21:59:58 INFO - Running setup.py install for mozprofile 21:59:58 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:59:58 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:59:58 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:59:58 INFO - Running setup.py install for mozrunner 21:59:58 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:59:58 INFO - Running setup.py install for mozscreenshot 21:59:58 INFO - Running setup.py install for moztest 21:59:58 INFO - Running setup.py install for mozversion 21:59:58 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:59:58 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:59:58 INFO - Cleaning up... 21:59:58 INFO - Return code: 0 21:59:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:59: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')]} 21:59:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:59:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59: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')]} 21:59:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:59:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59:58 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 0x7fd505bfff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a028a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2acd350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b5c1c0>, '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 0x2b5d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b5d550>, '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': '1f5564757af27664ca02d71f000001b0-1465275104.890256-2033184417', '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 21:59:58 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 21:59:58 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 21:59:58 INFO - Using env: {'DISPLAY': ':0', 21:59:58 INFO - 'HOME': '/home/cltbld', 21:59:58 INFO - 'LANG': 'en_US.UTF-8', 21:59:58 INFO - 'LANGUAGE': 'en_US:en', 21:59:58 INFO - 'LOGNAME': 'cltbld', 21:59:58 INFO - 'MAIL': '/var/mail/cltbld', 21:59:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:59:58 INFO - 'MOZ_NO_REMOTE': '1', 21:59:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:59:58 INFO - 'NO_EM_RESTART': '1', 21:59:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:59:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:59:58 INFO - 'PWD': '/builds/slave/test', 21:59:58 INFO - 'SHELL': '/bin/bash', 21:59:58 INFO - 'SHLVL': '1', 21:59:58 INFO - 'TERM': 'linux', 21:59:58 INFO - 'TMOUT': '86400', 21:59:58 INFO - 'USER': 'cltbld', 21:59:58 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1465275104.890256-2033184417', 21:59:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:59:58 INFO - '_': '/tools/buildbot/bin/python'} 21:59:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:59:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:59:58 INFO - Running setup.py (path:/tmp/pip-puqY4d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:59:58 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)) 21:59:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:59:58 INFO - Running setup.py (path:/tmp/pip-6KMSK0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:59:58 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)) 21:59:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:59:58 INFO - Running setup.py (path:/tmp/pip-FsE40S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:59:58 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)) 21:59:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:59:59 INFO - Running setup.py (path:/tmp/pip-5KUjW0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:59:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 21:59:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:59:59 INFO - Running setup.py (path:/tmp/pip-qXrM3i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:59:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 21:59:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:59:59 INFO - Running setup.py (path:/tmp/pip-KTx_kf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:59:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 21:59:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:59:59 INFO - Running setup.py (path:/tmp/pip-2pvNcl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:59:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 21:59:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:59:59 INFO - Running setup.py (path:/tmp/pip-VrxFWl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:59:59 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)) 21:59:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:59:59 INFO - Running setup.py (path:/tmp/pip-t6QkNM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:59:59 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)) 21:59:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:59:59 INFO - Running setup.py (path:/tmp/pip-2tIv5J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:59:59 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)) 21:59:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:59:59 INFO - Running setup.py (path:/tmp/pip-TeEeRg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:59:59 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)) 21:59:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:59:59 INFO - Running setup.py (path:/tmp/pip-LsEA6f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:59:59 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)) 21:59:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:59:59 INFO - Running setup.py (path:/tmp/pip-bZ1tkQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:59:59 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)) 21:59:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:59:59 INFO - Running setup.py (path:/tmp/pip-wqBTz0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:59:59 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)) 21:59:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:59:59 INFO - Running setup.py (path:/tmp/pip-VWyPoL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:59:59 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)) 21:59:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:59:59 INFO - Running setup.py (path:/tmp/pip-zQhEui-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:59:59 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)) 21:59:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:59:59 INFO - Running setup.py (path:/tmp/pip-8rngEf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:00:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 22:00:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 22:00:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 22:00:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 22:00:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 22:00:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 22:00:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:00:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:00:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:00:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:00:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:00:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:00:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:00:01 INFO - Downloading blessings-1.6.tar.gz 22:00:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:00:01 INFO - Installing collected packages: blessings 22:00:01 INFO - Running setup.py install for blessings 22:00:02 INFO - Successfully installed blessings 22:00:02 INFO - Cleaning up... 22:00:02 INFO - Return code: 0 22:00:02 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:00:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:00:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:00:02 INFO - Reading from file tmpfile_stdout 22:00:02 INFO - Current package versions: 22:00:02 INFO - argparse == 1.2.1 22:00:02 INFO - blessings == 1.6 22:00:02 INFO - blobuploader == 1.2.4 22:00:02 INFO - docopt == 0.6.1 22:00:02 INFO - functools32 == 3.2.3-2 22:00:02 INFO - jsonschema == 2.5.1 22:00:02 INFO - manifestparser == 1.1 22:00:02 INFO - mozInstall == 1.12 22:00:02 INFO - mozcrash == 0.17 22:00:02 INFO - mozdebug == 0.1 22:00:02 INFO - mozdevice == 0.48 22:00:02 INFO - mozfile == 1.2 22:00:02 INFO - mozhttpd == 0.7 22:00:02 INFO - mozinfo == 0.9 22:00:02 INFO - mozleak == 0.1 22:00:02 INFO - mozlog == 3.2 22:00:02 INFO - moznetwork == 0.27 22:00:02 INFO - mozprocess == 0.22 22:00:02 INFO - mozprofile == 0.28 22:00:02 INFO - mozrunner == 6.11 22:00:02 INFO - mozscreenshot == 0.1 22:00:02 INFO - mozsystemmonitor == 0.3 22:00:02 INFO - moztest == 0.7 22:00:02 INFO - mozversion == 1.4 22:00:02 INFO - psutil == 3.1.1 22:00:02 INFO - requests == 1.2.3 22:00:02 INFO - wsgiref == 0.1.2 22:00:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:00:02 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')]} 22:00:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:00:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00:02 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')]} 22:00:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:00:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00:02 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 0x7fd505bfff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a028a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2acd350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b5c1c0>, '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 0x2b5d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b5d550>, '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': '1f5564757af27664ca02d71f000001b0-1465275104.890256-2033184417', '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 22:00:02 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 22:00:02 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 22:00:02 INFO - Using env: {'DISPLAY': ':0', 22:00:02 INFO - 'HOME': '/home/cltbld', 22:00:02 INFO - 'LANG': 'en_US.UTF-8', 22:00:02 INFO - 'LANGUAGE': 'en_US:en', 22:00:02 INFO - 'LOGNAME': 'cltbld', 22:00:02 INFO - 'MAIL': '/var/mail/cltbld', 22:00:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:00:02 INFO - 'MOZ_NO_REMOTE': '1', 22:00:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:00:02 INFO - 'NO_EM_RESTART': '1', 22:00:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:00:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:00:02 INFO - 'PWD': '/builds/slave/test', 22:00:02 INFO - 'SHELL': '/bin/bash', 22:00:02 INFO - 'SHLVL': '1', 22:00:02 INFO - 'TERM': 'linux', 22:00:02 INFO - 'TMOUT': '86400', 22:00:02 INFO - 'USER': 'cltbld', 22:00:02 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1465275104.890256-2033184417', 22:00:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:00:02 INFO - '_': '/tools/buildbot/bin/python'} 22:00:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:00:02 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)) 22:00:02 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)) 22:00:02 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)) 22:00:02 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)) 22:00:02 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)) 22:00:02 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)) 22:00:02 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)) 22:00:02 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)) 22:00:02 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)) 22:00:02 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)) 22:00:02 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)) 22:00:02 INFO - Cleaning up... 22:00:02 INFO - Return code: 0 22:00:02 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 22:00:02 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')]} 22:00:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:00:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00:02 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')]} 22:00:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:00:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00:02 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 0x7fd505bfff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a028a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2acd350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b5c1c0>, '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 0x2b5d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b5d550>, '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': '1f5564757af27664ca02d71f000001b0-1465275104.890256-2033184417', '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 22:00:02 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 22:00:02 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 22:00:02 INFO - Using env: {'DISPLAY': ':0', 22:00:02 INFO - 'HOME': '/home/cltbld', 22:00:02 INFO - 'LANG': 'en_US.UTF-8', 22:00:02 INFO - 'LANGUAGE': 'en_US:en', 22:00:02 INFO - 'LOGNAME': 'cltbld', 22:00:02 INFO - 'MAIL': '/var/mail/cltbld', 22:00:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:00:02 INFO - 'MOZ_NO_REMOTE': '1', 22:00:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:00:02 INFO - 'NO_EM_RESTART': '1', 22:00:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:00:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:00:02 INFO - 'PWD': '/builds/slave/test', 22:00:02 INFO - 'SHELL': '/bin/bash', 22:00:02 INFO - 'SHLVL': '1', 22:00:02 INFO - 'TERM': 'linux', 22:00:02 INFO - 'TMOUT': '86400', 22:00:02 INFO - 'USER': 'cltbld', 22:00:02 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1465275104.890256-2033184417', 22:00:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:00:02 INFO - '_': '/tools/buildbot/bin/python'} 22:00:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:00:02 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 22:00:02 INFO - Cleaning up... 22:00:02 INFO - Return code: 0 22:00:02 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 22:00:02 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')]} 22:00:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:00:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00:02 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')]} 22:00:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:00:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00:02 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 0x7fd505bfff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a028a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2acd350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b5c1c0>, '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 0x2b5d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b5d550>, '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': '1f5564757af27664ca02d71f000001b0-1465275104.890256-2033184417', '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 22:00:02 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 22:00:02 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 22:00:02 INFO - Using env: {'DISPLAY': ':0', 22:00:02 INFO - 'HOME': '/home/cltbld', 22:00:02 INFO - 'LANG': 'en_US.UTF-8', 22:00:02 INFO - 'LANGUAGE': 'en_US:en', 22:00:02 INFO - 'LOGNAME': 'cltbld', 22:00:02 INFO - 'MAIL': '/var/mail/cltbld', 22:00:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:00:02 INFO - 'MOZ_NO_REMOTE': '1', 22:00:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:00:02 INFO - 'NO_EM_RESTART': '1', 22:00:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:00:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:00:02 INFO - 'PWD': '/builds/slave/test', 22:00:02 INFO - 'SHELL': '/bin/bash', 22:00:02 INFO - 'SHLVL': '1', 22:00:02 INFO - 'TERM': 'linux', 22:00:02 INFO - 'TMOUT': '86400', 22:00:02 INFO - 'USER': 'cltbld', 22:00:02 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1465275104.890256-2033184417', 22:00:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:00:02 INFO - '_': '/tools/buildbot/bin/python'} 22:00:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:00:03 INFO - Downloading/unpacking flake8 22:00:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:00:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:00:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:00:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:00:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:00:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:00:04 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 22:00:04 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 22:00:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:00:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:00:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:00:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:00:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:00:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:00:05 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 22:00:05 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 22:00:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:00:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:00:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:00:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:00:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:00:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:00:05 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 22:00:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:00:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:00:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:00:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:00:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:00:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:00:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 22:00:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:00:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:00:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:00:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:00:05 INFO - no previously-included directories found matching 'docs/_build' 22:00:05 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 22:00:05 INFO - Running setup.py install for pep8 22:00:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:00:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:00:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:00:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:00:05 INFO - no previously-included directories found matching 'docs/_build' 22:00:05 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 22:00:05 INFO - Successfully installed flake8 mccabe pyflakes pep8 22:00:05 INFO - Cleaning up... 22:00:05 INFO - Return code: 0 22:00:05 INFO - Running post-action listener: _resource_record_post_action 22:00:05 INFO - Running post-action listener: _start_resource_monitoring 22:00:05 INFO - Starting resource monitoring. 22:00:05 INFO - ##### 22:00:05 INFO - ##### Finished create-virtualenv step (success) 22:00:05 INFO - ##### 22:00:05 INFO - ##### 22:00:05 INFO - ##### Running install step. 22:00:05 INFO - ##### 22:00:05 INFO - Running pre-action listener: _resource_record_pre_action 22:00:05 INFO - Running main action method: install 22:00:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:00:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:00:06 INFO - Reading from file tmpfile_stdout 22:00:06 INFO - Detecting whether we're running mozinstall >=1.0... 22:00:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:00:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:00:06 INFO - Reading from file tmpfile_stdout 22:00:06 INFO - Output received: 22:00:06 INFO - Usage: mozinstall [options] installer 22:00:06 INFO - Options: 22:00:06 INFO - -h, --help show this help message and exit 22:00:06 INFO - -d DEST, --destination=DEST 22:00:06 INFO - Directory to install application into. [default: 22:00:06 INFO - "/builds/slave/test"] 22:00:06 INFO - --app=APP Application being installed. [default: firefox] 22:00:06 INFO - mkdir: /builds/slave/test/build/application 22:00:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 22:00:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 22:00:22 INFO - Reading from file tmpfile_stdout 22:00:22 INFO - Output received: 22:00:22 INFO - /builds/slave/test/build/application/firefox/firefox 22:00:22 INFO - Running post-action listener: _resource_record_post_action 22:00:22 INFO - ##### 22:00:22 INFO - ##### Finished install step (success) 22:00:22 INFO - ##### 22:00:22 INFO - ##### 22:00:22 INFO - ##### Running run-tests step. 22:00:22 INFO - ##### 22:00:22 INFO - Running pre-action listener: _resource_record_pre_action 22:00:22 INFO - Running main action method: run_tests 22:00:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:00:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:00:22 INFO - Python 2.7.3 22:00:22 INFO - Return code: 0 22:00:22 INFO - grabbing minidump binary from tooltool 22:00: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')]} 22:00:22 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b5c1c0>, '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 0x2b5d0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b5d550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:00:22 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 22:00:22 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 22:00:22 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 22:00:22 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:00:22 INFO - Return code: 0 22:00:22 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 22:00:22 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:00:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:00:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 22:00:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:00:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 22:00:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 22:00:23 INFO - Return code: 0 22:00:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/AiMBPPaXQoKsDvTd41gqUQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-027', '--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 22:00:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/AiMBPPaXQoKsDvTd41gqUQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-027 --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 22:00:23 INFO - Using env: {'DISPLAY': ':0', 22:00:23 INFO - 'HOME': '/home/cltbld', 22:00:23 INFO - 'LANG': 'en_US.UTF-8', 22:00:23 INFO - 'LANGUAGE': 'en_US:en', 22:00:23 INFO - 'LOGNAME': 'cltbld', 22:00:23 INFO - 'MAIL': '/var/mail/cltbld', 22:00:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:00:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 22:00:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:00:23 INFO - 'MOZ_NO_REMOTE': '1', 22:00:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:00:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:00:23 INFO - 'NO_EM_RESTART': '1', 22:00:23 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:00:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:00:23 INFO - 'PWD': '/builds/slave/test', 22:00:23 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:00:23 INFO - 'SHELL': '/bin/bash', 22:00:23 INFO - 'SHLVL': '1', 22:00:23 INFO - 'TERM': 'linux', 22:00:23 INFO - 'TMOUT': '86400', 22:00:23 INFO - 'USER': 'cltbld', 22:00:23 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1465275104.890256-2033184417', 22:00:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:00:23 INFO - '_': '/tools/buildbot/bin/python'} 22:00:23 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/AiMBPPaXQoKsDvTd41gqUQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-027', '--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 22:00:23 INFO - mozversion application_buildid: 20160606185231 22:00:23 INFO - mozversion application_changeset: 580436387d62e0a40fcc781832c3291858121816 22:00:23 INFO - mozversion application_display_name: Nightly 22:00:23 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:00:23 INFO - mozversion application_name: Firefox 22:00:23 INFO - mozversion application_remotingname: firefox 22:00:23 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 22:00:23 INFO - mozversion application_vendor: Mozilla 22:00:23 INFO - mozversion application_version: 50.0a1 22:00:23 INFO - mozversion platform_buildid: 20160606185231 22:00:23 INFO - mozversion platform_changeset: 580436387d62e0a40fcc781832c3291858121816 22:00:23 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 22:00:23 INFO - mozversion platform_version: 50.0a1 22:00:23 INFO - using testdate: 1465275623 22:00:23 INFO - actual date: 1465275623 22:00:23 INFO - starting webserver on 'localhost:40334' 22:00:23 INFO - SUITE-START | Running 2 tests 22:00:23 INFO - TEST-START | dromaeo_css 22:00:23 INFO - operating with platform_type : linux_ 22:00:23 INFO - Initialising browser for dromaeo_css test... 22:00:23 INFO - TEST-INFO | started process 22066 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKDrRbR/profile http://localhost:40334/getInfo.html) 22:00:27 INFO - PROCESS | 22066 | __metrics Screen width/height:1600/1200 22:00:27 INFO - PROCESS | 22066 | colorDepth:24 22:00:27 INFO - PROCESS | 22066 | Browser inner width/height: 1024/697 22:00:27 INFO - PROCESS | 22066 | __metrics 22:00:28 ERROR - PROCESS | 22066 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2944: TypeError: this.tabs is undefined 22:00:29 INFO - TEST-INFO | 22066: exit 0 22:00:29 INFO - Browser initialized. 22:00:29 INFO - Running cycle 1/1 for dromaeo_css test... 22:00:29 INFO - TEST-INFO | started process 22184 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKDrRbR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:00:41 INFO - PROCESS | 22184 | RSS: Main: 167788544 22:00:41 INFO - PROCESS | 22184 | 22:01:31 INFO - PROCESS | 22184 | 1465275691169 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] 22:03:41 INFO - PROCESS | 22184 | Cycle 1(1): loaded http://localhost:40334/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40334/tests/dromaeo/cssquery-ext.html) 22:03:43 INFO - PROCESS | 22184 | RSS: Main: 170770432 22:03:43 INFO - PROCESS | 22184 | 22:06:45 INFO - PROCESS | 22184 | Cycle 1(1): loaded http://localhost:40334/tests/dromaeo/cssquery-ext.html (next: http://localhost:40334/tests/dromaeo/cssquery-jquery.html) 22:06:45 INFO - PROCESS | 22184 | RSS: Main: 169480192 22:06:45 INFO - PROCESS | 22184 | 22:09:47 INFO - PROCESS | 22184 | Cycle 1(1): loaded http://localhost:40334/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40334/tests/dromaeo/cssquery-mootools.html) 22:09:48 INFO - PROCESS | 22184 | RSS: Main: 171184128 22:09:48 INFO - PROCESS | 22184 | 22:12:50 INFO - PROCESS | 22184 | Cycle 1(1): loaded http://localhost:40334/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40334/tests/dromaeo/cssquery-prototype.html) 22:12:50 INFO - PROCESS | 22184 | RSS: Main: 168923136 22:12:50 INFO - PROCESS | 22184 | 22:15:53 INFO - PROCESS | 22184 | Cycle 1(1): loaded http://localhost:40334/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40334/tests/dromaeo/cssquery-yui.html) 22:15:54 INFO - PROCESS | 22184 | RSS: Main: 171008000 22:15:54 INFO - PROCESS | 22184 | 22:18:56 INFO - PROCESS | 22184 | Cycle 1(1): loaded http://localhost:40334/tests/dromaeo/cssquery-yui.html (next: http://localhost:40334/tests/dromaeo/cssquery-dojo.html) 22:18:56 INFO - PROCESS | 22184 | RSS: Main: 171982848 22:18:56 INFO - PROCESS | 22184 | 22:18:56 INFO - PROCESS | 22184 | __start_tp_report 22:18:56 INFO - PROCESS | 22184 | _x_x_mozilla_page_load 22:18:56 INFO - PROCESS | 22184 | _x_x_mozilla_page_load_details 22:18:56 INFO - PROCESS | 22184 | |i|pagename|runs| 22:18:56 INFO - PROCESS | 22184 | |0;dojo.html;2679.0355472030064;2717.782577393809;2724.223596275062;2729.1266794625717;2730.1672989738145;4670.299455081735;4722.055588882225;4757.381540399748;4781.282807578857;4825.78283977221;4715.292706094087;4715.693479923802;4750;4761.999980004203;4800.9519904800945;4402.779861006953;4428.380026796235;4453.376527286183;4533.138703646297;4578.771061446931;38.599190494186345;4424.535423780505;4502.819887204508;4510.842120525782;4526.298423744325;4365;4374.868753937355;4407.140607581523;4443.755593442359;4446.266366049598;4373.584509471595;4393.692441529094;4393.890152746175;4414;4436.223660859369;4278.315469524861;4311.892202694927;4374.78126093694;4397.31841564558;4429.092036132617;4649.163150632885;4660.790264438075;4664.696794708333;4699.060187962421;4724.126036683225;5106.8212612558755;5119.6160287978555;5132.0249152661245;5135.460776618439;5211.9218211726475;5060.2409638554145;5112.284280200738;5169;5192.221166824968;5232.555232805216;4813.085513752376;4822.831200907986;4831.296717259455;4839.44346400165;4893.559579637849;5331.1470164773455;5335.466453354634;5336.573074154058;5337.2794672719465;5340.599455040888;4983.825566105169;5036.169032109661;5055.6713813602;5080.923786143211;5089.9745501272255;5157.329547158845;5176.948230517722;5186.948130518722;5199.376074870964;5239.607029472805;5020.523050310215;5128.461511541309;5129.64092513528;5137.51193636604;5138.8972220556125;4990.151674215392;5031.345925029723;5064.797408103708;5107.54032137102;5133.974330128325;4295.82816687329;4334.959609693651;4358.36803663467;4362.018545827227;4396.098799746044;3727.5713292971113;3793.506844110303;3805.086779173034;3811.466394704688;3874.2251549690177;4379.934300985487;4428.402165707588;4428.645708343325;4456.799444025027;4468;5076.390833100052;5112.539871411516;5123.718195499208;5136.30659860914;5186.429492755794;4297.419848320499;4418.536053714378;4441.111777644484;4457.331400289918;4510.345999830006;4582.404287442611;4619.099275641218;4624.468186158635;4637.373954516164;4668.253079507263;4888.633352498506;4891.168501354707;4897.2654101885;4900.975495122573;4914.459409464956;4983.227599722049;5089.541941225308;5125.103106956342;5193.0652482553505;5218.4259731430275;4840.031993601224;4865.58642515376;4873;4899.828506002273;4903.04390643821;5052.520010598987;5064.392272927273;5068.391792984866;5071.619628527801;5075.898482030412;5001.0748011616515;5166.8966620668125;5180.61145414103;5198.662086964335;5222.608304377263;5075.771590278372;5081.745912704424;5094.569557420427;5094.872628184325;5100.183970564692;5076.18780995039;5089.211172268304;5092.5162109601015;5098.847034588968;5105.821296254613;4788.904221915612;4805.615550756001;4923.630727695366;4936;4968.900621987612;5009.799608015638;5010.5240002199735;5021.949780502148;5025.195968644999;5037.19404895215;4948.975255123702;4949.480304568113;4958.256261560795;4959.70241785494;5004.599632029356 22:18:56 INFO - PROCESS | 22184 | |1;ext.html;554.5702080887314;600.8557946092938;603.3588638902185;608.5831205624148;619.4270299972527;28452.430951380986;31507.054788356356;39444.40833387498;40130.79934600323;40325;41727.582724172746;42154.57845421545;42226.57773422265;42264.15471690564;42442.36336454948;7651.234876512346;7803;7842.843143137163;7849.5682737449415;7853.96073019637;7692.653830577609;7788.415868809833;7789.065312162548;7803.5708036057995;7835.921640783605;7794.337481314095;7807.76576702697;7819.9218007820045;7827.491213071161;7838.9216107838765;7733.419993500482;7803.648835802374;7803.765887023398;7825.686972521093;7834.686612535492;7755.495892767009;7782.922170778333;7803.3367163791145;7835.412344074217;7858.174891636353;38238.23523529542;38617.61382386196;38655.61344386576;38725.41911871324;38768.418473722915;3063.479208534532;3191.3457741163006;3240.1575590346442;3246.6104067511815;3306.1073510152123;28246.293842653893;28762.81244380519;29161.416771664448;29470.263243419085;29603;3465.6534346565395;3499.4575840744724;3500.2124521982605;3520.6479352064844;3564.465330200465;244618;245511;245612;245785.77107114528;245882.7705861477;31257.687423125477;50591.494085059414;50778.74610626997;51216;51300.74349628228;32749;34098.65901341005;34270.828645856614;34306.48540271898;34335.828320858236;13077.41151648159;13099.869001309866;13140.60578182656;13191.934040329737;13208.801867971988;11405;11464.197506174487;11528.654140375802;11559;11561.88438115608;7899.921000789918;7921.247481489249;7942.166072562413;8001;8018.198180182052;3113.9377212455624;3114.8131112133347;3128.3586864692684;3161.0917955481013;3186.4105140549073;870.3820287595878;913.1097180249204;915.8826231996953;919.3380765848578;945.635930166877;27966.16101516958;28109.578356324673;28369.148925531856;28747.56878646822;28774.280642984093;894.7673604862653;982.2387649571497;991.1476130527741;1000.1698590170287;1073.0021080395306;14642;14968.401263949538;15132.621684457976;15214.543563693107;15365;383424;384324;385234;388826;389123;49104.75447622739;49394.259086113736;49710;49737.502624973284;49871;1197.604790419177;1230.876912308762;1232.4146030635557;1245.9439325230387;1249.0819247852821;25665;27289;27520.862395687895;28050.579241311803;28078.438431230854;41809;42187.578124218366;42252;42410.36384454174;42664.78667606642;330314;331049;331743;332687;333768;22976.19583314576;23212.419689507224;23295.53408931846;23399.298021059396;23452.765472345058;43575.34636980385;45460.77269613763;45561.54438455573;47708;48543.757281213366;36676.0830979217;36767;36868;37086.814565927;37849.62150378461;36699.08252293714;36892;36911.261774763814;37142.62857371392;37385;31796;34729;36061.63938360583;36440.453393199656;37641;31984.6801531991;33513;33564.832175838965;33582.328353432305;33613.495797562566;24901.750982489943;25310.873445632653;25424.237272881845;25771.613425798252;25974 22:18:56 INFO - PROCESS | 22184 | |2;jquery.html;356.2500935530706;366.06287902968404;367.86756767563674;374.14134561182084;375.60275774120265;15776.290066946985;16615.501534953957;17326.74009889853;17439.73840392392;17565.385211517598;15818.288177032033;16085;16889;16919.407820726276;16924.746128808078;4909.533594308544;5083.898322033557;5086.97456512717;5114.079465696173;5133.076046311662;3685.7419980601367;5038.496150384951;5652.802151924683;5958.9702051489685;5966.970165149168;5985.25184351956;5989.490893274077;5990.101484777275;6001.639901605918;6003.219581454405;5647.887042259153;5928.881422371572;5934.080217566284;5945.9108113378115;5960.612560183574;5055.74721263939;5134.71632091977;5156.948430515722;5161.896762064775;5167.250748641463;19515.316963906196;19525.316613918585;19653.115609797595;19963.30128445512;20754.273600424065;1895.2229585869866;1942.7571553555806;1970.3202395173641;2018.3339497965635;2080.4798800299927;12762;13019.153755005895;13082.672933176651;13164.86835131646;13228.206307621573;1573.6852629474151;1771.7785276840395;1809.80092189859;1821.4699652292138;1868.4394681595602;63750;64510.354896451376;65323.3467665322;65786.3421365785;65799.67100164517;8878.911210887938;9025;9253.768655783524;9465.66870159541;9601.711948641552;12606.55877044299;12656.620301390973;12669.429875655618;12735.55425560101;12759.61721148367;6888.173419189729;6960.860782784316;6964.4428445724225;7104.325089116525;7149.392301654418;6637.634930078795;6669.2997235289595;6703.711053780589;6845.247022827485;6868.347506986828;5829.62107463022;5892.292924849045;5938.792142275;6062.787802426894;6065.332813390523;1541.7070756556218;1606.1326883482789;1679.1184628070362;1687.1732850903215;1710.3757128647953;856.0198572634299;898.4294972692256;903.7153296711515;980.9215262778961;1004.1866088468219;16231.837681623269;16829.747553786703;17013;17157.742633860504;17394.826051739572;892.0054139634391;893.883795106632;895.9059298773665;912.2747415804319;960.6637676813059;9565.186959108414;9832.459214743258;9883.01169883006;9891.208703303719;9999;379531;390313;391741;393608;394897;64071;65585.34414655888;65649.34350656433;66208.33791662118;66542;888.7244954064261;897.7396554998977;905.1220316293185;920.6593560382702;945.924326053914;15150.621234468785;15251.313690884159;15350;15436.073835569901;15457.922710386376;31552;32153.517697234092;32493;32607.673923260463;33051.17372065718;40833.59166408417;42424.36363454489;42585.787071065686;43324.56675433205;47936.5206347932;7267.854642907007;7410.777676669709;7425.554466732014;7637.350825179699;7714.884276735741;11593.826092608786;11631.76736465283;11720.296782193096;11836.230645008047;12173.20874143178;10076.345037572535;10307.536160872629;10342.37945723259;10362.171026317727;10488.370697758159;10140.594376224868;10378.688639340831;10412.32319899204;10553.683389498327;10573.841392379274;10346.275760696679;10560.313579617301;10597.735056623338;10643.574257029632;10706.357618542912;7428.73999410018;7490.737824176345;7596.316331530189;7679.500832445873;7740.071191457061;10260.435676037889;10407.895921040692;10432.739181520523;10594.682159535227;10723.142148627934 22:18:56 INFO - PROCESS | 22184 | |3;mootools.html;1380.675541247807;1415.0589857744596;1521.6956608678267;1731.8354756298156;1744.6074633207522;6939.583624982504;7602.2017688142705;7603.847923041536;8109.107998120202;8123.796905077376;7640.88538671919;7810.3751699864015;7829.686812527492;7950.324222441085;7953.085395179542;2175.0647221694703;2199.571083638691;2208.6576580630026;2223.399682085836;2223.6219842626792;2113.714648522453;2138.1981756841183;2178.1287485005964;2182.9345119646355;2187.639039558471;2087.8016588424075;2110.725605671268;2116.502621883856;2129.946751331214;2182.639864422368;2074.813266805987;2080.365488525999;2083.8645488043303;2093.11042806808;2109.5675386545877;2086.91652333908;2103.2112957640884;2127.8936053197276;2139.486523234428;2140.347194105797;7835.49069310493;7843.098043724987;7861.174576669482;7889.960550197212;7910.129885712567;4464.754438505881;4522.140793249272;4569.9314510282375;4582.266837306049;4587.816487340502;2776.986115069412;2825.265430987958;2865.2407112115307;2929.7363237308746;2953.3945541164226;831.4304701279643;840.7267638017607;857.1728282207637;858.8754630578594;863.5595846118462;10857.34855908648;10897.83653245202;10919.945400273027;10926.453677316182;10943.507542160622;4175.707700460999;4182.958170418317;4263.232618128766;4278.593533614302;4303.311470164758;9174.082591740773;9195.264378849675;9199;9237.491937943478;9267.304952128618;4344.9565504344555;4378.430803995524;4413.3821265022925;4416.977915110404;4433.46798384196;3589.120665436985;3830.3488406970882;3897;3966.345552983783;4008.5590585035625;3614.204874927512;3646.08847788053;3688.5389326334207;3733.0667333166707;3777.54669439669;1173.841531393268;1191.0412118244897;1205.6322821539338;1206.957756478519;1213.7936550786387;728.726727477196;846.5809424334993;879.5909901895649;900.4147304252158;926.2127191886977;5358.410574836843;5586.832395028156;5669.149627555899;5693.800716974886;5803.274590676166;928.2666693312343;948.2793077261193;979.6962941488162;1004.0662184168647;1015.1067060986433;3792.5259342582176;3835.0987517933263;3850.8459661613783;3937.9015524612114;3956.7032472564674;9357.20463760588;9598.856017159747;9602.95198524003;9649.855252171223;9670.323077384515;9394.765130871783;9562.521873906417;9573.569189386495;9579.760505987406;9588.808223835484;6789.3550112740195;6998.825029374205;7020.122484689312;7065.258147894397;7087.681054352566;5370.62405631602;5463.071277882849;5479.4520547944885;5504.174373843955;5519.383251113438;8283.751487455385;8483.872741908754;8520.488770673779;8606.82786344282;8622.051574326944;8402.369822263232;8797.780055498408;8797.780055498664;8880.1563851434;8903.955480222558;6209.96895015522;6604.075429439787;6702.731890724316;6764.864702706017;6861.656917154222;7638.083429988437;7659.540427574363;7664.34853037498;7681.961590192237;7712.383009359126;6647.069410282661;6744.460443164633;6762.966185169043;6787.592744435349;6863.450923925974;6425;6450.322716114928;6473.611583305017;6501.927182015103;6588.242352129567;6548.738050477928;6578.111954886029;6595.208574971034;6639.535232533676;6640.302768209269;4760.619150468024;4763.214069678603;4861.465238823655;4872.512748725099;4883.926741098815;4634.907301854011;4698.671093023456;4752.901711501143;4789.1858384075485;4820.783064762164 22:18:56 INFO - PROCESS | 22184 | |4;prototype.html;287.3233535025016;289.62059701790656;290.97672186225105;292.7394618789279;292.99121026369215;5087.313212716283;5099.4900509949075;5109.642325037249;5116.258142569325;5136.383633963925;4987.551120399164;4989.75051247438;5020.121478741224;5036.974815125928;5042.47054059324;3680.3191409589313;3776.433534969749;3886.805659717017;3887.9805600972095;3915.865853110062;3872.9031774205587;3890.1636148228126;3891.6108389161;3897;3901.2782635212434;3840.9807950960208;3871.5160604924386;3873.6707379872746;3877.922441551167;3888.1640447303826;3796.1268908151005;3842.9423558646645;3845.1732877431486;3882.417637354405;3883.669888059518;3397.0997685613333;3398.2523844754114;3413.6586341365664;3430.1767575781882;3433.1931995980926;4769.833055843063;4782.115308667908;4821.63837712173;4827.275908613736;4833.516648335139;4417.536158703322;4461.687681862271;4464.843730469451;4468.955310446887;4486.910261794778;4918.16391213491;5227.686338819683;5239.13554263546;5258.2638430619745;5279.155335146358;3611.674949254553;3614.3855544557487;3631.509746184258;3638.5815631202486;3651.94522082169;5530.723463826793;5534.861628459281;5553.972799927998;5559.19391688207;5579.721013949286;3581.2658405026905;3702.500162478085;3713.424419215026;3715.2569486102348;3732.8133593320767;3762.967997281492;3772.5095737554493;3774.207416442523;3777.9433308500393;3787.337215987191;4300.956990430056;4341.956580434218;4348.2825333819565;4365.257906155961;4368.4102646143;5106.927545215546;5163.173892177234;5221.425643179247;5249.921251181236;5311.973440132774;1251.8873301402919;1265.6645988812973;1268.657462485124;1270.0347735720918;1275.3559452476625;782.9960850195713;804.7545498622976;812.2649002652608;816.3346872299057;818.1532114261711;4482.75344856036;4594.563516465931;4614.676972611885;4645.117427688729;4662.696924699883;5461;5471.480209380182;5471.671699698031;5479.698616576126;5509.559235261169;4472.464011955607;4607.44710634726;4621.514740952219;4637.930431043537;4666.836660716858;2861.283230061988;2902.505209816946;2938.3682508260827;2938.941221175607;2939.5590661400533;5144.71704056273;5175.353080864892;5196;5204.921926171035;5209.244659524347;5427.48438898304;5490.945090549043;5505.146702261156;5594.748236329375;5604.971975140098;5051.949480505222;5099.668521546162;5104.412992505835;5109.591232701375;5111.437741848394;5395.433479484755;5409.432009639088;5432.891342173213;5445.972770136124;5467.699276539828;5148.6910785353;5260.89478210426;5286.577073834161;5295.4439783822145;5320.600954928318;5090.490950905028;5108.463611320758;5109.182530795055;5110.207917772603;5119.667221630582;3739.1586892948867;3765.566959799658;3772.452994315754;3777.490038844721;3809.142942837839;5178.840907046774;5283.101872681576;5322.095243808484;5343.145096784496;5434.3750468695025;5173.198154286091;5245.737713114406;5266.631335806457;5273.7363131842485;5276.70978096193;5216.634835561475;5233.136532472099;5233.8018032427235;5249.606279529127;5280.287161233185;4990.525900039491;5014.52362025607;5142.1772516397195;5149.742512874416;5154.525827602846;5051.848444546669;5160.845174644766;5260.868478288074;5314.920276195783;5316.989771943318;5171.715555644325;5190.506901844319;5194.35070616173;5214.35747739476;5224.399194092728 22:18:56 INFO - PROCESS | 22184 | |5;yui.html;638.4955884850968;677.8949262864252;685.3622664494372;694.8471336306012;720.2545365546661;12033.51865925363;12438.502459901592;12503.18729282597;12586.307753073577;12595.937020314897;12599.370031498434;12679.683007924807;12683.04877134214;12713.809292860615;12751.489940402373;609.0863704443335;760.8820632801911;761.649641165062;768.5696010234286;788.0976282156927;762.2034973452727;772.1776308231744;772.2740623813597;774.1909704358931;774.9186335434782;819.8360327934437;820.2371794231362;822.383212590557;822.9300509456704;825.1583384947351;806.6974884418372;813.1949370123565;813.3818298093432;814.7107776739232;815.8001289684006;595.6396380189966;595.8480587450216;596.9343372229051;598.8622616798161;599.1581827532281;12210.26738395699;12267.877321226762;12330.938345308306;12340.074494412955;12351.691207719789;12932.870671293354;13181;13362.599122026355;13405.329733513383;13458.663533411645;10482.280523516447;10548.683539493828;10559.577616895314;10764.70823501177;10884.510197041152;3350.4136776064333;3380.290139070798;3401.149712571857;3413.368526822546;3444.8277586120844;54790;55043;55102.44897551013;56535.15197272044;56737.71631141818;10174.287799853939;10291.228157888188;10343.224258180666;10430.113440357503;10471.057604815604;19024.61950761005;19420;19431.514212144528;19432.12555435009;19434.70847937282;6506.642134682638;6974.128233970754;6991.685374158175;7136.892946605805;7150.320719531636;3666.6699996999864;3667.3803784169295;3700.726464787667;3778.414345776409;3782.3759079751535;2794.1338185162663;2914.198595386286;2928.3264849084403;2930.6629737580024;2943.5878976943245;494.7353166056143;495.25958691755335;501.8469366843148;503.47386980605353;511.2229411294811;456.61187990208055;460.4658596028591;531.1899353485965;544.9536789372947;561.5255109432604;7763.456558040996;8025.759227223192;8113.229243221885;8199.385046121446;8365.916340836635;566.6939852479615;572.1132245020202;575.7955925646419;577.6591810831629;584.9181114643953;3549.591796943333;3578.7852728835833;3608.5850127235703;3656.542932133483;3727.5154229949935;82098.58950705208;89062.55468722615;90974.54512727527;91063.08936910547;92272;51186;54651.72674136683;76373;76955;79383.60308198423;71968.64015679993;72520.23610868906;72905;73453.26546734678;73589.63205184047;7437.405007599487;7508;7508.174100849012;7674.654640541301;7711.151773305044;42020.36969445522;42590.361144583476;43717.56282437135;44575.77712111419;45100.548994510944;57765.71117144387;61156.69421653041;61509;61573.69213153906;61742.0738688911;8988;9119.49842758628;9163.816723665623;9272.026437223994;9329.486878221764;10530.368177909044;10660;10661.307015043998;10760.838587421038;10792.56829726802;9657.420554766737;9816;9859.605615775288;10132.13876820449;10151.492425378849;9657;9739;9788.119069283799;9879.308448408543;10081.495925203564;9142.725718228463;9328.860067098864;9423;9443;9627.470489123165;8167.877481837896;8187.995582660911;8301.252887240178;8536.530490823065;8562.315014798676;8423.747287581382;8507.787305317417;8548.273396761097;8729.51987640686;8740.650373984969 22:18:56 INFO - PROCESS | 22184 | __end_tp_report 22:18:56 INFO - PROCESS | 22184 | __start_cc_report 22:18:56 INFO - PROCESS | 22184 | _x_x_mozilla_cycle_collect,392 22:18:56 INFO - PROCESS | 22184 | __end_cc_report 22:18:56 INFO - PROCESS | 22184 | __startTimestamp1465276736931__endTimestamp 22:18:56 INFO - PROCESS | 22184 | 22:18:56 INFO - PROCESS | 22184 | ------- Summary: start ------- 22:18:56 INFO - PROCESS | 22184 | Number of tests: 6 22:18:56 INFO - PROCESS | 22184 | 22:18:56 INFO - PROCESS | 22184 | [#0] dojo.html Cycles:165 Average:4726.17 Median:4897.27 stddev:618.68 (12.6%) stddev-sans-first:599.37 22:18:56 INFO - PROCESS | 22184 | Values: 2679.0 2717.8 2724.2 2729.1 2730.2 4670.3 4722.1 4757.4 4781.3 4825.8 4715.3 4715.7 4750.0 4762.0 4801.0 4402.8 4428.4 4453.4 4533.1 4578.8 38.6 4424.5 4502.8 4510.8 4526.3 4365.0 4374.9 4407.1 4443.8 4446.3 4373.6 4393.7 4393.9 4414.0 4436.2 4278.3 4311.9 4374.8 4397.3 4429.1 4649.2 4660.8 4664.7 4699.1 4724.1 5106.8 5119.6 5132.0 5135.5 5211.9 5060.2 5112.3 5169.0 5192.2 5232.6 4813.1 4822.8 4831.3 4839.4 4893.6 5331.1 5335.5 5336.6 5337.3 5340.6 4983.8 5036.2 5055.7 5080.9 5090.0 5157.3 5176.9 5186.9 5199.4 5239.6 5020.5 5128.5 5129.6 5137.5 5138.9 4990.2 5031.3 5064.8 5107.5 5134.0 4295.8 4335.0 4358.4 4362.0 4396.1 3727.6 3793.5 3805.1 3811.5 3874.2 4379.9 4428.4 4428.6 4456.8 4468.0 5076.4 5112.5 5123.7 5136.3 5186.4 4297.4 4418.5 4441.1 4457.3 4510.3 4582.4 4619.1 4624.5 4637.4 4668.3 4888.6 4891.2 4897.3 4901.0 4914.5 4983.2 5089.5 5125.1 5193.1 5218.4 4840.0 4865.6 4873.0 4899.8 4903.0 5052.5 5064.4 5068.4 5071.6 5075.9 5001.1 5166.9 5180.6 5198.7 5222.6 5075.8 5081.7 5094.6 5094.9 5100.2 5076.2 5089.2 5092.5 5098.8 5105.8 4788.9 4805.6 4923.6 4936.0 4968.9 5009.8 5010.5 5021.9 5025.2 5037.2 4949.0 4949.5 4958.3 4959.7 5004.6 22:18:56 INFO - PROCESS | 22184 | 22:18:56 INFO - PROCESS | 22184 | [#1] ext.html Cycles:180 Average:46547.47 Median:36733.04 stddev:86132.07 (234.5%) stddev-sans-first:86304.47 22:18:56 INFO - PROCESS | 22184 | Values: 554.6 600.9 603.4 608.6 619.4 28452.4 31507.1 39444.4 40130.8 40325.0 41727.6 42154.6 42226.6 42264.2 42442.4 7651.2 7803.0 7842.8 7849.6 7854.0 7692.7 7788.4 7789.1 7803.6 7835.9 7794.3 7807.8 7819.9 7827.5 7838.9 7733.4 7803.6 7803.8 7825.7 7834.7 7755.5 7782.9 7803.3 7835.4 7858.2 38238.2 38617.6 38655.6 38725.4 38768.4 3063.5 3191.3 3240.2 3246.6 3306.1 28246.3 28762.8 29161.4 29470.3 29603.0 3465.7 3499.5 3500.2 3520.6 3564.5 244618.0 245511.0 245612.0 245785.8 245882.8 31257.7 50591.5 50778.7 51216.0 51300.7 32749.0 34098.7 34270.8 34306.5 34335.8 13077.4 13099.9 13140.6 13191.9 13208.8 11405.0 11464.2 11528.7 11559.0 11561.9 7899.9 7921.2 7942.2 8001.0 8018.2 3113.9 3114.8 3128.4 3161.1 3186.4 870.4 913.1 915.9 919.3 945.6 27966.2 28109.6 28369.1 28747.6 28774.3 894.8 982.2 991.1 1000.2 1073.0 14642.0 14968.4 15132.6 15214.5 15365.0 383424.0 384324.0 385234.0 388826.0 389123.0 49104.8 49394.3 49710.0 49737.5 49871.0 1197.6 1230.9 1232.4 1245.9 1249.1 25665.0 27289.0 27520.9 28050.6 28078.4 41809.0 42187.6 42252.0 42410.4 42664.8 330314.0 331049.0 331743.0 332687.0 333768.0 22976.2 23212.4 23295.5 23399.3 23452.8 43575.3 45460.8 45561.5 47708.0 48543.8 36676.1 36767.0 36868.0 37086.8 37849.6 36699.1 36892.0 36911.3 37142.6 37385.0 31796.0 34729.0 36061.6 36440.5 37641.0 31984.7 33513.0 33564.8 33582.3 33613.5 24901.8 25310.9 25424.2 25771.6 25974.0 22:18:56 INFO - PROCESS | 22184 | 22:18:56 INFO - PROCESS | 22184 | [#2] jquery.html Cycles:180 Average:23641.70 Median:394252.50 stddev:63964.04 (16.2%) stddev-sans-first:64119.58 22:18:56 INFO - PROCESS | 22184 | Values: 356.3 366.1 367.9 374.1 375.6 15776.3 16615.5 17326.7 17439.7 17565.4 15818.3 16085.0 16889.0 16919.4 16924.7 4909.5 5083.9 5087.0 5114.1 5133.1 3685.7 5038.5 5652.8 5959.0 5967.0 5985.3 5989.5 5990.1 6001.6 6003.2 5647.9 5928.9 5934.1 5945.9 5960.6 5055.7 5134.7 5156.9 5161.9 5167.3 19515.3 19525.3 19653.1 19963.3 20754.3 1895.2 1942.8 1970.3 2018.3 2080.5 12762.0 13019.2 13082.7 13164.9 13228.2 1573.7 1771.8 1809.8 1821.5 1868.4 63750.0 64510.4 65323.3 65786.3 65799.7 8878.9 9025.0 9253.8 9465.7 9601.7 12606.6 12656.6 12669.4 12735.6 12759.6 6888.2 6960.9 6964.4 7104.3 7149.4 6637.6 6669.3 6703.7 6845.2 6868.3 5829.6 5892.3 5938.8 6062.8 6065.3 1541.7 1606.1 1679.1 1687.2 1710.4 856.0 898.4 903.7 980.9 1004.2 16231.8 16829.7 17013.0 17157.7 17394.8 892.0 893.9 895.9 912.3 960.7 9565.2 9832.5 9883.0 9891.2 9999.0 379531.0 390313.0 391741.0 393608.0 394897.0 64071.0 65585.3 65649.3 66208.3 66542.0 888.7 897.7 905.1 920.7 945.9 15150.6 15251.3 15350.0 15436.1 15457.9 31552.0 32153.5 32493.0 32607.7 33051.2 40833.6 42424.4 42585.8 43324.6 47936.5 7267.9 7410.8 7425.6 7637.4 7714.9 11593.8 11631.8 11720.3 11836.2 12173.2 10076.3 10307.5 10342.4 10362.2 10488.4 10140.6 10378.7 10412.3 10553.7 10573.8 10346.3 10560.3 10597.7 10643.6 10706.4 7428.7 7490.7 7596.3 7679.5 7740.1 10260.4 10407.9 10432.7 10594.7 10723.1 22:18:56 INFO - PROCESS | 22184 | 22:18:56 INFO - PROCESS | 22184 | [#3] mootools.html Cycles:180 Average:5147.09 Median:5491.81 stddev:2864.77 (52.2%) stddev-sans-first:2858.82 22:18:56 INFO - PROCESS | 22184 | Values: 1380.7 1415.1 1521.7 1731.8 1744.6 6939.6 7602.2 7603.8 8109.1 8123.8 7640.9 7810.4 7829.7 7950.3 7953.1 2175.1 2199.6 2208.7 2223.4 2223.6 2113.7 2138.2 2178.1 2182.9 2187.6 2087.8 2110.7 2116.5 2129.9 2182.6 2074.8 2080.4 2083.9 2093.1 2109.6 2086.9 2103.2 2127.9 2139.5 2140.3 7835.5 7843.1 7861.2 7890.0 7910.1 4464.8 4522.1 4569.9 4582.3 4587.8 2777.0 2825.3 2865.2 2929.7 2953.4 831.4 840.7 857.2 858.9 863.6 10857.3 10897.8 10919.9 10926.5 10943.5 4175.7 4183.0 4263.2 4278.6 4303.3 9174.1 9195.3 9199.0 9237.5 9267.3 4345.0 4378.4 4413.4 4417.0 4433.5 3589.1 3830.3 3897.0 3966.3 4008.6 3614.2 3646.1 3688.5 3733.1 3777.5 1173.8 1191.0 1205.6 1207.0 1213.8 728.7 846.6 879.6 900.4 926.2 5358.4 5586.8 5669.1 5693.8 5803.3 928.3 948.3 979.7 1004.1 1015.1 3792.5 3835.1 3850.8 3937.9 3956.7 9357.2 9598.9 9603.0 9649.9 9670.3 9394.8 9562.5 9573.6 9579.8 9588.8 6789.4 6998.8 7020.1 7065.3 7087.7 5370.6 5463.1 5479.5 5504.2 5519.4 8283.8 8483.9 8520.5 8606.8 8622.1 8402.4 8797.8 8797.8 8880.2 8904.0 6210.0 6604.1 6702.7 6764.9 6861.7 7638.1 7659.5 7664.3 7682.0 7712.4 6647.1 6744.5 6763.0 6787.6 6863.5 6425.0 6450.3 6473.6 6501.9 6588.2 6548.7 6578.1 6595.2 6639.5 6640.3 4760.6 4763.2 4861.5 4872.5 4883.9 4634.9 4698.7 4752.9 4789.2 4820.8 22:18:56 INFO - PROCESS | 22184 | 22:18:56 INFO - PROCESS | 22184 | [#4] prototype.html Cycles:180 Average:4341.23 Median:5028.55 stddev:1288.32 (25.6%) stddev-sans-first:1255.48 22:18:56 INFO - PROCESS | 22184 | Values: 287.3 289.6 291.0 292.7 293.0 5087.3 5099.5 5109.6 5116.3 5136.4 4987.6 4989.8 5020.1 5037.0 5042.5 3680.3 3776.4 3886.8 3888.0 3915.9 3872.9 3890.2 3891.6 3897.0 3901.3 3841.0 3871.5 3873.7 3877.9 3888.2 3796.1 3842.9 3845.2 3882.4 3883.7 3397.1 3398.3 3413.7 3430.2 3433.2 4769.8 4782.1 4821.6 4827.3 4833.5 4417.5 4461.7 4464.8 4469.0 4486.9 4918.2 5227.7 5239.1 5258.3 5279.2 3611.7 3614.4 3631.5 3638.6 3651.9 5530.7 5534.9 5554.0 5559.2 5579.7 3581.3 3702.5 3713.4 3715.3 3732.8 3763.0 3772.5 3774.2 3777.9 3787.3 4301.0 4342.0 4348.3 4365.3 4368.4 5106.9 5163.2 5221.4 5249.9 5312.0 1251.9 1265.7 1268.7 1270.0 1275.4 783.0 804.8 812.3 816.3 818.2 4482.8 4594.6 4614.7 4645.1 4662.7 5461.0 5471.5 5471.7 5479.7 5509.6 4472.5 4607.4 4621.5 4637.9 4666.8 2861.3 2902.5 2938.4 2938.9 2939.6 5144.7 5175.4 5196.0 5204.9 5209.2 5427.5 5490.9 5505.1 5594.7 5605.0 5051.9 5099.7 5104.4 5109.6 5111.4 5395.4 5409.4 5432.9 5446.0 5467.7 5148.7 5260.9 5286.6 5295.4 5320.6 5090.5 5108.5 5109.2 5110.2 5119.7 3739.2 3765.6 3772.5 3777.5 3809.1 5178.8 5283.1 5322.1 5343.1 5434.4 5173.2 5245.7 5266.6 5273.7 5276.7 5216.6 5233.1 5233.8 5249.6 5280.3 4990.5 5014.5 5142.2 5149.7 5154.5 5051.8 5160.8 5260.9 5314.9 5317.0 5171.7 5190.5 5194.4 5214.4 5224.4 22:18:56 INFO - PROCESS | 22184 | 22:18:56 INFO - PROCESS | 22184 | [#5] yui.html Cycles:180 Average:16358.84 Median:590.28 stddev:23122.02 (3917.1%) stddev-sans-first:23156.76 22:18:56 INFO - PROCESS | 22184 | Values: 638.5 677.9 685.4 694.8 720.3 12033.5 12438.5 12503.2 12586.3 12595.9 12599.4 12679.7 12683.0 12713.8 12751.5 609.1 760.9 761.6 768.6 788.1 762.2 772.2 772.3 774.2 774.9 819.8 820.2 822.4 822.9 825.2 806.7 813.2 813.4 814.7 815.8 595.6 595.8 596.9 598.9 599.2 12210.3 12267.9 12330.9 12340.1 12351.7 12932.9 13181.0 13362.6 13405.3 13458.7 10482.3 10548.7 10559.6 10764.7 10884.5 3350.4 3380.3 3401.1 3413.4 3444.8 54790.0 55043.0 55102.4 56535.2 56737.7 10174.3 10291.2 10343.2 10430.1 10471.1 19024.6 19420.0 19431.5 19432.1 19434.7 6506.6 6974.1 6991.7 7136.9 7150.3 3666.7 3667.4 3700.7 3778.4 3782.4 2794.1 2914.2 2928.3 2930.7 2943.6 494.7 495.3 501.8 503.5 511.2 456.6 460.5 531.2 545.0 561.5 7763.5 8025.8 8113.2 8199.4 8365.9 566.7 572.1 575.8 577.7 584.9 3549.6 3578.8 3608.6 3656.5 3727.5 82098.6 89062.6 90974.5 91063.1 92272.0 51186.0 54651.7 76373.0 76955.0 79383.6 71968.6 72520.2 72905.0 73453.3 73589.6 7437.4 7508.0 7508.2 7674.7 7711.2 42020.4 42590.4 43717.6 44575.8 45100.5 57765.7 61156.7 61509.0 61573.7 61742.1 8988.0 9119.5 9163.8 9272.0 9329.5 10530.4 10660.0 10661.3 10760.8 10792.6 9657.4 9816.0 9859.6 10132.1 10151.5 9657.0 9739.0 9788.1 9879.3 10081.5 9142.7 9328.9 9423.0 9443.0 9627.5 8167.9 8188.0 8301.3 8536.5 8562.3 8423.7 8507.8 8548.3 8729.5 8740.7 22:18:56 INFO - PROCESS | 22184 | -------- Summary: end -------- 22:18:56 INFO - PROCESS | 22184 | 22:18:57 INFO - TEST-INFO | 22184: exit 0 22:18:57 INFO - TEST-OK | dromaeo_css | took 1114378ms 22:18:57 INFO - TEST-START | kraken 22:18:57 INFO - operating with platform_type : linux_ 22:18:57 INFO - Initialising browser for kraken test... 22:18:57 INFO - TEST-INFO | started process 22422 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJTNENt/profile http://localhost:40334/getInfo.html) 22:19:02 INFO - PROCESS | 22422 | __metrics Screen width/height:1600/1200 22:19:02 INFO - PROCESS | 22422 | colorDepth:24 22:19:02 INFO - PROCESS | 22422 | Browser inner width/height: 1024/697 22:19:02 INFO - PROCESS | 22422 | __metrics 22:19:02 ERROR - PROCESS | 22422 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2944: TypeError: this.tabs is undefined 22:19:03 INFO - TEST-INFO | 22422: exit 0 22:19:03 INFO - Browser initialized. 22:19:03 INFO - Running cycle 1/1 for kraken test... 22:19:03 INFO - TEST-INFO | started process 22540 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJTNENt/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:19:15 INFO - PROCESS | 22540 | RSS: Main: 167899136 22:19:15 INFO - PROCESS | 22540 | 22:19:18 INFO - PROCESS | 22540 | Cycle 1(1): loaded http://localhost:40334/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40334/tests/kraken/driver.html?testName=audio-beat-detection) 22:19:19 INFO - PROCESS | 22540 | RSS: Main: 173346816 22:19:19 INFO - PROCESS | 22540 | 22:19:22 INFO - PROCESS | 22540 | Cycle 1(1): loaded http://localhost:40334/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40334/tests/kraken/driver.html?testName=audio-dft) 22:19:22 INFO - PROCESS | 22540 | RSS: Main: 173023232 22:19:22 INFO - PROCESS | 22540 | 22:19:25 INFO - PROCESS | 22540 | Cycle 1(1): loaded http://localhost:40334/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40334/tests/kraken/driver.html?testName=audio-fft) 22:19:26 INFO - PROCESS | 22540 | RSS: Main: 168316928 22:19:26 INFO - PROCESS | 22540 | 22:19:28 INFO - PROCESS | 22540 | Cycle 1(1): loaded http://localhost:40334/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40334/tests/kraken/driver.html?testName=audio-oscillator) 22:19:29 INFO - PROCESS | 22540 | RSS: Main: 168660992 22:19:29 INFO - PROCESS | 22540 | 22:19:31 INFO - PROCESS | 22540 | Cycle 1(1): loaded http://localhost:40334/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40334/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:19:32 INFO - PROCESS | 22540 | RSS: Main: 168943616 22:19:32 INFO - PROCESS | 22540 | 22:19:35 INFO - PROCESS | 22540 | Cycle 1(1): loaded http://localhost:40334/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40334/tests/kraken/driver.html?testName=imaging-darkroom) 22:19:35 INFO - PROCESS | 22540 | RSS: Main: 169230336 22:19:35 INFO - PROCESS | 22540 | 22:19:39 INFO - PROCESS | 22540 | Cycle 1(1): loaded http://localhost:40334/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40334/tests/kraken/driver.html?testName=imaging-desaturate) 22:19:40 INFO - PROCESS | 22540 | RSS: Main: 166871040 22:19:40 INFO - PROCESS | 22540 | 22:19:43 INFO - PROCESS | 22540 | Cycle 1(1): loaded http://localhost:40334/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40334/tests/kraken/driver.html?testName=json-parse-financial) 22:19:43 INFO - PROCESS | 22540 | RSS: Main: 168091648 22:19:43 INFO - PROCESS | 22540 | 22:19:45 INFO - PROCESS | 22540 | Cycle 1(1): loaded http://localhost:40334/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40334/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:19:46 INFO - PROCESS | 22540 | RSS: Main: 168300544 22:19:46 INFO - PROCESS | 22540 | 22:19:47 INFO - PROCESS | 22540 | Cycle 1(1): loaded http://localhost:40334/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40334/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:19:48 INFO - PROCESS | 22540 | RSS: Main: 168542208 22:19:48 INFO - PROCESS | 22540 | 22:19:50 INFO - PROCESS | 22540 | Cycle 1(1): loaded http://localhost:40334/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40334/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:19:51 INFO - PROCESS | 22540 | RSS: Main: 169046016 22:19:51 INFO - PROCESS | 22540 | 22:19:54 INFO - PROCESS | 22540 | Cycle 1(1): loaded http://localhost:40334/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40334/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:19:55 INFO - PROCESS | 22540 | RSS: Main: 168865792 22:19:55 INFO - PROCESS | 22540 | 22:19:57 INFO - PROCESS | 22540 | Cycle 1(1): loaded http://localhost:40334/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40334/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:19:58 INFO - PROCESS | 22540 | RSS: Main: 168808448 22:19:58 INFO - PROCESS | 22540 | 22:20:00 INFO - PROCESS | 22540 | Cycle 1(1): loaded http://localhost:40334/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40334/tests/kraken/driver.html?testName=ai-astar) 22:20:00 INFO - PROCESS | 22540 | RSS: Main: 169562112 22:20:00 INFO - PROCESS | 22540 | 22:20:00 INFO - PROCESS | 22540 | __start_tp_report 22:20:00 INFO - PROCESS | 22540 | _x_x_mozilla_page_load 22:20:00 INFO - PROCESS | 22540 | _x_x_mozilla_page_load_details 22:20:00 INFO - PROCESS | 22540 | |i|pagename|runs| 22:20:00 INFO - PROCESS | 22540 | |0;ai-astar;115;108;117;115;113;114;114;113;116;115 22:20:00 INFO - PROCESS | 22540 | |1;audio-beat-detection;154;133;156;203;131;159;159;134;199;136 22:20:00 INFO - PROCESS | 22540 | |2;audio-dft;163;164;164;177;162;163;166;163;162;167 22:20:00 INFO - PROCESS | 22540 | |3;audio-fft;76;75;78;164;76;76;75;76;165;77 22:20:00 INFO - PROCESS | 22540 | |4;audio-oscillator;86;86;146;91;87;85;131;85;86;144 22:20:00 INFO - PROCESS | 22540 | |5;imaging-gaussian-blur;118;118;119;117;117;118;118;117;118;122 22:20:00 INFO - PROCESS | 22540 | |6;imaging-darkroom;148;148;149;148;147;149;147;149;147;146 22:20:00 INFO - PROCESS | 22540 | |7;imaging-desaturate;95;96;96;95;97;96;96;100;100;95 22:20:00 INFO - PROCESS | 22540 | |8;json-parse-financial;63;64;64;65;65;67;65;64;68;64 22:20:00 INFO - PROCESS | 22540 | |9;json-stringify-tinderbox;65;65;66;65;68;65;65;66;65;65 22:20:00 INFO - PROCESS | 22540 | |10;stanford-crypto-aes;87;83;85;90;92;86;92;85;115;85 22:20:00 INFO - PROCESS | 22540 | |11;stanford-crypto-ccm;134;130;141;144;142;143;133;136;148;136 22:20:00 INFO - PROCESS | 22540 | |12;stanford-crypto-pbkdf2;174;173;172;171;171;173;177;169;166;165 22:20:00 INFO - PROCESS | 22540 | |13;stanford-crypto-sha256-iterative;67;71;70;70;67;70;66;66;68;66 22:20:00 INFO - PROCESS | 22540 | __end_tp_report 22:20:00 INFO - PROCESS | 22540 | __start_cc_report 22:20:00 INFO - PROCESS | 22540 | _x_x_mozilla_cycle_collect,972 22:20:00 INFO - PROCESS | 22540 | __end_cc_report 22:20:00 INFO - PROCESS | 22540 | __startTimestamp1465276800554__endTimestamp 22:20:00 INFO - PROCESS | 22540 | 22:20:00 INFO - PROCESS | 22540 | ------- Summary: start ------- 22:20:00 INFO - PROCESS | 22540 | Number of tests: 14 22:20:00 INFO - PROCESS | 22540 | 22:20:00 INFO - PROCESS | 22540 | [#0] ai-astar Cycles:10 Average:114.00 Median:115.00 stddev:2.45 (2.1%) stddev-sans-first:2.57 22:20:00 INFO - PROCESS | 22540 | Values: 115.0 108.0 117.0 115.0 113.0 114.0 114.0 113.0 116.0 115.0 22:20:00 INFO - PROCESS | 22540 | 22:20:00 INFO - PROCESS | 22540 | [#1] audio-beat-detection Cycles:10 Average:156.40 Median:157.50 stddev:26.07 (16.6%) stddev-sans-first:27.64 22:20:00 INFO - PROCESS | 22540 | Values: 154.0 133.0 156.0 203.0 131.0 159.0 159.0 134.0 199.0 136.0 22:20:00 INFO - PROCESS | 22540 | 22:20:00 INFO - PROCESS | 22540 | [#2] audio-dft Cycles:10 Average:165.10 Median:164.00 stddev:4.48 (2.7%) stddev-sans-first:4.69 22:20:00 INFO - PROCESS | 22540 | Values: 163.0 164.0 164.0 177.0 162.0 163.0 166.0 163.0 162.0 167.0 22:20:00 INFO - PROCESS | 22540 | 22:20:00 INFO - PROCESS | 22540 | [#3] audio-fft Cycles:10 Average:93.80 Median:76.00 stddev:37.27 (49.0%) stddev-sans-first:38.97 22:20:00 INFO - PROCESS | 22540 | Values: 76.0 75.0 78.0 164.0 76.0 76.0 75.0 76.0 165.0 77.0 22:20:00 INFO - PROCESS | 22540 | 22:20:00 INFO - PROCESS | 22540 | [#4] audio-oscillator Cycles:10 Average:102.70 Median:86.00 stddev:26.31 (30.6%) stddev-sans-first:27.20 22:20:00 INFO - PROCESS | 22540 | Values: 86.0 86.0 146.0 91.0 87.0 85.0 131.0 85.0 86.0 144.0 22:20:00 INFO - PROCESS | 22540 | 22:20:00 INFO - PROCESS | 22540 | [#5] imaging-gaussian-blur Cycles:10 Average:118.20 Median:118.00 stddev:1.48 (1.3%) stddev-sans-first:1.56 22:20:00 INFO - PROCESS | 22540 | Values: 118.0 118.0 119.0 117.0 117.0 118.0 118.0 117.0 118.0 122.0 22:20:00 INFO - PROCESS | 22540 | 22:20:00 INFO - PROCESS | 22540 | [#6] imaging-darkroom Cycles:10 Average:147.80 Median:148.00 stddev:1.03 (0.7%) stddev-sans-first:1.09 22:20:00 INFO - PROCESS | 22540 | Values: 148.0 148.0 149.0 148.0 147.0 149.0 147.0 149.0 147.0 146.0 22:20:00 INFO - PROCESS | 22540 | 22:20:00 INFO - PROCESS | 22540 | [#7] imaging-desaturate Cycles:10 Average:96.60 Median:96.00 stddev:1.90 (2.0%) stddev-sans-first:1.92 22:20:00 INFO - PROCESS | 22540 | Values: 95.0 96.0 96.0 95.0 97.0 96.0 96.0 100.0 100.0 95.0 22:20:00 INFO - PROCESS | 22540 | 22:20:00 INFO - PROCESS | 22540 | [#8] json-parse-financial Cycles:10 Average:64.90 Median:65.00 stddev:1.52 (2.3%) stddev-sans-first:1.45 22:20:00 INFO - PROCESS | 22540 | Values: 63.0 64.0 64.0 65.0 65.0 67.0 65.0 64.0 68.0 64.0 22:20:00 INFO - PROCESS | 22540 | 22:20:00 INFO - PROCESS | 22540 | [#9] json-stringify-tinderbox Cycles:10 Average:65.50 Median:65.00 stddev:0.97 (1.5%) stddev-sans-first:1.01 22:20:00 INFO - PROCESS | 22540 | Values: 65.0 65.0 66.0 65.0 68.0 65.0 65.0 66.0 65.0 65.0 22:20:00 INFO - PROCESS | 22540 | 22:20:00 INFO - PROCESS | 22540 | [#10] stanford-crypto-aes Cycles:10 Average:90.00 Median:86.50 stddev:9.32 (10.8%) stddev-sans-first:9.82 22:20:00 INFO - PROCESS | 22540 | Values: 87.0 83.0 85.0 90.0 92.0 86.0 92.0 85.0 115.0 85.0 22:20:00 INFO - PROCESS | 22540 | 22:20:00 INFO - PROCESS | 22540 | [#11] stanford-crypto-ccm Cycles:10 Average:138.70 Median:141.50 stddev:5.72 (4.0%) stddev-sans-first:5.80 22:20:00 INFO - PROCESS | 22540 | Values: 134.0 130.0 141.0 144.0 142.0 143.0 133.0 136.0 148.0 136.0 22:20:00 INFO - PROCESS | 22540 | 22:20:00 INFO - PROCESS | 22540 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.10 Median:172.50 stddev:3.63 (2.1%) stddev-sans-first:3.70 22:20:00 INFO - PROCESS | 22540 | Values: 174.0 173.0 172.0 171.0 171.0 173.0 177.0 169.0 166.0 165.0 22:20:00 INFO - PROCESS | 22540 | 22:20:00 INFO - PROCESS | 22540 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.10 Median:69.00 stddev:1.97 (2.9%) stddev-sans-first:2.05 22:20:00 INFO - PROCESS | 22540 | Values: 67.0 71.0 70.0 70.0 67.0 70.0 66.0 66.0 68.0 66.0 22:20:00 INFO - PROCESS | 22540 | -------- Summary: end -------- 22:20:00 INFO - PROCESS | 22540 | 22:20:01 INFO - TEST-INFO | 22540: exit 0 22:20:01 INFO - TEST-OK | kraken | took 63876ms 22:20:01 INFO - SUITE-END | took 1178s 22:20:01 INFO - Completed test suite (00:19:38) 22:20:01 INFO - javascript benchmark 22:20:01 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6329.925325988242, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2679.0355472030064, 2717.782577393809, 2724.223596275062, 2729.1266794625717, 2730.1672989738145, 4670.299455081735, 4722.055588882225, 4757.381540399748, 4781.282807578857, 4825.78283977221, 4715.292706094087, 4715.693479923802, 4750.0, 4761.999980004203, 4800.9519904800945, 4402.779861006953, 4428.380026796235, 4453.376527286183, 4533.138703646297, 4578.771061446931, 38.599190494186345, 4424.535423780505, 4502.819887204508, 4510.842120525782, 4526.298423744325, 4365.0, 4374.868753937355, 4407.140607581523, 4443.755593442359, 4446.266366049598, 4373.584509471595, 4393.692441529094, 4393.890152746175, 4414.0, 4436.223660859369, 4278.315469524861, 4311.892202694927, 4374.78126093694, 4397.31841564558, 4429.092036132617, 4649.163150632885, 4660.790264438075, 4664.696794708333, 4699.060187962421, 4724.126036683225, 5106.8212612558755, 5119.6160287978555, 5132.0249152661245, 5135.460776618439, 5211.9218211726475, 5060.2409638554145, 5112.284280200738, 5169.0, 5192.221166824968, 5232.555232805216, 4813.085513752376, 4822.831200907986, 4831.296717259455, 4839.44346400165, 4893.559579637849, 5331.1470164773455, 5335.466453354634, 5336.573074154058, 5337.2794672719465, 5340.599455040888, 4983.825566105169, 5036.169032109661, 5055.6713813602, 5080.923786143211, 5089.9745501272255, 5157.329547158845, 5176.948230517722, 5186.948130518722, 5199.376074870964, 5239.607029472805, 5020.523050310215, 5128.461511541309, 5129.64092513528, 5137.51193636604, 5138.8972220556125, 4990.151674215392, 5031.345925029723, 5064.797408103708, 5107.54032137102, 5133.974330128325, 4295.82816687329, 4334.959609693651, 4358.36803663467, 4362.018545827227, 4396.098799746044, 3727.5713292971113, 3793.506844110303, 3805.086779173034, 3811.466394704688, 3874.2251549690177, 4379.934300985487, 4428.402165707588, 4428.645708343325, 4456.799444025027, 4468.0, 5076.390833100052, 5112.539871411516, 5123.718195499208, 5136.30659860914, 5186.429492755794, 4297.419848320499, 4418.536053714378, 4441.111777644484, 4457.331400289918, 4510.345999830006, 4582.404287442611, 4619.099275641218, 4624.468186158635, 4637.373954516164, 4668.253079507263, 4888.633352498506, 4891.168501354707, 4897.2654101885, 4900.975495122573, 4914.459409464956, 4983.227599722049, 5089.541941225308, 5125.103106956342, 5193.0652482553505, 5218.4259731430275, 4840.031993601224, 4865.58642515376, 4873.0, 4899.828506002273, 4903.04390643821, 5052.520010598987, 5064.392272927273, 5068.391792984866, 5071.619628527801, 5075.898482030412, 5001.0748011616515, 5166.8966620668125, 5180.61145414103, 5198.662086964335, 5222.608304377263, 5075.771590278372, 5081.745912704424, 5094.569557420427, 5094.872628184325, 5100.183970564692, 5076.18780995039, 5089.211172268304, 5092.5162109601015, 5098.847034588968, 5105.821296254613, 4788.904221915612, 4805.615550756001, 4923.630727695366, 4936.0, 4968.900621987612, 5009.799608015638, 5010.5240002199735, 5021.949780502148, 5025.195968644999, 5037.19404895215, 4948.975255123702, 4949.480304568113, 4958.256261560795, 4959.70241785494, 5004.599632029356], "value": 4690.067409774983, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [554.5702080887314, 600.8557946092938, 603.3588638902185, 608.5831205624148, 619.4270299972527, 28452.430951380986, 31507.054788356356, 39444.40833387498, 40130.79934600323, 40325.0, 41727.582724172746, 42154.57845421545, 42226.57773422265, 42264.15471690564, 42442.36336454948, 7651.234876512346, 7803.0, 7842.843143137163, 7849.5682737449415, 7853.96073019637, 7692.653830577609, 7788.415868809833, 7789.065312162548, 7803.5708036057995, 7835.921640783605, 7794.337481314095, 7807.76576702697, 7819.9218007820045, 7827.491213071161, 7838.9216107838765, 7733.419993500482, 7803.648835802374, 7803.765887023398, 7825.686972521093, 7834.686612535492, 7755.495892767009, 7782.922170778333, 7803.3367163791145, 7835.412344074217, 7858.174891636353, 38238.23523529542, 38617.61382386196, 38655.61344386576, 38725.41911871324, 38768.418473722915, 3063.479208534532, 3191.3457741163006, 3240.1575590346442, 3246.6104067511815, 3306.1073510152123, 28246.293842653893, 28762.81244380519, 29161.416771664448, 29470.263243419085, 29603.0, 3465.6534346565395, 3499.4575840744724, 3500.2124521982605, 3520.6479352064844, 3564.465330200465, 244618.0, 245511.0, 245612.0, 245785.77107114528, 245882.7705861477, 31257.687423125477, 50591.494085059414, 50778.74610626997, 51216.0, 51300.74349628228, 32749.0, 34098.65901341005, 34270.828645856614, 34306.48540271898, 34335.828320858236, 13077.41151648159, 13099.869001309866, 13140.60578182656, 13191.934040329737, 13208.801867971988, 11405.0, 11464.197506174487, 11528.654140375802, 11559.0, 11561.88438115608, 7899.921000789918, 7921.247481489249, 7942.166072562413, 8001.0, 8018.198180182052, 3113.9377212455624, 3114.8131112133347, 3128.3586864692684, 3161.0917955481013, 3186.4105140549073, 870.3820287595878, 913.1097180249204, 915.8826231996953, 919.3380765848578, 945.635930166877, 27966.16101516958, 28109.578356324673, 28369.148925531856, 28747.56878646822, 28774.280642984093, 894.7673604862653, 982.2387649571497, 991.1476130527741, 1000.1698590170287, 1073.0021080395306, 14642.0, 14968.401263949538, 15132.621684457976, 15214.543563693107, 15365.0, 383424.0, 384324.0, 385234.0, 388826.0, 389123.0, 49104.75447622739, 49394.259086113736, 49710.0, 49737.502624973284, 49871.0, 1197.604790419177, 1230.876912308762, 1232.4146030635557, 1245.9439325230387, 1249.0819247852821, 25665.0, 27289.0, 27520.862395687895, 28050.579241311803, 28078.438431230854, 41809.0, 42187.578124218366, 42252.0, 42410.36384454174, 42664.78667606642, 330314.0, 331049.0, 331743.0, 332687.0, 333768.0, 22976.19583314576, 23212.419689507224, 23295.53408931846, 23399.298021059396, 23452.765472345058, 43575.34636980385, 45460.77269613763, 45561.54438455573, 47708.0, 48543.757281213366, 36676.0830979217, 36767.0, 36868.0, 37086.814565927, 37849.62150378461, 36699.08252293714, 36892.0, 36911.261774763814, 37142.62857371392, 37385.0, 31796.0, 34729.0, 36061.63938360583, 36440.453393199656, 37641.0, 31984.6801531991, 33513.0, 33564.832175838965, 33582.328353432305, 33613.495797562566, 24901.750982489943, 25310.873445632653, 25424.237272881845, 25771.613425798252, 25974.0], "value": 16552.086275112182, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [356.2500935530706, 366.06287902968404, 367.86756767563674, 374.14134561182084, 375.60275774120265, 15776.290066946985, 16615.501534953957, 17326.74009889853, 17439.73840392392, 17565.385211517598, 15818.288177032033, 16085.0, 16889.0, 16919.407820726276, 16924.746128808078, 4909.533594308544, 5083.898322033557, 5086.97456512717, 5114.079465696173, 5133.076046311662, 3685.7419980601367, 5038.496150384951, 5652.802151924683, 5958.9702051489685, 5966.970165149168, 5985.25184351956, 5989.490893274077, 5990.101484777275, 6001.639901605918, 6003.219581454405, 5647.887042259153, 5928.881422371572, 5934.080217566284, 5945.9108113378115, 5960.612560183574, 5055.74721263939, 5134.71632091977, 5156.948430515722, 5161.896762064775, 5167.250748641463, 19515.316963906196, 19525.316613918585, 19653.115609797595, 19963.30128445512, 20754.273600424065, 1895.2229585869866, 1942.7571553555806, 1970.3202395173641, 2018.3339497965635, 2080.4798800299927, 12762.0, 13019.153755005895, 13082.672933176651, 13164.86835131646, 13228.206307621573, 1573.6852629474151, 1771.7785276840395, 1809.80092189859, 1821.4699652292138, 1868.4394681595602, 63750.0, 64510.354896451376, 65323.3467665322, 65786.3421365785, 65799.67100164517, 8878.911210887938, 9025.0, 9253.768655783524, 9465.66870159541, 9601.711948641552, 12606.55877044299, 12656.620301390973, 12669.429875655618, 12735.55425560101, 12759.61721148367, 6888.173419189729, 6960.860782784316, 6964.4428445724225, 7104.325089116525, 7149.392301654418, 6637.634930078795, 6669.2997235289595, 6703.711053780589, 6845.247022827485, 6868.347506986828, 5829.62107463022, 5892.292924849045, 5938.792142275, 6062.787802426894, 6065.332813390523, 1541.7070756556218, 1606.1326883482789, 1679.1184628070362, 1687.1732850903215, 1710.3757128647953, 856.0198572634299, 898.4294972692256, 903.7153296711515, 980.9215262778961, 1004.1866088468219, 16231.837681623269, 16829.747553786703, 17013.0, 17157.742633860504, 17394.826051739572, 892.0054139634391, 893.883795106632, 895.9059298773665, 912.2747415804319, 960.6637676813059, 9565.186959108414, 9832.459214743258, 9883.01169883006, 9891.208703303719, 9999.0, 379531.0, 390313.0, 391741.0, 393608.0, 394897.0, 64071.0, 65585.34414655888, 65649.34350656433, 66208.33791662118, 66542.0, 888.7244954064261, 897.7396554998977, 905.1220316293185, 920.6593560382702, 945.924326053914, 15150.621234468785, 15251.313690884159, 15350.0, 15436.073835569901, 15457.922710386376, 31552.0, 32153.517697234092, 32493.0, 32607.673923260463, 33051.17372065718, 40833.59166408417, 42424.36363454489, 42585.787071065686, 43324.56675433205, 47936.5206347932, 7267.854642907007, 7410.777676669709, 7425.554466732014, 7637.350825179699, 7714.884276735741, 11593.826092608786, 11631.76736465283, 11720.296782193096, 11836.230645008047, 12173.20874143178, 10076.345037572535, 10307.536160872629, 10342.37945723259, 10362.171026317727, 10488.370697758159, 10140.594376224868, 10378.688639340831, 10412.32319899204, 10553.683389498327, 10573.841392379274, 10346.275760696679, 10560.313579617301, 10597.735056623338, 10643.574257029632, 10706.357618542912, 7428.73999410018, 7490.737824176345, 7596.316331530189, 7679.500832445873, 7740.071191457061, 10260.435676037889, 10407.895921040692, 10432.739181520523, 10594.682159535227, 10723.142148627934], "value": 8232.076226879119, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1380.675541247807, 1415.0589857744596, 1521.6956608678267, 1731.8354756298156, 1744.6074633207522, 6939.583624982504, 7602.2017688142705, 7603.847923041536, 8109.107998120202, 8123.796905077376, 7640.88538671919, 7810.3751699864015, 7829.686812527492, 7950.324222441085, 7953.085395179542, 2175.0647221694703, 2199.571083638691, 2208.6576580630026, 2223.399682085836, 2223.6219842626792, 2113.714648522453, 2138.1981756841183, 2178.1287485005964, 2182.9345119646355, 2187.639039558471, 2087.8016588424075, 2110.725605671268, 2116.502621883856, 2129.946751331214, 2182.639864422368, 2074.813266805987, 2080.365488525999, 2083.8645488043303, 2093.11042806808, 2109.5675386545877, 2086.91652333908, 2103.2112957640884, 2127.8936053197276, 2139.486523234428, 2140.347194105797, 7835.49069310493, 7843.098043724987, 7861.174576669482, 7889.960550197212, 7910.129885712567, 4464.754438505881, 4522.140793249272, 4569.9314510282375, 4582.266837306049, 4587.816487340502, 2776.986115069412, 2825.265430987958, 2865.2407112115307, 2929.7363237308746, 2953.3945541164226, 831.4304701279643, 840.7267638017607, 857.1728282207637, 858.8754630578594, 863.5595846118462, 10857.34855908648, 10897.83653245202, 10919.945400273027, 10926.453677316182, 10943.507542160622, 4175.707700460999, 4182.958170418317, 4263.232618128766, 4278.593533614302, 4303.311470164758, 9174.082591740773, 9195.264378849675, 9199.0, 9237.491937943478, 9267.304952128618, 4344.9565504344555, 4378.430803995524, 4413.3821265022925, 4416.977915110404, 4433.46798384196, 3589.120665436985, 3830.3488406970882, 3897.0, 3966.345552983783, 4008.5590585035625, 3614.204874927512, 3646.08847788053, 3688.5389326334207, 3733.0667333166707, 3777.54669439669, 1173.841531393268, 1191.0412118244897, 1205.6322821539338, 1206.957756478519, 1213.7936550786387, 728.726727477196, 846.5809424334993, 879.5909901895649, 900.4147304252158, 926.2127191886977, 5358.410574836843, 5586.832395028156, 5669.149627555899, 5693.800716974886, 5803.274590676166, 928.2666693312343, 948.2793077261193, 979.6962941488162, 1004.0662184168647, 1015.1067060986433, 3792.5259342582176, 3835.0987517933263, 3850.8459661613783, 3937.9015524612114, 3956.7032472564674, 9357.20463760588, 9598.856017159747, 9602.95198524003, 9649.855252171223, 9670.323077384515, 9394.765130871783, 9562.521873906417, 9573.569189386495, 9579.760505987406, 9588.808223835484, 6789.3550112740195, 6998.825029374205, 7020.122484689312, 7065.258147894397, 7087.681054352566, 5370.62405631602, 5463.071277882849, 5479.4520547944885, 5504.174373843955, 5519.383251113438, 8283.751487455385, 8483.872741908754, 8520.488770673779, 8606.82786344282, 8622.051574326944, 8402.369822263232, 8797.780055498408, 8797.780055498664, 8880.1563851434, 8903.955480222558, 6209.96895015522, 6604.075429439787, 6702.731890724316, 6764.864702706017, 6861.656917154222, 7638.083429988437, 7659.540427574363, 7664.34853037498, 7681.961590192237, 7712.383009359126, 6647.069410282661, 6744.460443164633, 6762.966185169043, 6787.592744435349, 6863.450923925974, 6425.0, 6450.322716114928, 6473.611583305017, 6501.927182015103, 6588.242352129567, 6548.738050477928, 6578.111954886029, 6595.208574971034, 6639.535232533676, 6640.302768209269, 4760.619150468024, 4763.214069678603, 4861.465238823655, 4872.512748725099, 4883.926741098815, 4634.907301854011, 4698.671093023456, 4752.901711501143, 4789.1858384075485, 4820.783064762164], "value": 4156.269671883644, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [287.3233535025016, 289.62059701790656, 290.97672186225105, 292.7394618789279, 292.99121026369215, 5087.313212716283, 5099.4900509949075, 5109.642325037249, 5116.258142569325, 5136.383633963925, 4987.551120399164, 4989.75051247438, 5020.121478741224, 5036.974815125928, 5042.47054059324, 3680.3191409589313, 3776.433534969749, 3886.805659717017, 3887.9805600972095, 3915.865853110062, 3872.9031774205587, 3890.1636148228126, 3891.6108389161, 3897.0, 3901.2782635212434, 3840.9807950960208, 3871.5160604924386, 3873.6707379872746, 3877.922441551167, 3888.1640447303826, 3796.1268908151005, 3842.9423558646645, 3845.1732877431486, 3882.417637354405, 3883.669888059518, 3397.0997685613333, 3398.2523844754114, 3413.6586341365664, 3430.1767575781882, 3433.1931995980926, 4769.833055843063, 4782.115308667908, 4821.63837712173, 4827.275908613736, 4833.516648335139, 4417.536158703322, 4461.687681862271, 4464.843730469451, 4468.955310446887, 4486.910261794778, 4918.16391213491, 5227.686338819683, 5239.13554263546, 5258.2638430619745, 5279.155335146358, 3611.674949254553, 3614.3855544557487, 3631.509746184258, 3638.5815631202486, 3651.94522082169, 5530.723463826793, 5534.861628459281, 5553.972799927998, 5559.19391688207, 5579.721013949286, 3581.2658405026905, 3702.500162478085, 3713.424419215026, 3715.2569486102348, 3732.8133593320767, 3762.967997281492, 3772.5095737554493, 3774.207416442523, 3777.9433308500393, 3787.337215987191, 4300.956990430056, 4341.956580434218, 4348.2825333819565, 4365.257906155961, 4368.4102646143, 5106.927545215546, 5163.173892177234, 5221.425643179247, 5249.921251181236, 5311.973440132774, 1251.8873301402919, 1265.6645988812973, 1268.657462485124, 1270.0347735720918, 1275.3559452476625, 782.9960850195713, 804.7545498622976, 812.2649002652608, 816.3346872299057, 818.1532114261711, 4482.75344856036, 4594.563516465931, 4614.676972611885, 4645.117427688729, 4662.696924699883, 5461.0, 5471.480209380182, 5471.671699698031, 5479.698616576126, 5509.559235261169, 4472.464011955607, 4607.44710634726, 4621.514740952219, 4637.930431043537, 4666.836660716858, 2861.283230061988, 2902.505209816946, 2938.3682508260827, 2938.941221175607, 2939.5590661400533, 5144.71704056273, 5175.353080864892, 5196.0, 5204.921926171035, 5209.244659524347, 5427.48438898304, 5490.945090549043, 5505.146702261156, 5594.748236329375, 5604.971975140098, 5051.949480505222, 5099.668521546162, 5104.412992505835, 5109.591232701375, 5111.437741848394, 5395.433479484755, 5409.432009639088, 5432.891342173213, 5445.972770136124, 5467.699276539828, 5148.6910785353, 5260.89478210426, 5286.577073834161, 5295.4439783822145, 5320.600954928318, 5090.490950905028, 5108.463611320758, 5109.182530795055, 5110.207917772603, 5119.667221630582, 3739.1586892948867, 3765.566959799658, 3772.452994315754, 3777.490038844721, 3809.142942837839, 5178.840907046774, 5283.101872681576, 5322.095243808484, 5343.145096784496, 5434.3750468695025, 5173.198154286091, 5245.737713114406, 5266.631335806457, 5273.7363131842485, 5276.70978096193, 5216.634835561475, 5233.136532472099, 5233.8018032427235, 5249.606279529127, 5280.287161233185, 4990.525900039491, 5014.52362025607, 5142.1772516397195, 5149.742512874416, 5154.525827602846, 5051.848444546669, 5160.845174644766, 5260.868478288074, 5314.920276195783, 5316.989771943318, 5171.715555644325, 5190.506901844319, 5194.35070616173, 5214.35747739476, 5224.399194092728], "value": 3918.2285957365098, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [638.4955884850968, 677.8949262864252, 685.3622664494372, 694.8471336306012, 720.2545365546661, 12033.51865925363, 12438.502459901592, 12503.18729282597, 12586.307753073577, 12595.937020314897, 12599.370031498434, 12679.683007924807, 12683.04877134214, 12713.809292860615, 12751.489940402373, 609.0863704443335, 760.8820632801911, 761.649641165062, 768.5696010234286, 788.0976282156927, 762.2034973452727, 772.1776308231744, 772.2740623813597, 774.1909704358931, 774.9186335434782, 819.8360327934437, 820.2371794231362, 822.383212590557, 822.9300509456704, 825.1583384947351, 806.6974884418372, 813.1949370123565, 813.3818298093432, 814.7107776739232, 815.8001289684006, 595.6396380189966, 595.8480587450216, 596.9343372229051, 598.8622616798161, 599.1581827532281, 12210.26738395699, 12267.877321226762, 12330.938345308306, 12340.074494412955, 12351.691207719789, 12932.870671293354, 13181.0, 13362.599122026355, 13405.329733513383, 13458.663533411645, 10482.280523516447, 10548.683539493828, 10559.577616895314, 10764.70823501177, 10884.510197041152, 3350.4136776064333, 3380.290139070798, 3401.149712571857, 3413.368526822546, 3444.8277586120844, 54790.0, 55043.0, 55102.44897551013, 56535.15197272044, 56737.71631141818, 10174.287799853939, 10291.228157888188, 10343.224258180666, 10430.113440357503, 10471.057604815604, 19024.61950761005, 19420.0, 19431.514212144528, 19432.12555435009, 19434.70847937282, 6506.642134682638, 6974.128233970754, 6991.685374158175, 7136.892946605805, 7150.320719531636, 3666.6699996999864, 3667.3803784169295, 3700.726464787667, 3778.414345776409, 3782.3759079751535, 2794.1338185162663, 2914.198595386286, 2928.3264849084403, 2930.6629737580024, 2943.5878976943245, 494.7353166056143, 495.25958691755335, 501.8469366843148, 503.47386980605353, 511.2229411294811, 456.61187990208055, 460.4658596028591, 531.1899353485965, 544.9536789372947, 561.5255109432604, 7763.456558040996, 8025.759227223192, 8113.229243221885, 8199.385046121446, 8365.916340836635, 566.6939852479615, 572.1132245020202, 575.7955925646419, 577.6591810831629, 584.9181114643953, 3549.591796943333, 3578.7852728835833, 3608.5850127235703, 3656.542932133483, 3727.5154229949935, 82098.58950705208, 89062.55468722615, 90974.54512727527, 91063.08936910547, 92272.0, 51186.0, 54651.72674136683, 76373.0, 76955.0, 79383.60308198423, 71968.64015679993, 72520.23610868906, 72905.0, 73453.26546734678, 73589.63205184047, 7437.405007599487, 7508.0, 7508.174100849012, 7674.654640541301, 7711.151773305044, 42020.36969445522, 42590.361144583476, 43717.56282437135, 44575.77712111419, 45100.548994510944, 57765.71117144387, 61156.69421653041, 61509.0, 61573.69213153906, 61742.0738688911, 8988.0, 9119.49842758628, 9163.816723665623, 9272.026437223994, 9329.486878221764, 10530.368177909044, 10660.0, 10661.307015043998, 10760.838587421038, 10792.56829726802, 9657.420554766737, 9816.0, 9859.605615775288, 10132.13876820449, 10151.492425378849, 9657.0, 9739.0, 9788.119069283799, 9879.308448408543, 10081.495925203564, 9142.725718228463, 9328.860067098864, 9423.0, 9443.0, 9627.470489123165, 8167.877481837896, 8187.995582660911, 8301.252887240178, 8536.530490823065, 8562.315014798676, 8423.747287581382, 8507.787305317417, 8548.273396761097, 8729.51987640686, 8740.650373984969], "value": 6180.324809519757, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1592.8999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 108.0, 117.0, 115.0, 113.0, 114.0, 114.0, 113.0, 116.0, 115.0], "value": 114.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 133.0, 156.0, 203.0, 131.0, 159.0, 159.0, 134.0, 199.0, 136.0], "value": 156.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 164.0, 164.0, 177.0, 162.0, 163.0, 166.0, 163.0, 162.0, 167.0], "value": 165.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 78.0, 164.0, 76.0, 76.0, 75.0, 76.0, 165.0, 77.0], "value": 93.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 146.0, 91.0, 87.0, 85.0, 131.0, 85.0, 86.0, 144.0], "value": 102.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 119.0, 117.0, 117.0, 118.0, 118.0, 117.0, 118.0, 122.0], "value": 118.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 149.0, 148.0, 147.0, 149.0, 147.0, 149.0, 147.0, 146.0], "value": 147.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 96.0, 95.0, 97.0, 96.0, 96.0, 100.0, 100.0, 95.0], "value": 96.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 64.0, 65.0, 65.0, 67.0, 65.0, 64.0, 68.0, 64.0], "value": 64.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 66.0, 65.0, 68.0, 65.0, 65.0, 66.0, 65.0, 65.0], "value": 65.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 83.0, 85.0, 90.0, 92.0, 86.0, 92.0, 85.0, 115.0, 85.0], "value": 90.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 130.0, 141.0, 144.0, 142.0, 143.0, 133.0, 136.0, 148.0, 136.0], "value": 138.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 173.0, 172.0, 171.0, 171.0, 173.0, 177.0, 169.0, 166.0, 165.0], "value": 171.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 71.0, 70.0, 70.0, 67.0, 70.0, 66.0, 66.0, 68.0, 66.0], "value": 68.1, "unit": "score"}]}]} 22:20:01 INFO - Return code: 0 22:20:01 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 22:20:01 ERROR - # TBPL SUCCESS # 22:20:01 INFO - Running post-action listener: _resource_record_post_action 22:20:01 INFO - ##### 22:20:01 INFO - ##### Finished run-tests step (success) 22:20:01 INFO - ##### 22:20:01 INFO - Running post-run listener: _resource_record_post_run 22:20:01 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 4096; Write bytes: 532783104; Read time: 8; Write time: 443616 22:20:01 INFO - TinderboxPrint: CPU usage
13.4% 22:20:01 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 22:20:01 INFO - TinderboxPrint: I/O write bytes / time
532,783,104 / 443,616 22:20:01 INFO - TinderboxPrint: CPU idle
8,253.0 (86.5%) 22:20:01 INFO - TinderboxPrint: CPU user
1,228.9 (12.9%) 22:20:01 INFO - TinderboxPrint: Swap in / out
0 / 0 22:20:01 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 246755328; Read time: 0; Write time: 227252 22:20:01 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 4096; Write bytes: 286027776; Read time: 8; Write time: 216364 22:20:02 INFO - Running post-run listener: _upload_blobber_files 22:20:02 INFO - Blob upload gear active. 22:20:02 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 22:20:02 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 22:20:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 22:20:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 22:20:02 INFO - (blobuploader) - INFO - Open directory for files ... 22:20:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 22:20:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:20:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:20:08 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 22:20:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:20:08 INFO - (blobuploader) - INFO - Done attempting. 22:20:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 22:20:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:20:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:20:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 22:20:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:20:09 INFO - (blobuploader) - INFO - Done attempting. 22:20:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 22:20:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:20:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:20:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 22:20:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:20:10 INFO - (blobuploader) - INFO - Done attempting. 22:20:10 INFO - (blobuploader) - INFO - Iteration through files over. 22:20:10 INFO - Return code: 0 22:20:10 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 22:20:10 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 22:20:10 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c958c52df5f4f533f1ec687bc5904d6cfedd0cfec7c4057cbdb474290a22a2464da2133233eff78a8ed42d02693143f77d55a6d9a7bc7defe3b2810a7d65c97c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f09f9862a8948a9d524f79116d3f23f52dbd3b6348359198ada8cae425458cea9b8d63338835ffe7c7b0d9e63a6a4f4469ed4c93cddf87e9812332f3b10312e6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d6b1f203bc028f2fac560a89e6ead82e9bea5bb74e9dc85f5214c77941bb78b7a41accfc8878c8137739919b8da26f694cbdd396311bc550b44c52cbbf25d6d2"} 22:20:10 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 22:20:10 INFO - Writing to file /builds/slave/test/properties/blobber_files 22:20:10 INFO - Contents: 22:20:10 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c958c52df5f4f533f1ec687bc5904d6cfedd0cfec7c4057cbdb474290a22a2464da2133233eff78a8ed42d02693143f77d55a6d9a7bc7defe3b2810a7d65c97c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f09f9862a8948a9d524f79116d3f23f52dbd3b6348359198ada8cae425458cea9b8d63338835ffe7c7b0d9e63a6a4f4469ed4c93cddf87e9812332f3b10312e6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d6b1f203bc028f2fac560a89e6ead82e9bea5bb74e9dc85f5214c77941bb78b7a41accfc8878c8137739919b8da26f694cbdd396311bc550b44c52cbbf25d6d2"} 22:20:10 INFO - Running post-run listener: copy_logs_to_upload_dir 22:20:10 INFO - Copying logs to upload dir... 22:20:10 INFO - mkdir: /builds/slave/test/build/upload/logs 22:20:10 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1241.420172 ========= master_lag: 0.36 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-06-06 22:20:10.284502) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-06 22:20:10.289148) ========= 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=1f5564757af27664ca02d71f000001b0-1465275104.890256-2033184417 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/Fx-Team-Non-PGO/sha512/c958c52df5f4f533f1ec687bc5904d6cfedd0cfec7c4057cbdb474290a22a2464da2133233eff78a8ed42d02693143f77d55a6d9a7bc7defe3b2810a7d65c97c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f09f9862a8948a9d524f79116d3f23f52dbd3b6348359198ada8cae425458cea9b8d63338835ffe7c7b0d9e63a6a4f4469ed4c93cddf87e9812332f3b10312e6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d6b1f203bc028f2fac560a89e6ead82e9bea5bb74e9dc85f5214c77941bb78b7a41accfc8878c8137739919b8da26f694cbdd396311bc550b44c52cbbf25d6d2"} build_url:https://queue.taskcluster.net/v1/task/AiMBPPaXQoKsDvTd41gqUQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011392 build_url: 'https://queue.taskcluster.net/v1/task/AiMBPPaXQoKsDvTd41gqUQ/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/Fx-Team-Non-PGO/sha512/c958c52df5f4f533f1ec687bc5904d6cfedd0cfec7c4057cbdb474290a22a2464da2133233eff78a8ed42d02693143f77d55a6d9a7bc7defe3b2810a7d65c97c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f09f9862a8948a9d524f79116d3f23f52dbd3b6348359198ada8cae425458cea9b8d63338835ffe7c7b0d9e63a6a4f4469ed4c93cddf87e9812332f3b10312e6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d6b1f203bc028f2fac560a89e6ead82e9bea5bb74e9dc85f5214c77941bb78b7a41accfc8878c8137739919b8da26f694cbdd396311bc550b44c52cbbf25d6d2"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-06 22:20:10.322380) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 22:20:10.322780) ========= 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=1f5564757af27664ca02d71f000001b0-1465275104.890256-2033184417 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004540 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 22:20:10.372618) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-06 22:20:10.376006) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-06 22:20:10.376339) ========= ========= Total master_lag: 0.49 =========