builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-019 starttime: 1468279885.78 results: success (0) buildid: 20160711133152 builduid: 68c12927bce84086bd7c73f9611ba76f revision: 9189a2cc39d0c35e8823349aa0b4057ab8167b32 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-11 16:31:25.778584) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-11 16:31:25.779120) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-11 16:31:25.779440) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-11 16:31:25.795529) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 16:31:25.796016) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1468279875.724993-543624885 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-11 16:31:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.2M=0s 2016-07-11 16:31:26 (46.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.130440 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 16:31:25.971486) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 16:31:25.974904) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1468279875.724993-543624885 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018578 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 16:31:26.024562) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-11 16:31:26.024900) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 9189a2cc39d0c35e8823349aa0b4057ab8167b32 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 9189a2cc39d0c35e8823349aa0b4057ab8167b32 --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=78329bfc0fd5309db0a6e0ac000001b4-1468279875.724993-543624885 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-11 16:31:26,188 truncating revision to first 12 chars 2016-07-11 16:31:26,188 Setting DEBUG logging. 2016-07-11 16:31:26,188 attempt 1/10 2016-07-11 16:31:26,188 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/9189a2cc39d0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-11 16:31:27,490 unpacking tar archive at: mozilla-inbound-9189a2cc39d0/testing/mozharness/ program finished with exit code 0 elapsedTime=1.646793 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-11 16:31:27.688515) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-11 16:31:27.688821) ========= script_repo_revision: 9189a2cc39d0c35e8823349aa0b4057ab8167b32 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-11 16:31:27.689317) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-11 16:31:27.689633) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-11 16:31:27.699342) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 28 secs) (at 2016-07-11 16:31:27.699785) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 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', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] 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=78329bfc0fd5309db0a6e0ac000001b4-1468279875.724993-543624885 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:31:27 INFO - MultiFileLogger online at 20160711 16:31:27 in /builds/slave/test 16:31:27 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 16:31:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:31:27 INFO - {'append_to_log': False, 16:31:27 INFO - 'base_work_dir': '/builds/slave/test', 16:31:27 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 16:31:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:31:27 INFO - 'branch': 'Mozilla-Inbound', 16:31:27 INFO - 'buildbot_json_path': 'buildprops.json', 16:31:27 INFO - 'config_files': ('talos/linux_config.py',), 16:31:27 INFO - 'default_actions': ('clobber', 16:31:27 INFO - 'read-buildbot-config', 16:31:27 INFO - 'download-and-extract', 16:31:27 INFO - 'populate-webroot', 16:31:27 INFO - 'create-virtualenv', 16:31:27 INFO - 'install', 16:31:27 INFO - 'run-tests'), 16:31:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:31:27 INFO - 'download_minidump_stackwalk': True, 16:31:27 INFO - 'download_symbols': 'ondemand', 16:31:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:31:27 INFO - 'tooltool.py': '/tools/tooltool.py', 16:31:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:31:27 INFO - '/tools/misc-python/virtualenv.py')}, 16:31:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:31:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:31:27 INFO - 'installer_path': 'installer.exe', 16:31:27 INFO - 'log_level': 'info', 16:31:27 INFO - 'log_name': 'talos', 16:31:27 INFO - 'log_to_console': True, 16:31:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:31:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:31:27 INFO - 'opt_config_files': (), 16:31:27 INFO - 'pip_index': False, 16:31:27 INFO - 'sps_profile': False, 16:31:27 INFO - 'sps_profile_interval': 0, 16:31:27 INFO - 'suite': 'dromaeojs-e10s', 16:31:27 INFO - 'system_bits': '32', 16:31:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:31:27 INFO - 'title': 'talos-linux64-ix-019', 16:31:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:31:27 INFO - 'use_talos_json': True, 16:31:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:31:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:31:27 INFO - 'work_dir': 'build'} 16:31:27 INFO - ##### 16:31:27 INFO - ##### Running clobber step. 16:31:27 INFO - ##### 16:31:27 INFO - Running pre-action listener: _resource_record_pre_action 16:31:27 INFO - Running main action method: clobber 16:31:27 INFO - rmtree: /builds/slave/test/build 16:31:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:31:28 INFO - Running post-action listener: _resource_record_post_action 16:31:28 INFO - ##### 16:31:28 INFO - ##### Finished clobber step (success) 16:31:28 INFO - ##### 16:31:28 INFO - ##### 16:31:28 INFO - ##### Running read-buildbot-config step. 16:31:28 INFO - ##### 16:31:28 INFO - Running pre-action listener: _resource_record_pre_action 16:31:28 INFO - Running main action method: read_buildbot_config 16:31:28 INFO - Using buildbot properties: 16:31:28 INFO - { 16:31:28 INFO - "project": "", 16:31:28 INFO - "product": "firefox", 16:31:28 INFO - "script_repo_revision": "production", 16:31:28 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 16:31:28 INFO - "repository": "", 16:31:28 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 16:31:28 INFO - "buildid": "20160711133152", 16:31:28 INFO - "pgo_build": "True", 16:31:28 INFO - "basedir": "/builds/slave/test", 16:31:28 INFO - "buildnumber": 811, 16:31:28 INFO - "slavename": "talos-linux64-ix-019", 16:31:28 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 16:31:28 INFO - "platform": "ubuntu64_hw", 16:31:28 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 16:31:28 INFO - "branch": "mozilla-inbound", 16:31:28 INFO - "repo_path": "integration/mozilla-inbound", 16:31:28 INFO - "revision": "9189a2cc39d0c35e8823349aa0b4057ab8167b32", 16:31:28 INFO - "stage_platform": "linux64-pgo", 16:31:28 INFO - "builduid": "68c12927bce84086bd7c73f9611ba76f", 16:31:28 INFO - "slavebuilddir": "test" 16:31:28 INFO - } 16:31:28 INFO - Found installer url https://queue.taskcluster.net/v1/task/fJr9ruZITBWsryQTabOb9A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 16:31:28 INFO - Running post-action listener: _resource_record_post_action 16:31:28 INFO - ##### 16:31:28 INFO - ##### Finished read-buildbot-config step (success) 16:31:28 INFO - ##### 16:31:28 INFO - ##### 16:31:28 INFO - ##### Running download-and-extract step. 16:31:28 INFO - ##### 16:31:28 INFO - Running pre-action listener: _resource_record_pre_action 16:31:28 INFO - Running main action method: download_and_extract 16:31:28 INFO - mkdir: /builds/slave/test/build/tests 16:31:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:31:28 INFO - https://queue.taskcluster.net/v1/task/fJr9ruZITBWsryQTabOb9A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 16:31:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fJr9ruZITBWsryQTabOb9A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 16:31:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fJr9ruZITBWsryQTabOb9A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 16:31:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fJr9ruZITBWsryQTabOb9A/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 16:31:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fJr9ruZITBWsryQTabOb9A/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 16:31:29 INFO - Downloaded 1361 bytes. 16:31:29 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 16:31:29 INFO - Using the following test package requirements: 16:31:29 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 16:31:29 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:31:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 16:31:29 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:31:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 16:31:29 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:31:29 INFO - u'jsshell-linux-x86_64.zip'], 16:31:29 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:31:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 16:31:29 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 16:31:29 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:31:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 16:31:29 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:31:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 16:31:29 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:31:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 16:31:29 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:31:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 16:31:29 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:31: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')]} 16:31:29 INFO - https://queue.taskcluster.net/v1/task/fJr9ruZITBWsryQTabOb9A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:31:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fJr9ruZITBWsryQTabOb9A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 16:31:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fJr9ruZITBWsryQTabOb9A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 16:31:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fJr9ruZITBWsryQTabOb9A/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 16:31:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fJr9ruZITBWsryQTabOb9A/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 16:31:30 INFO - Downloaded 24307618 bytes. 16:31:30 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'] 16:31:30 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 16:31:32 INFO - Return code: 0 16:31: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 16:31: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')]} 16:31:32 INFO - https://queue.taskcluster.net/v1/task/fJr9ruZITBWsryQTabOb9A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:31:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fJr9ruZITBWsryQTabOb9A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 16:31:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fJr9ruZITBWsryQTabOb9A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 16:31:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fJr9ruZITBWsryQTabOb9A/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 16:31:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fJr9ruZITBWsryQTabOb9A/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 16:31:33 INFO - Downloaded 24307618 bytes. 16:31: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'] 16:31: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 16:31:34 INFO - Return code: 0 16:31:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:31:34 INFO - https://queue.taskcluster.net/v1/task/fJr9ruZITBWsryQTabOb9A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 16:31:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fJr9ruZITBWsryQTabOb9A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 16:31:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fJr9ruZITBWsryQTabOb9A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 16:31:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fJr9ruZITBWsryQTabOb9A/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 16:31:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fJr9ruZITBWsryQTabOb9A/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 16:31:35 INFO - Downloaded 14403317 bytes. 16:31:35 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'] 16:31:35 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 16:31:35 INFO - Return code: 0 16:31: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')]} 16:31:35 INFO - https://queue.taskcluster.net/v1/task/fJr9ruZITBWsryQTabOb9A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 16:31:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fJr9ruZITBWsryQTabOb9A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 16:31:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fJr9ruZITBWsryQTabOb9A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 16:31:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fJr9ruZITBWsryQTabOb9A/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 16:31:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fJr9ruZITBWsryQTabOb9A/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 16:31:37 INFO - Downloaded 60489570 bytes. 16:31:37 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/fJr9ruZITBWsryQTabOb9A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 16:31:37 INFO - mkdir: /builds/slave/test/properties 16:31:37 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:31:37 INFO - Writing to file /builds/slave/test/properties/build_url 16:31:37 INFO - Contents: 16:31:37 INFO - build_url:https://queue.taskcluster.net/v1/task/fJr9ruZITBWsryQTabOb9A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 16:31:37 INFO - Running post-action listener: _resource_record_post_action 16:31:37 INFO - Running post-action listener: set_extra_try_arguments 16:31:37 INFO - ##### 16:31:37 INFO - ##### Finished download-and-extract step (success) 16:31:37 INFO - ##### 16:31:37 INFO - ##### 16:31:37 INFO - ##### Running populate-webroot step. 16:31:37 INFO - ##### 16:31:37 INFO - Running pre-action listener: _resource_record_pre_action 16:31:37 INFO - Running main action method: populate_webroot 16:31:37 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:31:37 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:31:37 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:31:37 INFO - '--tppagecycles', 16:31:37 INFO - '7'], 16:31:37 INFO - 'tests': ['tsvgm']}}, 16:31:37 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:31:37 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:31:37 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:31:37 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:31:37 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:31:37 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:31:37 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:31:37 INFO - 'talos_options': ['--disable-e10s'], 16:31:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:31:37 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:31:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:31:37 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:31:37 INFO - 'talos_options': ['--disable-e10s'], 16:31:37 INFO - 'tests': ['damp', 'tps']}, 16:31:37 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:31:37 INFO - 'tests': ['damp', 'tps']}, 16:31:37 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:31:37 INFO - 'tests': ['dromaeo_dom']}, 16:31:37 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:31:37 INFO - 'g4': {'talos_options': ['--disable-e10s'], 16:31:37 INFO - 'tests': ['basic_compositor_video']}, 16:31:37 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 16:31:37 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:31:37 INFO - 'tests': ['a11yr', 16:31:37 INFO - 'ts_paint', 16:31:37 INFO - 'tpaint', 16:31:37 INFO - 'sessionrestore', 16:31:37 INFO - 'sessionrestore_no_auto_restore', 16:31:37 INFO - 'tabpaint']}, 16:31:37 INFO - 'other-e10s': {'tests': ['a11yr', 16:31:37 INFO - 'ts_paint', 16:31:37 INFO - 'tpaint', 16:31:37 INFO - 'sessionrestore', 16:31:37 INFO - 'sessionrestore_no_auto_restore', 16:31:37 INFO - 'tabpaint']}, 16:31:37 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:31:37 INFO - 'ts_paint', 16:31:37 INFO - 'tpaint', 16:31:37 INFO - 'sessionrestore', 16:31:37 INFO - 'sessionrestore_no_auto_restore', 16:31:37 INFO - 'tabpaint']}, 16:31:37 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:31:37 INFO - 'ts_paint', 16:31:37 INFO - 'tpaint', 16:31:37 INFO - 'sessionrestore', 16:31:37 INFO - 'sessionrestore_no_auto_restore', 16:31:37 INFO - 'tabpaint']}, 16:31:37 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:31:37 INFO - 'tests': ['a11yr', 16:31:37 INFO - 'ts_paint', 16:31:37 INFO - 'tpaint', 16:31:37 INFO - 'sessionrestore', 16:31:37 INFO - 'sessionrestore_no_auto_restore', 16:31:37 INFO - 'tabpaint']}, 16:31:37 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:31:37 INFO - 'tests': ['a11yr', 16:31:37 INFO - 'ts_paint', 16:31:37 INFO - 'tpaint', 16:31:37 INFO - 'sessionrestore', 16:31:37 INFO - 'sessionrestore_no_auto_restore', 16:31:37 INFO - 'tabpaint']}, 16:31:37 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:31:37 INFO - 'tests': ['tsvgx', 16:31:37 INFO - 'tsvgr_opacity', 16:31:37 INFO - 'tart', 16:31:37 INFO - 'tscrollx', 16:31:37 INFO - 'cart']}, 16:31:37 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:31:37 INFO - 'tsvgr_opacity', 16:31:37 INFO - 'tart', 16:31:37 INFO - 'tscrollx', 16:31:37 INFO - 'cart']}, 16:31:37 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:31:37 INFO - 'talos_options': ['--disable-e10s'], 16:31:37 INFO - 'tests': ['tp5o']}, 16:31:37 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:31:37 INFO - 'tests': ['tp5o']}, 16:31:37 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:31:37 INFO - 'talos_options': ['--disable-e10s', 16:31:37 INFO - '--xperf_path', 16:31:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:31:37 INFO - 'tests': ['tp5n']}, 16:31:37 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:31:37 INFO - 'talos_options': ['--xperf_path', 16:31:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:31:37 INFO - 'tests': ['tp5n']}}, 16:31:37 INFO - 'talos.zip': {'path': '', 16:31:37 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:31:37 INFO - Running post-action listener: _resource_record_post_action 16:31:37 INFO - ##### 16:31:37 INFO - ##### Finished populate-webroot step (success) 16:31:37 INFO - ##### 16:31:37 INFO - ##### 16:31:37 INFO - ##### Running create-virtualenv step. 16:31:37 INFO - ##### 16:31:37 INFO - Running pre-action listener: _resource_record_pre_action 16:31:37 INFO - Running main action method: create_virtualenv 16:31:37 INFO - Creating virtualenv /builds/slave/test/build/venv 16:31:37 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 16:31:37 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:31:37 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:31:37 INFO - Using real prefix '/usr' 16:31:37 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:31:38 INFO - Installing distribute.............................................................................................................................................................................................done. 16:31:40 INFO - Installing pip.................done. 16:31:40 INFO - Return code: 0 16:31:40 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:31:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:31:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:31:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:31:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:31:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31:40 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 0x26a0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28cf400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x295e570>, '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 0x295f470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x295f900>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1468279875.724993-543624885', '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 16:31:40 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 16:31:40 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 16:31:40 INFO - Using env: {'DISPLAY': ':0', 16:31:40 INFO - 'HOME': '/home/cltbld', 16:31:40 INFO - 'LANG': 'en_US.UTF-8', 16:31:40 INFO - 'LANGUAGE': 'en_US:en', 16:31:40 INFO - 'LOGNAME': 'cltbld', 16:31:40 INFO - 'MAIL': '/var/mail/cltbld', 16:31:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:31:40 INFO - 'MOZ_NO_REMOTE': '1', 16:31:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:31:40 INFO - 'NO_EM_RESTART': '1', 16:31:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:31:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:31:40 INFO - 'PWD': '/builds/slave/test', 16:31:40 INFO - 'SHELL': '/bin/bash', 16:31:40 INFO - 'SHLVL': '1', 16:31:40 INFO - 'TERM': 'linux', 16:31:40 INFO - 'TMOUT': '86400', 16:31:40 INFO - 'USER': 'cltbld', 16:31:40 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1468279875.724993-543624885', 16:31:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:31:40 INFO - '_': '/tools/buildbot/bin/python'} 16:31:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:31:40 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 16:31:40 INFO - Cleaning up... 16:31:40 INFO - Return code: 0 16:31:40 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:31:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:31:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:31:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:31:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:31:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31:40 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 0x26a0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28cf400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x295e570>, '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 0x295f470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x295f900>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1468279875.724993-543624885', '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 16:31:40 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 16:31:40 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 16:31:40 INFO - Using env: {'DISPLAY': ':0', 16:31:40 INFO - 'HOME': '/home/cltbld', 16:31:40 INFO - 'LANG': 'en_US.UTF-8', 16:31:40 INFO - 'LANGUAGE': 'en_US:en', 16:31:40 INFO - 'LOGNAME': 'cltbld', 16:31:40 INFO - 'MAIL': '/var/mail/cltbld', 16:31:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:31:40 INFO - 'MOZ_NO_REMOTE': '1', 16:31:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:31:40 INFO - 'NO_EM_RESTART': '1', 16:31:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:31:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:31:40 INFO - 'PWD': '/builds/slave/test', 16:31:40 INFO - 'SHELL': '/bin/bash', 16:31:40 INFO - 'SHLVL': '1', 16:31:40 INFO - 'TERM': 'linux', 16:31:40 INFO - 'TMOUT': '86400', 16:31:40 INFO - 'USER': 'cltbld', 16:31:40 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1468279875.724993-543624885', 16:31:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:31:40 INFO - '_': '/tools/buildbot/bin/python'} 16:31:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:31:40 INFO - Downloading/unpacking psutil>=3.1.1 16:31:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:31:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:31:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:31:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:31:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:31:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:31:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:31:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:31:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:31:42 INFO - Installing collected packages: psutil 16:31:42 INFO - Running setup.py install for psutil 16:31:42 INFO - building 'psutil._psutil_linux' extension 16:31:42 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 16:31:43 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 16:31:43 INFO - building 'psutil._psutil_posix' extension 16:31:43 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 16:31:43 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 16:31:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:31:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:31:43 INFO - Successfully installed psutil 16:31:43 INFO - Cleaning up... 16:31:43 INFO - Return code: 0 16:31:43 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:31:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:31:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:31:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:31:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:31:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31:43 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 0x26a0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28cf400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x295e570>, '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 0x295f470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x295f900>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1468279875.724993-543624885', '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 16:31:43 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 16:31:43 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 16:31:43 INFO - Using env: {'DISPLAY': ':0', 16:31:43 INFO - 'HOME': '/home/cltbld', 16:31:43 INFO - 'LANG': 'en_US.UTF-8', 16:31:43 INFO - 'LANGUAGE': 'en_US:en', 16:31:43 INFO - 'LOGNAME': 'cltbld', 16:31:43 INFO - 'MAIL': '/var/mail/cltbld', 16:31:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:31:43 INFO - 'MOZ_NO_REMOTE': '1', 16:31:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:31:43 INFO - 'NO_EM_RESTART': '1', 16:31:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:31:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:31:43 INFO - 'PWD': '/builds/slave/test', 16:31:43 INFO - 'SHELL': '/bin/bash', 16:31:43 INFO - 'SHLVL': '1', 16:31:43 INFO - 'TERM': 'linux', 16:31:43 INFO - 'TMOUT': '86400', 16:31:43 INFO - 'USER': 'cltbld', 16:31:43 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1468279875.724993-543624885', 16:31:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:31:43 INFO - '_': '/tools/buildbot/bin/python'} 16:31:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:31:43 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:31:43 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 16:31:43 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 16:31:43 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 16:31:43 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 16:31:43 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 16:31:43 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 16:31:45 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:31:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:31:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:31:45 INFO - Installing collected packages: mozsystemmonitor 16:31:45 INFO - Running setup.py install for mozsystemmonitor 16:31:45 INFO - Successfully installed mozsystemmonitor 16:31:45 INFO - Cleaning up... 16:31:45 INFO - Return code: 0 16:31:45 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:31:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:31:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:31:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:31:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:31:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x26a0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28cf400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x295e570>, '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 0x295f470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x295f900>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1468279875.724993-543624885', '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 16:31:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 16:31:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 16:31:45 INFO - Using env: {'DISPLAY': ':0', 16:31:45 INFO - 'HOME': '/home/cltbld', 16:31:45 INFO - 'LANG': 'en_US.UTF-8', 16:31:45 INFO - 'LANGUAGE': 'en_US:en', 16:31:45 INFO - 'LOGNAME': 'cltbld', 16:31:45 INFO - 'MAIL': '/var/mail/cltbld', 16:31:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:31:45 INFO - 'MOZ_NO_REMOTE': '1', 16:31:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:31:45 INFO - 'NO_EM_RESTART': '1', 16:31:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:31:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:31:45 INFO - 'PWD': '/builds/slave/test', 16:31:45 INFO - 'SHELL': '/bin/bash', 16:31:45 INFO - 'SHLVL': '1', 16:31:45 INFO - 'TERM': 'linux', 16:31:45 INFO - 'TMOUT': '86400', 16:31:45 INFO - 'USER': 'cltbld', 16:31:45 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1468279875.724993-543624885', 16:31:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:31:45 INFO - '_': '/tools/buildbot/bin/python'} 16:31:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:31:45 INFO - Downloading/unpacking jsonschema==2.5.1 16:31:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:31:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:31:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:31:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:31:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:31:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:31:47 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:31:47 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:31: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 16:31: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 16:31: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 16:31: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 16:31: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 16:31: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 16:31:47 INFO - Downloading functools32-3.2.3-2.tar.gz 16:31:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:31:48 INFO - warning: no files found matching '*.txt' 16:31:48 INFO - no previously-included directories found matching 'build' 16:31:48 INFO - no previously-included directories found matching 'dist' 16:31:48 INFO - no previously-included directories found matching '.git*' 16:31:48 INFO - Installing collected packages: jsonschema, functools32 16:31:48 INFO - Running setup.py install for functools32 16:31:48 INFO - warning: no files found matching '*.txt' 16:31:48 INFO - no previously-included directories found matching 'build' 16:31:48 INFO - no previously-included directories found matching 'dist' 16:31:48 INFO - no previously-included directories found matching '.git*' 16:31:48 INFO - Successfully installed jsonschema functools32 16:31:48 INFO - Cleaning up... 16:31:48 INFO - Return code: 0 16:31:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:31:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:31:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:31:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:31:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:31:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x26a0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28cf400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x295e570>, '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 0x295f470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x295f900>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1468279875.724993-543624885', '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 16:31:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 16:31:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 16:31:48 INFO - Using env: {'DISPLAY': ':0', 16:31:48 INFO - 'HOME': '/home/cltbld', 16:31:48 INFO - 'LANG': 'en_US.UTF-8', 16:31:48 INFO - 'LANGUAGE': 'en_US:en', 16:31:48 INFO - 'LOGNAME': 'cltbld', 16:31:48 INFO - 'MAIL': '/var/mail/cltbld', 16:31:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:31:48 INFO - 'MOZ_NO_REMOTE': '1', 16:31:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:31:48 INFO - 'NO_EM_RESTART': '1', 16:31:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:31:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:31:48 INFO - 'PWD': '/builds/slave/test', 16:31:48 INFO - 'SHELL': '/bin/bash', 16:31:48 INFO - 'SHLVL': '1', 16:31:48 INFO - 'TERM': 'linux', 16:31:48 INFO - 'TMOUT': '86400', 16:31:48 INFO - 'USER': 'cltbld', 16:31:48 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1468279875.724993-543624885', 16:31:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:31:48 INFO - '_': '/tools/buildbot/bin/python'} 16:31:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:31:48 INFO - Downloading/unpacking blobuploader==1.2.4 16:31:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:31:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:31:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:31:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:31:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:31:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:31:50 INFO - Downloading blobuploader-1.2.4.tar.gz 16:31:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:31:50 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:31:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:31:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:31:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:31:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:31:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:31:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:31:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:31:50 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:31:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:31:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:31:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:31:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:31:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:31:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:31:51 INFO - Downloading docopt-0.6.1.tar.gz 16:31:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:31:51 INFO - Installing collected packages: blobuploader, requests, docopt 16:31:51 INFO - Running setup.py install for blobuploader 16:31:51 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:31:51 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:31:51 INFO - Running setup.py install for requests 16:31:51 INFO - Running setup.py install for docopt 16:31:51 INFO - Successfully installed blobuploader requests docopt 16:31:51 INFO - Cleaning up... 16:31:51 INFO - Return code: 0 16:31:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:31: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')]} 16:31:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:31:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31: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')]} 16:31:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:31:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31:51 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 0x26a0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28cf400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x295e570>, '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 0x295f470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x295f900>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1468279875.724993-543624885', '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 16:31:51 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 16:31:51 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 16:31:51 INFO - Using env: {'DISPLAY': ':0', 16:31:51 INFO - 'HOME': '/home/cltbld', 16:31:51 INFO - 'LANG': 'en_US.UTF-8', 16:31:51 INFO - 'LANGUAGE': 'en_US:en', 16:31:51 INFO - 'LOGNAME': 'cltbld', 16:31:51 INFO - 'MAIL': '/var/mail/cltbld', 16:31:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:31:51 INFO - 'MOZ_NO_REMOTE': '1', 16:31:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:31:51 INFO - 'NO_EM_RESTART': '1', 16:31:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:31:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:31:51 INFO - 'PWD': '/builds/slave/test', 16:31:51 INFO - 'SHELL': '/bin/bash', 16:31:51 INFO - 'SHLVL': '1', 16:31:51 INFO - 'TERM': 'linux', 16:31:51 INFO - 'TMOUT': '86400', 16:31:51 INFO - 'USER': 'cltbld', 16:31:51 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1468279875.724993-543624885', 16:31:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:31:51 INFO - '_': '/tools/buildbot/bin/python'} 16:31:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:31:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:31:51 INFO - Running setup.py (path:/tmp/pip-JBxwZ8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:31:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:31:51 INFO - Running setup.py (path:/tmp/pip-sTG13d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:31:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:31:52 INFO - Running setup.py (path:/tmp/pip-8Itgfi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:31:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:31:52 INFO - Running setup.py (path:/tmp/pip-igyDNj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:31:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:31:52 INFO - Running setup.py (path:/tmp/pip-KCbQ7b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:31:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:31:52 INFO - Running setup.py (path:/tmp/pip-nhIPk9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:31:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:31:52 INFO - Running setup.py (path:/tmp/pip-N8xJ38-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:31:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:31:52 INFO - Running setup.py (path:/tmp/pip-y1CfSO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:31:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:31:52 INFO - Running setup.py (path:/tmp/pip-l8wSag-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:31:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:31:52 INFO - Running setup.py (path:/tmp/pip-ezKoyp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:31:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:31:52 INFO - Running setup.py (path:/tmp/pip-cPADyr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:31:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:31:52 INFO - Running setup.py (path:/tmp/pip-anjCat-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:31:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:31:52 INFO - Running setup.py (path:/tmp/pip-AT0sqi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:31:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:31:52 INFO - Running setup.py (path:/tmp/pip-FVSbjk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:31:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:31:52 INFO - Running setup.py (path:/tmp/pip-ljIThg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:31:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:31:53 INFO - Running setup.py (path:/tmp/pip-GaUID3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:31:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:31:53 INFO - Running setup.py (path:/tmp/pip-6kD0m9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:31:53 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:31:53 INFO - Running setup.py install for manifestparser 16:31:53 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:31:53 INFO - Running setup.py install for mozcrash 16:31:53 INFO - Running setup.py install for mozdebug 16:31:53 INFO - Running setup.py install for mozdevice 16:31:53 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:31:53 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:31:53 INFO - Running setup.py install for mozfile 16:31:53 INFO - Running setup.py install for mozhttpd 16:31:53 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:31:53 INFO - Running setup.py install for mozinfo 16:31:53 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:31:53 INFO - Running setup.py install for mozInstall 16:31:53 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:31:53 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:31:53 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:31:53 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:31:53 INFO - Running setup.py install for mozleak 16:31:54 INFO - Running setup.py install for mozlog 16:31:54 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:31:54 INFO - Running setup.py install for moznetwork 16:31:54 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:31:54 INFO - Running setup.py install for mozprocess 16:31:54 INFO - Running setup.py install for mozprofile 16:31:54 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:31:54 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:31:54 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:31:54 INFO - Running setup.py install for mozrunner 16:31:54 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:31:54 INFO - Running setup.py install for mozscreenshot 16:31:54 INFO - Running setup.py install for moztest 16:31:54 INFO - Running setup.py install for mozversion 16:31:54 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:31:54 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:31:54 INFO - Cleaning up... 16:31:54 INFO - Return code: 0 16:31:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:31:54 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')]} 16:31:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:31:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31:54 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')]} 16:31:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:31:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31:54 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 0x26a0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28cf400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x295e570>, '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 0x295f470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x295f900>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1468279875.724993-543624885', '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 16:31:54 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 16:31:54 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 16:31:54 INFO - Using env: {'DISPLAY': ':0', 16:31:54 INFO - 'HOME': '/home/cltbld', 16:31:54 INFO - 'LANG': 'en_US.UTF-8', 16:31:54 INFO - 'LANGUAGE': 'en_US:en', 16:31:54 INFO - 'LOGNAME': 'cltbld', 16:31:54 INFO - 'MAIL': '/var/mail/cltbld', 16:31:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:31:54 INFO - 'MOZ_NO_REMOTE': '1', 16:31:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:31:54 INFO - 'NO_EM_RESTART': '1', 16:31:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:31:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:31:54 INFO - 'PWD': '/builds/slave/test', 16:31:54 INFO - 'SHELL': '/bin/bash', 16:31:54 INFO - 'SHLVL': '1', 16:31:54 INFO - 'TERM': 'linux', 16:31:54 INFO - 'TMOUT': '86400', 16:31:54 INFO - 'USER': 'cltbld', 16:31:54 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1468279875.724993-543624885', 16:31:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:31:54 INFO - '_': '/tools/buildbot/bin/python'} 16:31:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:31:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:31:55 INFO - Running setup.py (path:/tmp/pip-EpwR5_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:31:55 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)) 16:31:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:31:55 INFO - Running setup.py (path:/tmp/pip-7XZerE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:31:55 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)) 16:31:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:31:55 INFO - Running setup.py (path:/tmp/pip-FBm6lV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:31:55 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)) 16:31:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:31:55 INFO - Running setup.py (path:/tmp/pip-cD1T7F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:31:55 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)) 16:31:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:31:55 INFO - Running setup.py (path:/tmp/pip-QFJeos-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:31:55 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)) 16:31:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:31:55 INFO - Running setup.py (path:/tmp/pip-T4l4VS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:31:55 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)) 16:31:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:31:55 INFO - Running setup.py (path:/tmp/pip-RhcUov-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:31:55 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)) 16:31:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:31:55 INFO - Running setup.py (path:/tmp/pip-eW2Eqn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:31:55 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)) 16:31:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:31:55 INFO - Running setup.py (path:/tmp/pip-qCodHd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:31:55 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)) 16:31:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:31:55 INFO - Running setup.py (path:/tmp/pip-wrBFqL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:31:55 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)) 16:31:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:31:55 INFO - Running setup.py (path:/tmp/pip-O7S_gR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:31:55 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)) 16:31:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:31:55 INFO - Running setup.py (path:/tmp/pip-B5Q8tz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:31:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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)) 16:31:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:31:56 INFO - Running setup.py (path:/tmp/pip-vOGiJi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:31:56 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)) 16:31:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:31:56 INFO - Running setup.py (path:/tmp/pip-SUMnaQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:31:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 16:31:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:31:56 INFO - Running setup.py (path:/tmp/pip-BYXYI1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:31:56 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)) 16:31:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:31:56 INFO - Running setup.py (path:/tmp/pip-S7LZw1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:31:56 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)) 16:31:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:31:56 INFO - Running setup.py (path:/tmp/pip-HPjIKW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:31:56 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)) 16:31:56 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)) 16:31:56 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)) 16:31:56 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)) 16:31:56 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)) 16:31:56 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)) 16:31:56 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:31:56 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 16:31:56 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 16:31:56 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 16:31:56 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 16:31:56 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 16:31:56 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 16:31:58 INFO - Downloading blessings-1.6.tar.gz 16:31:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:31:58 INFO - Installing collected packages: blessings 16:31:58 INFO - Running setup.py install for blessings 16:31:58 INFO - Successfully installed blessings 16:31:58 INFO - Cleaning up... 16:31:58 INFO - Return code: 0 16:31:58 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:31:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:31:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:31:58 INFO - Reading from file tmpfile_stdout 16:31:58 INFO - Current package versions: 16:31:58 INFO - argparse == 1.2.1 16:31:58 INFO - blessings == 1.6 16:31:58 INFO - blobuploader == 1.2.4 16:31:58 INFO - docopt == 0.6.1 16:31:58 INFO - functools32 == 3.2.3-2 16:31:58 INFO - jsonschema == 2.5.1 16:31:58 INFO - manifestparser == 1.1 16:31:58 INFO - mozInstall == 1.12 16:31:58 INFO - mozcrash == 0.17 16:31:58 INFO - mozdebug == 0.1 16:31:58 INFO - mozdevice == 0.48 16:31:58 INFO - mozfile == 1.2 16:31:58 INFO - mozhttpd == 0.7 16:31:58 INFO - mozinfo == 0.9 16:31:58 INFO - mozleak == 0.1 16:31:58 INFO - mozlog == 3.2 16:31:58 INFO - moznetwork == 0.27 16:31:58 INFO - mozprocess == 0.23 16:31:58 INFO - mozprofile == 0.28 16:31:58 INFO - mozrunner == 6.12 16:31:58 INFO - mozscreenshot == 0.1 16:31:58 INFO - mozsystemmonitor == 0.3 16:31:58 INFO - moztest == 0.7 16:31:58 INFO - mozversion == 1.4 16:31:58 INFO - psutil == 3.1.1 16:31:58 INFO - requests == 1.2.3 16:31:58 INFO - wsgiref == 0.1.2 16:31:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:31: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')]} 16:31:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:31:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31: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')]} 16:31:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:31:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31:58 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 0x26a0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28cf400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x295e570>, '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 0x295f470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x295f900>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1468279875.724993-543624885', '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 16:31:58 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 16:31:58 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 16:31:58 INFO - Using env: {'DISPLAY': ':0', 16:31:58 INFO - 'HOME': '/home/cltbld', 16:31:58 INFO - 'LANG': 'en_US.UTF-8', 16:31:58 INFO - 'LANGUAGE': 'en_US:en', 16:31:58 INFO - 'LOGNAME': 'cltbld', 16:31:58 INFO - 'MAIL': '/var/mail/cltbld', 16:31:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:31:58 INFO - 'MOZ_NO_REMOTE': '1', 16:31:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:31:58 INFO - 'NO_EM_RESTART': '1', 16:31:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:31:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:31:58 INFO - 'PWD': '/builds/slave/test', 16:31:58 INFO - 'SHELL': '/bin/bash', 16:31:58 INFO - 'SHLVL': '1', 16:31:58 INFO - 'TERM': 'linux', 16:31:58 INFO - 'TMOUT': '86400', 16:31:58 INFO - 'USER': 'cltbld', 16:31:58 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1468279875.724993-543624885', 16:31:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:31:58 INFO - '_': '/tools/buildbot/bin/python'} 16:31:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:31:58 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)) 16:31:58 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)) 16:31:58 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)) 16:31:58 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)) 16:31:58 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)) 16:31:58 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)) 16:31:58 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)) 16:31:58 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)) 16:31:58 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)) 16:31:58 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)) 16:31:58 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)) 16:31:58 INFO - Cleaning up... 16:31:58 INFO - Return code: 0 16:31:58 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:31: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')]} 16:31:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:31:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31: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')]} 16:31:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:31:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31:58 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 0x26a0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28cf400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x295e570>, '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 0x295f470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x295f900>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1468279875.724993-543624885', '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 16:31:58 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 16:31:58 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 16:31:58 INFO - Using env: {'DISPLAY': ':0', 16:31:58 INFO - 'HOME': '/home/cltbld', 16:31:58 INFO - 'LANG': 'en_US.UTF-8', 16:31:58 INFO - 'LANGUAGE': 'en_US:en', 16:31:58 INFO - 'LOGNAME': 'cltbld', 16:31:58 INFO - 'MAIL': '/var/mail/cltbld', 16:31:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:31:58 INFO - 'MOZ_NO_REMOTE': '1', 16:31:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:31:58 INFO - 'NO_EM_RESTART': '1', 16:31:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:31:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:31:58 INFO - 'PWD': '/builds/slave/test', 16:31:58 INFO - 'SHELL': '/bin/bash', 16:31:58 INFO - 'SHLVL': '1', 16:31:58 INFO - 'TERM': 'linux', 16:31:58 INFO - 'TMOUT': '86400', 16:31:58 INFO - 'USER': 'cltbld', 16:31:58 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1468279875.724993-543624885', 16:31:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:31:58 INFO - '_': '/tools/buildbot/bin/python'} 16:31:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:31:59 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:31:59 INFO - Cleaning up... 16:31:59 INFO - Return code: 0 16:31:59 INFO - Running post-action listener: _resource_record_post_action 16:31:59 INFO - Running post-action listener: _start_resource_monitoring 16:31:59 INFO - Starting resource monitoring. 16:31:59 INFO - ##### 16:31:59 INFO - ##### Finished create-virtualenv step (success) 16:31:59 INFO - ##### 16:31:59 INFO - ##### 16:31:59 INFO - ##### Running install step. 16:31:59 INFO - ##### 16:31:59 INFO - Running pre-action listener: _resource_record_pre_action 16:31:59 INFO - Running main action method: install 16:31:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:31:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:31:59 INFO - Reading from file tmpfile_stdout 16:31:59 INFO - Detecting whether we're running mozinstall >=1.0... 16:31:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:31:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:31:59 INFO - Reading from file tmpfile_stdout 16:31:59 INFO - Output received: 16:31:59 INFO - Usage: mozinstall [options] installer 16:31:59 INFO - Options: 16:31:59 INFO - -h, --help show this help message and exit 16:31:59 INFO - -d DEST, --destination=DEST 16:31:59 INFO - Directory to install application into. [default: 16:31:59 INFO - "/builds/slave/test"] 16:31:59 INFO - --app=APP Application being installed. [default: firefox] 16:31:59 INFO - mkdir: /builds/slave/test/build/application 16:31:59 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'] 16:31:59 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 16:32:16 INFO - Reading from file tmpfile_stdout 16:32:16 INFO - Output received: 16:32:16 INFO - /builds/slave/test/build/application/firefox/firefox 16:32:16 INFO - Running post-action listener: _resource_record_post_action 16:32:16 INFO - ##### 16:32:16 INFO - ##### Finished install step (success) 16:32:16 INFO - ##### 16:32:16 INFO - ##### 16:32:16 INFO - ##### Running run-tests step. 16:32:16 INFO - ##### 16:32:16 INFO - Running pre-action listener: _resource_record_pre_action 16:32:16 INFO - Running main action method: run_tests 16:32:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:32:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:32:16 INFO - Python 2.7.3 16:32:16 INFO - Return code: 0 16:32:16 INFO - grabbing minidump binary from tooltool 16:32:16 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')]} 16:32:16 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 0x295e570>, '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 0x295f470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x295f900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:32:16 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 16:32:16 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 16:32:16 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 16:32:16 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:32:16 INFO - Return code: 0 16:32:16 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:32:16 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:32:16 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:32:16 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:32:16 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:32:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fJr9ruZITBWsryQTabOb9A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-019', '--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 16:32:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/fJr9ruZITBWsryQTabOb9A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-019 --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 16:32:16 INFO - Using env: {'DISPLAY': ':0', 16:32:16 INFO - 'HOME': '/home/cltbld', 16:32:16 INFO - 'LANG': 'en_US.UTF-8', 16:32:16 INFO - 'LANGUAGE': 'en_US:en', 16:32:16 INFO - 'LOGNAME': 'cltbld', 16:32:16 INFO - 'MAIL': '/var/mail/cltbld', 16:32:16 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:32:16 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:32:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:32:16 INFO - 'MOZ_NO_REMOTE': '1', 16:32:16 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:32:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:32:16 INFO - 'NO_EM_RESTART': '1', 16:32:16 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:32:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:32:16 INFO - 'PWD': '/builds/slave/test', 16:32:16 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:32:16 INFO - 'SHELL': '/bin/bash', 16:32:16 INFO - 'SHLVL': '1', 16:32:16 INFO - 'TERM': 'linux', 16:32:16 INFO - 'TMOUT': '86400', 16:32:16 INFO - 'USER': 'cltbld', 16:32:16 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1468279875.724993-543624885', 16:32:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:32:16 INFO - '_': '/tools/buildbot/bin/python'} 16:32:16 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fJr9ruZITBWsryQTabOb9A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-019', '--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 16:32:16 INFO - mozversion application_buildid: 20160711133152 16:32:16 INFO - mozversion application_changeset: 9189a2cc39d0c35e8823349aa0b4057ab8167b32 16:32:16 INFO - mozversion application_display_name: Nightly 16:32:16 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:32:16 INFO - mozversion application_name: Firefox 16:32:16 INFO - mozversion application_remotingname: firefox 16:32:16 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 16:32:16 INFO - mozversion application_vendor: Mozilla 16:32:16 INFO - mozversion application_version: 50.0a1 16:32:16 INFO - mozversion platform_buildid: 20160711133152 16:32:16 INFO - mozversion platform_changeset: 9189a2cc39d0c35e8823349aa0b4057ab8167b32 16:32:16 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 16:32:16 INFO - mozversion platform_version: 50.0a1 16:32:16 INFO - using testdate: 1468279936 16:32:16 INFO - actual date: 1468279936 16:32:16 INFO - starting webserver on 'localhost:44674' 16:32:16 INFO - SUITE-START | Running 2 tests 16:32:16 INFO - TEST-START | dromaeo_css 16:32:16 INFO - operating with platform_type : linux_ 16:32:16 INFO - Initialising browser for dromaeo_css test... 16:32:16 INFO - TEST-INFO | started process 6906 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdEdWHS/profile http://localhost:44674/getInfo.html) 16:32:21 INFO - PROCESS | 6906 | __metrics Screen width/height:1600/1200 16:32:21 INFO - PROCESS | 6906 | colorDepth:24 16:32:21 INFO - PROCESS | 6906 | Browser inner width/height: 1024/697 16:32:21 INFO - PROCESS | 6906 | __metrics 16:32:22 ERROR - PROCESS | 6906 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2964: TypeError: this.tabs is undefined 16:32:23 INFO - TEST-INFO | 6906: exit 0 16:32:23 INFO - Browser initialized. 16:32:23 INFO - Running cycle 1/1 for dromaeo_css test... 16:32:23 INFO - TEST-INFO | started process 7030 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdEdWHS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:32:35 INFO - PROCESS | 7030 | RSS: Main: 166924288 16:32:35 INFO - PROCESS | 7030 | 16:33:24 INFO - PROCESS | 7030 | 1468280004741 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] 16:35:32 INFO - PROCESS | 7030 | Cycle 1(1): loaded http://localhost:44674/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44674/tests/dromaeo/cssquery-ext.html) 16:35:33 INFO - PROCESS | 7030 | RSS: Main: 170254336 16:35:33 INFO - PROCESS | 7030 | 16:38:35 INFO - PROCESS | 7030 | Cycle 1(1): loaded http://localhost:44674/tests/dromaeo/cssquery-ext.html (next: http://localhost:44674/tests/dromaeo/cssquery-jquery.html) 16:38:36 INFO - PROCESS | 7030 | RSS: Main: 167481344 16:38:36 INFO - PROCESS | 7030 | 16:41:38 INFO - PROCESS | 7030 | Cycle 1(1): loaded http://localhost:44674/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44674/tests/dromaeo/cssquery-mootools.html) 16:41:38 INFO - PROCESS | 7030 | RSS: Main: 170926080 16:41:38 INFO - PROCESS | 7030 | 16:44:40 INFO - PROCESS | 7030 | Cycle 1(1): loaded http://localhost:44674/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44674/tests/dromaeo/cssquery-prototype.html) 16:44:41 INFO - PROCESS | 7030 | RSS: Main: 166477824 16:44:41 INFO - PROCESS | 7030 | 16:47:43 INFO - PROCESS | 7030 | Cycle 1(1): loaded http://localhost:44674/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44674/tests/dromaeo/cssquery-yui.html) 16:47:44 INFO - PROCESS | 7030 | RSS: Main: 169115648 16:47:44 INFO - PROCESS | 7030 | 16:50:46 INFO - PROCESS | 7030 | Cycle 1(1): loaded http://localhost:44674/tests/dromaeo/cssquery-yui.html (next: http://localhost:44674/tests/dromaeo/cssquery-dojo.html) 16:50:46 INFO - PROCESS | 7030 | RSS: Main: 169443328 16:50:46 INFO - PROCESS | 7030 | 16:50:46 INFO - PROCESS | 7030 | __start_tp_report 16:50:46 INFO - PROCESS | 7030 | _x_x_mozilla_page_load 16:50:46 INFO - PROCESS | 7030 | _x_x_mozilla_page_load_details 16:50:46 INFO - PROCESS | 7030 | |i|pagename|runs| 16:50:46 INFO - PROCESS | 7030 | |0;dojo.html;3091.5826363440938;3135.404273188095;3145.95281070784;3170.3342298117395;3177.9205519862003;5523.834284971453;5555.472230138141;5565.610407271488;5606.663600183992;5650.180723795047;5376.1398176291705;5521.365043020054;5543.501084902358;5550.611457197998;5576.944230557693;4958.925616115761;4985.875353116165;5120.308758317636;5175.301334319875;5221.2429197766305;472.80682833636337;4961.8511444656715;5016.247562865563;5049.419316778581;5051.090803655341;5051.090803655341;5063.696178229318;5077.771500282496;5104.2088476286235;5110.6422550421485;5085.084684756743;5104.770285337168;5111.437741848394;5132.486751324875;5149.613778966555;4952.603791696655;5026.195808670632;5048.9495105048845;5078.984203159383;5084.51697088776;5529.502344788948;5550.417206193332;5560.304961879765;5581.469760372758;5605.747741351649;5683.829485115453;5978.611390259663;5987.37132601075;5988.071848863433;6010.639361638272;5812.680302583356;5889;5900.321463031763;5957.761689532414;5964.582479226456;5485.533729632986;5506.724663766836;5509.614326997152;5512.200730894038;5512.80705175317;5906.40935906406;5967.850803729854;6203.16257305258;6227.346128656516;6234.127222188898;5815.592908496449;5871.001929671966;5895.852603684856;5906.5570082244;5916.201312822714;5967.6121052131475;6036.305824830113;6059.0608455689435;6062.454379105901;6077.483413909778;5853.5317174625925;5873.647581145145;5988.760449581968;6055.061465472859;6058;5868.061110222429;5905.40945905406;5941.762329506858;5954.136650185699;6003.909941350883;4511.70673906195;4540.2054640438455;4541.613962813131;4546.590806827336;4577.56513131252;4020.7587544747407;4034.8386064557676;4057.655099316532;4079.7348172369293;4087.080406908481;5542.418046105182;5641.294838145232;5673.461021202979;5696.401877802854;5704.743286552115;5971.343152253248;6035.939640603538;6035.969820150959;6036.366181550874;6044.516438684895;5501.284832971688;5629.127485239795;5666.773329066874;5693.060644993529;5713.171590119409;5179.559737422286;5185.585153187736;5187.0922588546855;5191.143461328914;5191.351081114861;6264.686765661699;6279.717412716439;6280;6281.8743625127245;6283.340249273851;5785.82642520725;6007.309159446545;6055.788047418319;6076.483498902643;6077.544184186292;6246.08376515507;6271.96864015677;6295.96852015737;6298.968505157628;6327.335629758809;5644.548436125182;5935.584509084495;5961.254843144607;5973.731182096903;5981.641101533922;5969.194158788508;5996.190514280691;6078.057901025348;6083.939160608337;6125.816225513242;5880.26496687914;5930.347661757117;5937.406259374201;5942.881142377215;5990.191324171181;5633.0423827948525;5790.478856902899;5913.881722365442;5923.822285331447;5954.166416701579;5832.912506312494;5864.149698293638;5891.469767720926;5892.616979896293;5906.970465147819;5879.529637629065;5886.499647530008;5889.352171261072;5890.823275301748;5911.438413350725;5551.694656793915;5725.398833122629;5737.799177028784;5749.655020698771;5779.797707080232 16:50:46 INFO - PROCESS | 7030 | |1;ext.html;578.9855253618659;594.4115325827432;611.0559186057541;616.0236025898948;641.9069234960933;38087;43074;43134;43140;43309;42054.57945420545;42674.359884601756;42757.14485710284;42871.57128428715;43101.78449107758;8752.518611476366;8926.285897128215;8948.910510894906;8963.596638151299;8970;8808.119188081204;8871.068537803534;8919.331050171264;8956.507392093432;8958.32812539059;8932.034952310514;8933.865992010125;8938.821223575525;8942.597583108776;8960.327975401839;8894;8931.151540603632;8946.463212207256;8954;8965.103489651048;8856.64573417069;8873.556322183866;8900.465972041698;8913.108689131035;8950.104989501064;33175.33649327024;39781.40327895084;40047.7997610013;40110;40444.393334100016;3445.913852153691;3466.722662187019;3690.55713314404;4167.437395951569;4482.103579284156;31362.686373136206;32427;33109.83445082783;34253.6574634253;34636.48045279323;4435.800388982503;4450.326661313178;4517.796699148546;4535.297028960484;4684.648651351163;377694;381122;381952;384082;386714;34472.48291275633;34734.13164670904;59847.40152598506;60899.391006090256;61244.69377653083;37247.62752372496;37445.438318425244;37623.81188094042;37654.43518347227;37814.432783508266;14866.331015104346;14917.552473425814;14933.104013758992;15020.624484387978;15040.774388384183;12765.170263932814;12802.551910683082;12817.615471535868;12878.291693956735;12908.29004404748;8152.51084934894;8153.062397824207;8230.09468958414;8240.258376746122;8246.134155913544;3129.765267604939;3246.4092594628464;3293.9953314239388;3305.3554556861664;3329.9833500832824;1037.0148359058924;1081.7241603391085;1116.8938950799661;1124.7244425115898;1133.9773204535863;32000.679993200236;32230.83884580562;32313.838430807697;32816;32881.3423731524;1106.3417266726285;1109.8446217529552;1150.9539618415338;1154.4977934598476;1178.263585259213;16788;16845;16846.046325878742;17249.741253881202;17320.91339543294;552345;559349;559573;560846;563127;58647;58745.70627146922;58856;58952.41047589469;59058.704706476194;1349.689571398584;1361.0404664711355;1372.0807059270312;1382.5644921849585;1390.603677951779;29933.850330748206;30372.848135760065;30498;30986.69013309928;31396.68603314029;49069.75465122652;49205.50794492009;49205.75397122991;49209.75395123001;49249.50750492449;457135;460419;461247;461258;463588;27542;27665.308367290978;28382.71617283801;28673.28316792097;28687.856560717064;48013;48411.5158848407;48881.5111848877;49514.75242623764;49968.50031499784;40695.796521017204;41082.1783564333;41735.582644174385;42036.57963420327;42752.14495710006;39365.62220322275;40567;40839;40931.795341023106;41197.382039270036;40311.79844100878;40432.39351409672;41573.79213104036;41692.58307416887;41828;35036;37070.25859482741;37575.43636845504;37638;38371.6162838368;28552.714472855005;28995.13014609565;29106.854465727534;29220;29375.41249174962 16:50:46 INFO - PROCESS | 7030 | |2;jquery.html;383.7620675181386;390.86319788074167;393.77554793767564;396.2411981056277;412.07900342734;14002.159870407782;15601;18634.34779782708;19937.10283037263;19971.800281997177;18146.637067258645;18511.44465666029;18799.24803007878;20372.185112595478;20393.184272629078;5898.764049438028;5974.761009559634;6040.033594624861;6049.576529642927;6081.969590152043;5751.568632352591;5909.556783241253;5919.467247947684;5930.644161350311;5932.673702946337;5594.692291923942;5805.593608447411;5901.793437229677;5922.318933322658;5926.88146237075;5857.85355366115;5861.941380586182;5878.177055212273;5914.4381283777975;5925.34821169671;5701.743421546041;5720.742566584514;5733.684647344436;5755.539556835443;5760.942390576082;21805.454863628376;22951.885240573858;22953.54092918149;23814;24704;2101.821345185661;2252.6395776675818;2320.582295186866;2418.4558474343307;2522.646829443879;10134.290599658027;10213.948930255376;10223.386596804216;10312.948435257851;10862.61980830675;1900.4108726294892;1927.5952050069502;1973.2008536542724;1983.9702404463944;2030.116899148875;84339;84965.57517212375;85525;88585;90553;10758.408287544104;10990.725231869268;11111.939667815053;11171.608993685344;11204.719882003015;15256.084634921941;15448.459303924308;15528.223588820514;15559.611009724847;15582.9220853895;8032.4778889372;8221.136780638066;8287.088420273765;8416;8530.65877364911;8026.117127116013;8047.839043219103;8140.226678465655;8270.751877443687;8287.41988060842;4679.077300662314;4753.47711751707;4778.928316075262;4824.131656301899;4890.853274401774;1925.4993701637675;1965.9213631454868;1997.0786617678652;1999.780024197337;2030.644637188486;977.5014742481244;979.5298256836759;1021.7292417509366;1048.130052056791;1065.2969040433431;20270.69593956092;20340;20394.796052039586;20508.794912050987;20682.58634827295;970.4419958523877;986.8026394721085;991.5934466868549;1059.5496913811753;1080.7352198711367;10094.495275236355;11341.716457088638;11347.716307092389;11350.148738844455;11418.086553075735;472938;479817;480238;484141;486457;74837;91620;91979;95110.99999999862;95468;994.8757903569066;995.7012896131132;998.4059484606647;998.6404894238068;1003.5534187286587;17976;17977.640447191243;18055.277788888296;18239.635207296044;18463.35378261808;29802;30019.399612008074;36699.816500917324;42646;43649.78175109104;59175.40824591699;60438;60957.390426095175;61787.38212617816;62037.37962620316;8548.529830859363;8642.43824151428;8696.434731742416;8844.380893337404;8914.955425222832;10172.593096276067;13446.529371471952;13922.303884805922;13975.371108299947;14475.348609312818;11959.402029898645;12105.515779368727;12291.75416491683;12323.69190770238;12384.62846114618;11480.885191148316;11611.245269057485;12002.75994480123;12191.75616487683;12404.441800119197;12472.5010999559;12528.310942898228;12577.371131443575;12591.93704031474;12723.447424576536;7604.923950760643;7982.241687039722;8028.799280018046;8040.075391329838;8475.788105297417;11776.293422394683;12194.81707774402;12321.322327271728;12736.61790146297;12777.361131943551 16:50:46 INFO - PROCESS | 7030 | |3;mootools.html;1497.4609140709342;1517.2868751686706;1671.1393632279378;1795.5870149865523;1797.1014492753632;7927.088384835745;8738.995015573202;8749.343799215068;9333.626654933803;9366.672166474165;8760.474371537712;9054.139856713618;9105.908940910605;9111.726648200549;9124.908750912506;2325.825563082771;2355.37582540626;2355.3993731598416;2356.50513392187;2364;2313.2597568777996;2314.166899916029;2374.157174203159;2379.2505360811374;2379.5954687703047;2340.110757911991;2344.23812261015;2378.7621237876247;2413.5293617744546;2417.190241269177;2243.2821497120844;2269.6028195065965;2285.919992800252;2286.691296674944;2293.025464177718;2223.2329846203033;2226.387743370586;2226.6882636430914;2230.3086043326457;2234.4525591230254;9119.49842758648;9246.35275530713;9255.722328330161;9256.074392560757;9266.212371948392;5033.697978121288;5108.233764935252;5116.411612664517;5120.48795120485;5122.206058061007;3226.322472280824;3258.104021394112;3297.241634424072;3311.536384906091;3368.9157771055675;1150.413289222494;1159.8840115988335;2203.46015226269;2252.8986195621073;2257.5777260326054;12791.424385902657;12850.935745321307;12854.742905141844;12868.678283042906;12883.871161288362;4384.430024096847;4390.275604525217;4502.752348620857;4562.8631141065825;4570.565796249351;9908;9942.80114397708;9942.950285248673;10024.949875250722;10052;5268.15709486488;5285.788568457296;5296.364436267596;5300;5322.068637988336;4266.146770645822;4729.196036673774;4884.242942343943;4890.853274401774;4953.455119936804;3681.889543313705;3693.593704692482;3799.9240015199543;3803.5625903021505;3825.7895815729844;1134.432783608196;1135.250734515216;1141.1555448967704;1145.6505765741529;1148.5578052449866;902.9864552031725;976.9741771140274;1018.4245901065874;1055.8257887448638;1056.6301794372062;6354.205724284465;6376.489880809524;6479.546431749733;6499.675016249169;6573;429.94840619125904;432.3385220612468;435.89974305909817;446.6449172907546;480.7211817146047;4228.788560571959;4484.282514797616;4494.887627809266;4519.367288579601;4528.50186479487;10568;10682.679519614425;10818.891811081945;10842.132629389629;10873.891261087447;10642.787144257227;10658;10658.200634952409;10661.253712240225;10669.57321707123;8139.593020349077;8160.265576098061;8239.134890836496;8454.40819142654;8479.236868681848;6315.305316415099;6412.387498689676;6473.1261279728515;6492.188476440445;6585.473162147113;10351.275410721177;10614.203934705083;10627.149828013586;10711.517981690688;10735.516901739284;10566.788664226826;10816.513256903616;10890.891091088988;10924.235303528676;10967.83548246761;7391.926080739124;7648.082230132197;7705.229477052474;7738.883916741366;7998.440109192301;8574.09971952936;8626.698065567674;8630.439021463584;8643.827123457622;8645.049044604963;7540.245975402416;7615.504992175491;7652.617369131633;7816.218378162365;7904.091029531447;7158;7254.202037775735;7277.636118194175;7314.158871729819;7424.591647459441;6979.511434199558;6983.162020557363;6990.685419156049;7063.046488723957;7069.893951590628;5031.0441016206805;5077.213031980049;5147.3308469898675;5256.684598924076;5270.051390749549;5189.792408303626;5296.973515132399;5355.758990845499;5362.222477740784;5395.622306438511 16:50:46 INFO - PROCESS | 7030 | |4;prototype.html;327.2473311383818;333.2435371706227;338.0433373552844;338.8479170819214;340.3788086741697;5591.210812539994;5672.234248376468;5681.602287839848;5810.883782324351;5812.244408226925;5633.295838020247;5646.2942132233475;5661.23573317602;5681.7727290908315;5682.573806964484;4351.586599273072;4389.890252743691;4409.4488188976375;4415.801288942005;4431.468223813147;3986.2426139033637;4338.50107237667;4340.854483967819;4361.694681372305;4380.408644832939;4253.191893540217;4306.160298741746;4314.590113939186;4335.978320108395;4351.195028919644;4359.607635312821;4367.366731823868;4376.846810361654;4392.38506609075;4392.582704643054;3749.268892565951;3760.492333534965;3792.639699228569;3799.9240015199816;3804.1630841214887;5452.882159157363;5455.509004189602;5458.317710286215;5469.206964990094;5492.1212605982855;4973.776180071905;4974.801007959677;4981.750912454363;4989.251612258154;5015.6238282128625;5691.876303473575;5741.25363702716;5809.477147056743;5846.5322774178385;5846.912296315559;4151.190517849021;4161.771102589357;4165.58344165584;4173.414102640977;4174.979125104355;5912.674802885796;5967.940320596782;6025.553867071915;6030.276366836008;6075.210222671069;4188.727732697365;4231.915361692749;4241.575842415734;4242.53332133465;4300.483941926988;4310.482742070972;4339.804708788112;4348.804303806336;4357.694961352675;4363;4976.576990955737;4978.2034874419915;4978.925316120261;4996.975015124901;5002.1496345621335;5805.593608447452;5843.402007922024;5926.4666180044005;5952.642841429441;5973.701314934323;1479.6005078628925;1485.9152818442597;1489.3149151390483;1490.8509149085005;1497;926.666400095965;947.5972711597543;953.4136506048869;957.2724729205854;964.3056998960737;5024.79900803971;5041.697498150123;5499.7250137492965;5522.723863806794;5657.15142728594;6040.577159598786;6072.8785424292155;6097.939020609826;6131.294901086343;6179.567430279837;5532.225488431623;5690.955338893672;5703.828885133453;5736.311642602831;5740.68426236561;3222.951655725166;3230.919227019296;3239.3197428539797;3266.2324353776844;3267.5425440438357;6214.4407003369915;6272.5922815016875;6279.560430769802;6304.338044505353;6311;6044.486218671374;6105.206323177958;6106.1146133811235;6156.8758778221445;6159;6263.279722831841;6286.365544958252;6327.354887729131;6360.681965901686;6360.840978975562;5912.46787789101;6055.394460553909;6064.272287325549;6123.571350005457;6134.478569321657;5945.91081133792;5968.16445697594;5978.372270911492;6013.248343957005;6029.57792954489;6038.818835434944;6247.750089996349;6304.211973503312;6314.715837787402;6329.923912934904;4176.535843852142;4187.644050255641;4187.895302617459;4192.224438478891;4194.6853985950565;6043.3352331244405;6057.57596968208;6070.7875224366935;6090.969545152246;6104.26748790148;5770.365259821332;5898.1152827076285;5925.9407405925385;5943.673097979653;5951.226340575698;5866.530677545701;5883.146943693226;5888.352281249145;5901.439363260483;5938.792142275;5846.41535846412;5860.326062502867;5879.676617786063;5902.6458412495385;5919.644821310563;5634.74643641029;5871.882562348815;5925.103966730605;5925.259342582177;5932.525397968066;5762.193292939076;5811.82564523065;5815.331236907809;5817.76728930838;5829.912551311819 16:50:46 INFO - PROCESS | 7030 | |5;yui.html;739.7891600893745;753.3483536740717;771.1594362145261;800.5476905548367;806.6934564865351;15223.543293701192;15520.991135576194;15758.369665213406;15873.365065397385;16109.83890161098;16758.162091895418;16810.915945420285;16882.493525194233;16883.071431071286;16887.577810554743;816.7590560784553;823.4153750836898;826.2316046077145;829.8464784014947;846.4878748357216;843.4770442325766;844.5608283692476;845.1295165979021;847.1951645936355;849.6728759427604;875.2254254984321;877.1579283887444;880.3925291548811;880.770999540121;882.2677177942325;865.5758678247677;866.7399780065955;866.8959724833061;868.1015149320455;868.1492137705085;629.1852051593152;632.2602555010602;632.576173963441;632.6393955445398;633.3255083336278;14534.273286335641;14555.452795760699;14562.126272423688;14575;14614.561563153122;14842.183679897602;15193.392264309414;15235.923820380938;15247.16140612266;15331.23343832815;11951;12394.938025309906;12417.75164496705;12506.874931250662;12530.937345313216;3834.9233015339537;3868.9226215475533;3871.2064026874423;3909.863154789569;3990.620891015349;78550.21449785486;80848.59575702142;81445;82664.17335826624;82742.58628706879;11493.71265718347;11499.482523286471;11533.480993355319;11758.647240582795;11765.470553825098;21823.67264491034;21948.670769938464;21968.780312196992;22024.889875550518;22040.228591999523;7755.2244775521995;7759.612019399007;8198.139195384518;8255.298299644597;8557.358198135165;4514.7291162530355;4561.817527298937;4570.352021770218;4655.487896331469;4783.258594917724;3377.257003459235;3453.827308634558;3480.582330120402;3482.3383557124066;3514.121469632592;628.355935166458;635.1615867055442;637.4390536328094;649.0653459018997;658.9736410543525;666.5134451850176;673.2930423055772;691.9619420931897;739.1130643228148;743.7582785594703;10122.59509619607;10333.689989300334;10381.302097086762;10449.791004179873;10707.518161682743;697.4211404534225;766.1113108793772;781.3007358414301;781.9100803407567;790.3005839831791;4841.346418233494;5051.166557517969;5059.215821547666;5164.509371609691;5181.715005674724;69625.65187174032;71302.28697712957;87102;90594;125798.37100814437;63476.68261658662;89718.55140724254;91501;93834.5308273468;104226.47886760518;91964;92615.07384926065;93599.53200233955;94925;96462;10299.742506437398;10600.575976961143;10704.036636702735;10736.355818650905;10754.40850753216;52911;53320.46679533155;53396;53722.73138634282;54308.45691543192;71317;80287;82019.58990205011;82926.58536707278;82999.5850020746;13566;13719.931400342934;13808.714208078001;13959.092658977133;14129.788053179416;15873.2063396832;16010.19949002522;16227.837721622633;16278.267477963756;16938.49184524466;14166.504172353918;14269.571912842632;14580.270986450847;15093.622659433162;15175.241237937838;14499.420023199376;14755.336009879797;15161.848381516485;15458.922705386402;15519.37922483088;12025.949842916874;13172.736545269232;13637.241072091627;13802.17186968785;14900.701985960437;11537.884621154017;12288.385580721108;12404.937975310066;12462.439344197317;12510.687232819253;12445.439955201857;12599.658740532883;12859.292738899076;12990.155639883378;13082.738345233232 16:50:46 INFO - PROCESS | 7030 | __end_tp_report 16:50:46 INFO - PROCESS | 7030 | __start_cc_report 16:50:46 INFO - PROCESS | 7030 | _x_x_mozilla_cycle_collect,373 16:50:46 INFO - PROCESS | 7030 | __end_cc_report 16:50:46 INFO - PROCESS | 7030 | __startTimestamp1468281046829__endTimestamp 16:50:46 INFO - PROCESS | 7030 | 16:50:46 INFO - PROCESS | 7030 | ------- Summary: start ------- 16:50:46 INFO - PROCESS | 7030 | Number of tests: 6 16:50:46 INFO - PROCESS | 7030 | 16:50:46 INFO - PROCESS | 7030 | [#0] dojo.html Cycles:165 Average:5526.98 Median:5779.80 stddev:764.74 (13.2%) stddev-sans-first:742.84 16:50:46 INFO - PROCESS | 7030 | Values: 3091.6 3135.4 3146.0 3170.3 3177.9 5523.8 5555.5 5565.6 5606.7 5650.2 5376.1 5521.4 5543.5 5550.6 5576.9 4958.9 4985.9 5120.3 5175.3 5221.2 472.8 4961.9 5016.2 5049.4 5051.1 5051.1 5063.7 5077.8 5104.2 5110.6 5085.1 5104.8 5111.4 5132.5 5149.6 4952.6 5026.2 5048.9 5079.0 5084.5 5529.5 5550.4 5560.3 5581.5 5605.7 5683.8 5978.6 5987.4 5988.1 6010.6 5812.7 5889.0 5900.3 5957.8 5964.6 5485.5 5506.7 5509.6 5512.2 5512.8 5906.4 5967.9 6203.2 6227.3 6234.1 5815.6 5871.0 5895.9 5906.6 5916.2 5967.6 6036.3 6059.1 6062.5 6077.5 5853.5 5873.6 5988.8 6055.1 6058.0 5868.1 5905.4 5941.8 5954.1 6003.9 4511.7 4540.2 4541.6 4546.6 4577.6 4020.8 4034.8 4057.7 4079.7 4087.1 5542.4 5641.3 5673.5 5696.4 5704.7 5971.3 6035.9 6036.0 6036.4 6044.5 5501.3 5629.1 5666.8 5693.1 5713.2 5179.6 5185.6 5187.1 5191.1 5191.4 6264.7 6279.7 6280.0 6281.9 6283.3 5785.8 6007.3 6055.8 6076.5 6077.5 6246.1 6272.0 6296.0 6299.0 6327.3 5644.5 5935.6 5961.3 5973.7 5981.6 5969.2 5996.2 6078.1 6083.9 6125.8 5880.3 5930.3 5937.4 5942.9 5990.2 5633.0 5790.5 5913.9 5923.8 5954.2 5832.9 5864.1 5891.5 5892.6 5907.0 5879.5 5886.5 5889.4 5890.8 5911.4 5551.7 5725.4 5737.8 5749.7 5779.8 16:50:46 INFO - PROCESS | 7030 | 16:50:46 INFO - PROCESS | 7030 | [#1] ext.html Cycles:180 Average:61053.36 Median:40767.40 stddev:125813.30 (308.6%) stddev-sans-first:126084.30 16:50:46 INFO - PROCESS | 7030 | Values: 579.0 594.4 611.1 616.0 641.9 38087.0 43074.0 43134.0 43140.0 43309.0 42054.6 42674.4 42757.1 42871.6 43101.8 8752.5 8926.3 8948.9 8963.6 8970.0 8808.1 8871.1 8919.3 8956.5 8958.3 8932.0 8933.9 8938.8 8942.6 8960.3 8894.0 8931.2 8946.5 8954.0 8965.1 8856.6 8873.6 8900.5 8913.1 8950.1 33175.3 39781.4 40047.8 40110.0 40444.4 3445.9 3466.7 3690.6 4167.4 4482.1 31362.7 32427.0 33109.8 34253.7 34636.5 4435.8 4450.3 4517.8 4535.3 4684.6 377694.0 381122.0 381952.0 384082.0 386714.0 34472.5 34734.1 59847.4 60899.4 61244.7 37247.6 37445.4 37623.8 37654.4 37814.4 14866.3 14917.6 14933.1 15020.6 15040.8 12765.2 12802.6 12817.6 12878.3 12908.3 8152.5 8153.1 8230.1 8240.3 8246.1 3129.8 3246.4 3294.0 3305.4 3330.0 1037.0 1081.7 1116.9 1124.7 1134.0 32000.7 32230.8 32313.8 32816.0 32881.3 1106.3 1109.8 1151.0 1154.5 1178.3 16788.0 16845.0 16846.0 17249.7 17320.9 552345.0 559349.0 559573.0 560846.0 563127.0 58647.0 58745.7 58856.0 58952.4 59058.7 1349.7 1361.0 1372.1 1382.6 1390.6 29933.9 30372.8 30498.0 30986.7 31396.7 49069.8 49205.5 49205.8 49209.8 49249.5 457135.0 460419.0 461247.0 461258.0 463588.0 27542.0 27665.3 28382.7 28673.3 28687.9 48013.0 48411.5 48881.5 49514.8 49968.5 40695.8 41082.2 41735.6 42036.6 42752.1 39365.6 40567.0 40839.0 40931.8 41197.4 40311.8 40432.4 41573.8 41692.6 41828.0 35036.0 37070.3 37575.4 37638.0 38371.6 28552.7 28995.1 29106.9 29220.0 29375.4 16:50:46 INFO - PROCESS | 7030 | 16:50:46 INFO - PROCESS | 7030 | [#2] jquery.html Cycles:180 Average:28910.38 Median:16162.32 stddev:79382.96 (491.2%) stddev-sans-first:79576.75 16:50:46 INFO - PROCESS | 7030 | Values: 383.8 390.9 393.8 396.2 412.1 14002.2 15601.0 18634.3 19937.1 19971.8 18146.6 18511.4 18799.2 20372.2 20393.2 5898.8 5974.8 6040.0 6049.6 6082.0 5751.6 5909.6 5919.5 5930.6 5932.7 5594.7 5805.6 5901.8 5922.3 5926.9 5857.9 5861.9 5878.2 5914.4 5925.3 5701.7 5720.7 5733.7 5755.5 5760.9 21805.5 22951.9 22953.5 23814.0 24704.0 2101.8 2252.6 2320.6 2418.5 2522.6 10134.3 10213.9 10223.4 10312.9 10862.6 1900.4 1927.6 1973.2 1984.0 2030.1 84339.0 84965.6 85525.0 88585.0 90553.0 10758.4 10990.7 11111.9 11171.6 11204.7 15256.1 15448.5 15528.2 15559.6 15582.9 8032.5 8221.1 8287.1 8416.0 8530.7 8026.1 8047.8 8140.2 8270.8 8287.4 4679.1 4753.5 4778.9 4824.1 4890.9 1925.5 1965.9 1997.1 1999.8 2030.6 977.5 979.5 1021.7 1048.1 1065.3 20270.7 20340.0 20394.8 20508.8 20682.6 970.4 986.8 991.6 1059.5 1080.7 10094.5 11341.7 11347.7 11350.1 11418.1 472938.0 479817.0 480238.0 484141.0 486457.0 74837.0 91620.0 91979.0 95111.0 95468.0 994.9 995.7 998.4 998.6 1003.6 17976.0 17977.6 18055.3 18239.6 18463.4 29802.0 30019.4 36699.8 42646.0 43649.8 59175.4 60438.0 60957.4 61787.4 62037.4 8548.5 8642.4 8696.4 8844.4 8915.0 10172.6 13446.5 13922.3 13975.4 14475.3 11959.4 12105.5 12291.8 12323.7 12384.6 11480.9 11611.2 12002.8 12191.8 12404.4 12472.5 12528.3 12577.4 12591.9 12723.4 7604.9 7982.2 8028.8 8040.1 8475.8 11776.3 12194.8 12321.3 12736.6 12777.4 16:50:46 INFO - PROCESS | 7030 | 16:50:46 INFO - PROCESS | 7030 | [#3] mootools.html Cycles:180 Average:5876.04 Median:4511.06 stddev:3365.21 (74.6%) stddev-sans-first:3358.56 16:50:46 INFO - PROCESS | 7030 | Values: 1497.5 1517.3 1671.1 1795.6 1797.1 7927.1 8739.0 8749.3 9333.6 9366.7 8760.5 9054.1 9105.9 9111.7 9124.9 2325.8 2355.4 2355.4 2356.5 2364.0 2313.3 2314.2 2374.2 2379.3 2379.6 2340.1 2344.2 2378.8 2413.5 2417.2 2243.3 2269.6 2285.9 2286.7 2293.0 2223.2 2226.4 2226.7 2230.3 2234.5 9119.5 9246.4 9255.7 9256.1 9266.2 5033.7 5108.2 5116.4 5120.5 5122.2 3226.3 3258.1 3297.2 3311.5 3368.9 1150.4 1159.9 2203.5 2252.9 2257.6 12791.4 12850.9 12854.7 12868.7 12883.9 4384.4 4390.3 4502.8 4562.9 4570.6 9908.0 9942.8 9943.0 10024.9 10052.0 5268.2 5285.8 5296.4 5300.0 5322.1 4266.1 4729.2 4884.2 4890.9 4953.5 3681.9 3693.6 3799.9 3803.6 3825.8 1134.4 1135.3 1141.2 1145.7 1148.6 903.0 977.0 1018.4 1055.8 1056.6 6354.2 6376.5 6479.5 6499.7 6573.0 429.9 432.3 435.9 446.6 480.7 4228.8 4484.3 4494.9 4519.4 4528.5 10568.0 10682.7 10818.9 10842.1 10873.9 10642.8 10658.0 10658.2 10661.3 10669.6 8139.6 8160.3 8239.1 8454.4 8479.2 6315.3 6412.4 6473.1 6492.2 6585.5 10351.3 10614.2 10627.1 10711.5 10735.5 10566.8 10816.5 10890.9 10924.2 10967.8 7391.9 7648.1 7705.2 7738.9 7998.4 8574.1 8626.7 8630.4 8643.8 8645.0 7540.2 7615.5 7652.6 7816.2 7904.1 7158.0 7254.2 7277.6 7314.2 7424.6 6979.5 6983.2 6990.7 7063.0 7069.9 5031.0 5077.2 5147.3 5256.7 5270.1 5189.8 5297.0 5355.8 5362.2 5395.6 16:50:46 INFO - PROCESS | 7030 | 16:50:46 INFO - PROCESS | 7030 | [#4] prototype.html Cycles:180 Average:4949.02 Median:5691.42 stddev:1474.35 (25.9%) stddev-sans-first:1437.10 16:50:46 INFO - PROCESS | 7030 | Values: 327.2 333.2 338.0 338.8 340.4 5591.2 5672.2 5681.6 5810.9 5812.2 5633.3 5646.3 5661.2 5681.8 5682.6 4351.6 4389.9 4409.4 4415.8 4431.5 3986.2 4338.5 4340.9 4361.7 4380.4 4253.2 4306.2 4314.6 4336.0 4351.2 4359.6 4367.4 4376.8 4392.4 4392.6 3749.3 3760.5 3792.6 3799.9 3804.2 5452.9 5455.5 5458.3 5469.2 5492.1 4973.8 4974.8 4981.8 4989.3 5015.6 5691.9 5741.3 5809.5 5846.5 5846.9 4151.2 4161.8 4165.6 4173.4 4175.0 5912.7 5967.9 6025.6 6030.3 6075.2 4188.7 4231.9 4241.6 4242.5 4300.5 4310.5 4339.8 4348.8 4357.7 4363.0 4976.6 4978.2 4978.9 4997.0 5002.1 5805.6 5843.4 5926.5 5952.6 5973.7 1479.6 1485.9 1489.3 1490.9 1497.0 926.7 947.6 953.4 957.3 964.3 5024.8 5041.7 5499.7 5522.7 5657.2 6040.6 6072.9 6097.9 6131.3 6179.6 5532.2 5691.0 5703.8 5736.3 5740.7 3223.0 3230.9 3239.3 3266.2 3267.5 6214.4 6272.6 6279.6 6304.3 6311.0 6044.5 6105.2 6106.1 6156.9 6159.0 6263.3 6286.4 6327.4 6360.7 6360.8 5912.5 6055.4 6064.3 6123.6 6134.5 5945.9 5968.2 5978.4 6013.2 6029.6 6038.8 6247.8 6304.2 6314.7 6329.9 4176.5 4187.6 4187.9 4192.2 4194.7 6043.3 6057.6 6070.8 6091.0 6104.3 5770.4 5898.1 5925.9 5943.7 5951.2 5866.5 5883.1 5888.4 5901.4 5938.8 5846.4 5860.3 5879.7 5902.6 5919.6 5634.7 5871.9 5925.1 5925.3 5932.5 5762.2 5811.8 5815.3 5817.8 5829.9 16:50:46 INFO - PROCESS | 7030 | 16:50:46 INFO - PROCESS | 7030 | [#5] yui.html Cycles:180 Average:20714.63 Median:3950.24 stddev:28504.79 (721.6%) stddev-sans-first:28545.30 16:50:46 INFO - PROCESS | 7030 | Values: 739.8 753.3 771.2 800.5 806.7 15223.5 15521.0 15758.4 15873.4 16109.8 16758.2 16810.9 16882.5 16883.1 16887.6 816.8 823.4 826.2 829.8 846.5 843.5 844.6 845.1 847.2 849.7 875.2 877.2 880.4 880.8 882.3 865.6 866.7 866.9 868.1 868.1 629.2 632.3 632.6 632.6 633.3 14534.3 14555.5 14562.1 14575.0 14614.6 14842.2 15193.4 15235.9 15247.2 15331.2 11951.0 12394.9 12417.8 12506.9 12530.9 3834.9 3868.9 3871.2 3909.9 3990.6 78550.2 80848.6 81445.0 82664.2 82742.6 11493.7 11499.5 11533.5 11758.6 11765.5 21823.7 21948.7 21968.8 22024.9 22040.2 7755.2 7759.6 8198.1 8255.3 8557.4 4514.7 4561.8 4570.4 4655.5 4783.3 3377.3 3453.8 3480.6 3482.3 3514.1 628.4 635.2 637.4 649.1 659.0 666.5 673.3 692.0 739.1 743.8 10122.6 10333.7 10381.3 10449.8 10707.5 697.4 766.1 781.3 781.9 790.3 4841.3 5051.2 5059.2 5164.5 5181.7 69625.7 71302.3 87102.0 90594.0 125798.4 63476.7 89718.6 91501.0 93834.5 104226.5 91964.0 92615.1 93599.5 94925.0 96462.0 10299.7 10600.6 10704.0 10736.4 10754.4 52911.0 53320.5 53396.0 53722.7 54308.5 71317.0 80287.0 82019.6 82926.6 82999.6 13566.0 13719.9 13808.7 13959.1 14129.8 15873.2 16010.2 16227.8 16278.3 16938.5 14166.5 14269.6 14580.3 15093.6 15175.2 14499.4 14755.3 15161.8 15458.9 15519.4 12025.9 13172.7 13637.2 13802.2 14900.7 11537.9 12288.4 12404.9 12462.4 12510.7 12445.4 12599.7 12859.3 12990.2 13082.7 16:50:46 INFO - PROCESS | 7030 | -------- Summary: end -------- 16:50:46 INFO - PROCESS | 7030 | 16:50:47 INFO - TEST-INFO | 7030: exit 0 16:50:47 INFO - TEST-OK | dromaeo_css | took 1110670ms 16:50:47 INFO - TEST-START | kraken 16:50:47 INFO - operating with platform_type : linux_ 16:50:47 INFO - Initialising browser for kraken test... 16:50:47 INFO - TEST-INFO | started process 7276 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpR1qIqT/profile http://localhost:44674/getInfo.html) 16:50:52 INFO - PROCESS | 7276 | __metrics Screen width/height:1600/1200 16:50:52 INFO - PROCESS | 7276 | colorDepth:24 16:50:52 INFO - PROCESS | 7276 | Browser inner width/height: 1024/697 16:50:52 INFO - PROCESS | 7276 | __metrics 16:50:53 ERROR - PROCESS | 7276 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2964: TypeError: this.tabs is undefined 16:50:53 INFO - TEST-INFO | 7276: exit 0 16:50:54 INFO - Browser initialized. 16:50:54 INFO - Running cycle 1/1 for kraken test... 16:50:54 INFO - TEST-INFO | started process 7395 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpR1qIqT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:51:05 INFO - PROCESS | 7395 | RSS: Main: 167731200 16:51:05 INFO - PROCESS | 7395 | 16:51:08 INFO - PROCESS | 7395 | Cycle 1(1): loaded http://localhost:44674/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44674/tests/kraken/driver.html?testName=audio-beat-detection) 16:51:09 INFO - PROCESS | 7395 | RSS: Main: 172916736 16:51:09 INFO - PROCESS | 7395 | 16:51:11 INFO - PROCESS | 7395 | Cycle 1(1): loaded http://localhost:44674/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44674/tests/kraken/driver.html?testName=audio-dft) 16:51:12 INFO - PROCESS | 7395 | RSS: Main: 172314624 16:51:12 INFO - PROCESS | 7395 | 16:51:15 INFO - PROCESS | 7395 | Cycle 1(1): loaded http://localhost:44674/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44674/tests/kraken/driver.html?testName=audio-fft) 16:51:16 INFO - PROCESS | 7395 | RSS: Main: 167006208 16:51:16 INFO - PROCESS | 7395 | 16:51:18 INFO - PROCESS | 7395 | Cycle 1(1): loaded http://localhost:44674/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44674/tests/kraken/driver.html?testName=audio-oscillator) 16:51:18 INFO - PROCESS | 7395 | RSS: Main: 167800832 16:51:18 INFO - PROCESS | 7395 | 16:51:20 INFO - PROCESS | 7395 | Cycle 1(1): loaded http://localhost:44674/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44674/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:51:21 INFO - PROCESS | 7395 | RSS: Main: 168062976 16:51:21 INFO - PROCESS | 7395 | 16:51:24 INFO - PROCESS | 7395 | Cycle 1(1): loaded http://localhost:44674/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44674/tests/kraken/driver.html?testName=imaging-darkroom) 16:51:25 INFO - PROCESS | 7395 | RSS: Main: 167936000 16:51:25 INFO - PROCESS | 7395 | 16:51:28 INFO - PROCESS | 7395 | Cycle 1(1): loaded http://localhost:44674/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44674/tests/kraken/driver.html?testName=imaging-desaturate) 16:51:29 INFO - PROCESS | 7395 | RSS: Main: 166633472 16:51:29 INFO - PROCESS | 7395 | 16:51:32 INFO - PROCESS | 7395 | Cycle 1(1): loaded http://localhost:44674/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44674/tests/kraken/driver.html?testName=json-parse-financial) 16:51:32 INFO - PROCESS | 7395 | RSS: Main: 167788544 16:51:32 INFO - PROCESS | 7395 | 16:51:34 INFO - PROCESS | 7395 | Cycle 1(1): loaded http://localhost:44674/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44674/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:51:35 INFO - PROCESS | 7395 | RSS: Main: 168177664 16:51:35 INFO - PROCESS | 7395 | 16:51:36 INFO - PROCESS | 7395 | Cycle 1(1): loaded http://localhost:44674/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44674/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:51:37 INFO - PROCESS | 7395 | RSS: Main: 168529920 16:51:37 INFO - PROCESS | 7395 | 16:51:39 INFO - PROCESS | 7395 | Cycle 1(1): loaded http://localhost:44674/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44674/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:51:40 INFO - PROCESS | 7395 | RSS: Main: 168542208 16:51:40 INFO - PROCESS | 7395 | 16:51:42 INFO - PROCESS | 7395 | Cycle 1(1): loaded http://localhost:44674/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44674/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:51:43 INFO - PROCESS | 7395 | RSS: Main: 168714240 16:51:43 INFO - PROCESS | 7395 | 16:51:46 INFO - PROCESS | 7395 | Cycle 1(1): loaded http://localhost:44674/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44674/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:51:46 INFO - PROCESS | 7395 | RSS: Main: 168427520 16:51:46 INFO - PROCESS | 7395 | 16:51:48 INFO - PROCESS | 7395 | Cycle 1(1): loaded http://localhost:44674/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44674/tests/kraken/driver.html?testName=ai-astar) 16:51:48 INFO - PROCESS | 7395 | RSS: Main: 169275392 16:51:48 INFO - PROCESS | 7395 | 16:51:48 INFO - PROCESS | 7395 | __start_tp_report 16:51:48 INFO - PROCESS | 7395 | _x_x_mozilla_page_load 16:51:48 INFO - PROCESS | 7395 | _x_x_mozilla_page_load_details 16:51:48 INFO - PROCESS | 7395 | |i|pagename|runs| 16:51:48 INFO - PROCESS | 7395 | |0;ai-astar;104;113;105;113;113;111;114;111;112;112 16:51:48 INFO - PROCESS | 7395 | |1;audio-beat-detection;157;120;142;180;121;144;149;125;173;118 16:51:48 INFO - PROCESS | 7395 | |2;audio-dft;166;165;161;162;161;166;179;163;162;161 16:51:48 INFO - PROCESS | 7395 | |3;audio-fft;75;76;75;169;75;76;76;75;181;77 16:51:48 INFO - PROCESS | 7395 | |4;audio-oscillator;91;83;147;85;85;84;153;84;84;152 16:51:48 INFO - PROCESS | 7395 | |5;imaging-gaussian-blur;117;117;118;117;117;117;118;118;119;118 16:51:48 INFO - PROCESS | 7395 | |6;imaging-darkroom;148;149;147;147;148;146;147;147;148;147 16:51:48 INFO - PROCESS | 7395 | |7;imaging-desaturate;96;95;95;95;96;96;96;95;95;96 16:51:48 INFO - PROCESS | 7395 | |8;json-parse-financial;56;58;57;58;61;58;56;58;58;56 16:51:48 INFO - PROCESS | 7395 | |9;json-stringify-tinderbox;64;64;64;63;64;64;64;64;67;65 16:51:48 INFO - PROCESS | 7395 | |10;stanford-crypto-aes;75;76;77;75;76;76;74;75;76;86 16:51:48 INFO - PROCESS | 7395 | |11;stanford-crypto-ccm;127;120;130;125;130;120;124;126;192;132 16:51:48 INFO - PROCESS | 7395 | |12;stanford-crypto-pbkdf2;161;161;161;158;159;165;159;171;165;162 16:51:48 INFO - PROCESS | 7395 | |13;stanford-crypto-sha256-iterative;65;64;63;64;71;66;66;65;69;63 16:51:48 INFO - PROCESS | 7395 | __end_tp_report 16:51:48 INFO - PROCESS | 7395 | __start_cc_report 16:51:48 INFO - PROCESS | 7395 | _x_x_mozilla_cycle_collect,910 16:51:48 INFO - PROCESS | 7395 | __end_cc_report 16:51:48 INFO - PROCESS | 7395 | __startTimestamp1468281108778__endTimestamp 16:51:48 INFO - PROCESS | 7395 | 16:51:48 INFO - PROCESS | 7395 | ------- Summary: start ------- 16:51:48 INFO - PROCESS | 7395 | Number of tests: 14 16:51:48 INFO - PROCESS | 7395 | 16:51:48 INFO - PROCESS | 7395 | [#0] ai-astar Cycles:10 Average:110.80 Median:112.50 stddev:3.46 (3.1%) stddev-sans-first:2.65 16:51:48 INFO - PROCESS | 7395 | Values: 104.0 113.0 105.0 113.0 113.0 111.0 114.0 111.0 112.0 112.0 16:51:48 INFO - PROCESS | 7395 | 16:51:48 INFO - PROCESS | 7395 | [#1] audio-beat-detection Cycles:10 Average:142.90 Median:146.50 stddev:22.27 (15.2%) stddev-sans-first:23.03 16:51:48 INFO - PROCESS | 7395 | Values: 157.0 120.0 142.0 180.0 121.0 144.0 149.0 125.0 173.0 118.0 16:51:48 INFO - PROCESS | 7395 | 16:51:48 INFO - PROCESS | 7395 | [#2] audio-dft Cycles:10 Average:164.60 Median:164.00 stddev:5.44 (3.3%) stddev-sans-first:5.75 16:51:48 INFO - PROCESS | 7395 | Values: 166.0 165.0 161.0 162.0 161.0 166.0 179.0 163.0 162.0 161.0 16:51:48 INFO - PROCESS | 7395 | 16:51:48 INFO - PROCESS | 7395 | [#3] audio-fft Cycles:10 Average:95.50 Median:75.50 stddev:42.00 (55.6%) stddev-sans-first:43.89 16:51:48 INFO - PROCESS | 7395 | Values: 75.0 76.0 75.0 169.0 75.0 76.0 76.0 75.0 181.0 77.0 16:51:48 INFO - PROCESS | 7395 | 16:51:48 INFO - PROCESS | 7395 | [#4] audio-oscillator Cycles:10 Average:104.80 Median:84.00 stddev:31.76 (37.8%) stddev-sans-first:33.29 16:51:48 INFO - PROCESS | 7395 | Values: 91.0 83.0 147.0 85.0 85.0 84.0 153.0 84.0 84.0 152.0 16:51:48 INFO - PROCESS | 7395 | 16:51:48 INFO - PROCESS | 7395 | [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:118.00 stddev:0.70 (0.6%) stddev-sans-first:0.71 16:51:48 INFO - PROCESS | 7395 | Values: 117.0 117.0 118.0 117.0 117.0 117.0 118.0 118.0 119.0 118.0 16:51:48 INFO - PROCESS | 7395 | 16:51:48 INFO - PROCESS | 7395 | [#6] imaging-darkroom Cycles:10 Average:147.40 Median:147.50 stddev:0.84 (0.6%) stddev-sans-first:0.87 16:51:48 INFO - PROCESS | 7395 | Values: 148.0 149.0 147.0 147.0 148.0 146.0 147.0 147.0 148.0 147.0 16:51:48 INFO - PROCESS | 7395 | 16:51:48 INFO - PROCESS | 7395 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 16:51:48 INFO - PROCESS | 7395 | Values: 96.0 95.0 95.0 95.0 96.0 96.0 96.0 95.0 95.0 96.0 16:51:48 INFO - PROCESS | 7395 | 16:51:48 INFO - PROCESS | 7395 | [#8] json-parse-financial Cycles:10 Average:57.60 Median:58.00 stddev:1.51 (2.6%) stddev-sans-first:1.48 16:51:48 INFO - PROCESS | 7395 | Values: 56.0 58.0 57.0 58.0 61.0 58.0 56.0 58.0 58.0 56.0 16:51:48 INFO - PROCESS | 7395 | 16:51:48 INFO - PROCESS | 7395 | [#9] json-stringify-tinderbox Cycles:10 Average:64.30 Median:64.00 stddev:1.06 (1.7%) stddev-sans-first:1.12 16:51:48 INFO - PROCESS | 7395 | Values: 64.0 64.0 64.0 63.0 64.0 64.0 64.0 64.0 67.0 65.0 16:51:48 INFO - PROCESS | 7395 | 16:51:48 INFO - PROCESS | 7395 | [#10] stanford-crypto-aes Cycles:10 Average:76.60 Median:76.00 stddev:3.41 (4.5%) stddev-sans-first:3.56 16:51:48 INFO - PROCESS | 7395 | Values: 75.0 76.0 77.0 75.0 76.0 76.0 74.0 75.0 76.0 86.0 16:51:48 INFO - PROCESS | 7395 | 16:51:48 INFO - PROCESS | 7395 | [#11] stanford-crypto-ccm Cycles:10 Average:132.60 Median:128.50 stddev:21.26 (16.5%) stddev-sans-first:22.45 16:51:48 INFO - PROCESS | 7395 | Values: 127.0 120.0 130.0 125.0 130.0 120.0 124.0 126.0 192.0 132.0 16:51:48 INFO - PROCESS | 7395 | 16:51:48 INFO - PROCESS | 7395 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.20 Median:161.50 stddev:3.88 (2.4%) stddev-sans-first:4.09 16:51:48 INFO - PROCESS | 7395 | Values: 161.0 161.0 161.0 158.0 159.0 165.0 159.0 171.0 165.0 162.0 16:51:48 INFO - PROCESS | 7395 | 16:51:48 INFO - PROCESS | 7395 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.60 Median:65.50 stddev:2.59 (4.0%) stddev-sans-first:2.74 16:51:48 INFO - PROCESS | 7395 | Values: 65.0 64.0 63.0 64.0 71.0 66.0 66.0 65.0 69.0 63.0 16:51:48 INFO - PROCESS | 7395 | -------- Summary: end -------- 16:51:48 INFO - PROCESS | 7395 | 16:51:49 INFO - TEST-INFO | 7395: exit 0 16:51:49 INFO - TEST-OK | kraken | took 62164ms 16:51:49 INFO - SUITE-END | took 1172s 16:51:49 INFO - Completed test suite (00:19:33) 16:51:49 INFO - javascript benchmark 16:51:50 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7347.646776987234, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3091.5826363440938, 3135.404273188095, 3145.95281070784, 3170.3342298117395, 3177.9205519862003, 5523.834284971453, 5555.472230138141, 5565.610407271488, 5606.663600183992, 5650.180723795047, 5376.1398176291705, 5521.365043020054, 5543.501084902358, 5550.611457197998, 5576.944230557693, 4958.925616115761, 4985.875353116165, 5120.308758317636, 5175.301334319875, 5221.2429197766305, 472.80682833636337, 4961.8511444656715, 5016.247562865563, 5049.419316778581, 5051.090803655341, 5051.090803655341, 5063.696178229318, 5077.771500282496, 5104.2088476286235, 5110.6422550421485, 5085.084684756743, 5104.770285337168, 5111.437741848394, 5132.486751324875, 5149.613778966555, 4952.603791696655, 5026.195808670632, 5048.9495105048845, 5078.984203159383, 5084.51697088776, 5529.502344788948, 5550.417206193332, 5560.304961879765, 5581.469760372758, 5605.747741351649, 5683.829485115453, 5978.611390259663, 5987.37132601075, 5988.071848863433, 6010.639361638272, 5812.680302583356, 5889.0, 5900.321463031763, 5957.761689532414, 5964.582479226456, 5485.533729632986, 5506.724663766836, 5509.614326997152, 5512.200730894038, 5512.80705175317, 5906.40935906406, 5967.850803729854, 6203.16257305258, 6227.346128656516, 6234.127222188898, 5815.592908496449, 5871.001929671966, 5895.852603684856, 5906.5570082244, 5916.201312822714, 5967.6121052131475, 6036.305824830113, 6059.0608455689435, 6062.454379105901, 6077.483413909778, 5853.5317174625925, 5873.647581145145, 5988.760449581968, 6055.061465472859, 6058.0, 5868.061110222429, 5905.40945905406, 5941.762329506858, 5954.136650185699, 6003.909941350883, 4511.70673906195, 4540.2054640438455, 4541.613962813131, 4546.590806827336, 4577.56513131252, 4020.7587544747407, 4034.8386064557676, 4057.655099316532, 4079.7348172369293, 4087.080406908481, 5542.418046105182, 5641.294838145232, 5673.461021202979, 5696.401877802854, 5704.743286552115, 5971.343152253248, 6035.939640603538, 6035.969820150959, 6036.366181550874, 6044.516438684895, 5501.284832971688, 5629.127485239795, 5666.773329066874, 5693.060644993529, 5713.171590119409, 5179.559737422286, 5185.585153187736, 5187.0922588546855, 5191.143461328914, 5191.351081114861, 6264.686765661699, 6279.717412716439, 6280.0, 6281.8743625127245, 6283.340249273851, 5785.82642520725, 6007.309159446545, 6055.788047418319, 6076.483498902643, 6077.544184186292, 6246.08376515507, 6271.96864015677, 6295.96852015737, 6298.968505157628, 6327.335629758809, 5644.548436125182, 5935.584509084495, 5961.254843144607, 5973.731182096903, 5981.641101533922, 5969.194158788508, 5996.190514280691, 6078.057901025348, 6083.939160608337, 6125.816225513242, 5880.26496687914, 5930.347661757117, 5937.406259374201, 5942.881142377215, 5990.191324171181, 5633.0423827948525, 5790.478856902899, 5913.881722365442, 5923.822285331447, 5954.166416701579, 5832.912506312494, 5864.149698293638, 5891.469767720926, 5892.616979896293, 5906.970465147819, 5879.529637629065, 5886.499647530008, 5889.352171261072, 5890.823275301748, 5911.438413350725, 5551.694656793915, 5725.398833122629, 5737.799177028784, 5749.655020698771, 5779.797707080232], "value": 5475.060556350611, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [578.9855253618659, 594.4115325827432, 611.0559186057541, 616.0236025898948, 641.9069234960933, 38087.0, 43074.0, 43134.0, 43140.0, 43309.0, 42054.57945420545, 42674.359884601756, 42757.14485710284, 42871.57128428715, 43101.78449107758, 8752.518611476366, 8926.285897128215, 8948.910510894906, 8963.596638151299, 8970.0, 8808.119188081204, 8871.068537803534, 8919.331050171264, 8956.507392093432, 8958.32812539059, 8932.034952310514, 8933.865992010125, 8938.821223575525, 8942.597583108776, 8960.327975401839, 8894.0, 8931.151540603632, 8946.463212207256, 8954.0, 8965.103489651048, 8856.64573417069, 8873.556322183866, 8900.465972041698, 8913.108689131035, 8950.104989501064, 33175.33649327024, 39781.40327895084, 40047.7997610013, 40110.0, 40444.393334100016, 3445.913852153691, 3466.722662187019, 3690.55713314404, 4167.437395951569, 4482.103579284156, 31362.686373136206, 32427.0, 33109.83445082783, 34253.6574634253, 34636.48045279323, 4435.800388982503, 4450.326661313178, 4517.796699148546, 4535.297028960484, 4684.648651351163, 377694.0, 381122.0, 381952.0, 384082.0, 386714.0, 34472.48291275633, 34734.13164670904, 59847.40152598506, 60899.391006090256, 61244.69377653083, 37247.62752372496, 37445.438318425244, 37623.81188094042, 37654.43518347227, 37814.432783508266, 14866.331015104346, 14917.552473425814, 14933.104013758992, 15020.624484387978, 15040.774388384183, 12765.170263932814, 12802.551910683082, 12817.615471535868, 12878.291693956735, 12908.29004404748, 8152.51084934894, 8153.062397824207, 8230.09468958414, 8240.258376746122, 8246.134155913544, 3129.765267604939, 3246.4092594628464, 3293.9953314239388, 3305.3554556861664, 3329.9833500832824, 1037.0148359058924, 1081.7241603391085, 1116.8938950799661, 1124.7244425115898, 1133.9773204535863, 32000.679993200236, 32230.83884580562, 32313.838430807697, 32816.0, 32881.3423731524, 1106.3417266726285, 1109.8446217529552, 1150.9539618415338, 1154.4977934598476, 1178.263585259213, 16788.0, 16845.0, 16846.046325878742, 17249.741253881202, 17320.91339543294, 552345.0, 559349.0, 559573.0, 560846.0, 563127.0, 58647.0, 58745.70627146922, 58856.0, 58952.41047589469, 59058.704706476194, 1349.689571398584, 1361.0404664711355, 1372.0807059270312, 1382.5644921849585, 1390.603677951779, 29933.850330748206, 30372.848135760065, 30498.0, 30986.69013309928, 31396.68603314029, 49069.75465122652, 49205.50794492009, 49205.75397122991, 49209.75395123001, 49249.50750492449, 457135.0, 460419.0, 461247.0, 461258.0, 463588.0, 27542.0, 27665.308367290978, 28382.71617283801, 28673.28316792097, 28687.856560717064, 48013.0, 48411.5158848407, 48881.5111848877, 49514.75242623764, 49968.50031499784, 40695.796521017204, 41082.1783564333, 41735.582644174385, 42036.57963420327, 42752.14495710006, 39365.62220322275, 40567.0, 40839.0, 40931.795341023106, 41197.382039270036, 40311.79844100878, 40432.39351409672, 41573.79213104036, 41692.58307416887, 41828.0, 35036.0, 37070.25859482741, 37575.43636845504, 37638.0, 38371.6162838368, 28552.714472855005, 28995.13014609565, 29106.854465727534, 29220.0, 29375.41249174962], "value": 19032.891901613842, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [383.7620675181386, 390.86319788074167, 393.77554793767564, 396.2411981056277, 412.07900342734, 14002.159870407782, 15601.0, 18634.34779782708, 19937.10283037263, 19971.800281997177, 18146.637067258645, 18511.44465666029, 18799.24803007878, 20372.185112595478, 20393.184272629078, 5898.764049438028, 5974.761009559634, 6040.033594624861, 6049.576529642927, 6081.969590152043, 5751.568632352591, 5909.556783241253, 5919.467247947684, 5930.644161350311, 5932.673702946337, 5594.692291923942, 5805.593608447411, 5901.793437229677, 5922.318933322658, 5926.88146237075, 5857.85355366115, 5861.941380586182, 5878.177055212273, 5914.4381283777975, 5925.34821169671, 5701.743421546041, 5720.742566584514, 5733.684647344436, 5755.539556835443, 5760.942390576082, 21805.454863628376, 22951.885240573858, 22953.54092918149, 23814.0, 24704.0, 2101.821345185661, 2252.6395776675818, 2320.582295186866, 2418.4558474343307, 2522.646829443879, 10134.290599658027, 10213.948930255376, 10223.386596804216, 10312.948435257851, 10862.61980830675, 1900.4108726294892, 1927.5952050069502, 1973.2008536542724, 1983.9702404463944, 2030.116899148875, 84339.0, 84965.57517212375, 85525.0, 88585.0, 90553.0, 10758.408287544104, 10990.725231869268, 11111.939667815053, 11171.608993685344, 11204.719882003015, 15256.084634921941, 15448.459303924308, 15528.223588820514, 15559.611009724847, 15582.9220853895, 8032.4778889372, 8221.136780638066, 8287.088420273765, 8416.0, 8530.65877364911, 8026.117127116013, 8047.839043219103, 8140.226678465655, 8270.751877443687, 8287.41988060842, 4679.077300662314, 4753.47711751707, 4778.928316075262, 4824.131656301899, 4890.853274401774, 1925.4993701637675, 1965.9213631454868, 1997.0786617678652, 1999.780024197337, 2030.644637188486, 977.5014742481244, 979.5298256836759, 1021.7292417509366, 1048.130052056791, 1065.2969040433431, 20270.69593956092, 20340.0, 20394.796052039586, 20508.794912050987, 20682.58634827295, 970.4419958523877, 986.8026394721085, 991.5934466868549, 1059.5496913811753, 1080.7352198711367, 10094.495275236355, 11341.716457088638, 11347.716307092389, 11350.148738844455, 11418.086553075735, 472938.0, 479817.0, 480238.0, 484141.0, 486457.0, 74837.0, 91620.0, 91979.0, 95110.99999999862, 95468.0, 994.8757903569066, 995.7012896131132, 998.4059484606647, 998.6404894238068, 1003.5534187286587, 17976.0, 17977.640447191243, 18055.277788888296, 18239.635207296044, 18463.35378261808, 29802.0, 30019.399612008074, 36699.816500917324, 42646.0, 43649.78175109104, 59175.40824591699, 60438.0, 60957.390426095175, 61787.38212617816, 62037.37962620316, 8548.529830859363, 8642.43824151428, 8696.434731742416, 8844.380893337404, 8914.955425222832, 10172.593096276067, 13446.529371471952, 13922.303884805922, 13975.371108299947, 14475.348609312818, 11959.402029898645, 12105.515779368727, 12291.75416491683, 12323.69190770238, 12384.62846114618, 11480.885191148316, 11611.245269057485, 12002.75994480123, 12191.75616487683, 12404.441800119197, 12472.5010999559, 12528.310942898228, 12577.371131443575, 12591.93704031474, 12723.447424576536, 7604.923950760643, 7982.241687039722, 8028.799280018046, 8040.075391329838, 8475.788105297417, 11776.293422394683, 12194.81707774402, 12321.322327271728, 12736.61790146297, 12777.361131943551], "value": 9336.283906487015, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1497.4609140709342, 1517.2868751686706, 1671.1393632279378, 1795.5870149865523, 1797.1014492753632, 7927.088384835745, 8738.995015573202, 8749.343799215068, 9333.626654933803, 9366.672166474165, 8760.474371537712, 9054.139856713618, 9105.908940910605, 9111.726648200549, 9124.908750912506, 2325.825563082771, 2355.37582540626, 2355.3993731598416, 2356.50513392187, 2364.0, 2313.2597568777996, 2314.166899916029, 2374.157174203159, 2379.2505360811374, 2379.5954687703047, 2340.110757911991, 2344.23812261015, 2378.7621237876247, 2413.5293617744546, 2417.190241269177, 2243.2821497120844, 2269.6028195065965, 2285.919992800252, 2286.691296674944, 2293.025464177718, 2223.2329846203033, 2226.387743370586, 2226.6882636430914, 2230.3086043326457, 2234.4525591230254, 9119.49842758648, 9246.35275530713, 9255.722328330161, 9256.074392560757, 9266.212371948392, 5033.697978121288, 5108.233764935252, 5116.411612664517, 5120.48795120485, 5122.206058061007, 3226.322472280824, 3258.104021394112, 3297.241634424072, 3311.536384906091, 3368.9157771055675, 1150.413289222494, 1159.8840115988335, 2203.46015226269, 2252.8986195621073, 2257.5777260326054, 12791.424385902657, 12850.935745321307, 12854.742905141844, 12868.678283042906, 12883.871161288362, 4384.430024096847, 4390.275604525217, 4502.752348620857, 4562.8631141065825, 4570.565796249351, 9908.0, 9942.80114397708, 9942.950285248673, 10024.949875250722, 10052.0, 5268.15709486488, 5285.788568457296, 5296.364436267596, 5300.0, 5322.068637988336, 4266.146770645822, 4729.196036673774, 4884.242942343943, 4890.853274401774, 4953.455119936804, 3681.889543313705, 3693.593704692482, 3799.9240015199543, 3803.5625903021505, 3825.7895815729844, 1134.432783608196, 1135.250734515216, 1141.1555448967704, 1145.6505765741529, 1148.5578052449866, 902.9864552031725, 976.9741771140274, 1018.4245901065874, 1055.8257887448638, 1056.6301794372062, 6354.205724284465, 6376.489880809524, 6479.546431749733, 6499.675016249169, 6573.0, 429.94840619125904, 432.3385220612468, 435.89974305909817, 446.6449172907546, 480.7211817146047, 4228.788560571959, 4484.282514797616, 4494.887627809266, 4519.367288579601, 4528.50186479487, 10568.0, 10682.679519614425, 10818.891811081945, 10842.132629389629, 10873.891261087447, 10642.787144257227, 10658.0, 10658.200634952409, 10661.253712240225, 10669.57321707123, 8139.593020349077, 8160.265576098061, 8239.134890836496, 8454.40819142654, 8479.236868681848, 6315.305316415099, 6412.387498689676, 6473.1261279728515, 6492.188476440445, 6585.473162147113, 10351.275410721177, 10614.203934705083, 10627.149828013586, 10711.517981690688, 10735.516901739284, 10566.788664226826, 10816.513256903616, 10890.891091088988, 10924.235303528676, 10967.83548246761, 7391.926080739124, 7648.082230132197, 7705.229477052474, 7738.883916741366, 7998.440109192301, 8574.09971952936, 8626.698065567674, 8630.439021463584, 8643.827123457622, 8645.049044604963, 7540.245975402416, 7615.504992175491, 7652.617369131633, 7816.218378162365, 7904.091029531447, 7158.0, 7254.202037775735, 7277.636118194175, 7314.158871729819, 7424.591647459441, 6979.511434199558, 6983.162020557363, 6990.685419156049, 7063.046488723957, 7069.893951590628, 5031.0441016206805, 5077.213031980049, 5147.3308469898675, 5256.684598924076, 5270.051390749549, 5189.792408303626, 5296.973515132399, 5355.758990845499, 5362.222477740784, 5395.622306438511], "value": 4640.651223209276, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [327.2473311383818, 333.2435371706227, 338.0433373552844, 338.8479170819214, 340.3788086741697, 5591.210812539994, 5672.234248376468, 5681.602287839848, 5810.883782324351, 5812.244408226925, 5633.295838020247, 5646.2942132233475, 5661.23573317602, 5681.7727290908315, 5682.573806964484, 4351.586599273072, 4389.890252743691, 4409.4488188976375, 4415.801288942005, 4431.468223813147, 3986.2426139033637, 4338.50107237667, 4340.854483967819, 4361.694681372305, 4380.408644832939, 4253.191893540217, 4306.160298741746, 4314.590113939186, 4335.978320108395, 4351.195028919644, 4359.607635312821, 4367.366731823868, 4376.846810361654, 4392.38506609075, 4392.582704643054, 3749.268892565951, 3760.492333534965, 3792.639699228569, 3799.9240015199816, 3804.1630841214887, 5452.882159157363, 5455.509004189602, 5458.317710286215, 5469.206964990094, 5492.1212605982855, 4973.776180071905, 4974.801007959677, 4981.750912454363, 4989.251612258154, 5015.6238282128625, 5691.876303473575, 5741.25363702716, 5809.477147056743, 5846.5322774178385, 5846.912296315559, 4151.190517849021, 4161.771102589357, 4165.58344165584, 4173.414102640977, 4174.979125104355, 5912.674802885796, 5967.940320596782, 6025.553867071915, 6030.276366836008, 6075.210222671069, 4188.727732697365, 4231.915361692749, 4241.575842415734, 4242.53332133465, 4300.483941926988, 4310.482742070972, 4339.804708788112, 4348.804303806336, 4357.694961352675, 4363.0, 4976.576990955737, 4978.2034874419915, 4978.925316120261, 4996.975015124901, 5002.1496345621335, 5805.593608447452, 5843.402007922024, 5926.4666180044005, 5952.642841429441, 5973.701314934323, 1479.6005078628925, 1485.9152818442597, 1489.3149151390483, 1490.8509149085005, 1497.0, 926.666400095965, 947.5972711597543, 953.4136506048869, 957.2724729205854, 964.3056998960737, 5024.79900803971, 5041.697498150123, 5499.7250137492965, 5522.723863806794, 5657.15142728594, 6040.577159598786, 6072.8785424292155, 6097.939020609826, 6131.294901086343, 6179.567430279837, 5532.225488431623, 5690.955338893672, 5703.828885133453, 5736.311642602831, 5740.68426236561, 3222.951655725166, 3230.919227019296, 3239.3197428539797, 3266.2324353776844, 3267.5425440438357, 6214.4407003369915, 6272.5922815016875, 6279.560430769802, 6304.338044505353, 6311.0, 6044.486218671374, 6105.206323177958, 6106.1146133811235, 6156.8758778221445, 6159.0, 6263.279722831841, 6286.365544958252, 6327.354887729131, 6360.681965901686, 6360.840978975562, 5912.46787789101, 6055.394460553909, 6064.272287325549, 6123.571350005457, 6134.478569321657, 5945.91081133792, 5968.16445697594, 5978.372270911492, 6013.248343957005, 6029.57792954489, 6038.818835434944, 6247.750089996349, 6304.211973503312, 6314.715837787402, 6329.923912934904, 4176.535843852142, 4187.644050255641, 4187.895302617459, 4192.224438478891, 4194.6853985950565, 6043.3352331244405, 6057.57596968208, 6070.7875224366935, 6090.969545152246, 6104.26748790148, 5770.365259821332, 5898.1152827076285, 5925.9407405925385, 5943.673097979653, 5951.226340575698, 5866.530677545701, 5883.146943693226, 5888.352281249145, 5901.439363260483, 5938.792142275, 5846.41535846412, 5860.326062502867, 5879.676617786063, 5902.6458412495385, 5919.644821310563, 5634.74643641029, 5871.882562348815, 5925.103966730605, 5925.259342582177, 5932.525397968066, 5762.193292939076, 5811.82564523065, 5815.331236907809, 5817.76728930838, 5829.912551311819], "value": 4470.651185455325, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [739.7891600893745, 753.3483536740717, 771.1594362145261, 800.5476905548367, 806.6934564865351, 15223.543293701192, 15520.991135576194, 15758.369665213406, 15873.365065397385, 16109.83890161098, 16758.162091895418, 16810.915945420285, 16882.493525194233, 16883.071431071286, 16887.577810554743, 816.7590560784553, 823.4153750836898, 826.2316046077145, 829.8464784014947, 846.4878748357216, 843.4770442325766, 844.5608283692476, 845.1295165979021, 847.1951645936355, 849.6728759427604, 875.2254254984321, 877.1579283887444, 880.3925291548811, 880.770999540121, 882.2677177942325, 865.5758678247677, 866.7399780065955, 866.8959724833061, 868.1015149320455, 868.1492137705085, 629.1852051593152, 632.2602555010602, 632.576173963441, 632.6393955445398, 633.3255083336278, 14534.273286335641, 14555.452795760699, 14562.126272423688, 14575.0, 14614.561563153122, 14842.183679897602, 15193.392264309414, 15235.923820380938, 15247.16140612266, 15331.23343832815, 11951.0, 12394.938025309906, 12417.75164496705, 12506.874931250662, 12530.937345313216, 3834.9233015339537, 3868.9226215475533, 3871.2064026874423, 3909.863154789569, 3990.620891015349, 78550.21449785486, 80848.59575702142, 81445.0, 82664.17335826624, 82742.58628706879, 11493.71265718347, 11499.482523286471, 11533.480993355319, 11758.647240582795, 11765.470553825098, 21823.67264491034, 21948.670769938464, 21968.780312196992, 22024.889875550518, 22040.228591999523, 7755.2244775521995, 7759.612019399007, 8198.139195384518, 8255.298299644597, 8557.358198135165, 4514.7291162530355, 4561.817527298937, 4570.352021770218, 4655.487896331469, 4783.258594917724, 3377.257003459235, 3453.827308634558, 3480.582330120402, 3482.3383557124066, 3514.121469632592, 628.355935166458, 635.1615867055442, 637.4390536328094, 649.0653459018997, 658.9736410543525, 666.5134451850176, 673.2930423055772, 691.9619420931897, 739.1130643228148, 743.7582785594703, 10122.59509619607, 10333.689989300334, 10381.302097086762, 10449.791004179873, 10707.518161682743, 697.4211404534225, 766.1113108793772, 781.3007358414301, 781.9100803407567, 790.3005839831791, 4841.346418233494, 5051.166557517969, 5059.215821547666, 5164.509371609691, 5181.715005674724, 69625.65187174032, 71302.28697712957, 87102.0, 90594.0, 125798.37100814437, 63476.68261658662, 89718.55140724254, 91501.0, 93834.5308273468, 104226.47886760518, 91964.0, 92615.07384926065, 93599.53200233955, 94925.0, 96462.0, 10299.742506437398, 10600.575976961143, 10704.036636702735, 10736.355818650905, 10754.40850753216, 52911.0, 53320.46679533155, 53396.0, 53722.73138634282, 54308.45691543192, 71317.0, 80287.0, 82019.58990205011, 82926.58536707278, 82999.5850020746, 13566.0, 13719.931400342934, 13808.714208078001, 13959.092658977133, 14129.788053179416, 15873.2063396832, 16010.19949002522, 16227.837721622633, 16278.267477963756, 16938.49184524466, 14166.504172353918, 14269.571912842632, 14580.270986450847, 15093.622659433162, 15175.241237937838, 14499.420023199376, 14755.336009879797, 15161.848381516485, 15458.922705386402, 15519.37922483088, 12025.949842916874, 13172.736545269232, 13637.241072091627, 13802.17186968785, 14900.701985960437, 11537.884621154017, 12288.385580721108, 12404.937975310066, 12462.439344197317, 12510.687232819253, 12445.439955201857, 12599.658740532883, 12859.292738899076, 12990.155639883378, 13082.738345233232], "value": 7795.279671641872, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1537.9999999999995, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 113.0, 105.0, 113.0, 113.0, 111.0, 114.0, 111.0, 112.0, 112.0], "value": 110.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 120.0, 142.0, 180.0, 121.0, 144.0, 149.0, 125.0, 173.0, 118.0], "value": 142.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 165.0, 161.0, 162.0, 161.0, 166.0, 179.0, 163.0, 162.0, 161.0], "value": 164.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 75.0, 169.0, 75.0, 76.0, 76.0, 75.0, 181.0, 77.0], "value": 95.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 83.0, 147.0, 85.0, 85.0, 84.0, 153.0, 84.0, 84.0, 152.0], "value": 104.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 118.0, 117.0, 117.0, 117.0, 118.0, 118.0, 119.0, 118.0], "value": 117.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 149.0, 147.0, 147.0, 148.0, 146.0, 147.0, 147.0, 148.0, 147.0], "value": 147.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 95.0, 96.0, 96.0, 96.0, 95.0, 95.0, 96.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 58.0, 57.0, 58.0, 61.0, 58.0, 56.0, 58.0, 58.0, 56.0], "value": 57.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 64.0, 63.0, 64.0, 64.0, 64.0, 64.0, 67.0, 65.0], "value": 64.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 77.0, 75.0, 76.0, 76.0, 74.0, 75.0, 76.0, 86.0], "value": 76.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 120.0, 130.0, 125.0, 130.0, 120.0, 124.0, 126.0, 192.0, 132.0], "value": 132.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 161.0, 158.0, 159.0, 165.0, 159.0, 171.0, 165.0, 162.0], "value": 162.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 63.0, 64.0, 71.0, 66.0, 66.0, 65.0, 69.0, 63.0], "value": 65.6, "unit": "score"}]}]} 16:51:50 INFO - Return code: 0 16:51:50 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:51:50 ERROR - # TBPL SUCCESS # 16:51:50 INFO - Running post-action listener: _resource_record_post_action 16:51:50 INFO - ##### 16:51:50 INFO - ##### Finished run-tests step (success) 16:51:50 INFO - ##### 16:51:50 INFO - Running post-run listener: _resource_record_post_run 16:51:50 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 4096; Write bytes: 550924288; Read time: 8; Write time: 530936 16:51:50 INFO - TinderboxPrint: CPU usage
13.3% 16:51:50 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 16:51:50 INFO - TinderboxPrint: I/O write bytes / time
550,924,288 / 530,936 16:51:50 INFO - TinderboxPrint: CPU idle
8,233.9 (86.7%) 16:51:50 INFO - TinderboxPrint: CPU user
1,206.3 (12.7%) 16:51:50 INFO - TinderboxPrint: Swap in / out
0 / 0 16:51:50 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 256974848; Read time: 0; Write time: 272056 16:51:50 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 0; Write bytes: 293949440; Read time: 0; Write time: 258880 16:51:50 INFO - Running post-run listener: _upload_blobber_files 16:51:50 INFO - Blob upload gear active. 16:51:50 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:51:50 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 16:51:50 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', 'Mozilla-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:51:50 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 Mozilla-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:51:51 INFO - (blobuploader) - INFO - Open directory for files ... 16:51:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:51:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:51:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:51:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:51:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:51:51 INFO - (blobuploader) - INFO - Done attempting. 16:51:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:51:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:51:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:51:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:51:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:51:52 INFO - (blobuploader) - INFO - Done attempting. 16:51:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:51:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:51:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:51:56 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:51:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:51:56 INFO - (blobuploader) - INFO - Done attempting. 16:51:56 INFO - (blobuploader) - INFO - Iteration through files over. 16:51:56 INFO - Return code: 0 16:51:56 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:51:56 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:51:56 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/35da033d9edc899c10a369302d06839a30181a8356e4b9bbf65bb44384f1127409399f87e9398cd04459b4e72e404e53ef760d65c9bd3005a7877bcef990337b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/59cc0435f474c67796b9b884a0c9280aa9257d382ec19c0dd27bfb13171fd3cc5ad180c0b16501912afaa76531e4d835deac342e8b84674ce0d1490bd86cccea", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/15ceaa1788a5d704fa2f3b5a06b3911ce9837e16bbc598ca773506cbb8616f647fc9f2e801e4ceba50dbfde79d9da6b52e69481ea5019f3f88980c1aa2b6bb0e"} 16:51:56 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:51:56 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:51:56 INFO - Contents: 16:51:56 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/35da033d9edc899c10a369302d06839a30181a8356e4b9bbf65bb44384f1127409399f87e9398cd04459b4e72e404e53ef760d65c9bd3005a7877bcef990337b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/59cc0435f474c67796b9b884a0c9280aa9257d382ec19c0dd27bfb13171fd3cc5ad180c0b16501912afaa76531e4d835deac342e8b84674ce0d1490bd86cccea", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/15ceaa1788a5d704fa2f3b5a06b3911ce9837e16bbc598ca773506cbb8616f647fc9f2e801e4ceba50dbfde79d9da6b52e69481ea5019f3f88980c1aa2b6bb0e"} 16:51:56 INFO - Running post-run listener: copy_logs_to_upload_dir 16:51:56 INFO - Copying logs to upload dir... 16:51:56 INFO - mkdir: /builds/slave/test/build/upload/logs 16:51:56 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1228.736526 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 28 secs) (at 2016-07-11 16:51:56.453790) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-11 16:51:56.457064) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1468279875.724993-543624885 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/Mozilla-Inbound/sha512/35da033d9edc899c10a369302d06839a30181a8356e4b9bbf65bb44384f1127409399f87e9398cd04459b4e72e404e53ef760d65c9bd3005a7877bcef990337b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/59cc0435f474c67796b9b884a0c9280aa9257d382ec19c0dd27bfb13171fd3cc5ad180c0b16501912afaa76531e4d835deac342e8b84674ce0d1490bd86cccea", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/15ceaa1788a5d704fa2f3b5a06b3911ce9837e16bbc598ca773506cbb8616f647fc9f2e801e4ceba50dbfde79d9da6b52e69481ea5019f3f88980c1aa2b6bb0e"} build_url:https://queue.taskcluster.net/v1/task/fJr9ruZITBWsryQTabOb9A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011309 build_url: 'https://queue.taskcluster.net/v1/task/fJr9ruZITBWsryQTabOb9A/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/Mozilla-Inbound/sha512/35da033d9edc899c10a369302d06839a30181a8356e4b9bbf65bb44384f1127409399f87e9398cd04459b4e72e404e53ef760d65c9bd3005a7877bcef990337b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/59cc0435f474c67796b9b884a0c9280aa9257d382ec19c0dd27bfb13171fd3cc5ad180c0b16501912afaa76531e4d835deac342e8b84674ce0d1490bd86cccea", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/15ceaa1788a5d704fa2f3b5a06b3911ce9837e16bbc598ca773506cbb8616f647fc9f2e801e4ceba50dbfde79d9da6b52e69481ea5019f3f88980c1aa2b6bb0e"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-11 16:51:56.482856) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 16:51:56.483290) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1468279875.724993-543624885 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004481 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 16:51:56.566649) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-11 16:51:56.567015) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-11 16:51:56.567318) ========= ========= Total master_lag: 0.20 =========