builder: autoland_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-055 starttime: 1474516581.65 results: success (0) buildid: 20160921190806 builduid: c82a32ce26c54ed6bf301381ad07a3c6 revision: 8ab39d701f57e4fe3f8588ecbbbc9fb0ae2ddbd1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-21 20:56:21.648614) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-21 20:56:21.649048) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-21 20:56:21.649345) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-21 20:56:21.664087) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-21 20:56:21.664436) ========= 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=bb9b54edd4a927dc735d112f000001d9-1474516578.255741-337422071 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-21 20:56:21-- 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.6M=0s 2016-09-21 20:56:21 (46.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.075780 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-21 20:56:21.755577) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-21 20:56:21.755922) ========= 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=bb9b54edd4a927dc735d112f000001d9-1474516578.255741-337422071 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015070 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-21 20:56:21.807228) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-21 20:56:21.807704) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 8ab39d701f57e4fe3f8588ecbbbc9fb0ae2ddbd1 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev 8ab39d701f57e4fe3f8588ecbbbc9fb0ae2ddbd1 --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=bb9b54edd4a927dc735d112f000001d9-1474516578.255741-337422071 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-21 20:56:21,989 truncating revision to first 12 chars 2016-09-21 20:56:21,989 Setting DEBUG logging. 2016-09-21 20:56:21,989 attempt 1/10 2016-09-21 20:56:21,989 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/8ab39d701f57?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-21 20:56:22,304 unpacking tar archive at: autoland-8ab39d701f57/testing/mozharness/ program finished with exit code 0 elapsedTime=0.613459 ========= master_lag: 0.06 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-21 20:56:22.477551) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-21 20:56:22.477969) ========= script_repo_revision: 8ab39d701f57e4fe3f8588ecbbbc9fb0ae2ddbd1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-21 20:56:22.478421) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-21 20:56:22.478696) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-21 20:56:22.489484) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-09-21 20:56:22.489860) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Autoland-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=bb9b54edd4a927dc735d112f000001d9-1474516578.255741-337422071 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20:56:22 INFO - MultiFileLogger online at 20160921 20:56:22 in /builds/slave/test 20:56:22 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO 20:56:22 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:56:22 INFO - {'append_to_log': False, 20:56:22 INFO - 'base_work_dir': '/builds/slave/test', 20:56:22 INFO - 'blob_upload_branch': 'Autoland-Non-PGO', 20:56:22 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:56:22 INFO - 'branch': 'Autoland-Non-PGO', 20:56:22 INFO - 'buildbot_json_path': 'buildprops.json', 20:56:22 INFO - 'config_files': ('talos/linux_config.py',), 20:56:22 INFO - 'default_actions': ('clobber', 20:56:22 INFO - 'read-buildbot-config', 20:56:22 INFO - 'download-and-extract', 20:56:22 INFO - 'populate-webroot', 20:56:22 INFO - 'create-virtualenv', 20:56:22 INFO - 'install', 20:56:22 INFO - 'run-tests'), 20:56:22 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:56:22 INFO - 'download_minidump_stackwalk': True, 20:56:22 INFO - 'download_symbols': 'ondemand', 20:56:22 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:56:22 INFO - 'tooltool.py': '/tools/tooltool.py', 20:56:22 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:56:22 INFO - '/tools/misc-python/virtualenv.py')}, 20:56:22 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:56:22 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:56:22 INFO - 'installer_path': 'installer.exe', 20:56:22 INFO - 'log_level': 'info', 20:56:22 INFO - 'log_name': 'talos', 20:56:22 INFO - 'log_to_console': True, 20:56:22 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 20:56:22 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 20:56:22 INFO - 'opt_config_files': (), 20:56:22 INFO - 'pip_index': False, 20:56:22 INFO - 'sps_profile': False, 20:56:22 INFO - 'sps_profile_interval': 0, 20:56:22 INFO - 'suite': 'dromaeojs-e10s', 20:56:22 INFO - 'system_bits': '32', 20:56:22 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:56:22 INFO - 'title': 'talos-linux64-ix-055', 20:56:22 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:56:22 INFO - 'use_talos_json': True, 20:56:22 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:56:22 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:56:22 INFO - 'work_dir': 'build'} 20:56:22 INFO - [mozharness: 2016-09-22 03:56:22.770120Z] Running clobber step. 20:56:22 INFO - Running pre-action listener: _resource_record_pre_action 20:56:22 INFO - Running main action method: clobber 20:56:22 INFO - rmtree: /builds/slave/test/build 20:56:22 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:56:23 INFO - Running post-action listener: _resource_record_post_action 20:56:23 INFO - [mozharness: 2016-09-22 03:56:23.227407Z] Finished clobber step (success) 20:56:23 INFO - [mozharness: 2016-09-22 03:56:23.227508Z] Running read-buildbot-config step. 20:56:23 INFO - Running pre-action listener: _resource_record_pre_action 20:56:23 INFO - Running main action method: read_buildbot_config 20:56:23 INFO - Using buildbot properties: 20:56:23 INFO - { 20:56:23 INFO - "project": "", 20:56:23 INFO - "product": "firefox", 20:56:23 INFO - "script_repo_revision": "production", 20:56:23 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs-e10s", 20:56:23 INFO - "repository": "", 20:56:23 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland talos dromaeojs-e10s", 20:56:23 INFO - "buildid": "20160921190806", 20:56:23 INFO - "pgo_build": "False", 20:56:23 INFO - "basedir": "/builds/slave/test", 20:56:23 INFO - "buildnumber": 473, 20:56:23 INFO - "slavename": "talos-linux64-ix-055", 20:56:23 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 20:56:23 INFO - "platform": "ubuntu64_hw", 20:56:23 INFO - "scheduler": "tests-autoland-linux64-talos-8-3600", 20:56:23 INFO - "branch": "autoland", 20:56:23 INFO - "repo_path": "integration/autoland", 20:56:23 INFO - "revision": "8ab39d701f57e4fe3f8588ecbbbc9fb0ae2ddbd1", 20:56:23 INFO - "stage_platform": "linux64", 20:56:23 INFO - "builduid": "c82a32ce26c54ed6bf301381ad07a3c6", 20:56:23 INFO - "slavebuilddir": "test" 20:56:23 INFO - } 20:56:23 INFO - Found installer url https://queue.taskcluster.net/v1/task/P2AFQlp1S56mztYyg8aS8w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 20:56:23 INFO - Running post-action listener: _resource_record_post_action 20:56:23 INFO - [mozharness: 2016-09-22 03:56:23.230314Z] Finished read-buildbot-config step (success) 20:56:23 INFO - [mozharness: 2016-09-22 03:56:23.230403Z] Running download-and-extract step. 20:56:23 INFO - Running pre-action listener: _resource_record_pre_action 20:56:23 INFO - Running main action method: download_and_extract 20:56:23 INFO - mkdir: /builds/slave/test/build/tests 20:56:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:56:23 INFO - trying https://queue.taskcluster.net/v1/task/P2AFQlp1S56mztYyg8aS8w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 20:56:23 INFO - Downloading https://queue.taskcluster.net/v1/task/P2AFQlp1S56mztYyg8aS8w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 20:56:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/P2AFQlp1S56mztYyg8aS8w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 20:56:23 INFO - Downloaded 1361 bytes. 20:56:23 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 20:56:23 INFO - Using the following test package requirements: 20:56:23 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 20:56:23 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 20:56:23 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 20:56:23 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 20:56:23 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 20:56:23 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 20:56:23 INFO - u'jsshell-linux-x86_64.zip'], 20:56:23 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 20:56:23 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 20:56:23 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 20:56:23 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 20:56:23 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 20:56:23 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 20:56:23 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 20:56:23 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 20:56:23 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 20:56:23 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 20:56:23 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 20:56:23 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 20:56:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/P2AFQlp1S56mztYyg8aS8w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 20:56:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/P2AFQlp1S56mztYyg8aS8w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 20:56:23 INFO - Fetch https://queue.taskcluster.net/v1/task/P2AFQlp1S56mztYyg8aS8w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 20:56:24 INFO - Expected file size: 20373346 20:56:28 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 20:56:28 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/P2AFQlp1S56mztYyg8aS8w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 20:56:28 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/P2AFQlp1S56mztYyg8aS8w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 20:56:28 INFO - Fetch https://queue.taskcluster.net/v1/task/P2AFQlp1S56mztYyg8aS8w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 20:56:29 INFO - Expected file size: 20373346 20:56:33 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/P2AFQlp1S56mztYyg8aS8w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 20:56:33 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/P2AFQlp1S56mztYyg8aS8w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 20:56:33 INFO - Fetch https://queue.taskcluster.net/v1/task/P2AFQlp1S56mztYyg8aS8w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 20:56:34 INFO - Expected file size: 14414059 20:56: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:56:34 INFO - trying https://queue.taskcluster.net/v1/task/P2AFQlp1S56mztYyg8aS8w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 20:56:34 INFO - Downloading https://queue.taskcluster.net/v1/task/P2AFQlp1S56mztYyg8aS8w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 20:56:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/P2AFQlp1S56mztYyg8aS8w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 20:56:35 INFO - Downloaded 55616304 bytes. 20:56:35 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/P2AFQlp1S56mztYyg8aS8w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 20:56:35 INFO - mkdir: /builds/slave/test/properties 20:56:35 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:56:35 INFO - Writing to file /builds/slave/test/properties/build_url 20:56:35 INFO - Contents: 20:56:35 INFO - build_url:https://queue.taskcluster.net/v1/task/P2AFQlp1S56mztYyg8aS8w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 20:56:36 INFO - Running post-action listener: _resource_record_post_action 20:56:36 INFO - Running post-action listener: set_extra_try_arguments 20:56:36 INFO - [mozharness: 2016-09-22 03:56:36.593814Z] Finished download-and-extract step (success) 20:56:36 INFO - [mozharness: 2016-09-22 03:56:36.594117Z] Running populate-webroot step. 20:56:36 INFO - Running pre-action listener: _resource_record_pre_action 20:56:36 INFO - Running main action method: populate_webroot 20:56:36 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:56:36 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:56:36 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:56:36 INFO - '--tppagecycles', 20:56:36 INFO - '7'], 20:56:36 INFO - 'tests': ['tsvgm']}}, 20:56:36 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:56:36 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:56:36 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:56:36 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:56:36 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:56:36 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:56:36 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:56:36 INFO - 'talos_options': ['--disable-e10s'], 20:56:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:56:36 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:56:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:56:36 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:56:36 INFO - 'talos_options': ['--disable-e10s'], 20:56:36 INFO - 'tests': ['damp', 'tps']}, 20:56:36 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:56:36 INFO - 'tests': ['damp', 'tps']}, 20:56:36 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:56:36 INFO - 'tests': ['dromaeo_dom']}, 20:56:36 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:56:36 INFO - 'g4': {'talos_options': ['--disable-e10s'], 20:56:36 INFO - 'tests': ['basic_compositor_video']}, 20:56:36 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 20:56:36 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:56:36 INFO - 'tests': ['a11yr', 20:56:36 INFO - 'ts_paint', 20:56:36 INFO - 'tpaint', 20:56:36 INFO - 'sessionrestore', 20:56:36 INFO - 'sessionrestore_no_auto_restore', 20:56:36 INFO - 'tabpaint']}, 20:56:36 INFO - 'other-e10s': {'tests': ['a11yr', 20:56:36 INFO - 'ts_paint', 20:56:36 INFO - 'tpaint', 20:56:36 INFO - 'sessionrestore', 20:56:36 INFO - 'sessionrestore_no_auto_restore', 20:56:36 INFO - 'tabpaint']}, 20:56:36 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:56:36 INFO - 'ts_paint', 20:56:36 INFO - 'tpaint', 20:56:36 INFO - 'sessionrestore', 20:56:36 INFO - 'sessionrestore_no_auto_restore', 20:56:36 INFO - 'tabpaint']}, 20:56:36 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:56:36 INFO - 'ts_paint', 20:56:36 INFO - 'tpaint', 20:56:36 INFO - 'sessionrestore', 20:56:36 INFO - 'sessionrestore_no_auto_restore', 20:56:36 INFO - 'tabpaint']}, 20:56:36 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:56:36 INFO - 'tests': ['a11yr', 20:56:36 INFO - 'ts_paint', 20:56:36 INFO - 'tpaint', 20:56:36 INFO - 'sessionrestore', 20:56:36 INFO - 'sessionrestore_no_auto_restore', 20:56:36 INFO - 'tabpaint']}, 20:56:36 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:56:36 INFO - 'tests': ['a11yr', 20:56:36 INFO - 'ts_paint', 20:56:36 INFO - 'tpaint', 20:56:36 INFO - 'sessionrestore', 20:56:36 INFO - 'sessionrestore_no_auto_restore', 20:56:36 INFO - 'tabpaint']}, 20:56:36 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:56:36 INFO - 'tests': ['tsvgx', 20:56:36 INFO - 'tsvgr_opacity', 20:56:36 INFO - 'tart', 20:56:36 INFO - 'tscrollx', 20:56:36 INFO - 'cart']}, 20:56:36 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:56:36 INFO - 'tsvgr_opacity', 20:56:36 INFO - 'tart', 20:56:36 INFO - 'tscrollx', 20:56:36 INFO - 'cart']}, 20:56:36 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:56:36 INFO - 'talos_options': ['--disable-e10s'], 20:56:36 INFO - 'tests': ['tp5o']}, 20:56:36 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:56:36 INFO - 'tests': ['tp5o']}, 20:56:36 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:56:36 INFO - 'talos_options': ['--disable-e10s', 20:56:36 INFO - '--xperf_path', 20:56:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:56:36 INFO - 'tests': ['tp5n']}, 20:56:36 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:56:36 INFO - 'talos_options': ['--xperf_path', 20:56:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:56:36 INFO - 'tests': ['tp5n']}}, 20:56:36 INFO - 'talos.zip': {'path': '', 20:56:36 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:56:36 INFO - Running post-action listener: _resource_record_post_action 20:56:36 INFO - [mozharness: 2016-09-22 03:56:36.616194Z] Finished populate-webroot step (success) 20:56:36 INFO - [mozharness: 2016-09-22 03:56:36.616288Z] Running create-virtualenv step. 20:56:36 INFO - Running pre-action listener: _resource_record_pre_action 20:56:36 INFO - Running main action method: create_virtualenv 20:56:36 INFO - Creating virtualenv /builds/slave/test/build/venv 20:56:36 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 20:56:36 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:56:36 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:56:36 INFO - Using real prefix '/usr' 20:56:36 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:56:37 INFO - Installing distribute.............................................................................................................................................................................................done. 20:56:39 INFO - Installing pip.................done. 20:56:39 INFO - Return code: 0 20:56:39 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:56:39 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:56:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:56:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:56:39 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:56:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:56:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:56:39 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 0x7f0d296d6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25448a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2611ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x260ef60>, '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 0x260fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26101d0>, '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': 'bb9b54edd4a927dc735d112f000001d9-1474516578.255741-337422071', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:56:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 20:56:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 20:56:39 INFO - Using env: {'DISPLAY': ':0', 20:56:39 INFO - 'HOME': '/home/cltbld', 20:56:39 INFO - 'LANG': 'en_US.UTF-8', 20:56:39 INFO - 'LANGUAGE': 'en_US:en', 20:56:39 INFO - 'LOGNAME': 'cltbld', 20:56:39 INFO - 'MAIL': '/var/mail/cltbld', 20:56:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:56:39 INFO - 'MOZ_NO_REMOTE': '1', 20:56:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:56:39 INFO - 'NO_EM_RESTART': '1', 20:56:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:56:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:56:39 INFO - 'PWD': '/builds/slave/test', 20:56:39 INFO - 'SHELL': '/bin/bash', 20:56:39 INFO - 'SHLVL': '1', 20:56:39 INFO - 'TERM': 'linux', 20:56:39 INFO - 'TMOUT': '86400', 20:56:39 INFO - 'USER': 'cltbld', 20:56:39 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1474516578.255741-337422071', 20:56:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:56:39 INFO - '_': '/tools/buildbot/bin/python'} 20:56:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:56:39 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 20:56:39 INFO - Cleaning up... 20:56:39 INFO - Return code: 0 20:56:39 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 20:56:39 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:56:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:56:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:56:39 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:56:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:56:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:56:39 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 0x7f0d296d6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25448a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2611ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x260ef60>, '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 0x260fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26101d0>, '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': 'bb9b54edd4a927dc735d112f000001d9-1474516578.255741-337422071', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:56:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 20:56:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 20:56:39 INFO - Using env: {'DISPLAY': ':0', 20:56:39 INFO - 'HOME': '/home/cltbld', 20:56:39 INFO - 'LANG': 'en_US.UTF-8', 20:56:39 INFO - 'LANGUAGE': 'en_US:en', 20:56:39 INFO - 'LOGNAME': 'cltbld', 20:56:39 INFO - 'MAIL': '/var/mail/cltbld', 20:56:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:56:39 INFO - 'MOZ_NO_REMOTE': '1', 20:56:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:56:39 INFO - 'NO_EM_RESTART': '1', 20:56:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:56:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:56:39 INFO - 'PWD': '/builds/slave/test', 20:56:39 INFO - 'SHELL': '/bin/bash', 20:56:39 INFO - 'SHLVL': '1', 20:56:39 INFO - 'TERM': 'linux', 20:56:39 INFO - 'TMOUT': '86400', 20:56:39 INFO - 'USER': 'cltbld', 20:56:39 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1474516578.255741-337422071', 20:56:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:56:39 INFO - '_': '/tools/buildbot/bin/python'} 20:56:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:56:39 INFO - Downloading/unpacking psutil>=3.1.1 20:56:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:56:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:56:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:56:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:56:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:56:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:56:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:56:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:56:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:56:41 INFO - Installing collected packages: psutil 20:56:41 INFO - Running setup.py install for psutil 20:56:41 INFO - building 'psutil._psutil_linux' extension 20:56:41 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 20:56:41 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 20:56:41 INFO - building 'psutil._psutil_posix' extension 20:56:41 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 20:56:42 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 20:56:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:56:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:56:42 INFO - Successfully installed psutil 20:56:42 INFO - Cleaning up... 20:56:42 INFO - Return code: 0 20:56:42 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 20:56:42 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:56:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:56:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:56:42 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:56:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:56:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:56:42 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 0x7f0d296d6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25448a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2611ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x260ef60>, '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 0x260fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26101d0>, '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': 'bb9b54edd4a927dc735d112f000001d9-1474516578.255741-337422071', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:56:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 20:56:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 20:56:42 INFO - Using env: {'DISPLAY': ':0', 20:56:42 INFO - 'HOME': '/home/cltbld', 20:56:42 INFO - 'LANG': 'en_US.UTF-8', 20:56:42 INFO - 'LANGUAGE': 'en_US:en', 20:56:42 INFO - 'LOGNAME': 'cltbld', 20:56:42 INFO - 'MAIL': '/var/mail/cltbld', 20:56:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:56:42 INFO - 'MOZ_NO_REMOTE': '1', 20:56:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:56:42 INFO - 'NO_EM_RESTART': '1', 20:56:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:56:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:56:42 INFO - 'PWD': '/builds/slave/test', 20:56:42 INFO - 'SHELL': '/bin/bash', 20:56:42 INFO - 'SHLVL': '1', 20:56:42 INFO - 'TERM': 'linux', 20:56:42 INFO - 'TMOUT': '86400', 20:56:42 INFO - 'USER': 'cltbld', 20:56:42 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1474516578.255741-337422071', 20:56:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:56:42 INFO - '_': '/tools/buildbot/bin/python'} 20:56:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:56:42 INFO - Downloading/unpacking mozsystemmonitor==0.3 20:56:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:56:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:56:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:56:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:56:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:56:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:56:44 INFO - Downloading mozsystemmonitor-0.3.tar.gz 20:56:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:56:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 20:56:44 INFO - Installing collected packages: mozsystemmonitor 20:56:44 INFO - Running setup.py install for mozsystemmonitor 20:56:44 INFO - Successfully installed mozsystemmonitor 20:56:44 INFO - Cleaning up... 20:56:44 INFO - Return code: 0 20:56:44 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 20:56:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:56:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:56:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:56:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:56:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:56:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:56:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f0d296d6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25448a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2611ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x260ef60>, '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 0x260fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26101d0>, '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': 'bb9b54edd4a927dc735d112f000001d9-1474516578.255741-337422071', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:56:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 20:56:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 20:56:44 INFO - Using env: {'DISPLAY': ':0', 20:56:44 INFO - 'HOME': '/home/cltbld', 20:56:44 INFO - 'LANG': 'en_US.UTF-8', 20:56:44 INFO - 'LANGUAGE': 'en_US:en', 20:56:44 INFO - 'LOGNAME': 'cltbld', 20:56:44 INFO - 'MAIL': '/var/mail/cltbld', 20:56:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:56:44 INFO - 'MOZ_NO_REMOTE': '1', 20:56:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:56:44 INFO - 'NO_EM_RESTART': '1', 20:56:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:56:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:56:44 INFO - 'PWD': '/builds/slave/test', 20:56:44 INFO - 'SHELL': '/bin/bash', 20:56:44 INFO - 'SHLVL': '1', 20:56:44 INFO - 'TERM': 'linux', 20:56:44 INFO - 'TMOUT': '86400', 20:56:44 INFO - 'USER': 'cltbld', 20:56:44 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1474516578.255741-337422071', 20:56:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:56:44 INFO - '_': '/tools/buildbot/bin/python'} 20:56:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:56:44 INFO - Downloading/unpacking jsonschema==2.5.1 20:56:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:56:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:56:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:56:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:56:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:56:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:56:46 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:56:46 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 20:56:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:56:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:56:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:56:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:56:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:56:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:56:46 INFO - Downloading functools32-3.2.3-2.tar.gz 20:56:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:56:46 INFO - warning: no files found matching '*.txt' 20:56:46 INFO - no previously-included directories found matching 'build' 20:56:46 INFO - no previously-included directories found matching 'dist' 20:56:46 INFO - no previously-included directories found matching '.git*' 20:56:46 INFO - Installing collected packages: jsonschema, functools32 20:56:46 INFO - Running setup.py install for functools32 20:56:46 INFO - warning: no files found matching '*.txt' 20:56:46 INFO - no previously-included directories found matching 'build' 20:56:46 INFO - no previously-included directories found matching 'dist' 20:56:46 INFO - no previously-included directories found matching '.git*' 20:56:46 INFO - Successfully installed jsonschema functools32 20:56:46 INFO - Cleaning up... 20:56:47 INFO - Return code: 0 20:56:47 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 20:56:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:56:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:56:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:56:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:56:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:56:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:56:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0d296d6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25448a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2611ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x260ef60>, '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 0x260fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26101d0>, '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': 'bb9b54edd4a927dc735d112f000001d9-1474516578.255741-337422071', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:56:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 20:56:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 20:56:47 INFO - Using env: {'DISPLAY': ':0', 20:56:47 INFO - 'HOME': '/home/cltbld', 20:56:47 INFO - 'LANG': 'en_US.UTF-8', 20:56:47 INFO - 'LANGUAGE': 'en_US:en', 20:56:47 INFO - 'LOGNAME': 'cltbld', 20:56:47 INFO - 'MAIL': '/var/mail/cltbld', 20:56:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:56:47 INFO - 'MOZ_NO_REMOTE': '1', 20:56:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:56:47 INFO - 'NO_EM_RESTART': '1', 20:56:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:56:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:56:47 INFO - 'PWD': '/builds/slave/test', 20:56:47 INFO - 'SHELL': '/bin/bash', 20:56:47 INFO - 'SHLVL': '1', 20:56:47 INFO - 'TERM': 'linux', 20:56:47 INFO - 'TMOUT': '86400', 20:56:47 INFO - 'USER': 'cltbld', 20:56:47 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1474516578.255741-337422071', 20:56:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:56:47 INFO - '_': '/tools/buildbot/bin/python'} 20:56:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:56:47 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 20:56:47 INFO - Cleaning up... 20:56:47 INFO - Return code: 0 20:56:47 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:56:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:56:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:56:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:56:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:56:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:56:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:56:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f0d296d6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25448a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2611ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x260ef60>, '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 0x260fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26101d0>, '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': 'bb9b54edd4a927dc735d112f000001d9-1474516578.255741-337422071', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:56:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 20:56:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 20:56:47 INFO - Using env: {'DISPLAY': ':0', 20:56:47 INFO - 'HOME': '/home/cltbld', 20:56:47 INFO - 'LANG': 'en_US.UTF-8', 20:56:47 INFO - 'LANGUAGE': 'en_US:en', 20:56:47 INFO - 'LOGNAME': 'cltbld', 20:56:47 INFO - 'MAIL': '/var/mail/cltbld', 20:56:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:56:47 INFO - 'MOZ_NO_REMOTE': '1', 20:56:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:56:47 INFO - 'NO_EM_RESTART': '1', 20:56:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:56:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:56:47 INFO - 'PWD': '/builds/slave/test', 20:56:47 INFO - 'SHELL': '/bin/bash', 20:56:47 INFO - 'SHLVL': '1', 20:56:47 INFO - 'TERM': 'linux', 20:56:47 INFO - 'TMOUT': '86400', 20:56:47 INFO - 'USER': 'cltbld', 20:56:47 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1474516578.255741-337422071', 20:56:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:56:47 INFO - '_': '/tools/buildbot/bin/python'} 20:56:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:56:47 INFO - Downloading/unpacking blobuploader==1.2.4 20:56:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:56:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:56:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:56:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:56:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:56:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:56:49 INFO - Downloading blobuploader-1.2.4.tar.gz 20:56:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:56:49 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:56:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:56:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:56:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:56:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:56:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:56:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:56:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:56:49 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:56:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:56:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:56:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:56:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:56:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:56:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:56:50 INFO - Downloading docopt-0.6.1.tar.gz 20:56:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:56:50 INFO - Installing collected packages: blobuploader, requests, docopt 20:56:50 INFO - Running setup.py install for blobuploader 20:56:50 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:56:50 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:56:50 INFO - Running setup.py install for requests 20:56:50 INFO - Running setup.py install for docopt 20:56:50 INFO - Successfully installed blobuploader requests docopt 20:56:50 INFO - Cleaning up... 20:56:50 INFO - Return code: 0 20:56:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:56:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:56:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:56:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:56:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:56:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:56:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:56:50 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 0x7f0d296d6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25448a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2611ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x260ef60>, '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 0x260fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26101d0>, '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': 'bb9b54edd4a927dc735d112f000001d9-1474516578.255741-337422071', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:56:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 20:56:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 20:56:50 INFO - Using env: {'DISPLAY': ':0', 20:56:50 INFO - 'HOME': '/home/cltbld', 20:56:50 INFO - 'LANG': 'en_US.UTF-8', 20:56:50 INFO - 'LANGUAGE': 'en_US:en', 20:56:50 INFO - 'LOGNAME': 'cltbld', 20:56:50 INFO - 'MAIL': '/var/mail/cltbld', 20:56:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:56:50 INFO - 'MOZ_NO_REMOTE': '1', 20:56:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:56:50 INFO - 'NO_EM_RESTART': '1', 20:56:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:56:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:56:50 INFO - 'PWD': '/builds/slave/test', 20:56:50 INFO - 'SHELL': '/bin/bash', 20:56:50 INFO - 'SHLVL': '1', 20:56:50 INFO - 'TERM': 'linux', 20:56:50 INFO - 'TMOUT': '86400', 20:56:50 INFO - 'USER': 'cltbld', 20:56:50 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1474516578.255741-337422071', 20:56:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:56:50 INFO - '_': '/tools/buildbot/bin/python'} 20:56:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:56:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:56:50 INFO - Running setup.py (path:/tmp/pip-_t2TVn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:56:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:56:51 INFO - Running setup.py (path:/tmp/pip-22y6w_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:56:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:56:51 INFO - Running setup.py (path:/tmp/pip-KemIoK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:56:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:56:51 INFO - Running setup.py (path:/tmp/pip-1iWJi7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:56:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:56:51 INFO - Running setup.py (path:/tmp/pip-IxVsIO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:56:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:56:51 INFO - Running setup.py (path:/tmp/pip-Mvyk2X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:56:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:56:51 INFO - Running setup.py (path:/tmp/pip-UuEzUQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:56:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:56:51 INFO - Running setup.py (path:/tmp/pip-gutzg9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:56:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:56:51 INFO - Running setup.py (path:/tmp/pip-GyLoLo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:56:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:56:51 INFO - Running setup.py (path:/tmp/pip-GMDccj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:56:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:56:51 INFO - Running setup.py (path:/tmp/pip-3L43A4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:56:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:56:51 INFO - Running setup.py (path:/tmp/pip-yW2igw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:56:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:56:51 INFO - Running setup.py (path:/tmp/pip-2gNlso-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:56:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:56:51 INFO - Running setup.py (path:/tmp/pip-pdktai-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:56:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:56:51 INFO - Running setup.py (path:/tmp/pip-SQayFP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:56:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:56:52 INFO - Running setup.py (path:/tmp/pip-pJ7lob-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:56:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:56:52 INFO - Running setup.py (path:/tmp/pip-2O1LxY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:56:52 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:56:52 INFO - Running setup.py install for manifestparser 20:56:52 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:56:52 INFO - Running setup.py install for mozcrash 20:56:52 INFO - Running setup.py install for mozdebug 20:56:52 INFO - Running setup.py install for mozdevice 20:56:52 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:56:52 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:56:52 INFO - Running setup.py install for mozfile 20:56:52 INFO - Running setup.py install for mozhttpd 20:56:52 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:56:52 INFO - Running setup.py install for mozinfo 20:56:52 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:56:52 INFO - Running setup.py install for mozInstall 20:56:52 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:56:52 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:56:52 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:56:52 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:56:52 INFO - Running setup.py install for mozleak 20:56:53 INFO - Running setup.py install for mozlog 20:56:53 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:56:53 INFO - Running setup.py install for moznetwork 20:56:53 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:56:53 INFO - Running setup.py install for mozprocess 20:56:53 INFO - Running setup.py install for mozprofile 20:56:53 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:56:53 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:56:53 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:56:53 INFO - Running setup.py install for mozrunner 20:56:53 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:56:53 INFO - Running setup.py install for mozscreenshot 20:56:53 INFO - Running setup.py install for moztest 20:56:53 INFO - Running setup.py install for mozversion 20:56:53 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:56:53 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:56:53 INFO - Cleaning up... 20:56:53 INFO - Return code: 0 20:56:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:56:53 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:56:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:56:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:56:53 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:56:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:56:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:56:53 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 0x7f0d296d6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25448a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2611ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x260ef60>, '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 0x260fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26101d0>, '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': 'bb9b54edd4a927dc735d112f000001d9-1474516578.255741-337422071', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:56:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 20:56:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 20:56:53 INFO - Using env: {'DISPLAY': ':0', 20:56:53 INFO - 'HOME': '/home/cltbld', 20:56:53 INFO - 'LANG': 'en_US.UTF-8', 20:56:53 INFO - 'LANGUAGE': 'en_US:en', 20:56:53 INFO - 'LOGNAME': 'cltbld', 20:56:53 INFO - 'MAIL': '/var/mail/cltbld', 20:56:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:56:53 INFO - 'MOZ_NO_REMOTE': '1', 20:56:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:56:53 INFO - 'NO_EM_RESTART': '1', 20:56:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:56:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:56:53 INFO - 'PWD': '/builds/slave/test', 20:56:53 INFO - 'SHELL': '/bin/bash', 20:56:53 INFO - 'SHLVL': '1', 20:56:53 INFO - 'TERM': 'linux', 20:56:53 INFO - 'TMOUT': '86400', 20:56:53 INFO - 'USER': 'cltbld', 20:56:53 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1474516578.255741-337422071', 20:56:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:56:53 INFO - '_': '/tools/buildbot/bin/python'} 20:56:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:56:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:56:54 INFO - Running setup.py (path:/tmp/pip-8DOZeh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:56:54 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 20:56:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:56:54 INFO - Running setup.py (path:/tmp/pip-Z3bQmT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:56:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 20:56:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:56:54 INFO - Running setup.py (path:/tmp/pip-VjuHGI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:56:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 20:56:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:56:54 INFO - Running setup.py (path:/tmp/pip-iPYOMS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:56:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 20:56:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:56:54 INFO - Running setup.py (path:/tmp/pip-Nno9XA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:56:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 20:56:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:56:54 INFO - Running setup.py (path:/tmp/pip-P6E_g6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:56:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 20:56:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:56:54 INFO - Running setup.py (path:/tmp/pip-jRkLiO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:56:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 20:56:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:56:54 INFO - Running setup.py (path:/tmp/pip-GKsMvG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:56:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 20:56:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:56:54 INFO - Running setup.py (path:/tmp/pip-eZhBz2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:56:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 20:56:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:56:54 INFO - Running setup.py (path:/tmp/pip-1zgCPY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:56:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:56:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:56:54 INFO - Running setup.py (path:/tmp/pip-5i2WV1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:56: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)) 20:56:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:56:55 INFO - Running setup.py (path:/tmp/pip-Hih3hd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:56:55 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)) 20:56:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:56:55 INFO - Running setup.py (path:/tmp/pip-1bhAAE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:56:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 20:56:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:56:55 INFO - Running setup.py (path:/tmp/pip-QqlVnJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:56:55 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)) 20:56:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:56:55 INFO - Running setup.py (path:/tmp/pip-ReAmi2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:56:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 20:56:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:56:55 INFO - Running setup.py (path:/tmp/pip-kTRXwW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:56:55 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 20:56:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:56:55 INFO - Running setup.py (path:/tmp/pip-Z04NgQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:56:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 20:56:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 20:56:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 20:56:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 20:56:55 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 20:56:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 20:56:55 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:56:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:56:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:56:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:56:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:56:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:56:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:56:57 INFO - Downloading blessings-1.6.tar.gz 20:56:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:56:57 INFO - Installing collected packages: blessings 20:56:57 INFO - Running setup.py install for blessings 20:56:57 INFO - Successfully installed blessings 20:56:57 INFO - Cleaning up... 20:56:57 INFO - Return code: 0 20:56:57 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:56:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:56:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:56:57 INFO - Reading from file tmpfile_stdout 20:56:57 INFO - Current package versions: 20:56:57 INFO - argparse == 1.2.1 20:56:57 INFO - blessings == 1.6 20:56:57 INFO - blobuploader == 1.2.4 20:56:57 INFO - docopt == 0.6.1 20:56:57 INFO - functools32 == 3.2.3-2 20:56:57 INFO - jsonschema == 2.5.1 20:56:57 INFO - manifestparser == 1.1 20:56:57 INFO - mozInstall == 1.12 20:56:57 INFO - mozcrash == 0.17 20:56:57 INFO - mozdebug == 0.1 20:56:57 INFO - mozdevice == 0.48 20:56:57 INFO - mozfile == 1.2 20:56:57 INFO - mozhttpd == 0.7 20:56:57 INFO - mozinfo == 0.9 20:56:57 INFO - mozleak == 0.1 20:56:57 INFO - mozlog == 3.4 20:56:57 INFO - moznetwork == 0.27 20:56:57 INFO - mozprocess == 0.23 20:56:57 INFO - mozprofile == 0.28 20:56:57 INFO - mozrunner == 6.12 20:56:57 INFO - mozscreenshot == 0.1 20:56:57 INFO - mozsystemmonitor == 0.3 20:56:57 INFO - moztest == 0.7 20:56:57 INFO - mozversion == 1.4 20:56:57 INFO - psutil == 3.1.1 20:56:57 INFO - requests == 1.2.3 20:56:57 INFO - wsgiref == 0.1.2 20:56:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:56:57 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:56:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:56:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:56:57 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:56:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:56:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:56:57 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 0x7f0d296d6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25448a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2611ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x260ef60>, '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 0x260fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26101d0>, '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': 'bb9b54edd4a927dc735d112f000001d9-1474516578.255741-337422071', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:56:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 20:56:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 20:56:57 INFO - Using env: {'DISPLAY': ':0', 20:56:57 INFO - 'HOME': '/home/cltbld', 20:56:57 INFO - 'LANG': 'en_US.UTF-8', 20:56:57 INFO - 'LANGUAGE': 'en_US:en', 20:56:57 INFO - 'LOGNAME': 'cltbld', 20:56:57 INFO - 'MAIL': '/var/mail/cltbld', 20:56:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:56:57 INFO - 'MOZ_NO_REMOTE': '1', 20:56:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:56:57 INFO - 'NO_EM_RESTART': '1', 20:56:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:56:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:56:57 INFO - 'PWD': '/builds/slave/test', 20:56:57 INFO - 'SHELL': '/bin/bash', 20:56:57 INFO - 'SHLVL': '1', 20:56:57 INFO - 'TERM': 'linux', 20:56:57 INFO - 'TMOUT': '86400', 20:56:57 INFO - 'USER': 'cltbld', 20:56:57 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1474516578.255741-337422071', 20:56:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:56:57 INFO - '_': '/tools/buildbot/bin/python'} 20:56:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:56:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 20:56:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 20:56:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 20:56:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 20:56:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 20:56:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 20:56:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 20:56:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 20:56:57 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 20:56:57 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 20:56:57 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 20:56:57 INFO - Cleaning up... 20:56:58 INFO - Return code: 0 20:56:58 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:56: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:56:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:56:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:56: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:56:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:56:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:56: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 0x7f0d296d6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25448a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2611ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x260ef60>, '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 0x260fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26101d0>, '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': 'bb9b54edd4a927dc735d112f000001d9-1474516578.255741-337422071', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 20:56: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 20:56: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 20:56:58 INFO - Using env: {'DISPLAY': ':0', 20:56:58 INFO - 'HOME': '/home/cltbld', 20:56:58 INFO - 'LANG': 'en_US.UTF-8', 20:56:58 INFO - 'LANGUAGE': 'en_US:en', 20:56:58 INFO - 'LOGNAME': 'cltbld', 20:56:58 INFO - 'MAIL': '/var/mail/cltbld', 20:56:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:56:58 INFO - 'MOZ_NO_REMOTE': '1', 20:56:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:56:58 INFO - 'NO_EM_RESTART': '1', 20:56:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:56:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:56:58 INFO - 'PWD': '/builds/slave/test', 20:56:58 INFO - 'SHELL': '/bin/bash', 20:56:58 INFO - 'SHLVL': '1', 20:56:58 INFO - 'TERM': 'linux', 20:56:58 INFO - 'TMOUT': '86400', 20:56:58 INFO - 'USER': 'cltbld', 20:56:58 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1474516578.255741-337422071', 20:56:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:56:58 INFO - '_': '/tools/buildbot/bin/python'} 20:56:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:56:58 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 20:56:58 INFO - Cleaning up... 20:56:58 INFO - Return code: 0 20:56:58 INFO - Running post-action listener: _resource_record_post_action 20:56:58 INFO - Running post-action listener: _start_resource_monitoring 20:56:58 INFO - Starting resource monitoring. 20:56:58 INFO - [mozharness: 2016-09-22 03:56:58.259167Z] Finished create-virtualenv step (success) 20:56:58 INFO - [mozharness: 2016-09-22 03:56:58.259622Z] Running install step. 20:56:58 INFO - Running pre-action listener: _resource_record_pre_action 20:56:58 INFO - Running main action method: install 20:56:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:56:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:56:58 INFO - Reading from file tmpfile_stdout 20:56:58 INFO - Detecting whether we're running mozinstall >=1.0... 20:56:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:56:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:56:58 INFO - Reading from file tmpfile_stdout 20:56:58 INFO - Output received: 20:56:58 INFO - Usage: mozinstall [options] installer 20:56:58 INFO - Options: 20:56:58 INFO - -h, --help show this help message and exit 20:56:58 INFO - -d DEST, --destination=DEST 20:56:58 INFO - Directory to install application into. [default: 20:56:58 INFO - "/builds/slave/test"] 20:56:58 INFO - --app=APP Application being installed. [default: firefox] 20:56:58 INFO - mkdir: /builds/slave/test/build/application 20:56:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 20:56:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 20:57:14 INFO - Reading from file tmpfile_stdout 20:57:14 INFO - Output received: 20:57:14 INFO - /builds/slave/test/build/application/firefox/firefox 20:57:14 INFO - Running post-action listener: _resource_record_post_action 20:57:14 INFO - [mozharness: 2016-09-22 03:57:14.784378Z] Finished install step (success) 20:57:14 INFO - [mozharness: 2016-09-22 03:57:14.784623Z] Running run-tests step. 20:57:14 INFO - Running pre-action listener: _resource_record_pre_action 20:57:14 INFO - Running main action method: run_tests 20:57:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:57:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:57:14 INFO - Python 2.7.3 20:57:14 INFO - Return code: 0 20:57:14 INFO - grabbing minidump binary from tooltool 20:57:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:57:14 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 0x260ef60>, '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 0x260fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26101d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:57:14 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 20:57:14 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 20:57:14 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 20:57:14 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:57:14 INFO - Return code: 0 20:57:14 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 20:57:14 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:57:14 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:57:14 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 20:57:14 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:57:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/P2AFQlp1S56mztYyg8aS8w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-055', '--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 20:57:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/P2AFQlp1S56mztYyg8aS8w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-055 --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 20:57:14 INFO - Using env: {'DISPLAY': ':0', 20:57:14 INFO - 'HOME': '/home/cltbld', 20:57:14 INFO - 'LANG': 'en_US.UTF-8', 20:57:14 INFO - 'LANGUAGE': 'en_US:en', 20:57:14 INFO - 'LOGNAME': 'cltbld', 20:57:14 INFO - 'MAIL': '/var/mail/cltbld', 20:57:14 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:57:14 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 20:57:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:57:14 INFO - 'MOZ_NO_REMOTE': '1', 20:57:14 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:57:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:57:14 INFO - 'NO_EM_RESTART': '1', 20:57:14 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:57:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:57:14 INFO - 'PWD': '/builds/slave/test', 20:57:14 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:57:14 INFO - 'SHELL': '/bin/bash', 20:57:14 INFO - 'SHLVL': '1', 20:57:14 INFO - 'TERM': 'linux', 20:57:14 INFO - 'TMOUT': '86400', 20:57:14 INFO - 'USER': 'cltbld', 20:57:14 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1474516578.255741-337422071', 20:57:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:57:14 INFO - '_': '/tools/buildbot/bin/python'} 20:57:14 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/P2AFQlp1S56mztYyg8aS8w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-055', '--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 20:57:15 INFO - mozversion application_buildid: 20160921190806 20:57:15 INFO - mozversion application_changeset: 8ab39d701f57e4fe3f8588ecbbbc9fb0ae2ddbd1 20:57:15 INFO - mozversion application_display_name: Nightly 20:57:15 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:57:15 INFO - mozversion application_name: Firefox 20:57:15 INFO - mozversion application_remotingname: firefox 20:57:15 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 20:57:15 INFO - mozversion application_vendor: Mozilla 20:57:15 INFO - mozversion application_version: 52.0a1 20:57:15 INFO - mozversion platform_buildid: 20160921190806 20:57:15 INFO - mozversion platform_changeset: 8ab39d701f57e4fe3f8588ecbbbc9fb0ae2ddbd1 20:57:15 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 20:57:15 INFO - mozversion platform_version: 52.0a1 20:57:15 INFO - using testdate: 1474516635 20:57:15 INFO - actual date: 1474516635 20:57:15 INFO - starting webserver on 'localhost:33668' 20:57:15 INFO - SUITE-START | Running 2 tests 20:57:15 INFO - TEST-START | dromaeo_css 20:57:15 INFO - operating with platform_type : linux_ 20:57:15 INFO - Initialising browser for dromaeo_css test... 20:57:15 INFO - TEST-INFO | started process 6368 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQb2B2I/profile http://localhost:33668/getInfo.html) 20:57:20 INFO - PROCESS | 6368 | __metrics Screen width/height:1600/1200 20:57:20 INFO - PROCESS | 6368 | colorDepth:24 20:57:20 INFO - PROCESS | 6368 | Browser inner width/height: 1024/697 20:57:20 INFO - PROCESS | 6368 | __metrics 20:57:20 ERROR - PROCESS | 6368 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3067: TypeError: this.tabs is undefined 20:57:21 INFO - TEST-INFO | 6368: exit 0 20:57:21 INFO - Browser initialized. 20:57:21 INFO - Running cycle 1/1 for dromaeo_css test... 20:57:21 INFO - TEST-INFO | started process 6487 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQb2B2I/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:57:33 INFO - PROCESS | 6487 | RSS: Main: 186507264 20:57:33 INFO - PROCESS | 6487 | 20:58:23 INFO - PROCESS | 6487 | 1474516703590 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] 21:00:36 INFO - PROCESS | 6487 | Cycle 1(1): loaded http://localhost:33668/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33668/tests/dromaeo/cssquery-ext.html) 21:00:37 INFO - PROCESS | 6487 | RSS: Main: 195932160 21:00:37 INFO - PROCESS | 6487 | 21:03:40 INFO - PROCESS | 6487 | Cycle 1(1): loaded http://localhost:33668/tests/dromaeo/cssquery-ext.html (next: http://localhost:33668/tests/dromaeo/cssquery-jquery.html) 21:03:40 INFO - PROCESS | 6487 | RSS: Main: 196218880 21:03:40 INFO - PROCESS | 6487 | 21:06:42 INFO - PROCESS | 6487 | Cycle 1(1): loaded http://localhost:33668/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33668/tests/dromaeo/cssquery-mootools.html) 21:06:43 INFO - PROCESS | 6487 | RSS: Main: 198873088 21:06:43 INFO - PROCESS | 6487 | 21:09:45 INFO - PROCESS | 6487 | Cycle 1(1): loaded http://localhost:33668/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33668/tests/dromaeo/cssquery-prototype.html) 21:09:46 INFO - PROCESS | 6487 | RSS: Main: 195428352 21:09:46 INFO - PROCESS | 6487 | 21:12:49 INFO - PROCESS | 6487 | Cycle 1(1): loaded http://localhost:33668/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33668/tests/dromaeo/cssquery-yui.html) 21:12:49 INFO - PROCESS | 6487 | RSS: Main: 198230016 21:12:49 INFO - PROCESS | 6487 | 21:15:52 INFO - PROCESS | 6487 | Cycle 1(1): loaded http://localhost:33668/tests/dromaeo/cssquery-yui.html (next: http://localhost:33668/tests/dromaeo/cssquery-dojo.html) 21:15:52 INFO - PROCESS | 6487 | RSS: Main: 198995968 21:15:52 INFO - PROCESS | 6487 | 21:15:52 INFO - PROCESS | 6487 | __start_tp_report 21:15:52 INFO - PROCESS | 6487 | _x_x_mozilla_page_load 21:15:52 INFO - PROCESS | 6487 | _x_x_mozilla_page_load_details 21:15:52 INFO - PROCESS | 6487 | |i|pagename|runs| 21:15:52 INFO - PROCESS | 6487 | |0;dojo.html;2612.24244968959;2627.1724406811863;2632.486665100305;2659.4282229320697;2668.57302831547;4648.372469716587;4731.668783185179;4751.809927602896;4763.737994410306;4766.856994290169;4691.929621055679;4698.177818881699;4741.8103275868925;4753.120672675557;4791.401074865642;4322;4343.869683909487;4424.181526417623;4436.356728274398;4488.97755511222;4375.321825117096;4415.050764085721;4453.064856380148;4480.910381792379;4527.547245275479;4249.893752656178;4317.525072242051;4332.241857674926;4386.627136693385;4436.290193569013;4269.423627810237;4306.35404689296;4309.935350969738;4318.762468064255;4324.329728892027;4338.631216346615;4362.018545827195;4363;4389.802458889326;4408.184485870124;4714.080754252922;4724.95275047252;4738.4313882334;4741.241401375763;4746.83386081489;5023.547880690719;5059.74701264939;5078.568321692661;5080.491950804927;5156.484351564851;5097.515736005073;5108.412532558729;5128.589712822965;5131.897362052775;5177.689338639693;4643.071385722801;4690.929636055462;4763.095011947754;4763.976180119146;4774.21225497789;5196.662216955886;5210.452902445264;5245.029669511153;5267.0256002639635;5269.736513174326;4998.93333597931;5003.324551185616;5006.274090256892;5009.699418034929;5071.771770270347;4928.457869634337;4985.90028199434;5091.796328146833;5098.796048158107;5105.183170692671;5028.522290382408;5040.243963405518;5040.49595040493;5049.343585333957;5115.923261151086;5030.320906677625;5032.471590482946;5034.79860805571;5045.672031317952;5078.13671675816;4113.424120623115;4224.91550169001;4231.132617813341;4233.597808208216;4280.165367753259;3633;3673.412254039341;3705.314516814344;3734.066483379155;3787.772733635991;4415.315626077963;4447.599716025508;4452.198604251201;4467.195904737114;4499.055198408371;5088.974555127201;5102.591792656579;5141.691498510101;5158.123119069692;5178.0679477694375;4333.978330108393;4348.456442944632;4389.561043895649;4390.62679672225;4424.31423129409;4499.707519011319;4513.774311284423;4542.454905411306;4549.476810166807;4558.931616025762;4789.281607758794;4803.135435621622;4812.109759694397;4819.060283244734;4856.465788763163;4982.078315511642;5034.44621091687;5041.6470847040355;5077.7461126944245;5146.716930568855;4836.806527738851;4848.927266090941;4855.441624213261;4865.197242454955;4899.4365647950945;5027.27104569828;5049.116404629101;5049.141645920276;5075.264086707481;5112.693238405707;4965.726885021359;5001.049800537886;5006.098902197639;5121.8719532012;5191.039657663345;4866.343043689199;4900.14247506692;4905.386826646669;4914.99242655262;4961.107000739901;4884.804607815648;4887.291342755351;4897.314375987436;4900.485280166053;4960.355153829979;4699.506551812011;4738.691985020962;4755.738434386004;4822.107910036654;4836.879078023077;4940.357753492023;4942.085714142895;4944.134776414185;4948.554630083166;4989.101961646938;4831.830885918976;4835.468098509091;4835.685680430761;4884.755762211947;4909.386326709161 21:15:52 INFO - PROCESS | 6487 | |1;ext.html;539.657317603322;548.1202669715107;550.1719911533143;551.1374698596693;562.401042889323;38072.61927380726;39812;39894.401583976265;43989.34015989763;44106.77946610271;39099.60900390995;39458.408123878165;39713.80143099288;39916.20167596646;40002;7681.193474685161;7803.726869559567;7815.452918295721;7818.687252509922;7825;7596.5062270952485;7638.961805190994;7660.7701768946745;7674.769756907302;7678.731244406447;7650.808729781745;7693.576853273068;7695.115061767884;7696.153423123452;7715.459917805756;7389.1502477215;7390.667419966115;7390.7413240536325;7405.8889116663295;7421.406287496988;7651.1583725790115;7665.501742386783;7691.538507689556;7692.192319806451;7716.7684969451;38345.233095337935;38606.227875442615;38726.806365968274;38745.41881871746;38765.224695506215;3108.4249413858283;3526.4533997230214;3528.9294214115575;3533.6819686228105;3558.1638314995957;28144.859275703697;28679;28912.42175156506;28969.130926072252;29089;3350.530925670408;3376.375370556455;3471.8437670304897;3592.976001839463;3603.6396360364015;250193;251949;252490.99999999817;252727;252776;31038.84480577628;32318.192045198586;32323.191920201712;53030.46969530333;53286.46713532892;33592.32815343679;33811.323773524884;33845.83077084599;33979.150521236676;34084.44366672509;12914.708529147198;13055.804162937564;13056.086073974731;13060.08579399452;13063.542776002794;10636.893631063745;10684.89315106839;10689.144868410509;10718.839217411745;10733.78532429347;7733.342665873463;7837.960810195913;7838.098618658813;7851.411144164211;7887.605619718991;3057.5107982722657;3091.248788578167;3097.1947293703347;3113.657497675254;3121.2508997840355;826.8428998490388;834.6786487202471;838.262329150356;860.0324634785866;944.9935818353568;27073.32316692059;27583.44833103367;28420.85789571039;28426.573601395994;28740.281492962426;854.7563944275976;876.6537217799062;915.3089417489886;995.5370752599931;1000.7640563903574;14098.929505352613;14656.267186640625;14804.851951480563;14901.25493725331;14964.775528367083;394057;398802;399126;400437;401431;48443.757781210865;48602.27096593554;48974;49018.75490622596;49021.75489122532;1146.340854008948;1149.7240662241002;1161.6689243565543;1166.719987203065;1209.782239196953;25801.354966125997;26916.73083269142;27745.861270693516;27840.721592784623;28001.439971200056;42155.15689686128;42353.78823105865;42431;42465.787671061444;42539.36190957076;328008;328972;329159;329198;329839;24262.272131836075;25465;25828.741712582632;25838;25892.48215035651;38858.80570597242;40828.59171408248;42496;42600.36099458449;42640;35143.297134057684;36287.27425451423;36476;36647.26705465822;37118.8144059278;35156;36237.0940726484;38293.80853095717;39447.80276098716;39709.404358935215;35054.29891402107;35277.8603268945;35553.64446355607;35915.82042089877;36513.452298215016;30523.38953220879;33296.500552492216;34001.82999084989;34311.656883431846;34376.14059648529;25650;25870.223893283233;25903.22290331293;26031.349216269744;26101.216963491126 21:15:52 INFO - PROCESS | 6487 | |2;jquery.html;365.60149437113523;370.57939238963775;373.97569158004717;380.69734561023984;389.53645162256913;15432.537023889274;16317.83682163178;16806.411775587843;16981.660366792657;17058.147092645348;15816.209189540506;16416.589585260346;16875.493735187934;16912.408065717704;16947.661046779056;4956.132676781567;5218.504242097014;5220.243064755608;5220.451852555484;5221.373435187783;5064.442911279756;5087.236914462823;5142.408623008365;5167.870803229931;5171.508706672879;5291.497307755757;5397.487238712336;5403;5410.404855465896;5421.105517589593;5408.3509978802595;5408.513233808956;5478.369987451454;5561.860953476155;5899.203607512974;5243.187305967581;5264.5525130363585;5287.365516138049;5287.814926477555;5306.151015837448;11553.826692599618;11581.247218930826;11713.121515886258;11922.821157682642;11962.1626486146;1680.8739344549085;1720.4580557124466;1892.139076720089;1966.547694030381;2294.070901284982;9126.482391216325;9233.21517670992;9470.289728270407;9477.28920330971;9690.37012594179;1692.339987404913;1778.8043315235313;1795.2101075526857;1806.2504060814747;1827.1869018286734;60548;61687;63814.04278935866;66781.66609166923;72802.27197728008;10019.499025048719;10433.739156520996;10436.37381757097;10437.843432348522;10442.895571044344;13886;13951.02342836012;13987.510437134652;14011.649708757363;14049.90902001558;7308.890366644505;7394.815129621695;7436.702531898772;7556.282153195438;7627.351675107567;7085.787426377217;7237.3486386225495;7237.963810181021;7483.064616922885;7501.062367204099;4336.2438212523975;4369.761331508432;4371;4421.270490369053;4470.575295346936;1731.3334366268825;1821.6994195957784;1834.9994026046427;1850.2598960415671;1857.6377606366898;797.1789057270904;804.412778671573;808.0787901791962;886.3485338276362;888.4047688049022;16605.41881034182;16798.664026719398;17183.914080429517;17215.397461088804;17799.041152612208;836.9372297077743;857.7641148684162;859.9269062129664;876.8560868676153;898.1063841477771;9179.770505737277;9262.490563018964;9474.952625236967;9694.36986595869;9722.854157187649;288079;292104;292863;393145;393150;47260.29109563359;47799;84280;84555.5772221135;85963.57018214869;890.2299510923134;908.0783005249676;930.1210356213448;930.7812664023949;963.5134257200209;15685.921570392074;15749.448769293478;15751.212439377756;15874.7618785716;16493.422730204384;36875;38309.808450957564;38343.616563834;38453.80773096117;38877;46549.784783358635;47347.52652473569;49989.750051250965;50282;54000.459995401114;7188.353048225685;7315.561066336037;7356.264373562815;7369.705211791468;7417.888731669137;10847.45762711877;11584.652460426201;11624.476898539417;11640.825387619023;11976.520939162336;10124;10225.284230104118;10362;10493.370397776158;10567.365958042543;9937.701868943943;10035.799284014132;10248.897511024794;10299.948500257451;10502.947485262524;10336.741581460223;10395.636152734618;10485.528151233366;10694.679159625224;10706.464676765974;7285.708571657075;7533.096028476618;7624.046994125734;7708.691652333844;7847.293743563107;9656.517174141405;9995.850062248926;10099.44453055089;10727.785444291227;10791.676249712522 21:15:52 INFO - PROCESS | 6487 | |3;mootools.html;1345.1928842694385;1380.806687063811;1417.4967886400327;1611.1299898055051;1621.408186012106;6763.850145475269;6963.686634101465;7345.7428989985365;8029.317508011819;8049.637766300516;7397.408207343413;7625.31372176504;7658.310752032316;7931.9206807931905;7939.642716077776;2150.6989021536997;2202.3172816426877;2202.493426511903;2203.1958335207614;2219.5006123622215;2136.070809197996;2163.102312540294;2183.8316500672145;2185.3225500095023;2187.4203336115943;2150.709654196687;2151.515908920488;2170.6201414752436;2174.793394627508;2190.2553131935138;2083.1771450277056;2099.8110170084765;2105.031685424714;2124.8725076495384;2130.0734180631475;2077.2729544659246;2126;2127.5957568062017;2131.2753663754243;2143.20701340505;7794.688212471494;7960.482568633078;7968.960155199187;7977.441579089466;8000.159983201738;4505.504394516601;4628.143793398232;4639.327297541838;4641.535846415365;4647.512011238839;2774.7780177585946;2891.132660201952;2933.471975044491;2938.4563855686765;2952.6161598992207;863.6890719341033;893.2184338703635;924.9815003699888;928.1971095002841;929.60027188309;10502.947485262524;10503.317284376491;10504.527296271686;10521.631742889038;10535.947320263349;4047.3119569672635;4105.835766569364;4290.485141782943;4300.548442413501;4304.978475107667;9032.27741780656;9038.09619038091;9047.140521650434;9050.818983620291;9057.501837398875;4646.97676511622;4652.62778977681;4672.649551283599;4686.36734040907;4704.15325241453;3656.323580137683;3781.262653782486;4038.2932986727205;4194.328907374806;4249.68127390447;3449.844756985942;3542.5394698689006;3604.873829415958;3625.329314076904;3635.600083990759;1169.2575214738702;1228.6239411858776;1233.7162452635944;1238.5355491690616;1241.8137279407981;595.2589026661834;649.8797722421273;709.202147583968;721.6788529104603;724.8985142080113;4794.472608013116;5012.573931215888;5014.598832093424;5087.516685914832;5244.501772331622;378.9981050094787;403.11315106764647;414.44257473697826;417.68464809069565;421.0820411502953;3399.609044959812;3440.346334196495;3454.274602333488;3466.4973578830927;3554.964450355515;9433.198178154797;9509.762255943657;9532.90467095334;9561.569729362056;9628.133467987915;9519.524023798782;9521.143097121154;9552.283578731623;9559.474228917337;9569.234461243084;7204.207537170802;7342.669579868919;7401.5189012714;7421.851562968711;7423.703051877972;4758.571728544448;4876.561109500162;4909.607231421549;4968.751562421937;5139.665921715076;8705.390622656354;8779.078196789245;8805.075467075865;8845.292376609726;8863.911360886308;8811.383203175716;8972.596233169392;8992.055834137584;9063.864042039506;9085.500297483437;6465.967670161619;6552.63960482178;6589;6589.077529145828;6620.900686489803;7191.316824901626;7231.5299505531975;7237.493375463878;7244.927550724636;7256.818579535554;6518.413342799171;6596.076549283008;6620.5034622402545;6642.90035649456;6758.93241067583;6204.81385558434;6411.134496843053;6568.441682457044;6575.112359831553;6701.631410272482;5720.256366672306;5922.437368449991;5928.407159284209;5937.910931335947;5945.554083443672;4444.177827101997;4636.93044604338;4650.139724151043;4690.788914498788;4740.834070807643;4505.7296562206375;4537.614302784168;4671.042436300618;4671.182543054884;4769.809207631794 21:15:52 INFO - PROCESS | 6487 | |4;prototype.html;284.2651745238558;288.0221647506713;294.5463985462388;296.9228000719812;307.0940724861659;4832.975835120819;4977.253411988204;5009.699418034916;5065.645404821664;5088.618353623475;4780.952190478094;4878.560929516343;4914.164592019356;4916;4918.557329840313;3889.7666140031547;3890.9416358754643;3904.5900180481067;3920;3926.921461570767;3797.886063418102;3900.648941595256;3902.843886244547;3914.921701565967;3917.2361389529055;3855.8843234702863;3879.3405121129335;3882.4664257618224;3893.922121557567;3908.335582950891;3875.2830726315724;3895.3962135868987;3907.8046097695287;3909.5730058528434;3928.2143571285856;3219;3349.8325083745717;3358.529805827186;3453.8100404477746;3464.6708562686504;4858.927116093261;4862.610991120702;4876.658633895629;4889.633277504201;4918.336024636664;4391.231534481485;4412.0955204183065;4427.889302767424;4428.357888106207;4434.778261086933;4959.6528243023;5221.397235907212;5261.842144735626;5262.210668399733;5281;3630.9636903631153;3643.526341575605;3645.54430696163;3656.8537258509627;3660.6156353583024;5396.325459317585;5487.972560137214;5493.121100623881;5503.532199763025;5533.944660553383;3618.3125206210734;3700.3154416433044;3704.870329538507;3708.962910370916;3715.052661571336;3754.8310326035394;3758.7180961427457;3775.301569209705;3792.2984247914223;3802.6197380262306;4366.781660916941;4377.321515165155;4381.079973205598;4385.451818522684;4388.605025547652;5253;5256.342957130359;5269.604779641542;5273.841784746387;5286.656367336111;1224.7550489902055;1282.2947378941544;1296.8443786745652;1300.174389262825;1315.4014923209916;843.9450686641698;871.9346049046347;893.4148132972913;893.78995935955;899.820035992804;4565.748883811356;4569.885752856205;4576.977115114403;4608.677392582554;4626.265150568537;5331.333583302087;5332.760025798849;5337.905729325479;5342.465753424626;5357.19642053695;4471.5081341052455;4584.426946631671;4611.24772586415;4621.2837010263465;4649.883752906205;2457.6682147909805;2476.8761561922192;2488.25352394281;2497.475530138655;2517.1819158773105;4431.977840110779;4480.529544397791;4507.267369262261;4518.841840535565;4562.543745625411;4619.884502887455;4779.426468823764;4802.447718512346;4837.6613637045775;4855.732934688555;4449.13241917823;4474.776261186993;4476.753778542212;4481.820727170877;4505.36924830524;4675.275332323496;4697.976510117564;4706.61154959281;4716.528347165256;4752.691075080109;4648.930266045944;4649.5815376616265;4659.2312268475325;4660.976695116503;4680.461746899014;4222.704410691222;4411.602955733999;4439.578240067189;4442.42248507692;4471.463424389094;3373.6120346160506;3396.8131752753834;3421.7433692472664;3427.6058253300193;3428.7257019437884;4672.509386514367;4706.670533062653;4713.690291757083;4731.361266229015;5133.383993920754;5067.898642027212;5130.358705161855;5188.195829646411;5196.168613021899;5262.657927234717;5201.47985201492;5215.452377500308;5215.713135777569;5217.4260831307765;5218.6868787872845;4802.207635740064;5106.719130447861;5120.206368012964;5149.459306772735;5150.48495150482;5231.03836061477;5242.239875217996;5245.423003469692;5252.395974462986;5262.184361423985;5063.3417655704525;5143.588512919032;5162.457941916195;5182.170852663556;5188.455212202815 21:15:52 INFO - PROCESS | 6487 | |5;yui.html;650.5966300893446;679.5990365684245;705.8976448414977;743.9888401673976;747.2490147401863;12833.935830320846;13376.197428154317;14145.717085658294;14211;14494.130352178876;13398.263095529743;13549.59351219465;13610;13610.659733506642;13611.455541778318;730.817295676081;740.7185269597559;761.3338328962158;764.9579273139975;767.5049593012503;760.8516339313836;770.0720631638861;770.3298130626363;770.9884351734728;771.3289438188756;808.9716859909904;813.0284310249255;813.6907974969504;815.3477218225426;816.0696805641574;798.2855344466699;798.4969469234403;798.744401791427;801.3749275565068;802.3541049455187;591.3347484080409;591.6982339007094;592.0822724776622;592.4105515012546;592.62960649594;13980.370883310174;13983.37074831635;13999.51001714935;14032;14043.859561404357;12764.425600847984;12915.87084129156;13163.07858449909;13205.933970330183;13342.665733426677;10481.109105726022;10720.78558428835;10754.892451075468;10827.78344433107;11085.168612354106;3273.7217336526423;3313.8508767105536;3318.5188147718445;3335.1328654549748;3352.396568617648;67575.3242467574;67621.66189169121;68685.65657171732;69039;69753;9989.500524973722;10088.142507886765;10179.491025448846;10206.285560010876;10248.180145588334;18629.7205541917;18744.062796860104;18772.71840922387;18822.623547529245;19351.322703705304;6819.283975182633;6866.622335771481;6924.134483189601;6958.721651133999;7004.334588214213;3848.749831260959;3870.4968354113785;3911.6870650347905;3916.9020774480864;3939.369700847908;2875.7699384049224;2890.97109028907;2924.1958461422855;2933.31067199208;2983.045425463874;499.077898901924;501.5836855410001;512.6821370750084;515.1088616693141;521.1817446608787;539.7004662412398;552.9917051244234;570.7260514952762;582.3012385137766;609.2567068176817;7775.300222979846;7939.920600793918;8055.959720201478;8294.709685161111;8537.146285371537;484.30744036028113;508.6464906889676;510.91314476539077;533.8505218538737;548.7311217503394;3662.9707770346226;3746.5129533160516;3756.2487502499607;3780;3836.9040773980873;60395.09407358893;60975;77361.61319193368;109665;109810;90151.54924225337;90574;91937;92269.5386523063;92962.53518732364;77761;78898;80555.19444805477;82222;83853.58073209474;6983.615901125487;7015.859682806214;7601.543907365576;7602.315791578784;7793.961030194812;45515.772421137684;47221.527784721715;47832.76083619559;47860.760696196296;48044.27933580929;53534.196987044445;54224.18663719969;55271;62807.37192628015;64107.67946160426;11234.775304494027;11253.784737141768;11375.317480950838;11378.886211138113;11504.53981840717;11670.70823229426;11749.765004699688;11906.464209110438;12299.569515066929;12551.748965020466;10806;10836.566537338733;11318.32090074598;11799.292042477478;11818.82271765907;11172.88827111751;11311.773764524827;11382.430878456209;11674.591389301333;11894.226875253082;11826.290422574673;11942.462589183682;12011.519539218683;12378.938105309417;12656.810147847973;10026.348287361297;10269.74325641865;10300.536475858455;10339.327943683636;10896.945515272373;9433.29250306216;10276;10537.42044187577;10580.100691441314;10729.785404292026 21:15:52 INFO - PROCESS | 6487 | __end_tp_report 21:15:52 INFO - PROCESS | 6487 | __start_cc_report 21:15:52 INFO - PROCESS | 6487 | _x_x_mozilla_cycle_collect,353 21:15:52 INFO - PROCESS | 6487 | __end_cc_report 21:15:52 INFO - PROCESS | 6487 | __startTimestamp1474517752813__endTimestamp 21:15:52 INFO - PROCESS | 6487 | 21:15:52 INFO - PROCESS | 6487 | ------- Summary: start ------- 21:15:52 INFO - PROCESS | 6487 | Number of tests: 6 21:15:52 INFO - PROCESS | 6487 | 21:15:52 INFO - PROCESS | 6487 | [#0] dojo.html Cycles:165 Average:4688.65 Median:4822.11 stddev:497.71 (10.3%) stddev-sans-first:471.83 21:15:52 INFO - PROCESS | 6487 | Values: 2612.2 2627.2 2632.5 2659.4 2668.6 4648.4 4731.7 4751.8 4763.7 4766.9 4691.9 4698.2 4741.8 4753.1 4791.4 4322.0 4343.9 4424.2 4436.4 4489.0 4375.3 4415.1 4453.1 4480.9 4527.5 4249.9 4317.5 4332.2 4386.6 4436.3 4269.4 4306.4 4309.9 4318.8 4324.3 4338.6 4362.0 4363.0 4389.8 4408.2 4714.1 4725.0 4738.4 4741.2 4746.8 5023.5 5059.7 5078.6 5080.5 5156.5 5097.5 5108.4 5128.6 5131.9 5177.7 4643.1 4690.9 4763.1 4764.0 4774.2 5196.7 5210.5 5245.0 5267.0 5269.7 4998.9 5003.3 5006.3 5009.7 5071.8 4928.5 4985.9 5091.8 5098.8 5105.2 5028.5 5040.2 5040.5 5049.3 5115.9 5030.3 5032.5 5034.8 5045.7 5078.1 4113.4 4224.9 4231.1 4233.6 4280.2 3633.0 3673.4 3705.3 3734.1 3787.8 4415.3 4447.6 4452.2 4467.2 4499.1 5089.0 5102.6 5141.7 5158.1 5178.1 4334.0 4348.5 4389.6 4390.6 4424.3 4499.7 4513.8 4542.5 4549.5 4558.9 4789.3 4803.1 4812.1 4819.1 4856.5 4982.1 5034.4 5041.6 5077.7 5146.7 4836.8 4848.9 4855.4 4865.2 4899.4 5027.3 5049.1 5049.1 5075.3 5112.7 4965.7 5001.0 5006.1 5121.9 5191.0 4866.3 4900.1 4905.4 4915.0 4961.1 4884.8 4887.3 4897.3 4900.5 4960.4 4699.5 4738.7 4755.7 4822.1 4836.9 4940.4 4942.1 4944.1 4948.6 4989.1 4831.8 4835.5 4835.7 4884.8 4909.4 21:15:52 INFO - PROCESS | 6487 | 21:15:52 INFO - PROCESS | 6487 | [#1] ext.html Cycles:180 Average:46742.23 Median:36262.18 stddev:87710.01 (241.9%) stddev-sans-first:87887.46 21:15:52 INFO - PROCESS | 6487 | Values: 539.7 548.1 550.2 551.1 562.4 38072.6 39812.0 39894.4 43989.3 44106.8 39099.6 39458.4 39713.8 39916.2 40002.0 7681.2 7803.7 7815.5 7818.7 7825.0 7596.5 7639.0 7660.8 7674.8 7678.7 7650.8 7693.6 7695.1 7696.2 7715.5 7389.2 7390.7 7390.7 7405.9 7421.4 7651.2 7665.5 7691.5 7692.2 7716.8 38345.2 38606.2 38726.8 38745.4 38765.2 3108.4 3526.5 3528.9 3533.7 3558.2 28144.9 28679.0 28912.4 28969.1 29089.0 3350.5 3376.4 3471.8 3593.0 3603.6 250193.0 251949.0 252491.0 252727.0 252776.0 31038.8 32318.2 32323.2 53030.5 53286.5 33592.3 33811.3 33845.8 33979.2 34084.4 12914.7 13055.8 13056.1 13060.1 13063.5 10636.9 10684.9 10689.1 10718.8 10733.8 7733.3 7838.0 7838.1 7851.4 7887.6 3057.5 3091.2 3097.2 3113.7 3121.3 826.8 834.7 838.3 860.0 945.0 27073.3 27583.4 28420.9 28426.6 28740.3 854.8 876.7 915.3 995.5 1000.8 14098.9 14656.3 14804.9 14901.3 14964.8 394057.0 398802.0 399126.0 400437.0 401431.0 48443.8 48602.3 48974.0 49018.8 49021.8 1146.3 1149.7 1161.7 1166.7 1209.8 25801.4 26916.7 27745.9 27840.7 28001.4 42155.2 42353.8 42431.0 42465.8 42539.4 328008.0 328972.0 329159.0 329198.0 329839.0 24262.3 25465.0 25828.7 25838.0 25892.5 38858.8 40828.6 42496.0 42600.4 42640.0 35143.3 36287.3 36476.0 36647.3 37118.8 35156.0 36237.1 38293.8 39447.8 39709.4 35054.3 35277.9 35553.6 35915.8 36513.5 30523.4 33296.5 34001.8 34311.7 34376.1 25650.0 25870.2 25903.2 26031.3 26101.2 21:15:52 INFO - PROCESS | 6487 | 21:15:52 INFO - PROCESS | 6487 | [#2] jquery.html Cycles:180 Average:22162.54 Median:4445.92 stddev:55694.96 (1252.7%) stddev-sans-first:55827.15 21:15:52 INFO - PROCESS | 6487 | Values: 365.6 370.6 374.0 380.7 389.5 15432.5 16317.8 16806.4 16981.7 17058.1 15816.2 16416.6 16875.5 16912.4 16947.7 4956.1 5218.5 5220.2 5220.5 5221.4 5064.4 5087.2 5142.4 5167.9 5171.5 5291.5 5397.5 5403.0 5410.4 5421.1 5408.4 5408.5 5478.4 5561.9 5899.2 5243.2 5264.6 5287.4 5287.8 5306.2 11553.8 11581.2 11713.1 11922.8 11962.2 1680.9 1720.5 1892.1 1966.5 2294.1 9126.5 9233.2 9470.3 9477.3 9690.4 1692.3 1778.8 1795.2 1806.3 1827.2 60548.0 61687.0 63814.0 66781.7 72802.3 10019.5 10433.7 10436.4 10437.8 10442.9 13886.0 13951.0 13987.5 14011.6 14049.9 7308.9 7394.8 7436.7 7556.3 7627.4 7085.8 7237.3 7238.0 7483.1 7501.1 4336.2 4369.8 4371.0 4421.3 4470.6 1731.3 1821.7 1835.0 1850.3 1857.6 797.2 804.4 808.1 886.3 888.4 16605.4 16798.7 17183.9 17215.4 17799.0 836.9 857.8 859.9 876.9 898.1 9179.8 9262.5 9475.0 9694.4 9722.9 288079.0 292104.0 292863.0 393145.0 393150.0 47260.3 47799.0 84280.0 84555.6 85963.6 890.2 908.1 930.1 930.8 963.5 15685.9 15749.4 15751.2 15874.8 16493.4 36875.0 38309.8 38343.6 38453.8 38877.0 46549.8 47347.5 49989.8 50282.0 54000.5 7188.4 7315.6 7356.3 7369.7 7417.9 10847.5 11584.7 11624.5 11640.8 11976.5 10124.0 10225.3 10362.0 10493.4 10567.4 9937.7 10035.8 10248.9 10299.9 10502.9 10336.7 10395.6 10485.5 10694.7 10706.5 7285.7 7533.1 7624.0 7708.7 7847.3 9656.5 9995.9 10099.4 10727.8 10791.7 21:15:52 INFO - PROCESS | 6487 | 21:15:52 INFO - PROCESS | 6487 | [#3] mootools.html Cycles:180 Average:5048.92 Median:4782.14 stddev:2865.99 (59.9%) stddev-sans-first:2860.52 21:15:52 INFO - PROCESS | 6487 | Values: 1345.2 1380.8 1417.5 1611.1 1621.4 6763.9 6963.7 7345.7 8029.3 8049.6 7397.4 7625.3 7658.3 7931.9 7939.6 2150.7 2202.3 2202.5 2203.2 2219.5 2136.1 2163.1 2183.8 2185.3 2187.4 2150.7 2151.5 2170.6 2174.8 2190.3 2083.2 2099.8 2105.0 2124.9 2130.1 2077.3 2126.0 2127.6 2131.3 2143.2 7794.7 7960.5 7969.0 7977.4 8000.2 4505.5 4628.1 4639.3 4641.5 4647.5 2774.8 2891.1 2933.5 2938.5 2952.6 863.7 893.2 925.0 928.2 929.6 10502.9 10503.3 10504.5 10521.6 10535.9 4047.3 4105.8 4290.5 4300.5 4305.0 9032.3 9038.1 9047.1 9050.8 9057.5 4647.0 4652.6 4672.6 4686.4 4704.2 3656.3 3781.3 4038.3 4194.3 4249.7 3449.8 3542.5 3604.9 3625.3 3635.6 1169.3 1228.6 1233.7 1238.5 1241.8 595.3 649.9 709.2 721.7 724.9 4794.5 5012.6 5014.6 5087.5 5244.5 379.0 403.1 414.4 417.7 421.1 3399.6 3440.3 3454.3 3466.5 3555.0 9433.2 9509.8 9532.9 9561.6 9628.1 9519.5 9521.1 9552.3 9559.5 9569.2 7204.2 7342.7 7401.5 7421.9 7423.7 4758.6 4876.6 4909.6 4968.8 5139.7 8705.4 8779.1 8805.1 8845.3 8863.9 8811.4 8972.6 8992.1 9063.9 9085.5 6466.0 6552.6 6589.0 6589.1 6620.9 7191.3 7231.5 7237.5 7244.9 7256.8 6518.4 6596.1 6620.5 6642.9 6758.9 6204.8 6411.1 6568.4 6575.1 6701.6 5720.3 5922.4 5928.4 5937.9 5945.6 4444.2 4636.9 4650.1 4690.8 4740.8 4505.7 4537.6 4671.0 4671.2 4769.8 21:15:52 INFO - PROCESS | 6487 | 21:15:52 INFO - PROCESS | 6487 | [#4] prototype.html Cycles:180 Average:4183.33 Median:4609.96 stddev:1220.74 (26.5%) stddev-sans-first:1188.57 21:15:52 INFO - PROCESS | 6487 | Values: 284.3 288.0 294.5 296.9 307.1 4833.0 4977.3 5009.7 5065.6 5088.6 4781.0 4878.6 4914.2 4916.0 4918.6 3889.8 3890.9 3904.6 3920.0 3926.9 3797.9 3900.6 3902.8 3914.9 3917.2 3855.9 3879.3 3882.5 3893.9 3908.3 3875.3 3895.4 3907.8 3909.6 3928.2 3219.0 3349.8 3358.5 3453.8 3464.7 4858.9 4862.6 4876.7 4889.6 4918.3 4391.2 4412.1 4427.9 4428.4 4434.8 4959.7 5221.4 5261.8 5262.2 5281.0 3631.0 3643.5 3645.5 3656.9 3660.6 5396.3 5488.0 5493.1 5503.5 5533.9 3618.3 3700.3 3704.9 3709.0 3715.1 3754.8 3758.7 3775.3 3792.3 3802.6 4366.8 4377.3 4381.1 4385.5 4388.6 5253.0 5256.3 5269.6 5273.8 5286.7 1224.8 1282.3 1296.8 1300.2 1315.4 843.9 871.9 893.4 893.8 899.8 4565.7 4569.9 4577.0 4608.7 4626.3 5331.3 5332.8 5337.9 5342.5 5357.2 4471.5 4584.4 4611.2 4621.3 4649.9 2457.7 2476.9 2488.3 2497.5 2517.2 4432.0 4480.5 4507.3 4518.8 4562.5 4619.9 4779.4 4802.4 4837.7 4855.7 4449.1 4474.8 4476.8 4481.8 4505.4 4675.3 4698.0 4706.6 4716.5 4752.7 4648.9 4649.6 4659.2 4661.0 4680.5 4222.7 4411.6 4439.6 4442.4 4471.5 3373.6 3396.8 3421.7 3427.6 3428.7 4672.5 4706.7 4713.7 4731.4 5133.4 5067.9 5130.4 5188.2 5196.2 5262.7 5201.5 5215.5 5215.7 5217.4 5218.7 4802.2 5106.7 5120.2 5149.5 5150.5 5231.0 5242.2 5245.4 5252.4 5262.2 5063.3 5143.6 5162.5 5182.2 5188.5 21:15:52 INFO - PROCESS | 6487 | 21:15:52 INFO - PROCESS | 6487 | [#5] yui.html Cycles:180 Average:17925.57 Median:46368.65 stddev:25659.56 (55.3%) stddev-sans-first:25698.76 21:15:52 INFO - PROCESS | 6487 | Values: 650.6 679.6 705.9 744.0 747.2 12833.9 13376.2 14145.7 14211.0 14494.1 13398.3 13549.6 13610.0 13610.7 13611.5 730.8 740.7 761.3 765.0 767.5 760.9 770.1 770.3 771.0 771.3 809.0 813.0 813.7 815.3 816.1 798.3 798.5 798.7 801.4 802.4 591.3 591.7 592.1 592.4 592.6 13980.4 13983.4 13999.5 14032.0 14043.9 12764.4 12915.9 13163.1 13205.9 13342.7 10481.1 10720.8 10754.9 10827.8 11085.2 3273.7 3313.9 3318.5 3335.1 3352.4 67575.3 67621.7 68685.7 69039.0 69753.0 9989.5 10088.1 10179.5 10206.3 10248.2 18629.7 18744.1 18772.7 18822.6 19351.3 6819.3 6866.6 6924.1 6958.7 7004.3 3848.7 3870.5 3911.7 3916.9 3939.4 2875.8 2891.0 2924.2 2933.3 2983.0 499.1 501.6 512.7 515.1 521.2 539.7 553.0 570.7 582.3 609.3 7775.3 7939.9 8056.0 8294.7 8537.1 484.3 508.6 510.9 533.9 548.7 3663.0 3746.5 3756.2 3780.0 3836.9 60395.1 60975.0 77361.6 109665.0 109810.0 90151.5 90574.0 91937.0 92269.5 92962.5 77761.0 78898.0 80555.2 82222.0 83853.6 6983.6 7015.9 7601.5 7602.3 7794.0 45515.8 47221.5 47832.8 47860.8 48044.3 53534.2 54224.2 55271.0 62807.4 64107.7 11234.8 11253.8 11375.3 11378.9 11504.5 11670.7 11749.8 11906.5 12299.6 12551.7 10806.0 10836.6 11318.3 11799.3 11818.8 11172.9 11311.8 11382.4 11674.6 11894.2 11826.3 11942.5 12011.5 12378.9 12656.8 10026.3 10269.7 10300.5 10339.3 10896.9 9433.3 10276.0 10537.4 10580.1 10729.8 21:15:52 INFO - PROCESS | 6487 | -------- Summary: end -------- 21:15:52 INFO - PROCESS | 6487 | 21:15:53 INFO - TEST-INFO | 6487: exit 0 21:15:53 INFO - TEST-OK | dromaeo_css | took 1118743ms 21:15:53 INFO - TEST-START | kraken 21:15:53 INFO - operating with platform_type : linux_ 21:15:53 INFO - Initialising browser for kraken test... 21:15:53 INFO - TEST-INFO | started process 6844 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpStSHXU/profile http://localhost:33668/getInfo.html) 21:15:58 INFO - PROCESS | 6844 | __metrics Screen width/height:1600/1200 21:15:58 INFO - PROCESS | 6844 | colorDepth:24 21:15:58 INFO - PROCESS | 6844 | Browser inner width/height: 1024/697 21:15:58 INFO - PROCESS | 6844 | __metrics 21:15:59 ERROR - PROCESS | 6844 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3067: TypeError: this.tabs is undefined 21:16:00 INFO - TEST-INFO | 6844: exit 0 21:16:00 INFO - Browser initialized. 21:16:00 INFO - Running cycle 1/1 for kraken test... 21:16:00 INFO - TEST-INFO | started process 6965 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpStSHXU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:16:12 INFO - PROCESS | 6965 | RSS: Main: 186327040 21:16:12 INFO - PROCESS | 6965 | 21:16:15 INFO - PROCESS | 6965 | Cycle 1(1): loaded http://localhost:33668/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33668/tests/kraken/driver.html?testName=audio-beat-detection) 21:16:16 INFO - PROCESS | 6965 | RSS: Main: 195465216 21:16:16 INFO - PROCESS | 6965 | 21:16:19 INFO - PROCESS | 6965 | Cycle 1(1): loaded http://localhost:33668/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33668/tests/kraken/driver.html?testName=audio-dft) 21:16:19 INFO - PROCESS | 6965 | RSS: Main: 197804032 21:16:19 INFO - PROCESS | 6965 | 21:16:22 INFO - PROCESS | 6965 | Cycle 1(1): loaded http://localhost:33668/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33668/tests/kraken/driver.html?testName=audio-fft) 21:16:23 INFO - PROCESS | 6965 | RSS: Main: 193613824 21:16:23 INFO - PROCESS | 6965 | 21:16:25 INFO - PROCESS | 6965 | Cycle 1(1): loaded http://localhost:33668/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33668/tests/kraken/driver.html?testName=audio-oscillator) 21:16:26 INFO - PROCESS | 6965 | RSS: Main: 194289664 21:16:26 INFO - PROCESS | 6965 | 21:16:28 INFO - PROCESS | 6965 | Cycle 1(1): loaded http://localhost:33668/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33668/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:16:29 INFO - PROCESS | 6965 | RSS: Main: 194445312 21:16:29 INFO - PROCESS | 6965 | 21:16:32 INFO - PROCESS | 6965 | Cycle 1(1): loaded http://localhost:33668/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33668/tests/kraken/driver.html?testName=imaging-darkroom) 21:16:32 INFO - PROCESS | 6965 | RSS: Main: 194764800 21:16:32 INFO - PROCESS | 6965 | 21:16:36 INFO - PROCESS | 6965 | Cycle 1(1): loaded http://localhost:33668/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33668/tests/kraken/driver.html?testName=imaging-desaturate) 21:16:36 INFO - PROCESS | 6965 | RSS: Main: 192675840 21:16:36 INFO - PROCESS | 6965 | 21:16:39 INFO - PROCESS | 6965 | Cycle 1(1): loaded http://localhost:33668/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33668/tests/kraken/driver.html?testName=json-parse-financial) 21:16:40 INFO - PROCESS | 6965 | RSS: Main: 193794048 21:16:40 INFO - PROCESS | 6965 | 21:16:42 INFO - PROCESS | 6965 | Cycle 1(1): loaded http://localhost:33668/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33668/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:16:42 INFO - PROCESS | 6965 | RSS: Main: 194338816 21:16:42 INFO - PROCESS | 6965 | 21:16:44 INFO - PROCESS | 6965 | Cycle 1(1): loaded http://localhost:33668/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33668/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:16:45 INFO - PROCESS | 6965 | RSS: Main: 194273280 21:16:45 INFO - PROCESS | 6965 | 21:16:47 INFO - PROCESS | 6965 | Cycle 1(1): loaded http://localhost:33668/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33668/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:16:48 INFO - PROCESS | 6965 | RSS: Main: 194334720 21:16:48 INFO - PROCESS | 6965 | 21:16:51 INFO - PROCESS | 6965 | Cycle 1(1): loaded http://localhost:33668/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33668/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:16:51 INFO - PROCESS | 6965 | RSS: Main: 194908160 21:16:51 INFO - PROCESS | 6965 | 21:16:54 INFO - PROCESS | 6965 | Cycle 1(1): loaded http://localhost:33668/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33668/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:16:55 INFO - PROCESS | 6965 | RSS: Main: 194760704 21:16:55 INFO - PROCESS | 6965 | 21:16:57 INFO - PROCESS | 6965 | Cycle 1(1): loaded http://localhost:33668/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33668/tests/kraken/driver.html?testName=ai-astar) 21:16:57 INFO - PROCESS | 6965 | RSS: Main: 197140480 21:16:57 INFO - PROCESS | 6965 | 21:16:57 INFO - PROCESS | 6965 | __start_tp_report 21:16:57 INFO - PROCESS | 6965 | _x_x_mozilla_page_load 21:16:57 INFO - PROCESS | 6965 | _x_x_mozilla_page_load_details 21:16:57 INFO - PROCESS | 6965 | |i|pagename|runs| 21:16:57 INFO - PROCESS | 6965 | |0;ai-astar;107;115;115;118;117;115;116;115;117;116 21:16:57 INFO - PROCESS | 6965 | |1;audio-beat-detection;159;124;124;181;130;124;128;129;164;126 21:16:57 INFO - PROCESS | 6965 | |2;audio-dft;169;178;165;170;164;165;163;167;164;164 21:16:57 INFO - PROCESS | 6965 | |3;audio-fft;76;77;76;101;77;79;78;77;106;83 21:16:57 INFO - PROCESS | 6965 | |4;audio-oscillator;84;85;110;85;85;85;113;84;85;116 21:16:57 INFO - PROCESS | 6965 | |5;imaging-gaussian-blur;117;117;118;118;118;120;118;120;118;119 21:16:57 INFO - PROCESS | 6965 | |6;imaging-darkroom;148;147;147;147;148;147;148;150;147;148 21:16:57 INFO - PROCESS | 6965 | |7;imaging-desaturate;96;96;96;96;95;95;96;95;96;97 21:16:57 INFO - PROCESS | 6965 | |8;json-parse-financial;64;64;66;64;65;66;65;65;66;66 21:16:57 INFO - PROCESS | 6965 | |9;json-stringify-tinderbox;66;68;66;66;67;67;67;66;67;68 21:16:57 INFO - PROCESS | 6965 | |10;stanford-crypto-aes;80;83;88;83;84;83;83;83;88;88 21:16:57 INFO - PROCESS | 6965 | |11;stanford-crypto-ccm;144;150;141;134;148;135;135;142;171;142 21:16:57 INFO - PROCESS | 6965 | |12;stanford-crypto-pbkdf2;175;179;186;177;174;175;173;177;176;178 21:16:57 INFO - PROCESS | 6965 | |13;stanford-crypto-sha256-iterative;73;71;72;70;70;74;73;70;70;68 21:16:57 INFO - PROCESS | 6965 | __end_tp_report 21:16:57 INFO - PROCESS | 6965 | __start_cc_report 21:16:57 INFO - PROCESS | 6965 | _x_x_mozilla_cycle_collect,871 21:16:57 INFO - PROCESS | 6965 | __end_cc_report 21:16:57 INFO - PROCESS | 6965 | __startTimestamp1474517817583__endTimestamp 21:16:57 INFO - PROCESS | 6965 | 21:16:57 INFO - PROCESS | 6965 | ------- Summary: start ------- 21:16:57 INFO - PROCESS | 6965 | Number of tests: 14 21:16:57 INFO - PROCESS | 6965 | 21:16:57 INFO - PROCESS | 6965 | [#0] ai-astar Cycles:10 Average:115.10 Median:116.00 stddev:3.03 (2.6%) stddev-sans-first:1.12 21:16:57 INFO - PROCESS | 6965 | Values: 107.0 115.0 115.0 118.0 117.0 115.0 116.0 115.0 117.0 116.0 21:16:57 INFO - PROCESS | 6965 | 21:16:57 INFO - PROCESS | 6965 | [#1] audio-beat-detection Cycles:10 Average:138.90 Median:129.50 stddev:20.91 (16.1%) stddev-sans-first:20.87 21:16:57 INFO - PROCESS | 6965 | Values: 159.0 124.0 124.0 181.0 130.0 124.0 128.0 129.0 164.0 126.0 21:16:57 INFO - PROCESS | 6965 | 21:16:57 INFO - PROCESS | 6965 | [#2] audio-dft Cycles:10 Average:166.90 Median:166.00 stddev:4.53 (2.7%) stddev-sans-first:4.74 21:16:57 INFO - PROCESS | 6965 | Values: 169.0 178.0 165.0 170.0 164.0 165.0 163.0 167.0 164.0 164.0 21:16:57 INFO - PROCESS | 6965 | 21:16:57 INFO - PROCESS | 6965 | [#3] audio-fft Cycles:10 Average:83.00 Median:77.00 stddev:11.06 (14.4%) stddev-sans-first:11.43 21:16:57 INFO - PROCESS | 6965 | Values: 76.0 77.0 76.0 101.0 77.0 79.0 78.0 77.0 106.0 83.0 21:16:57 INFO - PROCESS | 6965 | 21:16:57 INFO - PROCESS | 6965 | [#4] audio-oscillator Cycles:10 Average:93.20 Median:85.00 stddev:13.74 (16.2%) stddev-sans-first:14.17 21:16:57 INFO - PROCESS | 6965 | Values: 84.0 85.0 110.0 85.0 85.0 85.0 113.0 84.0 85.0 116.0 21:16:57 INFO - PROCESS | 6965 | 21:16:57 INFO - PROCESS | 6965 | [#5] imaging-gaussian-blur Cycles:10 Average:118.30 Median:118.00 stddev:1.06 (0.9%) stddev-sans-first:1.01 21:16:57 INFO - PROCESS | 6965 | Values: 117.0 117.0 118.0 118.0 118.0 120.0 118.0 120.0 118.0 119.0 21:16:57 INFO - PROCESS | 6965 | 21:16:57 INFO - PROCESS | 6965 | [#6] imaging-darkroom Cycles:10 Average:147.70 Median:148.00 stddev:0.95 (0.6%) stddev-sans-first:1.00 21:16:57 INFO - PROCESS | 6965 | Values: 148.0 147.0 147.0 147.0 148.0 147.0 148.0 150.0 147.0 148.0 21:16:57 INFO - PROCESS | 6965 | 21:16:57 INFO - PROCESS | 6965 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 21:16:57 INFO - PROCESS | 6965 | Values: 96.0 96.0 96.0 96.0 95.0 95.0 96.0 95.0 96.0 97.0 21:16:57 INFO - PROCESS | 6965 | 21:16:57 INFO - PROCESS | 6965 | [#8] json-parse-financial Cycles:10 Average:65.10 Median:65.50 stddev:0.88 (1.3%) stddev-sans-first:0.83 21:16:57 INFO - PROCESS | 6965 | Values: 64.0 64.0 66.0 64.0 65.0 66.0 65.0 65.0 66.0 66.0 21:16:57 INFO - PROCESS | 6965 | 21:16:57 INFO - PROCESS | 6965 | [#9] json-stringify-tinderbox Cycles:10 Average:66.80 Median:67.00 stddev:0.79 (1.2%) stddev-sans-first:0.78 21:16:57 INFO - PROCESS | 6965 | Values: 66.0 68.0 66.0 66.0 67.0 67.0 67.0 66.0 67.0 68.0 21:16:57 INFO - PROCESS | 6965 | 21:16:57 INFO - PROCESS | 6965 | [#10] stanford-crypto-aes Cycles:10 Average:84.30 Median:83.50 stddev:2.75 (3.3%) stddev-sans-first:2.44 21:16:57 INFO - PROCESS | 6965 | Values: 80.0 83.0 88.0 83.0 84.0 83.0 83.0 83.0 88.0 88.0 21:16:57 INFO - PROCESS | 6965 | 21:16:57 INFO - PROCESS | 6965 | [#11] stanford-crypto-ccm Cycles:10 Average:144.20 Median:143.00 stddev:10.85 (7.6%) stddev-sans-first:11.51 21:16:57 INFO - PROCESS | 6965 | Values: 144.0 150.0 141.0 134.0 148.0 135.0 135.0 142.0 171.0 142.0 21:16:57 INFO - PROCESS | 6965 | 21:16:57 INFO - PROCESS | 6965 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:177.00 Median:177.00 stddev:3.65 (2.1%) stddev-sans-first:3.80 21:16:57 INFO - PROCESS | 6965 | Values: 175.0 179.0 186.0 177.0 174.0 175.0 173.0 177.0 176.0 178.0 21:16:57 INFO - PROCESS | 6965 | 21:16:57 INFO - PROCESS | 6965 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.10 Median:71.50 stddev:1.85 (2.6%) stddev-sans-first:1.83 21:16:57 INFO - PROCESS | 6965 | Values: 73.0 71.0 72.0 70.0 70.0 74.0 73.0 70.0 70.0 68.0 21:16:57 INFO - PROCESS | 6965 | -------- Summary: end -------- 21:16:57 INFO - PROCESS | 6965 | 21:16:57 INFO - PROCESS | 6965 | 21:16:57 INFO - PROCESS | 6965 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 21:16:57 INFO - PROCESS | 6965 | 21:16:57 INFO - PROCESS | 6965 | 21:16:57 INFO - PROCESS | 6965 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 21:16:57 INFO - PROCESS | 6965 | 21:16:57 INFO - PROCESS | 6965 | 21:16:57 INFO - PROCESS | 6965 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 21:16:57 INFO - PROCESS | 6965 | 21:16:57 INFO - PROCESS | 6965 | 21:16:57 INFO - PROCESS | 6965 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 21:16:57 INFO - PROCESS | 6965 | 21:16:57 INFO - PROCESS | 6965 | 21:16:57 INFO - PROCESS | 6965 | ###!!! [Parent][MessageChannel] Error: (msgtype=0x2000C,name=PAPZ::Msg_Destroy) Channel error: cannot send/recv 21:16:57 INFO - PROCESS | 6965 | 21:16:58 INFO - TEST-INFO | 6965: exit 0 21:16:58 INFO - TEST-OK | kraken | took 64978ms 21:16:58 INFO - SUITE-END | took 1183s 21:16:59 INFO - Completed test suite (00:19:44) 21:16:59 INFO - javascript benchmark 21:16:59 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6267.428897904791, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2612.24244968959, 2627.1724406811863, 2632.486665100305, 2659.4282229320697, 2668.57302831547, 4648.372469716587, 4731.668783185179, 4751.809927602896, 4763.737994410306, 4766.856994290169, 4691.929621055679, 4698.177818881699, 4741.8103275868925, 4753.120672675557, 4791.401074865642, 4322.0, 4343.869683909487, 4424.181526417623, 4436.356728274398, 4488.97755511222, 4375.321825117096, 4415.050764085721, 4453.064856380148, 4480.910381792379, 4527.547245275479, 4249.893752656178, 4317.525072242051, 4332.241857674926, 4386.627136693385, 4436.290193569013, 4269.423627810237, 4306.35404689296, 4309.935350969738, 4318.762468064255, 4324.329728892027, 4338.631216346615, 4362.018545827195, 4363.0, 4389.802458889326, 4408.184485870124, 4714.080754252922, 4724.95275047252, 4738.4313882334, 4741.241401375763, 4746.83386081489, 5023.547880690719, 5059.74701264939, 5078.568321692661, 5080.491950804927, 5156.484351564851, 5097.515736005073, 5108.412532558729, 5128.589712822965, 5131.897362052775, 5177.689338639693, 4643.071385722801, 4690.929636055462, 4763.095011947754, 4763.976180119146, 4774.21225497789, 5196.662216955886, 5210.452902445264, 5245.029669511153, 5267.0256002639635, 5269.736513174326, 4998.93333597931, 5003.324551185616, 5006.274090256892, 5009.699418034929, 5071.771770270347, 4928.457869634337, 4985.90028199434, 5091.796328146833, 5098.796048158107, 5105.183170692671, 5028.522290382408, 5040.243963405518, 5040.49595040493, 5049.343585333957, 5115.923261151086, 5030.320906677625, 5032.471590482946, 5034.79860805571, 5045.672031317952, 5078.13671675816, 4113.424120623115, 4224.91550169001, 4231.132617813341, 4233.597808208216, 4280.165367753259, 3633.0, 3673.412254039341, 3705.314516814344, 3734.066483379155, 3787.772733635991, 4415.315626077963, 4447.599716025508, 4452.198604251201, 4467.195904737114, 4499.055198408371, 5088.974555127201, 5102.591792656579, 5141.691498510101, 5158.123119069692, 5178.0679477694375, 4333.978330108393, 4348.456442944632, 4389.561043895649, 4390.62679672225, 4424.31423129409, 4499.707519011319, 4513.774311284423, 4542.454905411306, 4549.476810166807, 4558.931616025762, 4789.281607758794, 4803.135435621622, 4812.109759694397, 4819.060283244734, 4856.465788763163, 4982.078315511642, 5034.44621091687, 5041.6470847040355, 5077.7461126944245, 5146.716930568855, 4836.806527738851, 4848.927266090941, 4855.441624213261, 4865.197242454955, 4899.4365647950945, 5027.27104569828, 5049.116404629101, 5049.141645920276, 5075.264086707481, 5112.693238405707, 4965.726885021359, 5001.049800537886, 5006.098902197639, 5121.8719532012, 5191.039657663345, 4866.343043689199, 4900.14247506692, 4905.386826646669, 4914.99242655262, 4961.107000739901, 4884.804607815648, 4887.291342755351, 4897.314375987436, 4900.485280166053, 4960.355153829979, 4699.506551812011, 4738.691985020962, 4755.738434386004, 4822.107910036654, 4836.879078023077, 4940.357753492023, 4942.085714142895, 4944.134776414185, 4948.554630083166, 4989.101961646938, 4831.830885918976, 4835.468098509091, 4835.685680430761, 4884.755762211947, 4909.386326709161], "value": 4656.3922586157005, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [539.657317603322, 548.1202669715107, 550.1719911533143, 551.1374698596693, 562.401042889323, 38072.61927380726, 39812.0, 39894.401583976265, 43989.34015989763, 44106.77946610271, 39099.60900390995, 39458.408123878165, 39713.80143099288, 39916.20167596646, 40002.0, 7681.193474685161, 7803.726869559567, 7815.452918295721, 7818.687252509922, 7825.0, 7596.5062270952485, 7638.961805190994, 7660.7701768946745, 7674.769756907302, 7678.731244406447, 7650.808729781745, 7693.576853273068, 7695.115061767884, 7696.153423123452, 7715.459917805756, 7389.1502477215, 7390.667419966115, 7390.7413240536325, 7405.8889116663295, 7421.406287496988, 7651.1583725790115, 7665.501742386783, 7691.538507689556, 7692.192319806451, 7716.7684969451, 38345.233095337935, 38606.227875442615, 38726.806365968274, 38745.41881871746, 38765.224695506215, 3108.4249413858283, 3526.4533997230214, 3528.9294214115575, 3533.6819686228105, 3558.1638314995957, 28144.859275703697, 28679.0, 28912.42175156506, 28969.130926072252, 29089.0, 3350.530925670408, 3376.375370556455, 3471.8437670304897, 3592.976001839463, 3603.6396360364015, 250193.0, 251949.0, 252490.99999999817, 252727.0, 252776.0, 31038.84480577628, 32318.192045198586, 32323.191920201712, 53030.46969530333, 53286.46713532892, 33592.32815343679, 33811.323773524884, 33845.83077084599, 33979.150521236676, 34084.44366672509, 12914.708529147198, 13055.804162937564, 13056.086073974731, 13060.08579399452, 13063.542776002794, 10636.893631063745, 10684.89315106839, 10689.144868410509, 10718.839217411745, 10733.78532429347, 7733.342665873463, 7837.960810195913, 7838.098618658813, 7851.411144164211, 7887.605619718991, 3057.5107982722657, 3091.248788578167, 3097.1947293703347, 3113.657497675254, 3121.2508997840355, 826.8428998490388, 834.6786487202471, 838.262329150356, 860.0324634785866, 944.9935818353568, 27073.32316692059, 27583.44833103367, 28420.85789571039, 28426.573601395994, 28740.281492962426, 854.7563944275976, 876.6537217799062, 915.3089417489886, 995.5370752599931, 1000.7640563903574, 14098.929505352613, 14656.267186640625, 14804.851951480563, 14901.25493725331, 14964.775528367083, 394057.0, 398802.0, 399126.0, 400437.0, 401431.0, 48443.757781210865, 48602.27096593554, 48974.0, 49018.75490622596, 49021.75489122532, 1146.340854008948, 1149.7240662241002, 1161.6689243565543, 1166.719987203065, 1209.782239196953, 25801.354966125997, 26916.73083269142, 27745.861270693516, 27840.721592784623, 28001.439971200056, 42155.15689686128, 42353.78823105865, 42431.0, 42465.787671061444, 42539.36190957076, 328008.0, 328972.0, 329159.0, 329198.0, 329839.0, 24262.272131836075, 25465.0, 25828.741712582632, 25838.0, 25892.48215035651, 38858.80570597242, 40828.59171408248, 42496.0, 42600.36099458449, 42640.0, 35143.297134057684, 36287.27425451423, 36476.0, 36647.26705465822, 37118.8144059278, 35156.0, 36237.0940726484, 38293.80853095717, 39447.80276098716, 39709.404358935215, 35054.29891402107, 35277.8603268945, 35553.64446355607, 35915.82042089877, 36513.452298215016, 30523.38953220879, 33296.500552492216, 34001.82999084989, 34311.656883431846, 34376.14059648529, 25650.0, 25870.223893283233, 25903.22290331293, 26031.349216269744, 26101.216963491126], "value": 16328.432509725408, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [365.60149437113523, 370.57939238963775, 373.97569158004717, 380.69734561023984, 389.53645162256913, 15432.537023889274, 16317.83682163178, 16806.411775587843, 16981.660366792657, 17058.147092645348, 15816.209189540506, 16416.589585260346, 16875.493735187934, 16912.408065717704, 16947.661046779056, 4956.132676781567, 5218.504242097014, 5220.243064755608, 5220.451852555484, 5221.373435187783, 5064.442911279756, 5087.236914462823, 5142.408623008365, 5167.870803229931, 5171.508706672879, 5291.497307755757, 5397.487238712336, 5403.0, 5410.404855465896, 5421.105517589593, 5408.3509978802595, 5408.513233808956, 5478.369987451454, 5561.860953476155, 5899.203607512974, 5243.187305967581, 5264.5525130363585, 5287.365516138049, 5287.814926477555, 5306.151015837448, 11553.826692599618, 11581.247218930826, 11713.121515886258, 11922.821157682642, 11962.1626486146, 1680.8739344549085, 1720.4580557124466, 1892.139076720089, 1966.547694030381, 2294.070901284982, 9126.482391216325, 9233.21517670992, 9470.289728270407, 9477.28920330971, 9690.37012594179, 1692.339987404913, 1778.8043315235313, 1795.2101075526857, 1806.2504060814747, 1827.1869018286734, 60548.0, 61687.0, 63814.04278935866, 66781.66609166923, 72802.27197728008, 10019.499025048719, 10433.739156520996, 10436.37381757097, 10437.843432348522, 10442.895571044344, 13886.0, 13951.02342836012, 13987.510437134652, 14011.649708757363, 14049.90902001558, 7308.890366644505, 7394.815129621695, 7436.702531898772, 7556.282153195438, 7627.351675107567, 7085.787426377217, 7237.3486386225495, 7237.963810181021, 7483.064616922885, 7501.062367204099, 4336.2438212523975, 4369.761331508432, 4371.0, 4421.270490369053, 4470.575295346936, 1731.3334366268825, 1821.6994195957784, 1834.9994026046427, 1850.2598960415671, 1857.6377606366898, 797.1789057270904, 804.412778671573, 808.0787901791962, 886.3485338276362, 888.4047688049022, 16605.41881034182, 16798.664026719398, 17183.914080429517, 17215.397461088804, 17799.041152612208, 836.9372297077743, 857.7641148684162, 859.9269062129664, 876.8560868676153, 898.1063841477771, 9179.770505737277, 9262.490563018964, 9474.952625236967, 9694.36986595869, 9722.854157187649, 288079.0, 292104.0, 292863.0, 393145.0, 393150.0, 47260.29109563359, 47799.0, 84280.0, 84555.5772221135, 85963.57018214869, 890.2299510923134, 908.0783005249676, 930.1210356213448, 930.7812664023949, 963.5134257200209, 15685.921570392074, 15749.448769293478, 15751.212439377756, 15874.7618785716, 16493.422730204384, 36875.0, 38309.808450957564, 38343.616563834, 38453.80773096117, 38877.0, 46549.784783358635, 47347.52652473569, 49989.750051250965, 50282.0, 54000.459995401114, 7188.353048225685, 7315.561066336037, 7356.264373562815, 7369.705211791468, 7417.888731669137, 10847.45762711877, 11584.652460426201, 11624.476898539417, 11640.825387619023, 11976.520939162336, 10124.0, 10225.284230104118, 10362.0, 10493.370397776158, 10567.365958042543, 9937.701868943943, 10035.799284014132, 10248.897511024794, 10299.948500257451, 10502.947485262524, 10336.741581460223, 10395.636152734618, 10485.528151233366, 10694.679159625224, 10706.464676765974, 7285.708571657075, 7533.096028476618, 7624.046994125734, 7708.691652333844, 7847.293743563107, 9656.517174141405, 9995.850062248926, 10099.44453055089, 10727.785444291227, 10791.676249712522], "value": 8030.820687327508, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1345.1928842694385, 1380.806687063811, 1417.4967886400327, 1611.1299898055051, 1621.408186012106, 6763.850145475269, 6963.686634101465, 7345.7428989985365, 8029.317508011819, 8049.637766300516, 7397.408207343413, 7625.31372176504, 7658.310752032316, 7931.9206807931905, 7939.642716077776, 2150.6989021536997, 2202.3172816426877, 2202.493426511903, 2203.1958335207614, 2219.5006123622215, 2136.070809197996, 2163.102312540294, 2183.8316500672145, 2185.3225500095023, 2187.4203336115943, 2150.709654196687, 2151.515908920488, 2170.6201414752436, 2174.793394627508, 2190.2553131935138, 2083.1771450277056, 2099.8110170084765, 2105.031685424714, 2124.8725076495384, 2130.0734180631475, 2077.2729544659246, 2126.0, 2127.5957568062017, 2131.2753663754243, 2143.20701340505, 7794.688212471494, 7960.482568633078, 7968.960155199187, 7977.441579089466, 8000.159983201738, 4505.504394516601, 4628.143793398232, 4639.327297541838, 4641.535846415365, 4647.512011238839, 2774.7780177585946, 2891.132660201952, 2933.471975044491, 2938.4563855686765, 2952.6161598992207, 863.6890719341033, 893.2184338703635, 924.9815003699888, 928.1971095002841, 929.60027188309, 10502.947485262524, 10503.317284376491, 10504.527296271686, 10521.631742889038, 10535.947320263349, 4047.3119569672635, 4105.835766569364, 4290.485141782943, 4300.548442413501, 4304.978475107667, 9032.27741780656, 9038.09619038091, 9047.140521650434, 9050.818983620291, 9057.501837398875, 4646.97676511622, 4652.62778977681, 4672.649551283599, 4686.36734040907, 4704.15325241453, 3656.323580137683, 3781.262653782486, 4038.2932986727205, 4194.328907374806, 4249.68127390447, 3449.844756985942, 3542.5394698689006, 3604.873829415958, 3625.329314076904, 3635.600083990759, 1169.2575214738702, 1228.6239411858776, 1233.7162452635944, 1238.5355491690616, 1241.8137279407981, 595.2589026661834, 649.8797722421273, 709.202147583968, 721.6788529104603, 724.8985142080113, 4794.472608013116, 5012.573931215888, 5014.598832093424, 5087.516685914832, 5244.501772331622, 378.9981050094787, 403.11315106764647, 414.44257473697826, 417.68464809069565, 421.0820411502953, 3399.609044959812, 3440.346334196495, 3454.274602333488, 3466.4973578830927, 3554.964450355515, 9433.198178154797, 9509.762255943657, 9532.90467095334, 9561.569729362056, 9628.133467987915, 9519.524023798782, 9521.143097121154, 9552.283578731623, 9559.474228917337, 9569.234461243084, 7204.207537170802, 7342.669579868919, 7401.5189012714, 7421.851562968711, 7423.703051877972, 4758.571728544448, 4876.561109500162, 4909.607231421549, 4968.751562421937, 5139.665921715076, 8705.390622656354, 8779.078196789245, 8805.075467075865, 8845.292376609726, 8863.911360886308, 8811.383203175716, 8972.596233169392, 8992.055834137584, 9063.864042039506, 9085.500297483437, 6465.967670161619, 6552.63960482178, 6589.0, 6589.077529145828, 6620.900686489803, 7191.316824901626, 7231.5299505531975, 7237.493375463878, 7244.927550724636, 7256.818579535554, 6518.413342799171, 6596.076549283008, 6620.5034622402545, 6642.90035649456, 6758.93241067583, 6204.81385558434, 6411.134496843053, 6568.441682457044, 6575.112359831553, 6701.631410272482, 5720.256366672306, 5922.437368449991, 5928.407159284209, 5937.910931335947, 5945.554083443672, 4444.177827101997, 4636.93044604338, 4650.139724151043, 4690.788914498788, 4740.834070807643, 4505.7296562206375, 4537.614302784168, 4671.042436300618, 4671.182543054884, 4769.809207631794], "value": 3981.547311407039, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [284.2651745238558, 288.0221647506713, 294.5463985462388, 296.9228000719812, 307.0940724861659, 4832.975835120819, 4977.253411988204, 5009.699418034916, 5065.645404821664, 5088.618353623475, 4780.952190478094, 4878.560929516343, 4914.164592019356, 4916.0, 4918.557329840313, 3889.7666140031547, 3890.9416358754643, 3904.5900180481067, 3920.0, 3926.921461570767, 3797.886063418102, 3900.648941595256, 3902.843886244547, 3914.921701565967, 3917.2361389529055, 3855.8843234702863, 3879.3405121129335, 3882.4664257618224, 3893.922121557567, 3908.335582950891, 3875.2830726315724, 3895.3962135868987, 3907.8046097695287, 3909.5730058528434, 3928.2143571285856, 3219.0, 3349.8325083745717, 3358.529805827186, 3453.8100404477746, 3464.6708562686504, 4858.927116093261, 4862.610991120702, 4876.658633895629, 4889.633277504201, 4918.336024636664, 4391.231534481485, 4412.0955204183065, 4427.889302767424, 4428.357888106207, 4434.778261086933, 4959.6528243023, 5221.397235907212, 5261.842144735626, 5262.210668399733, 5281.0, 3630.9636903631153, 3643.526341575605, 3645.54430696163, 3656.8537258509627, 3660.6156353583024, 5396.325459317585, 5487.972560137214, 5493.121100623881, 5503.532199763025, 5533.944660553383, 3618.3125206210734, 3700.3154416433044, 3704.870329538507, 3708.962910370916, 3715.052661571336, 3754.8310326035394, 3758.7180961427457, 3775.301569209705, 3792.2984247914223, 3802.6197380262306, 4366.781660916941, 4377.321515165155, 4381.079973205598, 4385.451818522684, 4388.605025547652, 5253.0, 5256.342957130359, 5269.604779641542, 5273.841784746387, 5286.656367336111, 1224.7550489902055, 1282.2947378941544, 1296.8443786745652, 1300.174389262825, 1315.4014923209916, 843.9450686641698, 871.9346049046347, 893.4148132972913, 893.78995935955, 899.820035992804, 4565.748883811356, 4569.885752856205, 4576.977115114403, 4608.677392582554, 4626.265150568537, 5331.333583302087, 5332.760025798849, 5337.905729325479, 5342.465753424626, 5357.19642053695, 4471.5081341052455, 4584.426946631671, 4611.24772586415, 4621.2837010263465, 4649.883752906205, 2457.6682147909805, 2476.8761561922192, 2488.25352394281, 2497.475530138655, 2517.1819158773105, 4431.977840110779, 4480.529544397791, 4507.267369262261, 4518.841840535565, 4562.543745625411, 4619.884502887455, 4779.426468823764, 4802.447718512346, 4837.6613637045775, 4855.732934688555, 4449.13241917823, 4474.776261186993, 4476.753778542212, 4481.820727170877, 4505.36924830524, 4675.275332323496, 4697.976510117564, 4706.61154959281, 4716.528347165256, 4752.691075080109, 4648.930266045944, 4649.5815376616265, 4659.2312268475325, 4660.976695116503, 4680.461746899014, 4222.704410691222, 4411.602955733999, 4439.578240067189, 4442.42248507692, 4471.463424389094, 3373.6120346160506, 3396.8131752753834, 3421.7433692472664, 3427.6058253300193, 3428.7257019437884, 4672.509386514367, 4706.670533062653, 4713.690291757083, 4731.361266229015, 5133.383993920754, 5067.898642027212, 5130.358705161855, 5188.195829646411, 5196.168613021899, 5262.657927234717, 5201.47985201492, 5215.452377500308, 5215.713135777569, 5217.4260831307765, 5218.6868787872845, 4802.207635740064, 5106.719130447861, 5120.206368012964, 5149.459306772735, 5150.48495150482, 5231.03836061477, 5242.239875217996, 5245.423003469692, 5252.395974462986, 5262.184361423985, 5063.3417655704525, 5143.588512919032, 5162.457941916195, 5182.170852663556, 5188.455212202815], "value": 3795.253211210332, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [650.5966300893446, 679.5990365684245, 705.8976448414977, 743.9888401673976, 747.2490147401863, 12833.935830320846, 13376.197428154317, 14145.717085658294, 14211.0, 14494.130352178876, 13398.263095529743, 13549.59351219465, 13610.0, 13610.659733506642, 13611.455541778318, 730.817295676081, 740.7185269597559, 761.3338328962158, 764.9579273139975, 767.5049593012503, 760.8516339313836, 770.0720631638861, 770.3298130626363, 770.9884351734728, 771.3289438188756, 808.9716859909904, 813.0284310249255, 813.6907974969504, 815.3477218225426, 816.0696805641574, 798.2855344466699, 798.4969469234403, 798.744401791427, 801.3749275565068, 802.3541049455187, 591.3347484080409, 591.6982339007094, 592.0822724776622, 592.4105515012546, 592.62960649594, 13980.370883310174, 13983.37074831635, 13999.51001714935, 14032.0, 14043.859561404357, 12764.425600847984, 12915.87084129156, 13163.07858449909, 13205.933970330183, 13342.665733426677, 10481.109105726022, 10720.78558428835, 10754.892451075468, 10827.78344433107, 11085.168612354106, 3273.7217336526423, 3313.8508767105536, 3318.5188147718445, 3335.1328654549748, 3352.396568617648, 67575.3242467574, 67621.66189169121, 68685.65657171732, 69039.0, 69753.0, 9989.500524973722, 10088.142507886765, 10179.491025448846, 10206.285560010876, 10248.180145588334, 18629.7205541917, 18744.062796860104, 18772.71840922387, 18822.623547529245, 19351.322703705304, 6819.283975182633, 6866.622335771481, 6924.134483189601, 6958.721651133999, 7004.334588214213, 3848.749831260959, 3870.4968354113785, 3911.6870650347905, 3916.9020774480864, 3939.369700847908, 2875.7699384049224, 2890.97109028907, 2924.1958461422855, 2933.31067199208, 2983.045425463874, 499.077898901924, 501.5836855410001, 512.6821370750084, 515.1088616693141, 521.1817446608787, 539.7004662412398, 552.9917051244234, 570.7260514952762, 582.3012385137766, 609.2567068176817, 7775.300222979846, 7939.920600793918, 8055.959720201478, 8294.709685161111, 8537.146285371537, 484.30744036028113, 508.6464906889676, 510.91314476539077, 533.8505218538737, 548.7311217503394, 3662.9707770346226, 3746.5129533160516, 3756.2487502499607, 3780.0, 3836.9040773980873, 60395.09407358893, 60975.0, 77361.61319193368, 109665.0, 109810.0, 90151.54924225337, 90574.0, 91937.0, 92269.5386523063, 92962.53518732364, 77761.0, 78898.0, 80555.19444805477, 82222.0, 83853.58073209474, 6983.615901125487, 7015.859682806214, 7601.543907365576, 7602.315791578784, 7793.961030194812, 45515.772421137684, 47221.527784721715, 47832.76083619559, 47860.760696196296, 48044.27933580929, 53534.196987044445, 54224.18663719969, 55271.0, 62807.37192628015, 64107.67946160426, 11234.775304494027, 11253.784737141768, 11375.317480950838, 11378.886211138113, 11504.53981840717, 11670.70823229426, 11749.765004699688, 11906.464209110438, 12299.569515066929, 12551.748965020466, 10806.0, 10836.566537338733, 11318.32090074598, 11799.292042477478, 11818.82271765907, 11172.88827111751, 11311.773764524827, 11382.430878456209, 11674.591389301333, 11894.226875253082, 11826.290422574673, 11942.462589183682, 12011.519539218683, 12378.938105309417, 12656.810147847973, 10026.348287361297, 10269.74325641865, 10300.536475858455, 10339.327943683636, 10896.945515272373, 9433.29250306216, 10276.0, 10537.42044187577, 10580.100691441314, 10729.785404292026], "value": 6568.135122515394, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1567.3999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 115.0, 115.0, 118.0, 117.0, 115.0, 116.0, 115.0, 117.0, 116.0], "value": 115.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 124.0, 124.0, 181.0, 130.0, 124.0, 128.0, 129.0, 164.0, 126.0], "value": 138.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 178.0, 165.0, 170.0, 164.0, 165.0, 163.0, 167.0, 164.0, 164.0], "value": 166.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 76.0, 101.0, 77.0, 79.0, 78.0, 77.0, 106.0, 83.0], "value": 83.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 110.0, 85.0, 85.0, 85.0, 113.0, 84.0, 85.0, 116.0], "value": 93.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 118.0, 118.0, 118.0, 120.0, 118.0, 120.0, 118.0, 119.0], "value": 118.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 147.0, 147.0, 148.0, 147.0, 148.0, 150.0, 147.0, 148.0], "value": 147.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 96.0, 95.0, 95.0, 96.0, 95.0, 96.0, 97.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 66.0, 64.0, 65.0, 66.0, 65.0, 65.0, 66.0, 66.0], "value": 65.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 68.0, 66.0, 66.0, 67.0, 67.0, 67.0, 66.0, 67.0, 68.0], "value": 66.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 83.0, 88.0, 83.0, 84.0, 83.0, 83.0, 83.0, 88.0, 88.0], "value": 84.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 150.0, 141.0, 134.0, 148.0, 135.0, 135.0, 142.0, 171.0, 142.0], "value": 144.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 179.0, 186.0, 177.0, 174.0, 175.0, 173.0, 177.0, 176.0, 178.0], "value": 177.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 71.0, 72.0, 70.0, 70.0, 74.0, 73.0, 70.0, 70.0, 68.0], "value": 71.1, "unit": "score"}]}]} 21:16:59 INFO - Return code: 0 21:16:59 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 21:16:59 ERROR - # TBPL SUCCESS # 21:16:59 INFO - Running post-action listener: _resource_record_post_action 21:16:59 INFO - [mozharness: 2016-09-22 04:16:59.376420Z] Finished run-tests step (success) 21:16:59 INFO - Running post-run listener: _resource_record_post_run 21:16:59 INFO - Total resource usage - Wall time: 1201s; CPU: 13.0%; Read bytes: 4096; Write bytes: 392130560; Read time: 16; Write time: 214260 21:16:59 INFO - TinderboxPrint: CPU usage
13.4% 21:16:59 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 21:16:59 INFO - TinderboxPrint: I/O write bytes / time
392,130,560 / 214,260 21:16:59 INFO - TinderboxPrint: CPU idle
8,289.8 (86.5%) 21:16:59 INFO - TinderboxPrint: CPU user
1,228.3 (12.8%) 21:16:59 INFO - TinderboxPrint: Swap in / out
0 / 0 21:16:59 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 98942976; Read time: 0; Write time: 63612 21:16:59 INFO - run-tests - Wall time: 1185s; CPU: 13.0%; Read bytes: 0; Write bytes: 290541568; Read time: 0; Write time: 150380 21:17:00 INFO - Running post-run listener: _upload_blobber_files 21:17:00 INFO - Blob upload gear active. 21:17:00 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 21:17:00 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 21:17:00 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', 'Autoland-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 21:17:00 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 Autoland-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 21:17:00 INFO - (blobuploader) - INFO - Open directory for files ... 21:17:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 21:17:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:17:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:17:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 21:17:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:17:01 INFO - (blobuploader) - INFO - Done attempting. 21:17:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 21:17:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:17:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:17:06 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 21:17:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:17:06 INFO - (blobuploader) - INFO - Done attempting. 21:17:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 21:17:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:17:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:17:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 21:17:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:17:06 INFO - (blobuploader) - INFO - Done attempting. 21:17:06 INFO - (blobuploader) - INFO - Iteration through files over. 21:17:06 INFO - Return code: 0 21:17:06 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 21:17:06 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 21:17:06 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/287fcf8703d8c1354240d81d6aff4dcab6f8e63529b5a65a53435aaac12fa1790e79deb96848f1f130710c3cd14bcd6b3ebab4ec184e8c12bca342ce1ccdff04", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/75731df82b61a150a0fe25e41d88301e82895d0d7bbd2df96c128f02ee216e56e98dc0f90e43f4b3c1e1c56759c7eb642d28dd7f954fd29c72e6296d142798f1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/dd361fd83bc20b5445ad1ca747554e08bbd486b9c8d226af60e8bf674d6e07c6f30ac7980b207c31da75c7d8bc940054eae9558aee1fbfcbdf0d6c33505d5b79"} 21:17:06 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 21:17:06 INFO - Writing to file /builds/slave/test/properties/blobber_files 21:17:06 INFO - Contents: 21:17:06 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/287fcf8703d8c1354240d81d6aff4dcab6f8e63529b5a65a53435aaac12fa1790e79deb96848f1f130710c3cd14bcd6b3ebab4ec184e8c12bca342ce1ccdff04", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/75731df82b61a150a0fe25e41d88301e82895d0d7bbd2df96c128f02ee216e56e98dc0f90e43f4b3c1e1c56759c7eb642d28dd7f954fd29c72e6296d142798f1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/dd361fd83bc20b5445ad1ca747554e08bbd486b9c8d226af60e8bf674d6e07c6f30ac7980b207c31da75c7d8bc940054eae9558aee1fbfcbdf0d6c33505d5b79"} 21:17:06 INFO - Running post-run listener: copy_logs_to_upload_dir 21:17:06 INFO - Copying logs to upload dir... 21:17:06 INFO - mkdir: /builds/slave/test/build/upload/logs 21:17:06 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1244.110227 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-09-21 21:17:06.607523) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-21 21:17:06.610826) ========= 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=bb9b54edd4a927dc735d112f000001d9-1474516578.255741-337422071 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/Autoland-Non-PGO/sha512/287fcf8703d8c1354240d81d6aff4dcab6f8e63529b5a65a53435aaac12fa1790e79deb96848f1f130710c3cd14bcd6b3ebab4ec184e8c12bca342ce1ccdff04", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/75731df82b61a150a0fe25e41d88301e82895d0d7bbd2df96c128f02ee216e56e98dc0f90e43f4b3c1e1c56759c7eb642d28dd7f954fd29c72e6296d142798f1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/dd361fd83bc20b5445ad1ca747554e08bbd486b9c8d226af60e8bf674d6e07c6f30ac7980b207c31da75c7d8bc940054eae9558aee1fbfcbdf0d6c33505d5b79"} build_url:https://queue.taskcluster.net/v1/task/P2AFQlp1S56mztYyg8aS8w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011359 build_url: 'https://queue.taskcluster.net/v1/task/P2AFQlp1S56mztYyg8aS8w/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/287fcf8703d8c1354240d81d6aff4dcab6f8e63529b5a65a53435aaac12fa1790e79deb96848f1f130710c3cd14bcd6b3ebab4ec184e8c12bca342ce1ccdff04", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/75731df82b61a150a0fe25e41d88301e82895d0d7bbd2df96c128f02ee216e56e98dc0f90e43f4b3c1e1c56759c7eb642d28dd7f954fd29c72e6296d142798f1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/dd361fd83bc20b5445ad1ca747554e08bbd486b9c8d226af60e8bf674d6e07c6f30ac7980b207c31da75c7d8bc940054eae9558aee1fbfcbdf0d6c33505d5b79"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-21 21:17:06.636451) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-21 21:17:06.636850) ========= 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=bb9b54edd4a927dc735d112f000001d9-1474516578.255741-337422071 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004504 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-21 21:17:06.721060) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-21 21:17:06.721381) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-21 21:17:06.721675) ========= ========= Total master_lag: 0.21 =========