builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-052 starttime: 1490959737.69 results: success (0) revision: 03d602fd723ad6ff4588c04855884ffa1dee9410 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-31 04:28:57.687584) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-31 04:28:57.688034) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-31 04:28:57.688325) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-31 04:28:57.703363) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-31 04:28:57.703750) ========= 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=826874ccc97bd7bf541b4875000001d5-1490959737.771741-1957698411 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-03-31 04:28:58-- 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: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 225M=0s 2017-03-31 04:28:58 (225 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.140476 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-31 04:28:57.858546) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-31 04:28:57.858921) ========= 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=826874ccc97bd7bf541b4875000001d5-1490959737.771741-1957698411 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020070 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-31 04:28:57.909629) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-31 04:28:57.910059) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 03d602fd723ad6ff4588c04855884ffa1dee9410 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo mozilla-central --rev 03d602fd723ad6ff4588c04855884ffa1dee9410 --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=826874ccc97bd7bf541b4875000001d5-1490959737.771741-1957698411 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-03-31 04:28:58,647 truncating revision to first 12 chars 2017-03-31 04:28:58,648 Setting DEBUG logging. 2017-03-31 04:28:58,648 attempt 1/10 2017-03-31 04:28:58,648 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/03d602fd723a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-31 04:28:59,111 unpacking tar archive at: mozilla-central-03d602fd723a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.777812 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-31 04:28:58.701691) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-31 04:28:58.702008) ========= script_repo_revision: 03d602fd723ad6ff4588c04855884ffa1dee9410 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-31 04:28:58.702422) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-31 04:28:58.702685) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-31 04:28:58.712808) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2017-03-31 04:28:58.713266) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=826874ccc97bd7bf541b4875000001d5-1490959737.771741-1957698411 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:28:59 INFO - MultiFileLogger online at 20170331 04:28:59 in /builds/slave/test 04:28:59 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 04:28:59 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:28:59 INFO - {'append_to_log': False, 04:28:59 INFO - 'base_work_dir': '/builds/slave/test', 04:28:59 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 04:28:59 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:28:59 INFO - 'branch': 'Firefox-Non-PGO', 04:28:59 INFO - 'buildbot_json_path': 'buildprops.json', 04:28:59 INFO - 'config_files': ('talos/linux_config.py',), 04:28:59 INFO - 'default_actions': ('clobber', 04:28:59 INFO - 'read-buildbot-config', 04:28:59 INFO - 'download-and-extract', 04:28:59 INFO - 'populate-webroot', 04:28:59 INFO - 'create-virtualenv', 04:28:59 INFO - 'install', 04:28:59 INFO - 'run-tests'), 04:28:59 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:28:59 INFO - 'download_minidump_stackwalk': True, 04:28:59 INFO - 'download_symbols': 'ondemand', 04:28:59 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:28:59 INFO - 'tooltool.py': '/tools/tooltool.py', 04:28:59 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:28:59 INFO - '/tools/misc-python/virtualenv.py')}, 04:28:59 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:28:59 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:28:59 INFO - 'gecko_profile': False, 04:28:59 INFO - 'gecko_profile_interval': 0, 04:28:59 INFO - 'installer_path': 'installer.exe', 04:28:59 INFO - 'log_level': 'info', 04:28:59 INFO - 'log_name': 'talos', 04:28:59 INFO - 'log_to_console': True, 04:28:59 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:28:59 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:28:59 INFO - 'opt_config_files': (), 04:28:59 INFO - 'pip_index': False, 04:28:59 INFO - 'suite': 'dromaeojs-e10s', 04:28:59 INFO - 'system_bits': '32', 04:28:59 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:28:59 INFO - 'title': 'talos-linux64-ix-052', 04:28:59 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:28:59 INFO - 'use_talos_json': True, 04:28:59 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:28:59 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:28:59 INFO - 'work_dir': 'build'} 04:28:59 INFO - [mozharness: 2017-03-31 11:28:59.551883Z] Running clobber step. 04:28:59 INFO - Running pre-action listener: _resource_record_pre_action 04:28:59 INFO - Running main action method: clobber 04:28:59 INFO - rmtree: /builds/slave/test/build 04:28:59 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:29:00 INFO - Running post-action listener: _resource_record_post_action 04:29:00 INFO - [mozharness: 2017-03-31 11:29:00.487096Z] Finished clobber step (success) 04:29:00 INFO - [mozharness: 2017-03-31 11:29:00.487195Z] Running read-buildbot-config step. 04:29:00 INFO - Running pre-action listener: _resource_record_pre_action 04:29:00 INFO - Running main action method: read_buildbot_config 04:29:00 INFO - Using buildbot properties: 04:29:00 INFO - { 04:29:00 INFO - "project": "", 04:29:00 INFO - "product": "firefox", 04:29:00 INFO - "who": "cbook@mozilla.com", 04:29:00 INFO - "installer_path": "public/build/target.tar.bz2", 04:29:00 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 04:29:00 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 04:29:00 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 04:29:00 INFO - "stage_platform": "linux64", 04:29:00 INFO - "basedir": "/builds/slave/test", 04:29:00 INFO - "buildnumber": 496, 04:29:00 INFO - "platform": "ubuntu64_hw", 04:29:00 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 04:29:00 INFO - "slavebuilddir": "test", 04:29:00 INFO - "taskId": "UFxz5J0yRrKlEYJovTfBOQ", 04:29:00 INFO - "branch": "mozilla-central", 04:29:00 INFO - "script_repo_revision": "production", 04:29:00 INFO - "revision": "03d602fd723ad6ff4588c04855884ffa1dee9410", 04:29:00 INFO - "slavename": "talos-linux64-ix-052", 04:29:00 INFO - "repo_path": "mozilla-central" 04:29:00 INFO - } 04:29:00 INFO - Finding installer, test and symbols from parent task. 04:29:00 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UFxz5J0yRrKlEYJovTfBOQ'}, attempt #1 04:29:00 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UFxz5J0yRrKlEYJovTfBOQ'}, attempt #1 04:29:01 INFO - Task dependencies: FziPe46tTL-TfFHS0Z7sXw 04:29:01 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FziPe46tTL-TfFHS0Z7sXw'}, attempt #1 04:29:01 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/FziPe46tTL-TfFHS0Z7sXw/artifacts/public/build/target.tar.bz2 04:29:01 INFO - Set test_url: https://queue.taskcluster.net/v1/task/FziPe46tTL-TfFHS0Z7sXw/artifacts/public/build/test_packages.json 04:29:01 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/FziPe46tTL-TfFHS0Z7sXw/artifacts/public/build/target.crashreporter-symbols.zip 04:29:01 INFO - Running post-action listener: _resource_record_post_action 04:29:01 INFO - [mozharness: 2017-03-31 11:29:01.857972Z] Finished read-buildbot-config step (success) 04:29:01 INFO - [mozharness: 2017-03-31 11:29:01.858190Z] Running download-and-extract step. 04:29:01 INFO - Running pre-action listener: _resource_record_pre_action 04:29:01 INFO - Running main action method: download_and_extract 04:29:01 INFO - mkdir: /builds/slave/test/build/tests 04:29:01 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')]} 04:29:01 INFO - trying https://queue.taskcluster.net/v1/task/FziPe46tTL-TfFHS0Z7sXw/artifacts/public/build/target.test_packages.json 04:29:01 INFO - Downloading https://queue.taskcluster.net/v1/task/FziPe46tTL-TfFHS0Z7sXw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 04:29:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FziPe46tTL-TfFHS0Z7sXw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 04:29:02 INFO - Downloaded 986 bytes. 04:29:02 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 04:29:02 INFO - Using the following test package requirements: 04:29:02 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 04:29:02 INFO - u'common': [u'target.common.tests.zip'], 04:29:02 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 04:29:02 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 04:29:02 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 04:29:02 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 04:29:02 INFO - u'mozbase': [u'target.common.tests.zip'], 04:29:02 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 04:29:02 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 04:29:02 INFO - u'web-platform': [u'target.common.tests.zip', 04:29:02 INFO - u'target.web-platform.tests.zip'], 04:29:02 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 04:29:02 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 04:29:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FziPe46tTL-TfFHS0Z7sXw/artifacts/public/build/target.common.tests.zip 04:29:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FziPe46tTL-TfFHS0Z7sXw/artifacts/public/build/target.common.tests.zip'}, attempt #1 04:29:02 INFO - Fetch https://queue.taskcluster.net/v1/task/FziPe46tTL-TfFHS0Z7sXw/artifacts/public/build/target.common.tests.zip into memory 04:29:03 INFO - Expected file size: 58227794 04:29:03 INFO - Obtained file size: 58227794 04:29:13 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 04:29:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FziPe46tTL-TfFHS0Z7sXw/artifacts/public/build/target.common.tests.zip 04:29:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FziPe46tTL-TfFHS0Z7sXw/artifacts/public/build/target.common.tests.zip'}, attempt #1 04:29:13 INFO - Fetch https://queue.taskcluster.net/v1/task/FziPe46tTL-TfFHS0Z7sXw/artifacts/public/build/target.common.tests.zip into memory 04:29:14 INFO - Expected file size: 58227794 04:29:14 INFO - Obtained file size: 58227794 04:29:25 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FziPe46tTL-TfFHS0Z7sXw/artifacts/public/build/target.talos.tests.zip 04:29:25 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FziPe46tTL-TfFHS0Z7sXw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 04:29:25 INFO - Fetch https://queue.taskcluster.net/v1/task/FziPe46tTL-TfFHS0Z7sXw/artifacts/public/build/target.talos.tests.zip into memory 04:29:25 INFO - Expected file size: 14404152 04:29:25 INFO - Obtained file size: 14404152 04:29:26 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')]} 04:29:26 INFO - trying https://queue.taskcluster.net/v1/task/FziPe46tTL-TfFHS0Z7sXw/artifacts/public/build/target.tar.bz2 04:29:26 INFO - Downloading https://queue.taskcluster.net/v1/task/FziPe46tTL-TfFHS0Z7sXw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 04:29:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FziPe46tTL-TfFHS0Z7sXw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 04:29:27 INFO - Downloaded 62478421 bytes. 04:29:27 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/FziPe46tTL-TfFHS0Z7sXw/artifacts/public/build/target.tar.bz2 04:29:27 INFO - mkdir: /builds/slave/test/properties 04:29:27 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:29:27 INFO - Writing to file /builds/slave/test/properties/build_url 04:29:27 INFO - Contents: 04:29:27 INFO - build_url:https://queue.taskcluster.net/v1/task/FziPe46tTL-TfFHS0Z7sXw/artifacts/public/build/target.tar.bz2 04:29:27 INFO - Running post-action listener: _resource_record_post_action 04:29:27 INFO - Running post-action listener: set_extra_try_arguments 04:29:27 INFO - [mozharness: 2017-03-31 11:29:27.289340Z] Finished download-and-extract step (success) 04:29:27 INFO - [mozharness: 2017-03-31 11:29:27.289436Z] Running populate-webroot step. 04:29:27 INFO - Running pre-action listener: _resource_record_pre_action 04:29:27 INFO - Running main action method: populate_webroot 04:29:27 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:29:27 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:29:27 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:29:27 INFO - '--tppagecycles', 04:29:27 INFO - '7'], 04:29:27 INFO - 'tests': ['tsvgm']}}, 04:29:27 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:29:27 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:29:27 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:29:27 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:29:27 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:29:27 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:29:27 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 04:29:27 INFO - 'talos_options': ['--disable-e10s'], 04:29:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:29:27 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 04:29:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:29:27 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 04:29:27 INFO - 'talos_options': ['--disable-e10s'], 04:29:27 INFO - 'tests': ['damp', 'tps']}, 04:29:27 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 04:29:27 INFO - 'tests': ['damp', 'tps']}, 04:29:27 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:29:27 INFO - 'tests': ['dromaeo_dom']}, 04:29:27 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:29:27 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:29:27 INFO - 'tests': ['basic_compositor_video']}, 04:29:27 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:29:27 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:29:27 INFO - 'tests': ['a11yr', 04:29:27 INFO - 'ts_paint', 04:29:27 INFO - 'tpaint', 04:29:27 INFO - 'sessionrestore', 04:29:27 INFO - 'sessionrestore_no_auto_restore', 04:29:27 INFO - 'tabpaint']}, 04:29:27 INFO - 'other-e10s': {'tests': ['a11yr', 04:29:27 INFO - 'ts_paint', 04:29:27 INFO - 'tpaint', 04:29:27 INFO - 'sessionrestore', 04:29:27 INFO - 'sessionrestore_no_auto_restore', 04:29:27 INFO - 'tabpaint']}, 04:29:27 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:29:27 INFO - 'ts_paint', 04:29:27 INFO - 'tpaint', 04:29:27 INFO - 'sessionrestore', 04:29:27 INFO - 'sessionrestore_no_auto_restore', 04:29:27 INFO - 'tabpaint']}, 04:29:27 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:29:27 INFO - 'ts_paint', 04:29:27 INFO - 'tpaint', 04:29:27 INFO - 'sessionrestore', 04:29:27 INFO - 'sessionrestore_no_auto_restore', 04:29:27 INFO - 'tabpaint']}, 04:29:27 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:29:27 INFO - 'tests': ['a11yr', 04:29:27 INFO - 'ts_paint', 04:29:27 INFO - 'tpaint', 04:29:27 INFO - 'sessionrestore', 04:29:27 INFO - 'sessionrestore_no_auto_restore', 04:29:27 INFO - 'tabpaint']}, 04:29:27 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:29:27 INFO - 'tests': ['a11yr', 04:29:27 INFO - 'ts_paint', 04:29:27 INFO - 'tpaint', 04:29:27 INFO - 'sessionrestore', 04:29:27 INFO - 'sessionrestore_no_auto_restore', 04:29:27 INFO - 'tabpaint']}, 04:29:27 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:29:27 INFO - 'tests': ['tsvgx', 04:29:27 INFO - 'tsvgr_opacity', 04:29:27 INFO - 'tart', 04:29:27 INFO - 'tscrollx', 04:29:27 INFO - 'cart', 04:29:27 INFO - 'tsvg_static']}, 04:29:27 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:29:27 INFO - 'tsvgr_opacity', 04:29:27 INFO - 'tart', 04:29:27 INFO - 'tscrollx', 04:29:27 INFO - 'cart', 04:29:27 INFO - 'tsvg_static']}, 04:29:27 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 04:29:27 INFO - 'talos_options': ['--disable-e10s'], 04:29:27 INFO - 'tests': ['tp5o']}, 04:29:27 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 04:29:27 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 04:29:27 INFO - 'talos_options': ['--disable-e10s', 04:29:27 INFO - '--xperf_path', 04:29:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:29:27 INFO - 'tests': ['tp5n']}, 04:29:27 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 04:29:27 INFO - 'talos_options': ['--xperf_path', 04:29:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:29:27 INFO - 'tests': ['tp5n']}}, 04:29:27 INFO - 'talos.zip': {'path': '', 04:29:27 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:29:27 INFO - Running post-action listener: _resource_record_post_action 04:29:27 INFO - [mozharness: 2017-03-31 11:29:27.302838Z] Finished populate-webroot step (success) 04:29:27 INFO - [mozharness: 2017-03-31 11:29:27.302927Z] Running create-virtualenv step. 04:29:27 INFO - Running pre-action listener: _resource_record_pre_action 04:29:27 INFO - Running main action method: create_virtualenv 04:29:27 INFO - Creating virtualenv /builds/slave/test/build/venv 04:29:27 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 04:29:27 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:29:27 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:29:27 INFO - Using real prefix '/usr' 04:29:27 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:29:27 INFO - Installing distribute.............................................................................................................................................................................................done. 04:29:29 INFO - Installing pip.................done. 04:29:29 INFO - Return code: 0 04:29:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:29:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:29:30 INFO - Reading from file tmpfile_stdout 04:29:30 INFO - Output received: 04:29:30 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 04:29:30 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:29:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:29:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:29:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:29:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:29:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:29:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:29:30 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 0x162a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1722a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18c7b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c5290>, '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 0x18c5b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18c6040>, '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': '826874ccc97bd7bf541b4875000001d5-1490959737.771741-1957698411', '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 04:29:30 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 04:29:30 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 04:29:30 INFO - Using env: {'DISPLAY': ':0', 04:29:30 INFO - 'HOME': '/home/cltbld', 04:29:30 INFO - 'LANG': 'en_US.UTF-8', 04:29:30 INFO - 'LANGUAGE': 'en_US:en', 04:29:30 INFO - 'LOGNAME': 'cltbld', 04:29:30 INFO - 'MAIL': '/var/mail/cltbld', 04:29:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:29:30 INFO - 'MOZ_NO_REMOTE': '1', 04:29:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:29:30 INFO - 'NO_EM_RESTART': '1', 04:29:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:29:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:29:30 INFO - 'PWD': '/builds/slave/test', 04:29:30 INFO - 'SHELL': '/bin/bash', 04:29:30 INFO - 'SHLVL': '1', 04:29:30 INFO - 'TERM': 'linux', 04:29:30 INFO - 'TMOUT': '86400', 04:29:30 INFO - 'USER': 'cltbld', 04:29:30 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1490959737.771741-1957698411', 04:29:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:29:30 INFO - '_': '/tools/buildbot/bin/python'} 04:29:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:29:30 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 04:29:30 INFO - Cleaning up... 04:29:30 INFO - Return code: 0 04:29:30 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:29:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:29:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:29:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:29:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:29:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:29:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:29:30 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 0x162a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1722a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18c7b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c5290>, '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 0x18c5b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18c6040>, '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': '826874ccc97bd7bf541b4875000001d5-1490959737.771741-1957698411', '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 04:29:30 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 04:29:30 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 04:29:30 INFO - Using env: {'DISPLAY': ':0', 04:29:30 INFO - 'HOME': '/home/cltbld', 04:29:30 INFO - 'LANG': 'en_US.UTF-8', 04:29:30 INFO - 'LANGUAGE': 'en_US:en', 04:29:30 INFO - 'LOGNAME': 'cltbld', 04:29:30 INFO - 'MAIL': '/var/mail/cltbld', 04:29:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:29:30 INFO - 'MOZ_NO_REMOTE': '1', 04:29:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:29:30 INFO - 'NO_EM_RESTART': '1', 04:29:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:29:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:29:30 INFO - 'PWD': '/builds/slave/test', 04:29:30 INFO - 'SHELL': '/bin/bash', 04:29:30 INFO - 'SHLVL': '1', 04:29:30 INFO - 'TERM': 'linux', 04:29:30 INFO - 'TMOUT': '86400', 04:29:30 INFO - 'USER': 'cltbld', 04:29:30 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1490959737.771741-1957698411', 04:29:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:29:30 INFO - '_': '/tools/buildbot/bin/python'} 04:29:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:29:30 INFO - Downloading/unpacking psutil>=3.1.1 04:29:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:29:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:29:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:29:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:29:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:29:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:29:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:29:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:29:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:29:33 INFO - Installing collected packages: psutil 04:29:33 INFO - Running setup.py install for psutil 04:29:33 INFO - building 'psutil._psutil_linux' extension 04:29:33 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 04:29:33 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 04:29:33 INFO - building 'psutil._psutil_posix' extension 04:29:33 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 04:29:33 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 04:29:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:29:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:29:33 INFO - Successfully installed psutil 04:29:33 INFO - Cleaning up... 04:29:33 INFO - Return code: 0 04:29:33 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:29:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:29:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:29:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:29:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:29:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:29:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:29:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x162a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1722a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18c7b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c5290>, '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 0x18c5b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18c6040>, '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': '826874ccc97bd7bf541b4875000001d5-1490959737.771741-1957698411', '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 04:29:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 04:29:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 04:29:33 INFO - Using env: {'DISPLAY': ':0', 04:29:33 INFO - 'HOME': '/home/cltbld', 04:29:33 INFO - 'LANG': 'en_US.UTF-8', 04:29:33 INFO - 'LANGUAGE': 'en_US:en', 04:29:33 INFO - 'LOGNAME': 'cltbld', 04:29:33 INFO - 'MAIL': '/var/mail/cltbld', 04:29:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:29:33 INFO - 'MOZ_NO_REMOTE': '1', 04:29:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:29:33 INFO - 'NO_EM_RESTART': '1', 04:29:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:29:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:29:33 INFO - 'PWD': '/builds/slave/test', 04:29:33 INFO - 'SHELL': '/bin/bash', 04:29:33 INFO - 'SHLVL': '1', 04:29:33 INFO - 'TERM': 'linux', 04:29:33 INFO - 'TMOUT': '86400', 04:29:33 INFO - 'USER': 'cltbld', 04:29:33 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1490959737.771741-1957698411', 04:29:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:29:33 INFO - '_': '/tools/buildbot/bin/python'} 04:29:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:29:33 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:29:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:29:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:29:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:29:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:29:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:29:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:29:35 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:29:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:29:35 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:29:35 INFO - Installing collected packages: mozsystemmonitor 04:29:35 INFO - Running setup.py install for mozsystemmonitor 04:29:36 INFO - Successfully installed mozsystemmonitor 04:29:36 INFO - Cleaning up... 04:29:36 INFO - Return code: 0 04:29:36 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:29:36 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')]} 04:29:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:29:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:29:36 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')]} 04:29:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:29:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:29:36 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 0x162a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1722a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18c7b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c5290>, '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 0x18c5b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18c6040>, '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': '826874ccc97bd7bf541b4875000001d5-1490959737.771741-1957698411', '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 04:29:36 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 04:29:36 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 04:29:36 INFO - Using env: {'DISPLAY': ':0', 04:29:36 INFO - 'HOME': '/home/cltbld', 04:29:36 INFO - 'LANG': 'en_US.UTF-8', 04:29:36 INFO - 'LANGUAGE': 'en_US:en', 04:29:36 INFO - 'LOGNAME': 'cltbld', 04:29:36 INFO - 'MAIL': '/var/mail/cltbld', 04:29:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:29:36 INFO - 'MOZ_NO_REMOTE': '1', 04:29:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:29:36 INFO - 'NO_EM_RESTART': '1', 04:29:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:29:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:29:36 INFO - 'PWD': '/builds/slave/test', 04:29:36 INFO - 'SHELL': '/bin/bash', 04:29:36 INFO - 'SHLVL': '1', 04:29:36 INFO - 'TERM': 'linux', 04:29:36 INFO - 'TMOUT': '86400', 04:29:36 INFO - 'USER': 'cltbld', 04:29:36 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1490959737.771741-1957698411', 04:29:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:29:36 INFO - '_': '/tools/buildbot/bin/python'} 04:29:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:29:36 INFO - Downloading/unpacking jsonschema==2.5.1 04:29:36 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 04:29:36 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 04:29:36 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 04:29:36 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 04:29:36 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 04:29:36 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 04:29:38 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:29:38 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:29:38 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 04:29:38 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 04:29:38 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 04:29:38 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 04:29:38 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 04:29:38 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 04:29:38 INFO - Downloading functools32-3.2.3-2.tar.gz 04:29:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:29:38 INFO - warning: no files found matching '*.txt' 04:29:38 INFO - no previously-included directories found matching 'build' 04:29:38 INFO - no previously-included directories found matching 'dist' 04:29:38 INFO - no previously-included directories found matching '.git*' 04:29:38 INFO - Installing collected packages: jsonschema, functools32 04:29:38 INFO - Running setup.py install for functools32 04:29:38 INFO - warning: no files found matching '*.txt' 04:29:38 INFO - no previously-included directories found matching 'build' 04:29:38 INFO - no previously-included directories found matching 'dist' 04:29:38 INFO - no previously-included directories found matching '.git*' 04:29:38 INFO - Successfully installed jsonschema functools32 04:29:38 INFO - Cleaning up... 04:29:39 INFO - Return code: 0 04:29:39 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:29: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')]} 04:29:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:29:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:29: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')]} 04:29:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:29:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:29: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', '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 0x162a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1722a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18c7b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c5290>, '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 0x18c5b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18c6040>, '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': '826874ccc97bd7bf541b4875000001d5-1490959737.771741-1957698411', '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 04:29: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 04:29: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 functools32==3.2.3-2 04:29:39 INFO - Using env: {'DISPLAY': ':0', 04:29:39 INFO - 'HOME': '/home/cltbld', 04:29:39 INFO - 'LANG': 'en_US.UTF-8', 04:29:39 INFO - 'LANGUAGE': 'en_US:en', 04:29:39 INFO - 'LOGNAME': 'cltbld', 04:29:39 INFO - 'MAIL': '/var/mail/cltbld', 04:29:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:29:39 INFO - 'MOZ_NO_REMOTE': '1', 04:29:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:29:39 INFO - 'NO_EM_RESTART': '1', 04:29:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:29:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:29:39 INFO - 'PWD': '/builds/slave/test', 04:29:39 INFO - 'SHELL': '/bin/bash', 04:29:39 INFO - 'SHLVL': '1', 04:29:39 INFO - 'TERM': 'linux', 04:29:39 INFO - 'TMOUT': '86400', 04:29:39 INFO - 'USER': 'cltbld', 04:29:39 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1490959737.771741-1957698411', 04:29:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:29:39 INFO - '_': '/tools/buildbot/bin/python'} 04:29:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:29:39 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:29:39 INFO - Cleaning up... 04:29:39 INFO - Return code: 0 04:29:39 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:29: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')]} 04:29:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:29:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:29: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')]} 04:29:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:29:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:29: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', '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 0x162a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1722a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18c7b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c5290>, '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 0x18c5b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18c6040>, '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': '826874ccc97bd7bf541b4875000001d5-1490959737.771741-1957698411', '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 04:29: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:29: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 blobuploader==1.2.4 04:29:39 INFO - Using env: {'DISPLAY': ':0', 04:29:39 INFO - 'HOME': '/home/cltbld', 04:29:39 INFO - 'LANG': 'en_US.UTF-8', 04:29:39 INFO - 'LANGUAGE': 'en_US:en', 04:29:39 INFO - 'LOGNAME': 'cltbld', 04:29:39 INFO - 'MAIL': '/var/mail/cltbld', 04:29:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:29:39 INFO - 'MOZ_NO_REMOTE': '1', 04:29:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:29:39 INFO - 'NO_EM_RESTART': '1', 04:29:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:29:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:29:39 INFO - 'PWD': '/builds/slave/test', 04:29:39 INFO - 'SHELL': '/bin/bash', 04:29:39 INFO - 'SHLVL': '1', 04:29:39 INFO - 'TERM': 'linux', 04:29:39 INFO - 'TMOUT': '86400', 04:29:39 INFO - 'USER': 'cltbld', 04:29:39 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1490959737.771741-1957698411', 04:29:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:29:39 INFO - '_': '/tools/buildbot/bin/python'} 04:29:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:29:39 INFO - Downloading/unpacking blobuploader==1.2.4 04:29: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 04:29: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 04:29: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 04:29: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 04:29: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 04:29: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 04:29:41 INFO - Downloading blobuploader-1.2.4.tar.gz 04:29:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:29:41 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:29:41 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 04:29:41 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 04:29:41 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 04:29:41 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 04:29:41 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 04:29:41 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 04:29:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:29:41 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:29:41 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 04:29:41 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 04:29:41 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 04:29:41 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 04:29:41 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 04:29:41 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 04:29:42 INFO - Downloading docopt-0.6.1.tar.gz 04:29:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:29:42 INFO - Installing collected packages: blobuploader, requests, docopt 04:29:42 INFO - Running setup.py install for blobuploader 04:29:42 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:29:42 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:29:42 INFO - Running setup.py install for requests 04:29:42 INFO - Running setup.py install for docopt 04:29:42 INFO - Successfully installed blobuploader requests docopt 04:29:42 INFO - Cleaning up... 04:29:42 INFO - Return code: 0 04:29:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:29: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')]} 04:29:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:29:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:29: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')]} 04:29:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:29:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:29:42 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 0x162a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1722a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18c7b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c5290>, '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 0x18c5b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18c6040>, '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': '826874ccc97bd7bf541b4875000001d5-1490959737.771741-1957698411', '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 04:29:42 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 04:29:42 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 04:29:42 INFO - Using env: {'DISPLAY': ':0', 04:29:42 INFO - 'HOME': '/home/cltbld', 04:29:42 INFO - 'LANG': 'en_US.UTF-8', 04:29:42 INFO - 'LANGUAGE': 'en_US:en', 04:29:42 INFO - 'LOGNAME': 'cltbld', 04:29:42 INFO - 'MAIL': '/var/mail/cltbld', 04:29:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:29:42 INFO - 'MOZ_NO_REMOTE': '1', 04:29:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:29:42 INFO - 'NO_EM_RESTART': '1', 04:29:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:29:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:29:42 INFO - 'PWD': '/builds/slave/test', 04:29:42 INFO - 'SHELL': '/bin/bash', 04:29:42 INFO - 'SHLVL': '1', 04:29:42 INFO - 'TERM': 'linux', 04:29:42 INFO - 'TMOUT': '86400', 04:29:42 INFO - 'USER': 'cltbld', 04:29:42 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1490959737.771741-1957698411', 04:29:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:29:42 INFO - '_': '/tools/buildbot/bin/python'} 04:29:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:29:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:29:43 INFO - Running setup.py (path:/tmp/pip-HD1_rV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:29:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:29:43 INFO - Running setup.py (path:/tmp/pip-CbcF78-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:29:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:29:43 INFO - Running setup.py (path:/tmp/pip-pjlHiJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:29:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:29:43 INFO - Running setup.py (path:/tmp/pip-WDsLtG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:29:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:29:43 INFO - Running setup.py (path:/tmp/pip-fJ3A09-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:29:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:29:43 INFO - Running setup.py (path:/tmp/pip-6tihCq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:29:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:29:43 INFO - Running setup.py (path:/tmp/pip-y3NpmE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:29:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:29:43 INFO - Running setup.py (path:/tmp/pip-zO8eIY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:29:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:29:43 INFO - Running setup.py (path:/tmp/pip-Odjj2d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:29:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:29:43 INFO - Running setup.py (path:/tmp/pip-pOz17Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:29:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:29:43 INFO - Running setup.py (path:/tmp/pip-4fqI_o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:29:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:29:43 INFO - Running setup.py (path:/tmp/pip-E5lLbS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:29:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:29:43 INFO - Running setup.py (path:/tmp/pip-u66CiH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:29:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:29:44 INFO - Running setup.py (path:/tmp/pip-cEOXYD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:29:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:29:44 INFO - Running setup.py (path:/tmp/pip-cG_I9R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:29:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:29:44 INFO - Running setup.py (path:/tmp/pip-U5s7X3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:29:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:29:44 INFO - Running setup.py (path:/tmp/pip-fWXZLl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:29:44 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:29:44 INFO - Running setup.py install for manifestparser 04:29:44 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:29:44 INFO - Running setup.py install for mozcrash 04:29:44 INFO - Running setup.py install for mozdebug 04:29:44 INFO - Running setup.py install for mozdevice 04:29:44 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:29:44 INFO - Running setup.py install for mozfile 04:29:44 INFO - Running setup.py install for mozhttpd 04:29:44 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:29:44 INFO - Running setup.py install for mozinfo 04:29:45 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:29:45 INFO - Running setup.py install for mozInstall 04:29:45 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:29:45 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:29:45 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:29:45 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:29:45 INFO - Running setup.py install for mozleak 04:29:45 INFO - Running setup.py install for mozlog 04:29:45 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:29:45 INFO - Running setup.py install for moznetwork 04:29:45 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:29:45 INFO - Running setup.py install for mozprocess 04:29:45 INFO - Running setup.py install for mozprofile 04:29:45 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:29:45 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:29:45 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:29:45 INFO - Running setup.py install for mozrunner 04:29:45 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:29:45 INFO - Running setup.py install for mozscreenshot 04:29:45 INFO - Running setup.py install for moztest 04:29:46 INFO - Running setup.py install for mozversion 04:29:46 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:29:46 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:29:46 INFO - Cleaning up... 04:29:46 INFO - Return code: 0 04:29:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:29:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:29:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:29:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:29:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:29:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:29:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:29:46 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 0x162a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1722a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18c7b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c5290>, '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 0x18c5b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18c6040>, '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': '826874ccc97bd7bf541b4875000001d5-1490959737.771741-1957698411', '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 04:29:46 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 04:29:46 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 04:29:46 INFO - Using env: {'DISPLAY': ':0', 04:29:46 INFO - 'HOME': '/home/cltbld', 04:29:46 INFO - 'LANG': 'en_US.UTF-8', 04:29:46 INFO - 'LANGUAGE': 'en_US:en', 04:29:46 INFO - 'LOGNAME': 'cltbld', 04:29:46 INFO - 'MAIL': '/var/mail/cltbld', 04:29:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:29:46 INFO - 'MOZ_NO_REMOTE': '1', 04:29:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:29:46 INFO - 'NO_EM_RESTART': '1', 04:29:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:29:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:29:46 INFO - 'PWD': '/builds/slave/test', 04:29:46 INFO - 'SHELL': '/bin/bash', 04:29:46 INFO - 'SHLVL': '1', 04:29:46 INFO - 'TERM': 'linux', 04:29:46 INFO - 'TMOUT': '86400', 04:29:46 INFO - 'USER': 'cltbld', 04:29:46 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1490959737.771741-1957698411', 04:29:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:29:46 INFO - '_': '/tools/buildbot/bin/python'} 04:29:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:29:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:29:46 INFO - Running setup.py (path:/tmp/pip-8WiFjy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:29:46 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)) 04:29:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:29:46 INFO - Running setup.py (path:/tmp/pip-d0HQLE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:29:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 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)) 04:29:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:29:46 INFO - Running setup.py (path:/tmp/pip-sVL1zv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:29:46 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)) 04:29:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:29:46 INFO - Running setup.py (path:/tmp/pip-v_SZBP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:29:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 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)) 04:29:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:29:46 INFO - Running setup.py (path:/tmp/pip-oGBKrp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:29:46 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)) 04:29:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:29:46 INFO - Running setup.py (path:/tmp/pip-6r8uei-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:29:46 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)) 04:29:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:29:46 INFO - Running setup.py (path:/tmp/pip-UBpdTc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:29:46 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)) 04:29:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:29:46 INFO - Running setup.py (path:/tmp/pip-ZzC0Tw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:29:46 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)) 04:29:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:29:46 INFO - Running setup.py (path:/tmp/pip-j33WSe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:29:47 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)) 04:29:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:29:47 INFO - Running setup.py (path:/tmp/pip-bQfXOj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:29:47 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)) 04:29:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:29:47 INFO - Running setup.py (path:/tmp/pip-oG1uqz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:29:47 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)) 04:29:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:29:47 INFO - Running setup.py (path:/tmp/pip-Ka3tDp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:29:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 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)) 04:29:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:29:47 INFO - Running setup.py (path:/tmp/pip-EuabFy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:29:47 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)) 04:29:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:29:47 INFO - Running setup.py (path:/tmp/pip-tcv3yW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:29:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 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)) 04:29:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:29:47 INFO - Running setup.py (path:/tmp/pip-Mno4__-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:29:47 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)) 04:29:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:29:47 INFO - Running setup.py (path:/tmp/pip-ojvn1I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:29:47 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 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)) 04:29:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:29:47 INFO - Running setup.py (path:/tmp/pip-Lea7pG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:29:47 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)) 04:29:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:29:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:29:47 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)) 04:29:47 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:29:47 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:29:47 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:29: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 04:29: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 04:29: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 04:29: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 04:29: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 04:29: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 04:29:49 INFO - Downloading blessings-1.6.tar.gz 04:29:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:29:49 INFO - Installing collected packages: blessings 04:29:49 INFO - Running setup.py install for blessings 04:29:49 INFO - Successfully installed blessings 04:29:49 INFO - Cleaning up... 04:29:49 INFO - Return code: 0 04:29:49 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:29:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:29:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:29:50 INFO - Reading from file tmpfile_stdout 04:29:50 INFO - Current package versions: 04:29:50 INFO - argparse == 1.2.1 04:29:50 INFO - blessings == 1.6 04:29:50 INFO - blobuploader == 1.2.4 04:29:50 INFO - docopt == 0.6.1 04:29:50 INFO - functools32 == 3.2.3-2 04:29:50 INFO - jsonschema == 2.5.1 04:29:50 INFO - manifestparser == 1.1 04:29:50 INFO - mozInstall == 1.12 04:29:50 INFO - mozcrash == 1.0 04:29:50 INFO - mozdebug == 0.1 04:29:50 INFO - mozdevice == 0.49 04:29:50 INFO - mozfile == 1.2 04:29:50 INFO - mozhttpd == 0.7 04:29:50 INFO - mozinfo == 0.9 04:29:50 INFO - mozleak == 0.1 04:29:50 INFO - mozlog == 3.4 04:29:50 INFO - moznetwork == 0.27 04:29:50 INFO - mozprocess == 0.25 04:29:50 INFO - mozprofile == 0.28 04:29:50 INFO - mozrunner == 6.13 04:29:50 INFO - mozscreenshot == 0.1 04:29:50 INFO - mozsystemmonitor == 0.3 04:29:50 INFO - moztest == 0.8 04:29:50 INFO - mozversion == 1.4 04:29:50 INFO - psutil == 3.1.1 04:29:50 INFO - requests == 1.2.3 04:29:50 INFO - wsgiref == 0.1.2 04:29:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:29: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')]} 04:29:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:29:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:29: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')]} 04:29:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:29:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:29:50 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 0x162a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1722a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18c7b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c5290>, '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 0x18c5b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18c6040>, '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': '826874ccc97bd7bf541b4875000001d5-1490959737.771741-1957698411', '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 04:29:50 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 04:29:50 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 04:29:50 INFO - Using env: {'DISPLAY': ':0', 04:29:50 INFO - 'HOME': '/home/cltbld', 04:29:50 INFO - 'LANG': 'en_US.UTF-8', 04:29:50 INFO - 'LANGUAGE': 'en_US:en', 04:29:50 INFO - 'LOGNAME': 'cltbld', 04:29:50 INFO - 'MAIL': '/var/mail/cltbld', 04:29:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:29:50 INFO - 'MOZ_NO_REMOTE': '1', 04:29:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:29:50 INFO - 'NO_EM_RESTART': '1', 04:29:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:29:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:29:50 INFO - 'PWD': '/builds/slave/test', 04:29:50 INFO - 'SHELL': '/bin/bash', 04:29:50 INFO - 'SHLVL': '1', 04:29:50 INFO - 'TERM': 'linux', 04:29:50 INFO - 'TMOUT': '86400', 04:29:50 INFO - 'USER': 'cltbld', 04:29:50 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1490959737.771741-1957698411', 04:29:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:29:50 INFO - '_': '/tools/buildbot/bin/python'} 04:29:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:29:50 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)) 04:29:50 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)) 04:29:50 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)) 04:29:50 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)) 04:29:50 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)) 04:29:50 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)) 04:29:50 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)) 04:29:50 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)) 04:29:50 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)) 04:29:50 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)) 04:29:50 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)) 04:29:50 INFO - Cleaning up... 04:29:50 INFO - Return code: 0 04:29:50 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:29: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')]} 04:29:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:29:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:29: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')]} 04:29:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:29:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:29:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x162a1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1722a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18c7b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18c5290>, '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 0x18c5b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18c6040>, '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': '826874ccc97bd7bf541b4875000001d5-1490959737.771741-1957698411', '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 04:29:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:29:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:29:50 INFO - Using env: {'DISPLAY': ':0', 04:29:50 INFO - 'HOME': '/home/cltbld', 04:29:50 INFO - 'LANG': 'en_US.UTF-8', 04:29:50 INFO - 'LANGUAGE': 'en_US:en', 04:29:50 INFO - 'LOGNAME': 'cltbld', 04:29:50 INFO - 'MAIL': '/var/mail/cltbld', 04:29:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:29:50 INFO - 'MOZ_NO_REMOTE': '1', 04:29:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:29:50 INFO - 'NO_EM_RESTART': '1', 04:29:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:29:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:29:50 INFO - 'PWD': '/builds/slave/test', 04:29:50 INFO - 'SHELL': '/bin/bash', 04:29:50 INFO - 'SHLVL': '1', 04:29:50 INFO - 'TERM': 'linux', 04:29:50 INFO - 'TMOUT': '86400', 04:29:50 INFO - 'USER': 'cltbld', 04:29:50 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1490959737.771741-1957698411', 04:29:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:29:50 INFO - '_': '/tools/buildbot/bin/python'} 04:29:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:29:50 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:29:50 INFO - Cleaning up... 04:29:50 INFO - Return code: 0 04:29:50 INFO - Running post-action listener: _resource_record_post_action 04:29:50 INFO - Running post-action listener: _start_resource_monitoring 04:29:50 INFO - Starting resource monitoring. 04:29:50 INFO - [mozharness: 2017-03-31 11:29:50.584882Z] Finished create-virtualenv step (success) 04:29:50 INFO - [mozharness: 2017-03-31 11:29:50.585390Z] Running install step. 04:29:50 INFO - Running pre-action listener: _resource_record_pre_action 04:29:50 INFO - Running main action method: install 04:29:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:29:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:29:50 INFO - Reading from file tmpfile_stdout 04:29:50 INFO - Detecting whether we're running mozinstall >=1.0... 04:29:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:29:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:29:50 INFO - Reading from file tmpfile_stdout 04:29:50 INFO - Output received: 04:29:50 INFO - Usage: mozinstall [options] installer 04:29:50 INFO - Options: 04:29:50 INFO - -h, --help show this help message and exit 04:29:50 INFO - -d DEST, --destination=DEST 04:29:50 INFO - Directory to install application into. [default: 04:29:50 INFO - "/builds/slave/test"] 04:29:50 INFO - --app=APP Application being installed. [default: firefox] 04:29:50 INFO - mkdir: /builds/slave/test/build/application 04:29:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 04:29:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 04:30:06 INFO - Reading from file tmpfile_stdout 04:30:06 INFO - Output received: 04:30:06 INFO - /builds/slave/test/build/application/firefox/firefox 04:30:06 INFO - Running post-action listener: _resource_record_post_action 04:30:06 INFO - [mozharness: 2017-03-31 11:30:06.544346Z] Finished install step (success) 04:30:06 INFO - [mozharness: 2017-03-31 11:30:06.544621Z] Running run-tests step. 04:30:06 INFO - Running pre-action listener: _resource_record_pre_action 04:30:06 INFO - Running main action method: run_tests 04:30:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:30:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:30:06 INFO - Python 2.7.3 04:30:06 INFO - Return code: 0 04:30:06 INFO - grabbing minidump binary from tooltool 04:30:06 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')]} 04:30:06 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 0x18c5290>, '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 0x18c5b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18c6040>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:30:06 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 04:30:06 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 04:30:06 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 04:30:06 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:30:06 INFO - Return code: 0 04:30:06 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:30:06 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:30:06 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:30:06 INFO - ENV: RUST_BACKTRACE is now 1 04:30:06 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:30:06 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:30:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FziPe46tTL-TfFHS0Z7sXw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-052', '--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 04:30:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/FziPe46tTL-TfFHS0Z7sXw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-052 --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 04:30:06 INFO - Using env: {'DISPLAY': ':0', 04:30:06 INFO - 'HOME': '/home/cltbld', 04:30:06 INFO - 'LANG': 'en_US.UTF-8', 04:30:06 INFO - 'LANGUAGE': 'en_US:en', 04:30:06 INFO - 'LOGNAME': 'cltbld', 04:30:06 INFO - 'MAIL': '/var/mail/cltbld', 04:30:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:30:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:30:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:30:06 INFO - 'MOZ_NO_REMOTE': '1', 04:30:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:30:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:30:06 INFO - 'NO_EM_RESTART': '1', 04:30:06 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:30:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:30:06 INFO - 'PWD': '/builds/slave/test', 04:30:06 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:30:06 INFO - 'RUST_BACKTRACE': '1', 04:30:06 INFO - 'SHELL': '/bin/bash', 04:30:06 INFO - 'SHLVL': '1', 04:30:06 INFO - 'TERM': 'linux', 04:30:06 INFO - 'TMOUT': '86400', 04:30:06 INFO - 'USER': 'cltbld', 04:30:06 INFO - 'XDG_SESSION_COOKIE': '826874ccc97bd7bf541b4875000001d5-1490959737.771741-1957698411', 04:30:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:30:06 INFO - '_': '/tools/buildbot/bin/python'} 04:30:06 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FziPe46tTL-TfFHS0Z7sXw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-052', '--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 04:30:06 INFO - mozversion application_buildid: 20170330114804 04:30:06 INFO - mozversion application_changeset: 03d602fd723ad6ff4588c04855884ffa1dee9410 04:30:06 INFO - mozversion application_display_name: Nightly 04:30:06 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:30:06 INFO - mozversion application_name: Firefox 04:30:06 INFO - mozversion application_remotingname: firefox 04:30:06 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:30:06 INFO - mozversion application_vendor: Mozilla 04:30:06 INFO - mozversion application_version: 55.0a1 04:30:06 INFO - mozversion platform_buildid: 20170330114804 04:30:06 INFO - mozversion platform_changeset: 03d602fd723ad6ff4588c04855884ffa1dee9410 04:30:06 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:30:06 INFO - mozversion platform_version: 55.0a1 04:30:06 INFO - using testdate: 1490959806 04:30:06 INFO - actual date: 1490959806 04:30:06 INFO - starting webserver on 'localhost:55070' 04:30:06 INFO - SUITE-START | Running 2 tests 04:30:06 INFO - TEST-START | dromaeo_css 04:30:06 INFO - operating with platform_type : linux_ 04:30:06 INFO - Initialising browser for dromaeo_css test... 04:30:06 INFO - TEST-INFO | started process 31921 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQ4I_nP/profile http://localhost:55070/getInfo.html) 04:30:10 INFO - PID 31921 | __metrics Screen width/height:1600/1200 04:30:10 INFO - PID 31921 | colorDepth:24 04:30:10 INFO - PID 31921 | Browser inner width/height: 1024/697 04:30:10 INFO - PID 31921 | __metrics 04:30:11 ERROR - PID 31921 | 1490959811808 addons.xpi WARN Exception running bootstrap method shutdown on shield-recipe-client@mozilla.org: TypeError: log is null (resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:96:5) JS Stack trace: this.shutdown@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@bootstrap.js:96:5 < callBootstrapMethod@XPIProvider.jsm:4957:11 < observe@XPIProvider.jsm:2924:15 < permitUnload@remote-browser.xml:357:13 < CanCloseWindow@browser.js:6382:36 < canClose@browser.js:5233:12 < forceQuit@jar:file:///tmp/tmpQ4I_nP/profile/extensions/talos-powers@TalosPowersService.js:237:7 < whenDone@jar:file:///tmp/tmpQ4I_nP/profile/extensions/talos-powers@TalosPowersService.js:222:9 < promise callback*forceQuit@jar:file:///tmp/tmpQ4I_nP/profile/extensions/talos-powers@TalosPowersService.js:224:7 < receiveMessage@jar:file:///tmp/tmpQ4I_nP/profile/extensions/talos-powers@TalosPowersService.js:55:9 04:30:11 ERROR - PID 31921 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3396: TypeError: this.tabs is undefined 04:30:12 INFO - TEST-INFO | 31921: exit 0 04:30:12 INFO - Browser initialized. 04:30:12 INFO - Running cycle 1/1 for dromaeo_css test... 04:30:12 INFO - TEST-INFO | started process 32053 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQ4I_nP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:30:25 INFO - PID 32053 | RSS: Main: 155725824 04:30:25 INFO - PID 32053 | 04:33:29 INFO - PID 32053 | Cycle 1(1): loaded http://localhost:55070/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55070/tests/dromaeo/cssquery-ext.html) 04:33:31 INFO - PID 32053 | RSS: Main: 165621760 04:33:31 INFO - PID 32053 | 04:35:13 INFO - PID 32053 | ************************* 04:35:13 INFO - PID 32053 | A coding exception was thrown and uncaught in a Task. 04:35:13 INFO - PID 32053 | 04:35:13 ERROR - PID 32053 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:35:13 INFO - PID 32053 | Full stack: 04:35:13 INFO - PID 32053 | ************************* 04:35:13 INFO - PID 32053 | ************************* 04:35:13 INFO - PID 32053 | A coding exception was thrown and uncaught in a Task. 04:35:13 INFO - PID 32053 | 04:35:13 ERROR - PID 32053 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:35:13 INFO - PID 32053 | Full stack: 04:35:13 INFO - PID 32053 | ************************* 04:35:13 INFO - PID 32053 | ************************* 04:35:13 INFO - PID 32053 | A coding exception was thrown and uncaught in a Task. 04:35:13 INFO - PID 32053 | 04:35:13 ERROR - PID 32053 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:35:13 INFO - PID 32053 | Full stack: 04:35:13 INFO - PID 32053 | ************************* 04:35:13 INFO - PID 32053 | ************************* 04:35:13 INFO - PID 32053 | A coding exception was thrown and uncaught in a Task. 04:35:13 INFO - PID 32053 | 04:35:13 ERROR - PID 32053 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:35:13 INFO - PID 32053 | Full stack: 04:35:13 INFO - PID 32053 | ************************* 04:36:33 INFO - PID 32053 | Cycle 1(1): loaded http://localhost:55070/tests/dromaeo/cssquery-ext.html (next: http://localhost:55070/tests/dromaeo/cssquery-jquery.html) 04:36:34 INFO - PID 32053 | RSS: Main: 161505280 04:36:34 INFO - PID 32053 | 04:39:36 INFO - PID 32053 | Cycle 1(1): loaded http://localhost:55070/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55070/tests/dromaeo/cssquery-mootools.html) 04:39:36 INFO - PID 32053 | RSS: Main: 169537536 04:39:36 INFO - PID 32053 | 04:42:38 INFO - PID 32053 | Cycle 1(1): loaded http://localhost:55070/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55070/tests/dromaeo/cssquery-prototype.html) 04:42:39 INFO - PID 32053 | RSS: Main: 161054720 04:42:39 INFO - PID 32053 | 04:45:42 INFO - PID 32053 | Cycle 1(1): loaded http://localhost:55070/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55070/tests/dromaeo/cssquery-yui.html) 04:45:43 INFO - PID 32053 | RSS: Main: 169156608 04:45:43 INFO - PID 32053 | 04:48:45 INFO - PID 32053 | Cycle 1(1): loaded http://localhost:55070/tests/dromaeo/cssquery-yui.html (next: http://localhost:55070/tests/dromaeo/cssquery-dojo.html) 04:48:45 INFO - PID 32053 | RSS: Main: 161984512 04:48:45 INFO - PID 32053 | 04:48:45 INFO - PID 32053 | __start_tp_report 04:48:45 INFO - PID 32053 | _x_x_mozilla_page_load 04:48:45 INFO - PID 32053 | _x_x_mozilla_page_load_details 04:48:45 INFO - PID 32053 | |i|pagename|runs| 04:48:45 INFO - PID 32053 | |0;dojo.html;2687;2712.349036231305;2724.6457960465136;2736.315921019745;2741.684706258781;5108.182690769478;5220.738963051846;5221.660592061513;5258.44786297439;5261.131913234317;5183.740812959356;5189.040027594898;5194.974025129878;5282.5245727884485;5311.937612477501;4748.667593268473;4774.641901857357;4792.664513484057;4796.544328288807;4839.879003024935;4818.180909245437;4849.733264670442;4904.288878112671;4911.852644420673;4948.282499037656;4699.130660827758;4702.106599746037;4778.737169455679;4787.497312782142;4795.928061079087;4720.221163508017;4766.976165119152;4807.399075115611;4830.4203495580405;4848.2727590861305;4677.74272415017;4741.715497070187;4752.572268495817;4770.8330208442885;4785.808567657289;5065.645404821664;5135.101357262502;5221.112410890158;5224.895502089975;5278;5642.98426283273;5673.489385955284;5724.656520608777;5726.112452569817;5730.083186690152;5682.460166284196;5693.316801983747;5702.657840529581;5704.885902281972;5708.857278568027;5172.818951336685;5274.894502109936;5275.076861549213;5290.576753859682;5349.625526213128;5711.600187986801;5763.0202865512965;5780.768769249183;5793.159991801165;5797.826065218051;5523.199136125239;5538.6399884007415;5541.33503979517;5607.523360514402;5632.211490391349;5609.915851262234;5676.091825307931;5682.147677848273;5693.629914055573;5696.430356964271;5634.859128521738;5644.153376993484;5647.915281270784;5650.519705825051;5665.688387138664;5432.483914028161;5542.501174894279;5560.638558493766;5627.831165065055;5668.376478587352;4758;4764.595009424238;4765.070811191785;4769.189237829577;4826.396700412449;4080.489938757655;4082.4284600156;4085.428040074392;4110.260153172398;4122.2579935611275;4734.621230301567;4805.807767689324;4807.807687692523;4833.4441539222735;4842.5157484251295;5666.490015898589;5679.062954612526;5698.287714035746;5731.656100633975;5747.482726554546;4829.903401932012;4878.121938051114;4880;4885.902281954341;4931.0630980113665;5076.593872490192;5093.981203759189;5097.1844504879045;5102.974485127551;5107.055194788902;5192.169252919514;5263.23683065961;5267.209918512254;5276.577873770166;5277.076511610529;5567.777288908398;5617.662940223599;5625.521830644441;5628.662280263197;5630.465105814941;5227.398849132398;5228.058949389147;5296.814611488733;5311.973440132774;5313.893722125458;5558.221848941071;5584.0227960106;5602.971985140048;5608.439156084359;5609.691466969356;5530.668159910419;5677.829665110054;5683.374828768915;5685.374608793112;5736.196932429547;5462.317210348707;5492.5331346835965;5535.529479994246;5558.555315574825;5563;5490.3411590609385;5517.44825517445;5523.613347065667;5526.032944234823;5533.695646739468;5241.816536421207;5324.547413469899;5422.783088676409;5464.836054918359;5506.944930550803;5468.0977638690765;5477.75350109238;5481.862953426196;5486.067368547277;5496.065668836228;5318.095923692904;5322.414534401135;5329.067413202752;5329.706866122246;5331.760070796746 04:48:45 INFO - PID 32053 | |1;ext.html;606.2391698418484;663.1180529895239;684.0867441964976;1195.3186683590357;1217.3669691760279;36615.81692091539;37886;37899.24201515968;37936.24127517448;37939.81030094853;35329.47005794909;35666.46500302491;35708.82145589275;35742.82128589354;35750.463743043874;6930.653467326639;7105.040819489381;7153.284671532831;7341.339279464847;7371;7484.962575187116;7546.434017448713;7566.394688424913;7589.962050189742;7591.164971853092;7502.249775022508;7550.7734767957045;7564.773056808304;7604.125525564548;7614.08630964285;7522.172561018284;7547.773566793005;7562.659680314399;7587.468877178628;7599.088109426849;7428.665710043061;7499.062617172854;7500.549967001943;7508.699652013967;7513.361364284043;33650.326993459996;33779.32441351184;33888;33958.660413395795;33988.49017264743;2608.47830433914;2652.6949400818958;2655.6282120503147;2655.9601605975927;2708.5801700736415;24084.759152408427;24270.514589708284;24329.513409731884;24634;24933.252002439956;2412.457197130649;2454.840435371695;2473.6784218051716;2474.2453551666736;2485.465624890639;145478;146010;146387;146429;146626.26686866605;41374.58625413768;41403.41053957677;41428.79285603553;41466.378004329956;41466.792666036476;43598.34602480965;43853.78073109614;43872.3419148713;43901.78049109734;43938;12797.872021279669;13045.152065115737;13118.606441806762;13151.473941042252;13212.801807972888;10500.73748156287;10513.421761803022;10527.315724477885;10540.367577945348;10543.789124217472;12948.417321220568;13012.154209976321;13056.151350162208;13223.867761322455;13229.536966206137;5579.4420557944695;5667.533216357334;5714.285714285715;5716.02736098416;5737.3688894221605;836.2306677856386;850.9702160424356;865.1348651348651;871.4771137317558;888.2146884761546;20497.692534611993;21224.893875530834;21306.467338316357;21338.893305533373;21638.783612163676;943.2831048403262;953.8998405167496;954.9952250238844;961.5384615384514;984.1978787288338;10993.890061099446;11043.895610439053;11047.226694131334;11105.278156919774;11137.443127843575;238355;239883;240288;240472.73854398815;241480;43387;43591.56408435875;43736.75158980943;43767.56232437699;43825;1203.5907791350983;1220.8473940757406;1241.1436109084702;1244.2161438293817;1245.8318127052912;23122.190723324602;23200.18799342015;23976.760232397453;24228.63657045181;24383;28285;28332.575011374433;28334.43331133407;28340.85829570839;28348;176063;176633;176761;177319;177776;26316.342091447867;26821.597676034486;26986;27099.86450067737;27115.457690845677;32165.35669286648;32486.67513324931;32764.836175818968;32789.18027049343;32937.67062329346;24703.87648061748;25347.179153869845;26298.474030519665;26968.595471068344;27524.44951101007;26987.730122698522;27294.590581140903;27635.170944871687;28442.71557284401;28601.570976435785;29691.257718556346;30364.544531832482;30435.847820760755;30828.22929426782;31259.53110703296;26722.331941701614;26900.596491053042;27345.316367090185;27397.17808465749;27998;19931.402057938285;21273.6808947869;21350.35948921535;21367.78632213658;21430.464238393542 04:48:45 INFO - PID 32053 | |2;jquery.html;410.57505481826314;414.8402864897014;418.8136279355686;437.73735758544876;443.0275545178335;18231.817681823177;18720.90639546802;19007.61984760304;19068.42794716159;19508.804911950876;16932.576685582866;17409.91295043526;17456.650866982654;18143.364982225623;18439.907800461013;4194;5727.742251598667;5903.439173278553;5933.258342707161;5956.047032474805;5699.772009119631;5757.050086735683;5790.189373487715;5798.9130163047585;5802.709864506779;5525.696086715229;5769.16347129666;5783.363829978699;5785.595008349417;5796.652200867961;5576.972115139399;5724;5795.362510123925;5800.506956908668;5805.825825225229;5243.056249875021;5278.630495865291;5279.894402111975;5280.102382594968;5286.709230992294;22496;22745.431364215863;22850.542989140125;23354.7664523356;23513.17703880373;1508.4644951042442;1514.295852428626;1534.9309281082378;1572.2217502336416;1585.7938467999086;13201.20792752438;13878.375473103735;14129.646758831008;14495.71008579833;14569.417223311055;1601.2794242590764;1604.2460043779406;1612.6694027724288;1625.244261418446;1641.720907445737;91350;92750.7557021161;94040.52979735058;96200.51899740526;96997;10792.977966169485;11125.888741112485;11334.829977550344;11369;11413.60052398162;15459;15590.532284031497;15594.986325888782;15641.843581564266;15645.217739113226;7509.62451877404;7742.61286935651;7763.767086987399;7870.4884182529095;7976.960115199387;7080.893786593205;7192.3886469649615;7367.373773229228;7374.741884034033;7379.483436159418;6808.2170550386345;6916.377526022682;7040.6479676016;7076.363127318566;7117.145942486831;2044.1516770540356;2044.427560283123;2099.3072286145534;2118.978810211909;2183.094015983349;836.2599099796602;844.1853611265036;861.8362511122866;867.8481265778463;881.457903389411;15444.227788610524;16325.67348653044;16341.428050018192;16435.26041328143;16492.17539123039;865.4720620421538;883.5008220355479;885.0706757904303;886.7650072730731;894.6779159502574;8576.785580360542;8716.346274029347;9057.230135438562;9190.310726695525;9194.862077068849;435714;443672;478502;480265;480513;87063.56468217746;89119.55440222757;90139.54930225307;91482.54258728663;92874.53562732278;1054.8154073037342;1062.697131317571;1071.1751950997689;1078.8381742738495;1084.6095405653957;13628.52300169529;13705.862941370458;13755.31223438804;13884.58346249614;14335.139891606537;40950;41679;41996;42287.15425691407;44703.10593788171;51436.74281628568;52711;52987.470125298256;53387.19919201137;54630.72684636551;8181.222783835526;8208.548529830916;8327.50034997902;8428.704995325133;8556.57217139128;13030.47878084866;13043;13387.732245354844;13409.128406653535;13445.394957226752;11004.724881877697;11105.16711246676;11362.157598032933;11454.659886712261;11600.88399115998;10879.510422031186;10985;11018.850652484265;11296.943515282699;11382.430878455878;11020.393878336448;11375.772484550098;11462.598809041978;11643.41782910834;11823.586174483851;8284.71003514874;8337.666493340199;8439.282660973886;8457.57712114404;8707.129287071242;11242.494087766234;11703.707407314545;11868.991135753558;11886.940565297118;11911.76176476483 04:48:45 INFO - PID 32053 | |3;mootools.html;1255.4036832504562;1312.1667740984483;1316.756400065988;1322.2397121655051;1346.0106821486206;9547.14075733184;9902.35634683745;9944.303898727092;9959;10210.489475526212;9889.505524723752;9964.302498825085;10055.346402483834;10055.949720251407;10073.54669039893;2202.4383782135574;2230.4981379189717;2237.9552408951813;2250.718660167479;2254.4025833154146;2103.359379683849;2195.5169862630196;2201.933941981743;2204.5921504521716;2213.1258153029544;2121.2605663356053;2201.2075652764993;2201.3836125884777;2205.2171479124922;2209.215728416413;2168.609650262952;2174.4346469917778;2175.8476906616543;2177.2923799765063;2188.1466228171025;1832.2213059449814;1913.1104036622899;2116.121809449077;2131.7015617813363;2164.545445456456;9935.90064099357;10019.89980100197;10021.39871607706;10026.749331266703;10028.348157369748;5364.946350536484;5527.778888844482;5563.304586926634;5569.053260945649;5574.885022995377;3414.402479566066;3425.1265927188406;3481.0253129123885;3484.1463841358777;3501.8074005929666;1059.1632610237903;1068.0707784227693;1080.1952545353683;1105.3147048829696;1119.6473110970019;13595.524156654568;13674.658133546642;13705.45178192871;13711.9999999999;13760.449582016707;4540.886477838015;4698.671093023524;4788.497207793202;4817.470078291385;4846.684965477232;10747.731306717395;10749.570017199225;10759.30064545802;10774.676759697064;10790.784184316426;5442.782288708408;5480.095784195642;5482.396936337;5489.066858634042;5491.807786727445;4762.571368576845;4888.780004899788;4913.238448040488;4945.653804233741;5023.924641130386;3742.8877133686033;3822.503074600284;3923.058465968204;3935.0949281664803;4026.516817981861;1168.2523185161504;1169.0997931592626;1183.3077649575096;1190.6249531397582;1192.070185255502;676.7732809508869;689.6655122265797;701.4038067642565;701.9684114214873;723.8588475247382;5264.710440925709;5285.233641122093;5307.044731948286;5984.640921544721;6019.127226552126;822.5393779483509;830.7134038756619;843.8059246373246;850.2220468271586;865.4893612768496;3580.3197392495345;3626.8730594429067;3650.233450975272;3657.908552286161;3832.329342365075;12283.14018018748;12635;12713.364331783374;12827.166234194934;12900.612981610566;12505.812412813815;12701.682457938625;12720.491180352683;12724.745505089846;12751.107422480338;9147.176754092163;9428.198603118812;9431.434113953048;9446.338756286994;9469.810603787886;5560.443955604569;5592.832215033555;5617.88764224705;5685.260916080883;5777.277840269966;11417.60038398652;11562.653120406401;11618.70953226176;11680.415979200836;11688.47401866901;11097.500612472297;11319.547218111184;11362.715932101764;11395.145364097893;11470.885291146982;8012.198780122174;8085.029796424232;8268.627911744106;8274.710385136492;8279.793005174919;9092.045335239969;9093.909060909305;9104.817903642022;9167.08329167078;9182.724518264462;7184.856302873809;7287.161976372573;7378.778636640909;7417.851642967218;7538.811529711801;7197.928020719726;7304.707811687473;7339.816504587428;7549.0941087069905;7562.508436951581;6704.6982885769285;6752.257251702407;6836.111305530249;6841.828954276183;6852.725890964306;4951.925721114114;5103.87240318995;5208.9739551302;5282.524572788314;5342.11855043929;4273.594008569181;5030.723310217973;5060.089183946925;5148.43367229597;5188.377394712658 04:48:45 INFO - PID 32053 | |4;prototype.html;386.8665310467889;389.61622801540483;391.4558763318989;399.3849471813406;400.4493820996131;5559.972200138999;5577.330720313558;5580.414056524068;5588.245586845775;5622.7188640567965;5281.2342210379475;5403.891922161554;5438.129899216126;5472.753726082326;5482.780688772445;4369.847055353063;4380.89047773805;4381.145676593065;4388.780560971954;4399.714018588797;4373.278409062501;4392.12157568486;4401.449818772653;4412.404325416076;4416.183006143858;4031.5766844481345;4199.517055538607;4382.737035777847;4399.890002749925;4405.691601587874;4175.144095460423;4183.100633363842;4200.096979149497;4201.222773786844;4203.5165955915;3650.817459127033;3653.5615726113037;3669.486271921933;3670.6145854685406;3675.9632403675887;5275.155975044013;5439.700816455093;5448.673079615196;5449.209864569655;5451.945480545183;4797.736124513151;4798.256270278112;4798.328234047236;4824.228123500223;4830.7101573905675;5738.167965644958;5764.798232061899;5769.163471296639;5771.653700777967;5774.82675519735;3918.804059796999;3993.940090898639;3995.081131339808;3996.1807829395193;4021.055052062763;5987.790427335066;6123.448889599913;6153.569250152491;6165.996051283396;6182.381761823826;4080.449139366207;4110.527289361702;4120.649744771668;4127.587241275848;4142;4108.876733697994;4161.334186530141;4164.063085805669;4168.2080404723;4173.582641735802;4573.908521829545;4816.325714399987;4822.758862056883;4838.250071238964;4863.7324947128245;5781.306243250753;5783.306003279633;5801.680907550125;5812.447817457335;5816.243888294494;1449.8260208775014;1454.8036015138032;1467.7211329847296;1471.6909449015614;1473.2265560580781;939.8606887079342;974.2692980264801;994.6618149829093;995.5719040812376;997.9002099790108;5112.6421150519855;5112.948870511322;5116.923246151311;5120.1039818031695;5133.25567792668;6013.639181649115;6073.939260607426;6075.969620151871;6082.817515474543;6084.939150608526;4913.63147763912;5036.974815125975;5091.363579552556;5093.541581257705;5108.361454818148;3172.5399817026864;3190.8723651053697;3209.149575362531;3215.3087086276096;3218.6781321867625;5598.076317407664;5608;5608.158776183605;5609.186667933209;5638.9699708105045;5961.672108034013;6150.477209437158;6187.3503282155625;6251.343608921089;6271.3728627136925;5625.578081643893;5631.267935168484;5644.915326270109;5663.6035477517;5673.326673326674;5826.077394459733;6048.790241951539;6087.808388980052;6115.296740874856;6123.969380153071;5954.255718035246;5993.700314984146;6002.489788368038;6011.27864656244;6016.338202797601;5355.491228333302;5476.890462190813;5498.780048798163;5636.098224284095;5642.463965923231;4106.404571337199;4114.703868281482;4116.341385378325;4118.567550407164;4121.979390103031;5950.31571369298;6072.362401947908;6073.969630151821;6075.453209211192;6107.175531303217;5814.331351894417;5865.3254875688135;5868.61853979507;5872.765089396376;5895.322037965518;5834.533237341087;5852.268466441695;5853.2976042875125;5865.970670146622;5872.677002764718;5562.666240025612;5754.108113242454;5772;5799.3040835100055;5807.970960145172;5885.529157667462;5896.528277737856;5900.144479050427;5901.439363260483;5931.851703707442;5695.401982791747;5703.258576385043;5716.514096301695;5751.223584815996;5756.769729210785 04:48:45 INFO - PID 32053 | |5;yui.html;593.4984937727621;600.7927265093547;614.4562062574621;615.2156001098599;642.9067785171151;12410.131290809646;12502.124851260416;12538.435770390342;12596.433160507777;12869.5495657652;12995.960323174148;13110.475580976774;13134.540291089814;13160.144590601603;13185.077044606882;834.9791255218607;850;855.9871601925945;856.0797143071193;889.0620395482763;917.1149840404008;928.2017464980146;928.9163975242227;930.4463844012802;931.6087243357806;970.398353021128;977.8093271811999;979.5053497983544;983.9606415743361;986.6793292180034;963.0946909904702;964.3683387381207;965.425571784794;971.1405406215515;972.0182615558336;710.8258476673249;714.9428045756327;721.1418412089649;721.4192574977142;722.8518153778463;13656;13715.314234288246;14308.356123974447;14318.71362572753;14400.495982640661;13195.2742599157;13557.796633050511;13582.864171358258;13741.725165496735;13845.446182152702;8855.867161992575;9191.35660503765;9343.626254949793;9405.623775048989;9695.563699633534;2308.2959697292317;2335.7781010804115;2336.0610693124668;2341.2742049964395;2348.3659411958674;61906.38093619096;62807.68596157036;64119;64892.67553662249;65441.672791636214;10087.646932357333;10225.693229203136;10311.587536498457;10349.74125646865;10404.843927341097;21342;21350.679739803916;21364.465888352915;21730.456738581663;21741.67387489189;6171.814845554641;6231.813045608639;6242.531810114259;6293.496520278458;6376;2988.8206707597615;2998.7600991920594;3039.224997625591;3049.0700336397613;3098.209956461088;3557.857685692595;3667.394879844849;3693.0951916780023;3709.332320182339;3740.1958578905123;605;605.0591330481057;605.7849463440504;619.9845003874939;627.1220291591808;458.11355028020887;474.995250047502;479.8008826337101;491.7786995851881;492.5616201580596;7188.604626745475;7222.74720384784;7243.239459856744;7431.632872143437;7468.663910123949;461.35640781110163;471.67925810449225;473.97630118493936;483.15689122481496;489.5838537243386;3170.3183815479783;3204.7115759581748;3205.6794320568224;3257.4950882613234;3383.7123844473495;60177;61018.372703412075;63257;65853.34146658568;66565.33434665688;51359.22961155586;51407.74296128495;51430;51796.741016294676;54072.72963635156;45726;46100.538994610295;46629.30056049162;47344.28983565249;47821;7795.22047795216;8179.83640327202;8239.134890836616;8247.793805154919;8303.418760686694;23926.52146957016;24116.87941560281;24192.758072419052;24316.39209019718;25601.48797024086;43050.78474607607;44101.77949110234;44319.33520997123;44453;44781;10008.949955250177;10206.387616743019;10224;10245.385276883411;10400.687979360631;11554.133439992202;11762.770994268627;11873.703157421134;11926.522939082686;12054.156209065632;10390.688279351632;10590.523426445983;10624;10747.838782418426;10981.231313807957;11112.833307500556;11449.198556101326;11464.770704586028;11536.942315288705;11710.297382157098;9273.443593384418;9703.611855525982;9733.756656083655;9739.172170365599;9787.217022638315;7369.263073692588;7461.738839140604;7552.169261381134;7613.5431874087735;7774.455788094779;7386.778396648109;7465.917441970775;8334.12491688364;8390.622421990904;8686.39195256326 04:48:45 INFO - PID 32053 | __end_tp_report 04:48:45 INFO - PID 32053 | __start_cc_report 04:48:45 INFO - PID 32053 | _x_x_mozilla_cycle_collect,391 04:48:45 INFO - PID 32053 | __end_cc_report 04:48:45 INFO - PID 32053 | __startTimestamp1490960925948__endTimestamp 04:48:45 INFO - PID 32053 | 04:48:45 INFO - PID 32053 | ------- Summary: start ------- 04:48:45 INFO - PID 32053 | Number of tests: 6 04:48:45 INFO - PID 32053 | 04:48:45 INFO - PID 32053 | [#0] dojo.html Cycles:165 Average:5188.39 Median:5311.94 stddev:588.76 (11.1%) stddev-sans-first:556.91 04:48:45 INFO - PID 32053 | Values: 2687.0 2712.3 2724.6 2736.3 2741.7 5108.2 5220.7 5221.7 5258.4 5261.1 5183.7 5189.0 5195.0 5282.5 5311.9 4748.7 4774.6 4792.7 4796.5 4839.9 4818.2 4849.7 4904.3 4911.9 4948.3 4699.1 4702.1 4778.7 4787.5 4795.9 4720.2 4767.0 4807.4 4830.4 4848.3 4677.7 4741.7 4752.6 4770.8 4785.8 5065.6 5135.1 5221.1 5224.9 5278.0 5643.0 5673.5 5724.7 5726.1 5730.1 5682.5 5693.3 5702.7 5704.9 5708.9 5172.8 5274.9 5275.1 5290.6 5349.6 5711.6 5763.0 5780.8 5793.2 5797.8 5523.2 5538.6 5541.3 5607.5 5632.2 5609.9 5676.1 5682.1 5693.6 5696.4 5634.9 5644.2 5647.9 5650.5 5665.7 5432.5 5542.5 5560.6 5627.8 5668.4 4758.0 4764.6 4765.1 4769.2 4826.4 4080.5 4082.4 4085.4 4110.3 4122.3 4734.6 4805.8 4807.8 4833.4 4842.5 5666.5 5679.1 5698.3 5731.7 5747.5 4829.9 4878.1 4880.0 4885.9 4931.1 5076.6 5094.0 5097.2 5103.0 5107.1 5192.2 5263.2 5267.2 5276.6 5277.1 5567.8 5617.7 5625.5 5628.7 5630.5 5227.4 5228.1 5296.8 5312.0 5313.9 5558.2 5584.0 5603.0 5608.4 5609.7 5530.7 5677.8 5683.4 5685.4 5736.2 5462.3 5492.5 5535.5 5558.6 5563.0 5490.3 5517.4 5523.6 5526.0 5533.7 5241.8 5324.5 5422.8 5464.8 5506.9 5468.1 5477.8 5481.9 5486.1 5496.1 5318.1 5322.4 5329.1 5329.7 5331.8 04:48:45 INFO - PID 32053 | 04:48:45 INFO - PID 32053 | [#1] ext.html Cycles:180 Average:33032.62 Median:28308.79 stddev:49887.35 (176.2%) stddev-sans-first:49967.89 04:48:45 INFO - PID 32053 | Values: 606.2 663.1 684.1 1195.3 1217.4 36615.8 37886.0 37899.2 37936.2 37939.8 35329.5 35666.5 35708.8 35742.8 35750.5 6930.7 7105.0 7153.3 7341.3 7371.0 7485.0 7546.4 7566.4 7590.0 7591.2 7502.2 7550.8 7564.8 7604.1 7614.1 7522.2 7547.8 7562.7 7587.5 7599.1 7428.7 7499.1 7500.5 7508.7 7513.4 33650.3 33779.3 33888.0 33958.7 33988.5 2608.5 2652.7 2655.6 2656.0 2708.6 24084.8 24270.5 24329.5 24634.0 24933.3 2412.5 2454.8 2473.7 2474.2 2485.5 145478.0 146010.0 146387.0 146429.0 146626.3 41374.6 41403.4 41428.8 41466.4 41466.8 43598.3 43853.8 43872.3 43901.8 43938.0 12797.9 13045.2 13118.6 13151.5 13212.8 10500.7 10513.4 10527.3 10540.4 10543.8 12948.4 13012.2 13056.2 13223.9 13229.5 5579.4 5667.5 5714.3 5716.0 5737.4 836.2 851.0 865.1 871.5 888.2 20497.7 21224.9 21306.5 21338.9 21638.8 943.3 953.9 955.0 961.5 984.2 10993.9 11043.9 11047.2 11105.3 11137.4 238355.0 239883.0 240288.0 240472.7 241480.0 43387.0 43591.6 43736.8 43767.6 43825.0 1203.6 1220.8 1241.1 1244.2 1245.8 23122.2 23200.2 23976.8 24228.6 24383.0 28285.0 28332.6 28334.4 28340.9 28348.0 176063.0 176633.0 176761.0 177319.0 177776.0 26316.3 26821.6 26986.0 27099.9 27115.5 32165.4 32486.7 32764.8 32789.2 32937.7 24703.9 25347.2 26298.5 26968.6 27524.4 26987.7 27294.6 27635.2 28442.7 28601.6 29691.3 30364.5 30435.8 30828.2 31259.5 26722.3 26900.6 27345.3 27397.2 27998.0 19931.4 21273.7 21350.4 21367.8 21430.5 04:48:45 INFO - PID 32053 | 04:48:45 INFO - PID 32053 | [#2] jquery.html Cycles:180 Average:28255.11 Median:23095.00 stddev:76916.14 (333.0%) stddev-sans-first:77103.49 04:48:45 INFO - PID 32053 | Values: 410.6 414.8 418.8 437.7 443.0 18231.8 18720.9 19007.6 19068.4 19508.8 16932.6 17409.9 17456.7 18143.4 18439.9 4194.0 5727.7 5903.4 5933.3 5956.0 5699.8 5757.1 5790.2 5798.9 5802.7 5525.7 5769.2 5783.4 5785.6 5796.7 5577.0 5724.0 5795.4 5800.5 5805.8 5243.1 5278.6 5279.9 5280.1 5286.7 22496.0 22745.4 22850.5 23354.8 23513.2 1508.5 1514.3 1534.9 1572.2 1585.8 13201.2 13878.4 14129.6 14495.7 14569.4 1601.3 1604.2 1612.7 1625.2 1641.7 91350.0 92750.8 94040.5 96200.5 96997.0 10793.0 11125.9 11334.8 11369.0 11413.6 15459.0 15590.5 15595.0 15641.8 15645.2 7509.6 7742.6 7763.8 7870.5 7977.0 7080.9 7192.4 7367.4 7374.7 7379.5 6808.2 6916.4 7040.6 7076.4 7117.1 2044.2 2044.4 2099.3 2119.0 2183.1 836.3 844.2 861.8 867.8 881.5 15444.2 16325.7 16341.4 16435.3 16492.2 865.5 883.5 885.1 886.8 894.7 8576.8 8716.3 9057.2 9190.3 9194.9 435714.0 443672.0 478502.0 480265.0 480513.0 87063.6 89119.6 90139.5 91482.5 92874.5 1054.8 1062.7 1071.2 1078.8 1084.6 13628.5 13705.9 13755.3 13884.6 14335.1 40950.0 41679.0 41996.0 42287.2 44703.1 51436.7 52711.0 52987.5 53387.2 54630.7 8181.2 8208.5 8327.5 8428.7 8556.6 13030.5 13043.0 13387.7 13409.1 13445.4 11004.7 11105.2 11362.2 11454.7 11600.9 10879.5 10985.0 11018.9 11296.9 11382.4 11020.4 11375.8 11462.6 11643.4 11823.6 8284.7 8337.7 8439.3 8457.6 8707.1 11242.5 11703.7 11869.0 11886.9 11911.8 04:48:45 INFO - PID 32053 | 04:48:45 INFO - PID 32053 | [#3] mootools.html Cycles:180 Average:6106.59 Median:3929.08 stddev:3840.64 (97.7%) stddev-sans-first:3834.11 04:48:45 INFO - PID 32053 | Values: 1255.4 1312.2 1316.8 1322.2 1346.0 9547.1 9902.4 9944.3 9959.0 10210.5 9889.5 9964.3 10055.3 10055.9 10073.5 2202.4 2230.5 2238.0 2250.7 2254.4 2103.4 2195.5 2201.9 2204.6 2213.1 2121.3 2201.2 2201.4 2205.2 2209.2 2168.6 2174.4 2175.8 2177.3 2188.1 1832.2 1913.1 2116.1 2131.7 2164.5 9935.9 10019.9 10021.4 10026.7 10028.3 5364.9 5527.8 5563.3 5569.1 5574.9 3414.4 3425.1 3481.0 3484.1 3501.8 1059.2 1068.1 1080.2 1105.3 1119.6 13595.5 13674.7 13705.5 13712.0 13760.4 4540.9 4698.7 4788.5 4817.5 4846.7 10747.7 10749.6 10759.3 10774.7 10790.8 5442.8 5480.1 5482.4 5489.1 5491.8 4762.6 4888.8 4913.2 4945.7 5023.9 3742.9 3822.5 3923.1 3935.1 4026.5 1168.3 1169.1 1183.3 1190.6 1192.1 676.8 689.7 701.4 702.0 723.9 5264.7 5285.2 5307.0 5984.6 6019.1 822.5 830.7 843.8 850.2 865.5 3580.3 3626.9 3650.2 3657.9 3832.3 12283.1 12635.0 12713.4 12827.2 12900.6 12505.8 12701.7 12720.5 12724.7 12751.1 9147.2 9428.2 9431.4 9446.3 9469.8 5560.4 5592.8 5617.9 5685.3 5777.3 11417.6 11562.7 11618.7 11680.4 11688.5 11097.5 11319.5 11362.7 11395.1 11470.9 8012.2 8085.0 8268.6 8274.7 8279.8 9092.0 9093.9 9104.8 9167.1 9182.7 7184.9 7287.2 7378.8 7417.9 7538.8 7197.9 7304.7 7339.8 7549.1 7562.5 6704.7 6752.3 6836.1 6841.8 6852.7 4951.9 5103.9 5209.0 5282.5 5342.1 4273.6 5030.7 5060.1 5148.4 5188.4 04:48:45 INFO - PID 32053 | 04:48:45 INFO - PID 32053 | [#4] prototype.html Cycles:180 Average:4816.27 Median:5479.84 stddev:1421.99 (25.9%) stddev-sans-first:1386.57 04:48:45 INFO - PID 32053 | Values: 386.9 389.6 391.5 399.4 400.4 5560.0 5577.3 5580.4 5588.2 5622.7 5281.2 5403.9 5438.1 5472.8 5482.8 4369.8 4380.9 4381.1 4388.8 4399.7 4373.3 4392.1 4401.4 4412.4 4416.2 4031.6 4199.5 4382.7 4399.9 4405.7 4175.1 4183.1 4200.1 4201.2 4203.5 3650.8 3653.6 3669.5 3670.6 3676.0 5275.2 5439.7 5448.7 5449.2 5451.9 4797.7 4798.3 4798.3 4824.2 4830.7 5738.2 5764.8 5769.2 5771.7 5774.8 3918.8 3993.9 3995.1 3996.2 4021.1 5987.8 6123.4 6153.6 6166.0 6182.4 4080.4 4110.5 4120.6 4127.6 4142.0 4108.9 4161.3 4164.1 4168.2 4173.6 4573.9 4816.3 4822.8 4838.3 4863.7 5781.3 5783.3 5801.7 5812.4 5816.2 1449.8 1454.8 1467.7 1471.7 1473.2 939.9 974.3 994.7 995.6 997.9 5112.6 5112.9 5116.9 5120.1 5133.3 6013.6 6073.9 6076.0 6082.8 6084.9 4913.6 5037.0 5091.4 5093.5 5108.4 3172.5 3190.9 3209.1 3215.3 3218.7 5598.1 5608.0 5608.2 5609.2 5639.0 5961.7 6150.5 6187.4 6251.3 6271.4 5625.6 5631.3 5644.9 5663.6 5673.3 5826.1 6048.8 6087.8 6115.3 6124.0 5954.3 5993.7 6002.5 6011.3 6016.3 5355.5 5476.9 5498.8 5636.1 5642.5 4106.4 4114.7 4116.3 4118.6 4122.0 5950.3 6072.4 6074.0 6075.5 6107.2 5814.3 5865.3 5868.6 5872.8 5895.3 5834.5 5852.3 5853.3 5866.0 5872.7 5562.7 5754.1 5772.0 5799.3 5808.0 5885.5 5896.5 5900.1 5901.4 5931.9 5695.4 5703.3 5716.5 5751.2 5756.8 04:48:45 INFO - PID 32053 | 04:48:45 INFO - PID 32053 | [#5] yui.html Cycles:180 Average:13862.07 Median:481.48 stddev:17444.03 (3623.0%) stddev-sans-first:17464.51 04:48:45 INFO - PID 32053 | Values: 593.5 600.8 614.5 615.2 642.9 12410.1 12502.1 12538.4 12596.4 12869.5 12996.0 13110.5 13134.5 13160.1 13185.1 835.0 850.0 856.0 856.1 889.1 917.1 928.2 928.9 930.4 931.6 970.4 977.8 979.5 984.0 986.7 963.1 964.4 965.4 971.1 972.0 710.8 714.9 721.1 721.4 722.9 13656.0 13715.3 14308.4 14318.7 14400.5 13195.3 13557.8 13582.9 13741.7 13845.4 8855.9 9191.4 9343.6 9405.6 9695.6 2308.3 2335.8 2336.1 2341.3 2348.4 61906.4 62807.7 64119.0 64892.7 65441.7 10087.6 10225.7 10311.6 10349.7 10404.8 21342.0 21350.7 21364.5 21730.5 21741.7 6171.8 6231.8 6242.5 6293.5 6376.0 2988.8 2998.8 3039.2 3049.1 3098.2 3557.9 3667.4 3693.1 3709.3 3740.2 605.0 605.1 605.8 620.0 627.1 458.1 475.0 479.8 491.8 492.6 7188.6 7222.7 7243.2 7431.6 7468.7 461.4 471.7 474.0 483.2 489.6 3170.3 3204.7 3205.7 3257.5 3383.7 60177.0 61018.4 63257.0 65853.3 66565.3 51359.2 51407.7 51430.0 51796.7 54072.7 45726.0 46100.5 46629.3 47344.3 47821.0 7795.2 8179.8 8239.1 8247.8 8303.4 23926.5 24116.9 24192.8 24316.4 25601.5 43050.8 44101.8 44319.3 44453.0 44781.0 10008.9 10206.4 10224.0 10245.4 10400.7 11554.1 11762.8 11873.7 11926.5 12054.2 10390.7 10590.5 10624.0 10747.8 10981.2 11112.8 11449.2 11464.8 11536.9 11710.3 9273.4 9703.6 9733.8 9739.2 9787.2 7369.3 7461.7 7552.2 7613.5 7774.5 7386.8 7465.9 8334.1 8390.6 8686.4 04:48:45 INFO - PID 32053 | -------- Summary: end -------- 04:48:45 INFO - PID 32053 | 04:48:46 INFO - TEST-INFO | 32053: exit 0 04:48:46 INFO - TEST-OK | dromaeo_css | took 1120006ms 04:48:46 INFO - TEST-START | kraken 04:48:46 INFO - operating with platform_type : linux_ 04:48:46 INFO - Initialising browser for kraken test... 04:48:46 INFO - TEST-INFO | started process 32440 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6tONa2/profile http://localhost:55070/getInfo.html) 04:48:50 INFO - PID 32440 | __metrics Screen width/height:1600/1200 04:48:50 INFO - PID 32440 | colorDepth:24 04:48:50 INFO - PID 32440 | Browser inner width/height: 1024/697 04:48:50 INFO - PID 32440 | __metrics 04:48:51 ERROR - PID 32440 | 1490960931528 addons.xpi WARN Exception running bootstrap method shutdown on shield-recipe-client@mozilla.org: TypeError: log is null (resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:96:5) JS Stack trace: this.shutdown@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@bootstrap.js:96:5 < callBootstrapMethod@XPIProvider.jsm:4957:11 < observe@XPIProvider.jsm:2924:15 < permitUnload@remote-browser.xml:357:13 < CanCloseWindow@browser.js:6382:36 < canClose@browser.js:5233:12 < forceQuit@jar:file:///tmp/tmp6tONa2/profile/extensions/talos-powers@TalosPowersService.js:237:7 < whenDone@jar:file:///tmp/tmp6tONa2/profile/extensions/talos-powers@TalosPowersService.js:222:9 < promise callback*forceQuit@jar:file:///tmp/tmp6tONa2/profile/extensions/talos-powers@TalosPowersService.js:224:7 < receiveMessage@jar:file:///tmp/tmp6tONa2/profile/extensions/talos-powers@TalosPowersService.js:55:9 04:48:51 ERROR - PID 32440 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3396: TypeError: this.tabs is undefined 04:48:52 INFO - TEST-INFO | 32440: exit 0 04:48:52 INFO - Browser initialized. 04:48:52 INFO - Running cycle 1/1 for kraken test... 04:48:52 INFO - TEST-INFO | started process 32571 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6tONa2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:49:04 INFO - PID 32571 | RSS: Main: 156041216 04:49:04 INFO - PID 32571 | 04:49:07 INFO - PID 32571 | Cycle 1(1): loaded http://localhost:55070/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55070/tests/kraken/driver.html?testName=audio-beat-detection) 04:49:08 INFO - PID 32571 | RSS: Main: 161521664 04:49:08 INFO - PID 32571 | 04:49:10 INFO - PID 32571 | Cycle 1(1): loaded http://localhost:55070/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55070/tests/kraken/driver.html?testName=audio-dft) 04:49:11 INFO - PID 32571 | RSS: Main: 161591296 04:49:11 INFO - PID 32571 | 04:49:14 INFO - PID 32571 | Cycle 1(1): loaded http://localhost:55070/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55070/tests/kraken/driver.html?testName=audio-fft) 04:49:15 INFO - PID 32571 | RSS: Main: 158154752 04:49:15 INFO - PID 32571 | 04:49:17 INFO - PID 32571 | Cycle 1(1): loaded http://localhost:55070/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55070/tests/kraken/driver.html?testName=audio-oscillator) 04:49:18 INFO - PID 32571 | RSS: Main: 158814208 04:49:18 INFO - PID 32571 | 04:49:20 INFO - PID 32571 | Cycle 1(1): loaded http://localhost:55070/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55070/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:49:20 INFO - PID 32571 | RSS: Main: 159232000 04:49:20 INFO - PID 32571 | 04:49:24 INFO - PID 32571 | Cycle 1(1): loaded http://localhost:55070/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55070/tests/kraken/driver.html?testName=imaging-darkroom) 04:49:24 INFO - PID 32571 | RSS: Main: 164118528 04:49:24 INFO - PID 32571 | 04:49:28 INFO - PID 32571 | Cycle 1(1): loaded http://localhost:55070/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55070/tests/kraken/driver.html?testName=imaging-desaturate) 04:49:28 INFO - PID 32571 | RSS: Main: 161492992 04:49:28 INFO - PID 32571 | 04:49:31 INFO - PID 32571 | Cycle 1(1): loaded http://localhost:55070/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55070/tests/kraken/driver.html?testName=json-parse-financial) 04:49:32 INFO - PID 32571 | RSS: Main: 162381824 04:49:32 INFO - PID 32571 | 04:49:34 INFO - PID 32571 | Cycle 1(1): loaded http://localhost:55070/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55070/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:49:34 INFO - PID 32571 | RSS: Main: 163110912 04:49:34 INFO - PID 32571 | 04:49:36 INFO - PID 32571 | Cycle 1(1): loaded http://localhost:55070/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55070/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:49:37 INFO - PID 32571 | RSS: Main: 162951168 04:49:37 INFO - PID 32571 | 04:49:39 INFO - PID 32571 | Cycle 1(1): loaded http://localhost:55070/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55070/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:49:40 INFO - PID 32571 | RSS: Main: 163958784 04:49:40 INFO - PID 32571 | 04:49:43 INFO - PID 32571 | Cycle 1(1): loaded http://localhost:55070/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55070/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:49:43 INFO - PID 32571 | RSS: Main: 163958784 04:49:43 INFO - PID 32571 | 04:49:47 INFO - PID 32571 | Cycle 1(1): loaded http://localhost:55070/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55070/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:49:47 INFO - PID 32571 | RSS: Main: 163643392 04:49:47 INFO - PID 32571 | 04:49:49 INFO - PID 32571 | Cycle 1(1): loaded http://localhost:55070/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55070/tests/kraken/driver.html?testName=ai-astar) 04:49:49 INFO - PID 32571 | RSS: Main: 165240832 04:49:49 INFO - PID 32571 | 04:49:49 INFO - PID 32571 | __start_tp_report 04:49:49 INFO - PID 32571 | _x_x_mozilla_page_load 04:49:49 INFO - PID 32571 | _x_x_mozilla_page_load_details 04:49:49 INFO - PID 32571 | |i|pagename|runs| 04:49:49 INFO - PID 32571 | |0;ai-astar;106;112;111;113;111;112;111;112;112;110 04:49:49 INFO - PID 32571 | |1;audio-beat-detection;156;126;138;169;128;126;127;123;148;126 04:49:49 INFO - PID 32571 | |2;audio-dft;166;168;166;169;173;167;176;165;167;165 04:49:49 INFO - PID 32571 | |3;audio-fft;76;76;75;123;76;76;76;76;94;79 04:49:49 INFO - PID 32571 | |4;audio-oscillator;84;84;104;85;85;84;106;86;84;105 04:49:49 INFO - PID 32571 | |5;imaging-gaussian-blur;114;114;115;114;113;114;114;115;115;115 04:49:49 INFO - PID 32571 | |6;imaging-darkroom;152;151;151;151;152;150;151;152;151;152 04:49:49 INFO - PID 32571 | |7;imaging-desaturate;95;94;96;96;95;95;95;95;96;96 04:49:49 INFO - PID 32571 | |8;json-parse-financial;68;68;68;67;69;68;70;70;69;70 04:49:49 INFO - PID 32571 | |9;json-stringify-tinderbox;59;57;63;57;56;56;56;56;56;56 04:49:49 INFO - PID 32571 | |10;stanford-crypto-aes;85;90;87;84;92;83;84;84;83;84 04:49:49 INFO - PID 32571 | |11;stanford-crypto-ccm;136;135;136;137;141;147;141;141;185;143 04:49:49 INFO - PID 32571 | |12;stanford-crypto-pbkdf2;187;201;196;211;198;204;200;192;202;186 04:49:49 INFO - PID 32571 | |13;stanford-crypto-sha256-iterative;72;72;71;72;72;72;71;72;72;70 04:49:49 INFO - PID 32571 | __end_tp_report 04:49:49 INFO - PID 32571 | __start_cc_report 04:49:49 INFO - PID 32571 | _x_x_mozilla_cycle_collect,905 04:49:49 INFO - PID 32571 | __end_cc_report 04:49:49 INFO - PID 32571 | __startTimestamp1490960989930__endTimestamp 04:49:49 INFO - PID 32571 | 04:49:49 INFO - PID 32571 | ------- Summary: start ------- 04:49:49 INFO - PID 32571 | Number of tests: 14 04:49:49 INFO - PID 32571 | 04:49:49 INFO - PID 32571 | [#0] ai-astar Cycles:10 Average:111.00 Median:112.00 stddev:1.94 (1.7%) stddev-sans-first:0.88 04:49:49 INFO - PID 32571 | Values: 106.0 112.0 111.0 113.0 111.0 112.0 111.0 112.0 112.0 110.0 04:49:49 INFO - PID 32571 | 04:49:49 INFO - PID 32571 | [#1] audio-beat-detection Cycles:10 Average:136.70 Median:133.00 stddev:15.80 (11.9%) stddev-sans-first:15.13 04:49:49 INFO - PID 32571 | Values: 156.0 126.0 138.0 169.0 128.0 126.0 127.0 123.0 148.0 126.0 04:49:49 INFO - PID 32571 | 04:49:49 INFO - PID 32571 | [#2] audio-dft Cycles:10 Average:168.20 Median:167.50 stddev:3.61 (2.2%) stddev-sans-first:3.75 04:49:49 INFO - PID 32571 | Values: 166.0 168.0 166.0 169.0 173.0 167.0 176.0 165.0 167.0 165.0 04:49:49 INFO - PID 32571 | 04:49:49 INFO - PID 32571 | [#3] audio-fft Cycles:10 Average:82.70 Median:76.00 stddev:15.25 (20.1%) stddev-sans-first:15.99 04:49:49 INFO - PID 32571 | Values: 76.0 76.0 75.0 123.0 76.0 76.0 76.0 76.0 94.0 79.0 04:49:49 INFO - PID 32571 | 04:49:49 INFO - PID 32571 | [#4] audio-oscillator Cycles:10 Average:90.70 Median:84.00 stddev:9.90 (11.8%) stddev-sans-first:10.20 04:49:49 INFO - PID 32571 | Values: 84.0 84.0 104.0 85.0 85.0 84.0 106.0 86.0 84.0 105.0 04:49:49 INFO - PID 32571 | 04:49:49 INFO - PID 32571 | [#5] imaging-gaussian-blur Cycles:10 Average:114.30 Median:114.50 stddev:0.67 (0.6%) stddev-sans-first:0.71 04:49:49 INFO - PID 32571 | Values: 114.0 114.0 115.0 114.0 113.0 114.0 114.0 115.0 115.0 115.0 04:49:49 INFO - PID 32571 | 04:49:49 INFO - PID 32571 | [#6] imaging-darkroom Cycles:10 Average:151.30 Median:151.50 stddev:0.67 (0.4%) stddev-sans-first:0.67 04:49:49 INFO - PID 32571 | Values: 152.0 151.0 151.0 151.0 152.0 150.0 151.0 152.0 151.0 152.0 04:49:49 INFO - PID 32571 | 04:49:49 INFO - PID 32571 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.50 stddev:0.67 (0.7%) stddev-sans-first:0.71 04:49:49 INFO - PID 32571 | Values: 95.0 94.0 96.0 96.0 95.0 95.0 95.0 95.0 96.0 96.0 04:49:49 INFO - PID 32571 | 04:49:49 INFO - PID 32571 | [#8] json-parse-financial Cycles:10 Average:68.70 Median:69.00 stddev:1.06 (1.5%) stddev-sans-first:1.09 04:49:49 INFO - PID 32571 | Values: 68.0 68.0 68.0 67.0 69.0 68.0 70.0 70.0 69.0 70.0 04:49:49 INFO - PID 32571 | 04:49:49 INFO - PID 32571 | [#9] json-stringify-tinderbox Cycles:10 Average:57.20 Median:56.50 stddev:2.25 (4.0%) stddev-sans-first:2.29 04:49:49 INFO - PID 32571 | Values: 59.0 57.0 63.0 57.0 56.0 56.0 56.0 56.0 56.0 56.0 04:49:49 INFO - PID 32571 | 04:49:49 INFO - PID 32571 | [#10] stanford-crypto-aes Cycles:10 Average:85.60 Median:84.50 stddev:3.10 (3.7%) stddev-sans-first:3.28 04:49:49 INFO - PID 32571 | Values: 85.0 90.0 87.0 84.0 92.0 83.0 84.0 84.0 83.0 84.0 04:49:49 INFO - PID 32571 | 04:49:49 INFO - PID 32571 | [#11] stanford-crypto-ccm Cycles:10 Average:144.20 Median:141.00 stddev:14.82 (10.5%) stddev-sans-first:15.41 04:49:49 INFO - PID 32571 | Values: 136.0 135.0 136.0 137.0 141.0 147.0 141.0 141.0 185.0 143.0 04:49:49 INFO - PID 32571 | 04:49:49 INFO - PID 32571 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:197.70 Median:200.50 stddev:7.73 (3.9%) stddev-sans-first:7.17 04:49:49 INFO - PID 32571 | Values: 187.0 201.0 196.0 211.0 198.0 204.0 200.0 192.0 202.0 186.0 04:49:49 INFO - PID 32571 | 04:49:49 INFO - PID 32571 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.60 Median:72.00 stddev:0.70 (1.0%) stddev-sans-first:0.73 04:49:49 INFO - PID 32571 | Values: 72.0 72.0 71.0 72.0 72.0 72.0 71.0 72.0 72.0 70.0 04:49:49 INFO - PID 32571 | -------- Summary: end -------- 04:49:49 INFO - PID 32571 | 04:49:51 INFO - TEST-INFO | 32571: exit 0 04:49:51 INFO - TEST-OK | kraken | took 64304ms 04:49:51 INFO - SUITE-END | took 1184s 04:49:51 INFO - Completed test suite (00:19:44) 04:49:51 INFO - javascript benchmark 04:49:51 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6607.1173534162535, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2687.0, 2712.349036231305, 2724.6457960465136, 2736.315921019745, 2741.684706258781, 5108.182690769478, 5220.738963051846, 5221.660592061513, 5258.44786297439, 5261.131913234317, 5183.740812959356, 5189.040027594898, 5194.974025129878, 5282.5245727884485, 5311.937612477501, 4748.667593268473, 4774.641901857357, 4792.664513484057, 4796.544328288807, 4839.879003024935, 4818.180909245437, 4849.733264670442, 4904.288878112671, 4911.852644420673, 4948.282499037656, 4699.130660827758, 4702.106599746037, 4778.737169455679, 4787.497312782142, 4795.928061079087, 4720.221163508017, 4766.976165119152, 4807.399075115611, 4830.4203495580405, 4848.2727590861305, 4677.74272415017, 4741.715497070187, 4752.572268495817, 4770.8330208442885, 4785.808567657289, 5065.645404821664, 5135.101357262502, 5221.112410890158, 5224.895502089975, 5278.0, 5642.98426283273, 5673.489385955284, 5724.656520608777, 5726.112452569817, 5730.083186690152, 5682.460166284196, 5693.316801983747, 5702.657840529581, 5704.885902281972, 5708.857278568027, 5172.818951336685, 5274.894502109936, 5275.076861549213, 5290.576753859682, 5349.625526213128, 5711.600187986801, 5763.0202865512965, 5780.768769249183, 5793.159991801165, 5797.826065218051, 5523.199136125239, 5538.6399884007415, 5541.33503979517, 5607.523360514402, 5632.211490391349, 5609.915851262234, 5676.091825307931, 5682.147677848273, 5693.629914055573, 5696.430356964271, 5634.859128521738, 5644.153376993484, 5647.915281270784, 5650.519705825051, 5665.688387138664, 5432.483914028161, 5542.501174894279, 5560.638558493766, 5627.831165065055, 5668.376478587352, 4758.0, 4764.595009424238, 4765.070811191785, 4769.189237829577, 4826.396700412449, 4080.489938757655, 4082.4284600156, 4085.428040074392, 4110.260153172398, 4122.2579935611275, 4734.621230301567, 4805.807767689324, 4807.807687692523, 4833.4441539222735, 4842.5157484251295, 5666.490015898589, 5679.062954612526, 5698.287714035746, 5731.656100633975, 5747.482726554546, 4829.903401932012, 4878.121938051114, 4880.0, 4885.902281954341, 4931.0630980113665, 5076.593872490192, 5093.981203759189, 5097.1844504879045, 5102.974485127551, 5107.055194788902, 5192.169252919514, 5263.23683065961, 5267.209918512254, 5276.577873770166, 5277.076511610529, 5567.777288908398, 5617.662940223599, 5625.521830644441, 5628.662280263197, 5630.465105814941, 5227.398849132398, 5228.058949389147, 5296.814611488733, 5311.973440132774, 5313.893722125458, 5558.221848941071, 5584.0227960106, 5602.971985140048, 5608.439156084359, 5609.691466969356, 5530.668159910419, 5677.829665110054, 5683.374828768915, 5685.374608793112, 5736.196932429547, 5462.317210348707, 5492.5331346835965, 5535.529479994246, 5558.555315574825, 5563.0, 5490.3411590609385, 5517.44825517445, 5523.613347065667, 5526.032944234823, 5533.695646739468, 5241.816536421207, 5324.547413469899, 5422.783088676409, 5464.836054918359, 5506.944930550803, 5468.0977638690765, 5477.75350109238, 5481.862953426196, 5486.067368547277, 5496.065668836228, 5318.095923692904, 5322.414534401135, 5329.067413202752, 5329.706866122246, 5331.760070796746], "value": 5146.285810442407, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [606.2391698418484, 663.1180529895239, 684.0867441964976, 1195.3186683590357, 1217.3669691760279, 36615.81692091539, 37886.0, 37899.24201515968, 37936.24127517448, 37939.81030094853, 35329.47005794909, 35666.46500302491, 35708.82145589275, 35742.82128589354, 35750.463743043874, 6930.653467326639, 7105.040819489381, 7153.284671532831, 7341.339279464847, 7371.0, 7484.962575187116, 7546.434017448713, 7566.394688424913, 7589.962050189742, 7591.164971853092, 7502.249775022508, 7550.7734767957045, 7564.773056808304, 7604.125525564548, 7614.08630964285, 7522.172561018284, 7547.773566793005, 7562.659680314399, 7587.468877178628, 7599.088109426849, 7428.665710043061, 7499.062617172854, 7500.549967001943, 7508.699652013967, 7513.361364284043, 33650.326993459996, 33779.32441351184, 33888.0, 33958.660413395795, 33988.49017264743, 2608.47830433914, 2652.6949400818958, 2655.6282120503147, 2655.9601605975927, 2708.5801700736415, 24084.759152408427, 24270.514589708284, 24329.513409731884, 24634.0, 24933.252002439956, 2412.457197130649, 2454.840435371695, 2473.6784218051716, 2474.2453551666736, 2485.465624890639, 145478.0, 146010.0, 146387.0, 146429.0, 146626.26686866605, 41374.58625413768, 41403.41053957677, 41428.79285603553, 41466.378004329956, 41466.792666036476, 43598.34602480965, 43853.78073109614, 43872.3419148713, 43901.78049109734, 43938.0, 12797.872021279669, 13045.152065115737, 13118.606441806762, 13151.473941042252, 13212.801807972888, 10500.73748156287, 10513.421761803022, 10527.315724477885, 10540.367577945348, 10543.789124217472, 12948.417321220568, 13012.154209976321, 13056.151350162208, 13223.867761322455, 13229.536966206137, 5579.4420557944695, 5667.533216357334, 5714.285714285715, 5716.02736098416, 5737.3688894221605, 836.2306677856386, 850.9702160424356, 865.1348651348651, 871.4771137317558, 888.2146884761546, 20497.692534611993, 21224.893875530834, 21306.467338316357, 21338.893305533373, 21638.783612163676, 943.2831048403262, 953.8998405167496, 954.9952250238844, 961.5384615384514, 984.1978787288338, 10993.890061099446, 11043.895610439053, 11047.226694131334, 11105.278156919774, 11137.443127843575, 238355.0, 239883.0, 240288.0, 240472.73854398815, 241480.0, 43387.0, 43591.56408435875, 43736.75158980943, 43767.56232437699, 43825.0, 1203.5907791350983, 1220.8473940757406, 1241.1436109084702, 1244.2161438293817, 1245.8318127052912, 23122.190723324602, 23200.18799342015, 23976.760232397453, 24228.63657045181, 24383.0, 28285.0, 28332.575011374433, 28334.43331133407, 28340.85829570839, 28348.0, 176063.0, 176633.0, 176761.0, 177319.0, 177776.0, 26316.342091447867, 26821.597676034486, 26986.0, 27099.86450067737, 27115.457690845677, 32165.35669286648, 32486.67513324931, 32764.836175818968, 32789.18027049343, 32937.67062329346, 24703.87648061748, 25347.179153869845, 26298.474030519665, 26968.595471068344, 27524.44951101007, 26987.730122698522, 27294.590581140903, 27635.170944871687, 28442.71557284401, 28601.570976435785, 29691.257718556346, 30364.544531832482, 30435.847820760755, 30828.22929426782, 31259.53110703296, 26722.331941701614, 26900.596491053042, 27345.316367090185, 27397.17808465749, 27998.0, 19931.402057938285, 21273.6808947869, 21350.35948921535, 21367.78632213658, 21430.464238393542], "value": 14798.69620092456, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [410.57505481826314, 414.8402864897014, 418.8136279355686, 437.73735758544876, 443.0275545178335, 18231.817681823177, 18720.90639546802, 19007.61984760304, 19068.42794716159, 19508.804911950876, 16932.576685582866, 17409.91295043526, 17456.650866982654, 18143.364982225623, 18439.907800461013, 4194.0, 5727.742251598667, 5903.439173278553, 5933.258342707161, 5956.047032474805, 5699.772009119631, 5757.050086735683, 5790.189373487715, 5798.9130163047585, 5802.709864506779, 5525.696086715229, 5769.16347129666, 5783.363829978699, 5785.595008349417, 5796.652200867961, 5576.972115139399, 5724.0, 5795.362510123925, 5800.506956908668, 5805.825825225229, 5243.056249875021, 5278.630495865291, 5279.894402111975, 5280.102382594968, 5286.709230992294, 22496.0, 22745.431364215863, 22850.542989140125, 23354.7664523356, 23513.17703880373, 1508.4644951042442, 1514.295852428626, 1534.9309281082378, 1572.2217502336416, 1585.7938467999086, 13201.20792752438, 13878.375473103735, 14129.646758831008, 14495.71008579833, 14569.417223311055, 1601.2794242590764, 1604.2460043779406, 1612.6694027724288, 1625.244261418446, 1641.720907445737, 91350.0, 92750.7557021161, 94040.52979735058, 96200.51899740526, 96997.0, 10792.977966169485, 11125.888741112485, 11334.829977550344, 11369.0, 11413.60052398162, 15459.0, 15590.532284031497, 15594.986325888782, 15641.843581564266, 15645.217739113226, 7509.62451877404, 7742.61286935651, 7763.767086987399, 7870.4884182529095, 7976.960115199387, 7080.893786593205, 7192.3886469649615, 7367.373773229228, 7374.741884034033, 7379.483436159418, 6808.2170550386345, 6916.377526022682, 7040.6479676016, 7076.363127318566, 7117.145942486831, 2044.1516770540356, 2044.427560283123, 2099.3072286145534, 2118.978810211909, 2183.094015983349, 836.2599099796602, 844.1853611265036, 861.8362511122866, 867.8481265778463, 881.457903389411, 15444.227788610524, 16325.67348653044, 16341.428050018192, 16435.26041328143, 16492.17539123039, 865.4720620421538, 883.5008220355479, 885.0706757904303, 886.7650072730731, 894.6779159502574, 8576.785580360542, 8716.346274029347, 9057.230135438562, 9190.310726695525, 9194.862077068849, 435714.0, 443672.0, 478502.0, 480265.0, 480513.0, 87063.56468217746, 89119.55440222757, 90139.54930225307, 91482.54258728663, 92874.53562732278, 1054.8154073037342, 1062.697131317571, 1071.1751950997689, 1078.8381742738495, 1084.6095405653957, 13628.52300169529, 13705.862941370458, 13755.31223438804, 13884.58346249614, 14335.139891606537, 40950.0, 41679.0, 41996.0, 42287.15425691407, 44703.10593788171, 51436.74281628568, 52711.0, 52987.470125298256, 53387.19919201137, 54630.72684636551, 8181.222783835526, 8208.548529830916, 8327.50034997902, 8428.704995325133, 8556.57217139128, 13030.47878084866, 13043.0, 13387.732245354844, 13409.128406653535, 13445.394957226752, 11004.724881877697, 11105.16711246676, 11362.157598032933, 11454.659886712261, 11600.88399115998, 10879.510422031186, 10985.0, 11018.850652484265, 11296.943515282699, 11382.430878455878, 11020.393878336448, 11375.772484550098, 11462.598809041978, 11643.41782910834, 11823.586174483851, 8284.71003514874, 8337.666493340199, 8439.282660973886, 8457.57712114404, 8707.129287071242, 11242.494087766234, 11703.707407314545, 11868.991135753558, 11886.940565297118, 11911.76176476483], "value": 8983.549175220074, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1255.4036832504562, 1312.1667740984483, 1316.756400065988, 1322.2397121655051, 1346.0106821486206, 9547.14075733184, 9902.35634683745, 9944.303898727092, 9959.0, 10210.489475526212, 9889.505524723752, 9964.302498825085, 10055.346402483834, 10055.949720251407, 10073.54669039893, 2202.4383782135574, 2230.4981379189717, 2237.9552408951813, 2250.718660167479, 2254.4025833154146, 2103.359379683849, 2195.5169862630196, 2201.933941981743, 2204.5921504521716, 2213.1258153029544, 2121.2605663356053, 2201.2075652764993, 2201.3836125884777, 2205.2171479124922, 2209.215728416413, 2168.609650262952, 2174.4346469917778, 2175.8476906616543, 2177.2923799765063, 2188.1466228171025, 1832.2213059449814, 1913.1104036622899, 2116.121809449077, 2131.7015617813363, 2164.545445456456, 9935.90064099357, 10019.89980100197, 10021.39871607706, 10026.749331266703, 10028.348157369748, 5364.946350536484, 5527.778888844482, 5563.304586926634, 5569.053260945649, 5574.885022995377, 3414.402479566066, 3425.1265927188406, 3481.0253129123885, 3484.1463841358777, 3501.8074005929666, 1059.1632610237903, 1068.0707784227693, 1080.1952545353683, 1105.3147048829696, 1119.6473110970019, 13595.524156654568, 13674.658133546642, 13705.45178192871, 13711.9999999999, 13760.449582016707, 4540.886477838015, 4698.671093023524, 4788.497207793202, 4817.470078291385, 4846.684965477232, 10747.731306717395, 10749.570017199225, 10759.30064545802, 10774.676759697064, 10790.784184316426, 5442.782288708408, 5480.095784195642, 5482.396936337, 5489.066858634042, 5491.807786727445, 4762.571368576845, 4888.780004899788, 4913.238448040488, 4945.653804233741, 5023.924641130386, 3742.8877133686033, 3822.503074600284, 3923.058465968204, 3935.0949281664803, 4026.516817981861, 1168.2523185161504, 1169.0997931592626, 1183.3077649575096, 1190.6249531397582, 1192.070185255502, 676.7732809508869, 689.6655122265797, 701.4038067642565, 701.9684114214873, 723.8588475247382, 5264.710440925709, 5285.233641122093, 5307.044731948286, 5984.640921544721, 6019.127226552126, 822.5393779483509, 830.7134038756619, 843.8059246373246, 850.2220468271586, 865.4893612768496, 3580.3197392495345, 3626.8730594429067, 3650.233450975272, 3657.908552286161, 3832.329342365075, 12283.14018018748, 12635.0, 12713.364331783374, 12827.166234194934, 12900.612981610566, 12505.812412813815, 12701.682457938625, 12720.491180352683, 12724.745505089846, 12751.107422480338, 9147.176754092163, 9428.198603118812, 9431.434113953048, 9446.338756286994, 9469.810603787886, 5560.443955604569, 5592.832215033555, 5617.88764224705, 5685.260916080883, 5777.277840269966, 11417.60038398652, 11562.653120406401, 11618.70953226176, 11680.415979200836, 11688.47401866901, 11097.500612472297, 11319.547218111184, 11362.715932101764, 11395.145364097893, 11470.885291146982, 8012.198780122174, 8085.029796424232, 8268.627911744106, 8274.710385136492, 8279.793005174919, 9092.045335239969, 9093.909060909305, 9104.817903642022, 9167.08329167078, 9182.724518264462, 7184.856302873809, 7287.161976372573, 7378.778636640909, 7417.851642967218, 7538.811529711801, 7197.928020719726, 7304.707811687473, 7339.816504587428, 7549.0941087069905, 7562.508436951581, 6704.6982885769285, 6752.257251702407, 6836.111305530249, 6841.828954276183, 6852.725890964306, 4951.925721114114, 5103.87240318995, 5208.9739551302, 5282.524572788314, 5342.11855043929, 4273.594008569181, 5030.723310217973, 5060.089183946925, 5148.43367229597, 5188.377394712658], "value": 4647.84021085385, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [386.8665310467889, 389.61622801540483, 391.4558763318989, 399.3849471813406, 400.4493820996131, 5559.972200138999, 5577.330720313558, 5580.414056524068, 5588.245586845775, 5622.7188640567965, 5281.2342210379475, 5403.891922161554, 5438.129899216126, 5472.753726082326, 5482.780688772445, 4369.847055353063, 4380.89047773805, 4381.145676593065, 4388.780560971954, 4399.714018588797, 4373.278409062501, 4392.12157568486, 4401.449818772653, 4412.404325416076, 4416.183006143858, 4031.5766844481345, 4199.517055538607, 4382.737035777847, 4399.890002749925, 4405.691601587874, 4175.144095460423, 4183.100633363842, 4200.096979149497, 4201.222773786844, 4203.5165955915, 3650.817459127033, 3653.5615726113037, 3669.486271921933, 3670.6145854685406, 3675.9632403675887, 5275.155975044013, 5439.700816455093, 5448.673079615196, 5449.209864569655, 5451.945480545183, 4797.736124513151, 4798.256270278112, 4798.328234047236, 4824.228123500223, 4830.7101573905675, 5738.167965644958, 5764.798232061899, 5769.163471296639, 5771.653700777967, 5774.82675519735, 3918.804059796999, 3993.940090898639, 3995.081131339808, 3996.1807829395193, 4021.055052062763, 5987.790427335066, 6123.448889599913, 6153.569250152491, 6165.996051283396, 6182.381761823826, 4080.449139366207, 4110.527289361702, 4120.649744771668, 4127.587241275848, 4142.0, 4108.876733697994, 4161.334186530141, 4164.063085805669, 4168.2080404723, 4173.582641735802, 4573.908521829545, 4816.325714399987, 4822.758862056883, 4838.250071238964, 4863.7324947128245, 5781.306243250753, 5783.306003279633, 5801.680907550125, 5812.447817457335, 5816.243888294494, 1449.8260208775014, 1454.8036015138032, 1467.7211329847296, 1471.6909449015614, 1473.2265560580781, 939.8606887079342, 974.2692980264801, 994.6618149829093, 995.5719040812376, 997.9002099790108, 5112.6421150519855, 5112.948870511322, 5116.923246151311, 5120.1039818031695, 5133.25567792668, 6013.639181649115, 6073.939260607426, 6075.969620151871, 6082.817515474543, 6084.939150608526, 4913.63147763912, 5036.974815125975, 5091.363579552556, 5093.541581257705, 5108.361454818148, 3172.5399817026864, 3190.8723651053697, 3209.149575362531, 3215.3087086276096, 3218.6781321867625, 5598.076317407664, 5608.0, 5608.158776183605, 5609.186667933209, 5638.9699708105045, 5961.672108034013, 6150.477209437158, 6187.3503282155625, 6251.343608921089, 6271.3728627136925, 5625.578081643893, 5631.267935168484, 5644.915326270109, 5663.6035477517, 5673.326673326674, 5826.077394459733, 6048.790241951539, 6087.808388980052, 6115.296740874856, 6123.969380153071, 5954.255718035246, 5993.700314984146, 6002.489788368038, 6011.27864656244, 6016.338202797601, 5355.491228333302, 5476.890462190813, 5498.780048798163, 5636.098224284095, 5642.463965923231, 4106.404571337199, 4114.703868281482, 4116.341385378325, 4118.567550407164, 4121.979390103031, 5950.31571369298, 6072.362401947908, 6073.969630151821, 6075.453209211192, 6107.175531303217, 5814.331351894417, 5865.3254875688135, 5868.61853979507, 5872.765089396376, 5895.322037965518, 5834.533237341087, 5852.268466441695, 5853.2976042875125, 5865.970670146622, 5872.677002764718, 5562.666240025612, 5754.108113242454, 5772.0, 5799.3040835100055, 5807.970960145172, 5885.529157667462, 5896.528277737856, 5900.144479050427, 5901.439363260483, 5931.851703707442, 5695.401982791747, 5703.258576385043, 5716.514096301695, 5751.223584815996, 5756.769729210785], "value": 4379.014620522512, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [593.4984937727621, 600.7927265093547, 614.4562062574621, 615.2156001098599, 642.9067785171151, 12410.131290809646, 12502.124851260416, 12538.435770390342, 12596.433160507777, 12869.5495657652, 12995.960323174148, 13110.475580976774, 13134.540291089814, 13160.144590601603, 13185.077044606882, 834.9791255218607, 850.0, 855.9871601925945, 856.0797143071193, 889.0620395482763, 917.1149840404008, 928.2017464980146, 928.9163975242227, 930.4463844012802, 931.6087243357806, 970.398353021128, 977.8093271811999, 979.5053497983544, 983.9606415743361, 986.6793292180034, 963.0946909904702, 964.3683387381207, 965.425571784794, 971.1405406215515, 972.0182615558336, 710.8258476673249, 714.9428045756327, 721.1418412089649, 721.4192574977142, 722.8518153778463, 13656.0, 13715.314234288246, 14308.356123974447, 14318.71362572753, 14400.495982640661, 13195.2742599157, 13557.796633050511, 13582.864171358258, 13741.725165496735, 13845.446182152702, 8855.867161992575, 9191.35660503765, 9343.626254949793, 9405.623775048989, 9695.563699633534, 2308.2959697292317, 2335.7781010804115, 2336.0610693124668, 2341.2742049964395, 2348.3659411958674, 61906.38093619096, 62807.68596157036, 64119.0, 64892.67553662249, 65441.672791636214, 10087.646932357333, 10225.693229203136, 10311.587536498457, 10349.74125646865, 10404.843927341097, 21342.0, 21350.679739803916, 21364.465888352915, 21730.456738581663, 21741.67387489189, 6171.814845554641, 6231.813045608639, 6242.531810114259, 6293.496520278458, 6376.0, 2988.8206707597615, 2998.7600991920594, 3039.224997625591, 3049.0700336397613, 3098.209956461088, 3557.857685692595, 3667.394879844849, 3693.0951916780023, 3709.332320182339, 3740.1958578905123, 605.0, 605.0591330481057, 605.7849463440504, 619.9845003874939, 627.1220291591808, 458.11355028020887, 474.995250047502, 479.8008826337101, 491.7786995851881, 492.5616201580596, 7188.604626745475, 7222.74720384784, 7243.239459856744, 7431.632872143437, 7468.663910123949, 461.35640781110163, 471.67925810449225, 473.97630118493936, 483.15689122481496, 489.5838537243386, 3170.3183815479783, 3204.7115759581748, 3205.6794320568224, 3257.4950882613234, 3383.7123844473495, 60177.0, 61018.372703412075, 63257.0, 65853.34146658568, 66565.33434665688, 51359.22961155586, 51407.74296128495, 51430.0, 51796.741016294676, 54072.72963635156, 45726.0, 46100.538994610295, 46629.30056049162, 47344.28983565249, 47821.0, 7795.22047795216, 8179.83640327202, 8239.134890836616, 8247.793805154919, 8303.418760686694, 23926.52146957016, 24116.87941560281, 24192.758072419052, 24316.39209019718, 25601.48797024086, 43050.78474607607, 44101.77949110234, 44319.33520997123, 44453.0, 44781.0, 10008.949955250177, 10206.387616743019, 10224.0, 10245.385276883411, 10400.687979360631, 11554.133439992202, 11762.770994268627, 11873.703157421134, 11926.522939082686, 12054.156209065632, 10390.688279351632, 10590.523426445983, 10624.0, 10747.838782418426, 10981.231313807957, 11112.833307500556, 11449.198556101326, 11464.770704586028, 11536.942315288705, 11710.297382157098, 9273.443593384418, 9703.611855525982, 9733.756656083655, 9739.172170365599, 9787.217022638315, 7369.263073692588, 7461.738839140604, 7552.169261381134, 7613.5431874087735, 7774.455788094779, 7386.778396648109, 7465.917441970775, 8334.12491688364, 8390.622421990904, 8686.39195256326], "value": 5973.738865282512, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1575.1999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 112.0, 111.0, 113.0, 111.0, 112.0, 111.0, 112.0, 112.0, 110.0], "value": 111.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 126.0, 138.0, 169.0, 128.0, 126.0, 127.0, 123.0, 148.0, 126.0], "value": 136.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 168.0, 166.0, 169.0, 173.0, 167.0, 176.0, 165.0, 167.0, 165.0], "value": 168.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 75.0, 123.0, 76.0, 76.0, 76.0, 76.0, 94.0, 79.0], "value": 82.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 104.0, 85.0, 85.0, 84.0, 106.0, 86.0, 84.0, 105.0], "value": 90.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 115.0, 114.0, 113.0, 114.0, 114.0, 115.0, 115.0, 115.0], "value": 114.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 151.0, 151.0, 151.0, 152.0, 150.0, 151.0, 152.0, 151.0, 152.0], "value": 151.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 96.0, 96.0, 95.0, 95.0, 95.0, 95.0, 96.0, 96.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 68.0, 67.0, 69.0, 68.0, 70.0, 70.0, 69.0, 70.0], "value": 68.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 57.0, 63.0, 57.0, 56.0, 56.0, 56.0, 56.0, 56.0, 56.0], "value": 57.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 90.0, 87.0, 84.0, 92.0, 83.0, 84.0, 84.0, 83.0, 84.0], "value": 85.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 135.0, 136.0, 137.0, 141.0, 147.0, 141.0, 141.0, 185.0, 143.0], "value": 144.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [187.0, 201.0, 196.0, 211.0, 198.0, 204.0, 200.0, 192.0, 202.0, 186.0], "value": 197.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 72.0, 71.0, 72.0, 72.0, 72.0, 71.0, 72.0, 72.0, 70.0], "value": 71.6, "unit": "score"}]}]} 04:49:51 INFO - Return code: 0 04:49:51 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:49:51 ERROR - # TBPL SUCCESS # 04:49:51 INFO - Running post-action listener: _resource_record_post_action 04:49:51 INFO - [mozharness: 2017-03-31 11:49:51.732707Z] Finished run-tests step (success) 04:49:51 INFO - Running post-run listener: _resource_record_post_run 04:49:51 INFO - Total resource usage - Wall time: 1201s; CPU: 13.0%; Read bytes: 8192; Write bytes: 377139200; Read time: 128; Write time: 337816 04:49:51 INFO - TinderboxPrint: CPU usage
13.3% 04:49:51 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 128 04:49:51 INFO - TinderboxPrint: I/O write bytes / time
377,139,200 / 337,816 04:49:51 INFO - TinderboxPrint: CPU idle
8,304.2 (86.6%) 04:49:51 INFO - TinderboxPrint: CPU user
1,223.7 (12.8%) 04:49:51 INFO - TinderboxPrint: Swap in / out
0 / 0 04:49:51 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 117309440; Read time: 0; Write time: 137220 04:49:51 INFO - run-tests - Wall time: 1185s; CPU: 13.0%; Read bytes: 8192; Write bytes: 259055616; Read time: 128; Write time: 200576 04:49:52 INFO - Running post-run listener: _upload_blobber_files 04:49:52 INFO - Blob upload gear active. 04:49:52 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:49:52 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 04:49:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:49:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:49:52 INFO - (blobuploader) - INFO - Open directory for files ... 04:49:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 04:49:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:49:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:49:54 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 04:49:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:49:54 INFO - (blobuploader) - INFO - Done attempting. 04:49:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:49:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:49:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:49:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:49:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:49:55 INFO - (blobuploader) - INFO - Done attempting. 04:49:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:49:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:49:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:49:58 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:49:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:49:58 INFO - (blobuploader) - INFO - Done attempting. 04:49:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:49:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:49:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:49:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:49:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:49:59 INFO - (blobuploader) - INFO - Done attempting. 04:49:59 INFO - (blobuploader) - INFO - Iteration through files over. 04:49:59 INFO - Return code: 0 04:49:59 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:49:59 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:49:59 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3bb81dd7c4fa64b1050af9d17942d872a533eda9a01d470d50eeaf78d18d14ede744bd302d5a0474a767bf7300a049f7208061137d5f330837c33774557e3187", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7a988e1ead7e4d47d600840fce3499c779a6b9e99a712df849210df70b9447d18eced878b05abcc2dca0d36bc60f6fcd3b564789a7707e6f9c653c15bf450b4d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b1504c57c342bcc483e20c8f808f18ab65ef5cc6e48adefedab590c4a2a244a42ade3221f90f6e3891491469520f8d1de04b89053177fe4d6424c9bd6683fa3f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/91c0cfbc9cb475062373ff25bd60798cfa06c2cc8a13d0a62087c38b382032c8bbbd4db12e32cbc4ce25e486ac829e785c9b8308c48c41541580ac60a1cf333d"} 04:49:59 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:49:59 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:49:59 INFO - Contents: 04:49:59 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3bb81dd7c4fa64b1050af9d17942d872a533eda9a01d470d50eeaf78d18d14ede744bd302d5a0474a767bf7300a049f7208061137d5f330837c33774557e3187", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7a988e1ead7e4d47d600840fce3499c779a6b9e99a712df849210df70b9447d18eced878b05abcc2dca0d36bc60f6fcd3b564789a7707e6f9c653c15bf450b4d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b1504c57c342bcc483e20c8f808f18ab65ef5cc6e48adefedab590c4a2a244a42ade3221f90f6e3891491469520f8d1de04b89053177fe4d6424c9bd6683fa3f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/91c0cfbc9cb475062373ff25bd60798cfa06c2cc8a13d0a62087c38b382032c8bbbd4db12e32cbc4ce25e486ac829e785c9b8308c48c41541580ac60a1cf333d"} 04:49:59 INFO - Running post-run listener: copy_logs_to_upload_dir 04:49:59 INFO - Copying logs to upload dir... 04:49:59 INFO - mkdir: /builds/slave/test/build/upload/logs 04:49:59 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1259.910469 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2017-03-31 04:49:58.628989) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-31 04:49:58.632565) ========= 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=826874ccc97bd7bf541b4875000001d5-1490959737.771741-1957698411 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3bb81dd7c4fa64b1050af9d17942d872a533eda9a01d470d50eeaf78d18d14ede744bd302d5a0474a767bf7300a049f7208061137d5f330837c33774557e3187", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7a988e1ead7e4d47d600840fce3499c779a6b9e99a712df849210df70b9447d18eced878b05abcc2dca0d36bc60f6fcd3b564789a7707e6f9c653c15bf450b4d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b1504c57c342bcc483e20c8f808f18ab65ef5cc6e48adefedab590c4a2a244a42ade3221f90f6e3891491469520f8d1de04b89053177fe4d6424c9bd6683fa3f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/91c0cfbc9cb475062373ff25bd60798cfa06c2cc8a13d0a62087c38b382032c8bbbd4db12e32cbc4ce25e486ac829e785c9b8308c48c41541580ac60a1cf333d"} build_url:https://queue.taskcluster.net/v1/task/FziPe46tTL-TfFHS0Z7sXw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011417 build_url: 'https://queue.taskcluster.net/v1/task/FziPe46tTL-TfFHS0Z7sXw/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3bb81dd7c4fa64b1050af9d17942d872a533eda9a01d470d50eeaf78d18d14ede744bd302d5a0474a767bf7300a049f7208061137d5f330837c33774557e3187", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7a988e1ead7e4d47d600840fce3499c779a6b9e99a712df849210df70b9447d18eced878b05abcc2dca0d36bc60f6fcd3b564789a7707e6f9c653c15bf450b4d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b1504c57c342bcc483e20c8f808f18ab65ef5cc6e48adefedab590c4a2a244a42ade3221f90f6e3891491469520f8d1de04b89053177fe4d6424c9bd6683fa3f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/91c0cfbc9cb475062373ff25bd60798cfa06c2cc8a13d0a62087c38b382032c8bbbd4db12e32cbc4ce25e486ac829e785c9b8308c48c41541580ac60a1cf333d"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-31 04:49:58.660247) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-31 04:49:58.660602) ========= 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=826874ccc97bd7bf541b4875000001d5-1490959737.771741-1957698411 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004492 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-31 04:49:58.745145) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-31 04:49:58.745462) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-31 04:49:58.745780) ========= ========= Total master_lag: 0.16 =========