builder: mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s slave: talos-linux64-ix-072 starttime: 1495083322.1 results: success (0) revision: 0b529227685dc071774480f756bf41dff7068452 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-17 21:55:22.100353) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-17 21:55:22.100859) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-17 21:55:22.101153) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-17 21:55:22.117099) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-17 21:55:22.117427) ========= 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=199fb4c72b90437b990b419b000001c5-1495077469.137364-1482554342 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-17 21:55:23-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 42.0M=0s 2017-05-17 21:55:23 (42.0 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.126626 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-17 21:55:22.262460) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-17 21:55:22.262795) ========= 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=199fb4c72b90437b990b419b000001c5-1495077469.137364-1482554342 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017504 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-17 21:55:22.312928) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-17 21:55:22.313234) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 0b529227685dc071774480f756bf41dff7068452 --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 0b529227685dc071774480f756bf41dff7068452 --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=199fb4c72b90437b990b419b000001c5-1495077469.137364-1482554342 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-17 21:55:23,522 truncating revision to first 12 chars 2017-05-17 21:55:23,522 Setting DEBUG logging. 2017-05-17 21:55:23,522 attempt 1/10 2017-05-17 21:55:23,522 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/0b529227685d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-17 21:55:23,835 unpacking tar archive at: mozilla-central-0b529227685d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.660852 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-17 21:55:22.989068) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-17 21:55:22.989605) ========= script_repo_revision: 0b529227685dc071774480f756bf41dff7068452 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-17 21:55:22.990195) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-17 21:55:22.990615) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-17 21:55:23.000501) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2017-05-17 21:55:23.000779) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=199fb4c72b90437b990b419b000001c5-1495077469.137364-1482554342 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 21:55:24 INFO - MultiFileLogger online at 20170517 21:55:24 in /builds/slave/test 21:55:24 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 21:55:24 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:55:24 INFO - {'append_to_log': False, 21:55:24 INFO - 'base_work_dir': '/builds/slave/test', 21:55:24 INFO - 'blob_upload_branch': 'Firefox', 21:55:24 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:55:24 INFO - 'branch': 'Firefox', 21:55:24 INFO - 'buildbot_json_path': 'buildprops.json', 21:55:24 INFO - 'config_files': ('talos/linux_config.py',), 21:55:24 INFO - 'default_actions': ('clobber', 21:55:24 INFO - 'read-buildbot-config', 21:55:24 INFO - 'download-and-extract', 21:55:24 INFO - 'populate-webroot', 21:55:24 INFO - 'create-virtualenv', 21:55:24 INFO - 'install', 21:55:24 INFO - 'run-tests'), 21:55:24 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:55:24 INFO - 'download_minidump_stackwalk': True, 21:55:24 INFO - 'download_symbols': 'ondemand', 21:55:24 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:55:24 INFO - 'tooltool.py': '/tools/tooltool.py', 21:55:24 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:55:24 INFO - '/tools/misc-python/virtualenv.py')}, 21:55:24 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:55:24 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:55:24 INFO - 'gecko_profile': False, 21:55:24 INFO - 'gecko_profile_interval': 0, 21:55:24 INFO - 'installer_path': 'installer.exe', 21:55:24 INFO - 'log_level': 'info', 21:55:24 INFO - 'log_name': 'talos', 21:55:24 INFO - 'log_to_console': True, 21:55:24 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 21:55:24 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 21:55:24 INFO - 'opt_config_files': (), 21:55:24 INFO - 'pip_index': False, 21:55:24 INFO - 'suite': 'dromaeojs-e10s', 21:55:24 INFO - 'system_bits': '32', 21:55:24 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:55:24 INFO - 'title': 'talos-linux64-ix-072', 21:55:24 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:55:24 INFO - 'use_talos_json': True, 21:55:24 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:55:24 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:55:24 INFO - 'work_dir': 'build'} 21:55:24 INFO - [mozharness: 2017-05-18 04:55:24.305976Z] Running clobber step. 21:55:24 INFO - Running pre-action listener: _resource_record_pre_action 21:55:24 INFO - Running main action method: clobber 21:55:24 INFO - rmtree: /builds/slave/test/build 21:55:24 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:55:25 INFO - Running post-action listener: _resource_record_post_action 21:55:25 INFO - [mozharness: 2017-05-18 04:55:25.816896Z] Finished clobber step (success) 21:55:25 INFO - [mozharness: 2017-05-18 04:55:25.816995Z] Running read-buildbot-config step. 21:55:25 INFO - Running pre-action listener: _resource_record_pre_action 21:55:25 INFO - Running main action method: read_buildbot_config 21:55:25 INFO - Using buildbot properties: 21:55:25 INFO - { 21:55:25 INFO - "project": "", 21:55:25 INFO - "product": "firefox", 21:55:25 INFO - "who": "ihsiao@mozilla.com", 21:55:25 INFO - "installer_path": "public/build/target.tar.bz2", 21:55:25 INFO - "builddir": "mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s", 21:55:25 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 21:55:25 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo mozilla-central talos dromaeojs-e10s", 21:55:25 INFO - "stage_platform": "linux64-stylo", 21:55:25 INFO - "basedir": "/builds/slave/test", 21:55:25 INFO - "buildnumber": 95, 21:55:25 INFO - "platform": "ubuntu64_hw_stylo", 21:55:25 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 21:55:25 INFO - "slavebuilddir": "test", 21:55:25 INFO - "taskId": "McWpa6y8Sk-8DnpfNdzM_A", 21:55:25 INFO - "branch": "mozilla-central", 21:55:25 INFO - "script_repo_revision": "production", 21:55:25 INFO - "revision": "0b529227685dc071774480f756bf41dff7068452", 21:55:25 INFO - "slavename": "talos-linux64-ix-072", 21:55:25 INFO - "repo_path": "mozilla-central" 21:55:25 INFO - } 21:55:25 INFO - Finding installer, test and symbols from parent task. 21:55:25 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/McWpa6y8Sk-8DnpfNdzM_A'}, attempt #1 21:55:26 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/McWpa6y8Sk-8DnpfNdzM_A'}, attempt #1 21:55:26 INFO - Task dependencies: Ng2ZE6IuS9S32HYlv8C-HA 21:55:26 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ng2ZE6IuS9S32HYlv8C-HA'}, attempt #1 21:55:27 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/Ng2ZE6IuS9S32HYlv8C-HA/artifacts/public/build/target.tar.bz2 21:55:27 INFO - Set test_url: https://queue.taskcluster.net/v1/task/Ng2ZE6IuS9S32HYlv8C-HA/artifacts/public/build/test_packages.json 21:55:27 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/Ng2ZE6IuS9S32HYlv8C-HA/artifacts/public/build/target.crashreporter-symbols.zip 21:55:27 INFO - Running post-action listener: _resource_record_post_action 21:55:27 INFO - [mozharness: 2017-05-18 04:55:27.288215Z] Finished read-buildbot-config step (success) 21:55:27 INFO - [mozharness: 2017-05-18 04:55:27.288435Z] Running download-and-extract step. 21:55:27 INFO - Running pre-action listener: _resource_record_pre_action 21:55:27 INFO - Running main action method: download_and_extract 21:55:27 INFO - mkdir: /builds/slave/test/build/tests 21:55:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 21:55:27 INFO - trying https://queue.taskcluster.net/v1/task/Ng2ZE6IuS9S32HYlv8C-HA/artifacts/public/build/target.test_packages.json 21:55:27 INFO - Downloading https://queue.taskcluster.net/v1/task/Ng2ZE6IuS9S32HYlv8C-HA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 21:55:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ng2ZE6IuS9S32HYlv8C-HA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 21:55:27 INFO - Downloaded 986 bytes. 21:55:27 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 21:55:27 INFO - Using the following test package requirements: 21:55:27 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 21:55:27 INFO - u'common': [u'target.common.tests.zip'], 21:55:27 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 21:55:27 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 21:55:27 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 21:55:27 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 21:55:27 INFO - u'mozbase': [u'target.common.tests.zip'], 21:55:27 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 21:55:27 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 21:55:27 INFO - u'web-platform': [u'target.common.tests.zip', 21:55:27 INFO - u'target.web-platform.tests.zip'], 21:55:27 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 21:55:27 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 21:55:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Ng2ZE6IuS9S32HYlv8C-HA/artifacts/public/build/target.common.tests.zip 21:55:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ng2ZE6IuS9S32HYlv8C-HA/artifacts/public/build/target.common.tests.zip'}, attempt #1 21:55:27 INFO - Fetch https://queue.taskcluster.net/v1/task/Ng2ZE6IuS9S32HYlv8C-HA/artifacts/public/build/target.common.tests.zip into memory 21:55:30 INFO - Content-Length response header: 62459748 21:55:30 INFO - Bytes received: 62459748 21:55:40 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 21:55:40 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Ng2ZE6IuS9S32HYlv8C-HA/artifacts/public/build/target.common.tests.zip 21:55:40 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ng2ZE6IuS9S32HYlv8C-HA/artifacts/public/build/target.common.tests.zip'}, attempt #1 21:55:40 INFO - Fetch https://queue.taskcluster.net/v1/task/Ng2ZE6IuS9S32HYlv8C-HA/artifacts/public/build/target.common.tests.zip into memory 21:55:42 INFO - Content-Length response header: 62459748 21:55:42 INFO - Bytes received: 62459748 21:55:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Ng2ZE6IuS9S32HYlv8C-HA/artifacts/public/build/target.talos.tests.zip 21:55:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ng2ZE6IuS9S32HYlv8C-HA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 21:55:53 INFO - Fetch https://queue.taskcluster.net/v1/task/Ng2ZE6IuS9S32HYlv8C-HA/artifacts/public/build/target.talos.tests.zip into memory 21:55:54 INFO - Content-Length response header: 14410001 21:55:54 INFO - Bytes received: 14410001 21:55:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 21:55:54 INFO - trying https://queue.taskcluster.net/v1/task/Ng2ZE6IuS9S32HYlv8C-HA/artifacts/public/build/target.tar.bz2 21:55:54 INFO - Downloading https://queue.taskcluster.net/v1/task/Ng2ZE6IuS9S32HYlv8C-HA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 21:55:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ng2ZE6IuS9S32HYlv8C-HA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 21:55:57 INFO - Downloaded 59722408 bytes. 21:55:57 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Ng2ZE6IuS9S32HYlv8C-HA/artifacts/public/build/target.tar.bz2 21:55:57 INFO - mkdir: /builds/slave/test/properties 21:55:57 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:55:57 INFO - Writing to file /builds/slave/test/properties/build_url 21:55:57 INFO - Contents: 21:55:57 INFO - build_url:https://queue.taskcluster.net/v1/task/Ng2ZE6IuS9S32HYlv8C-HA/artifacts/public/build/target.tar.bz2 21:55:57 INFO - Running post-action listener: _resource_record_post_action 21:55:57 INFO - Running post-action listener: set_extra_try_arguments 21:55:57 INFO - [mozharness: 2017-05-18 04:55:57.625645Z] Finished download-and-extract step (success) 21:55:57 INFO - [mozharness: 2017-05-18 04:55:57.625874Z] Running populate-webroot step. 21:55:57 INFO - Running pre-action listener: _resource_record_pre_action 21:55:57 INFO - Running main action method: populate_webroot 21:55:57 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:55:57 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:55:57 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:55:57 INFO - '--tppagecycles', 21:55:57 INFO - '7'], 21:55:57 INFO - 'tests': ['tsvgm']}}, 21:55:57 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 21:55:57 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:55:57 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 21:55:57 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 21:55:57 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:55:57 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 21:55:57 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 21:55:57 INFO - 'talos_options': ['--disable-e10s'], 21:55:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:55:57 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 21:55:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:55:57 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 21:55:57 INFO - 'talos_options': ['--disable-e10s'], 21:55:57 INFO - 'tests': ['damp', 'tps']}, 21:55:57 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 21:55:57 INFO - 'tests': ['damp', 'tps']}, 21:55:57 INFO - 'g3': {'talos_options': ['--disable-e10s'], 21:55:57 INFO - 'tests': ['dromaeo_dom']}, 21:55:57 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:55:57 INFO - 'g4': {'talos_options': ['--disable-e10s'], 21:55:57 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 21:55:57 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 21:55:57 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 21:55:57 INFO - 'tests': ['ts_paint', 'tp5o']}, 21:55:57 INFO - 'other': {'talos_options': ['--disable-e10s'], 21:55:57 INFO - 'tests': ['a11yr', 21:55:57 INFO - 'ts_paint', 21:55:57 INFO - 'tpaint', 21:55:57 INFO - 'sessionrestore', 21:55:57 INFO - 'sessionrestore_no_auto_restore', 21:55:57 INFO - 'tabpaint']}, 21:55:57 INFO - 'other-e10s': {'tests': ['a11yr', 21:55:57 INFO - 'ts_paint', 21:55:57 INFO - 'tpaint', 21:55:57 INFO - 'sessionrestore', 21:55:57 INFO - 'sessionrestore_no_auto_restore', 21:55:57 INFO - 'tabpaint']}, 21:55:57 INFO - 'other-e10s_l64': {'tests': ['a11yr', 21:55:57 INFO - 'ts_paint', 21:55:57 INFO - 'tpaint', 21:55:57 INFO - 'sessionrestore', 21:55:57 INFO - 'sessionrestore_no_auto_restore', 21:55:57 INFO - 'tabpaint']}, 21:55:57 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 21:55:57 INFO - 'ts_paint', 21:55:57 INFO - 'tpaint', 21:55:57 INFO - 'sessionrestore', 21:55:57 INFO - 'sessionrestore_no_auto_restore', 21:55:57 INFO - 'tabpaint']}, 21:55:57 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 21:55:57 INFO - 'tests': ['a11yr', 21:55:57 INFO - 'ts_paint', 21:55:57 INFO - 'tpaint', 21:55:57 INFO - 'sessionrestore', 21:55:57 INFO - 'sessionrestore_no_auto_restore', 21:55:57 INFO - 'tabpaint']}, 21:55:57 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 21:55:57 INFO - 'tests': ['a11yr', 21:55:57 INFO - 'ts_paint', 21:55:57 INFO - 'tpaint', 21:55:57 INFO - 'sessionrestore', 21:55:57 INFO - 'sessionrestore_no_auto_restore', 21:55:57 INFO - 'tabpaint']}, 21:55:57 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 21:55:57 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 21:55:57 INFO - 'bloom_basic_ref']}, 21:55:57 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 21:55:57 INFO - 'tests': ['tsvgx', 21:55:57 INFO - 'tsvgr_opacity', 21:55:57 INFO - 'tart', 21:55:57 INFO - 'tscrollx', 21:55:57 INFO - 'cart', 21:55:57 INFO - 'tsvg_static']}, 21:55:57 INFO - 'svgr-e10s': {'tests': ['tsvgx', 21:55:57 INFO - 'tsvgr_opacity', 21:55:57 INFO - 'tart', 21:55:57 INFO - 'tscrollx', 21:55:57 INFO - 'cart', 21:55:57 INFO - 'tsvg_static']}, 21:55:57 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 21:55:57 INFO - 'talos_options': ['--disable-e10s'], 21:55:57 INFO - 'tests': ['tp5o']}, 21:55:57 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 21:55:57 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 21:55:57 INFO - 'talos_options': ['--disable-e10s', 21:55:57 INFO - '--xperf_path', 21:55:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:55:57 INFO - 'tests': ['tp5n']}, 21:55:57 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 21:55:57 INFO - 'talos_options': ['--xperf_path', 21:55:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:55:57 INFO - 'tests': ['tp5n']}}, 21:55:57 INFO - 'talos.zip': {'path': '', 21:55:57 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:55:57 INFO - Running post-action listener: _resource_record_post_action 21:55:57 INFO - [mozharness: 2017-05-18 04:55:57.641978Z] Finished populate-webroot step (success) 21:55:57 INFO - [mozharness: 2017-05-18 04:55:57.642066Z] Running create-virtualenv step. 21:55:57 INFO - Running pre-action listener: _resource_record_pre_action 21:55:57 INFO - Running main action method: create_virtualenv 21:55:57 INFO - Creating virtualenv /builds/slave/test/build/venv 21:55:57 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 21:55:57 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:55:57 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:55:57 INFO - Using real prefix '/usr' 21:55:57 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:55:58 INFO - Installing distribute.............................................................................................................................................................................................done. 21:56:00 INFO - Installing pip.................done. 21:56:00 INFO - Return code: 0 21:56:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 21:56:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 21:56:00 INFO - Reading from file tmpfile_stdout 21:56:00 INFO - Output received: 21:56:00 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) 21:56:00 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:56:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 21:56:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:56:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 21:56:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:56:00 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/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 0x15451f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1712a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18b85c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18b57a0>, '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 0x18b66a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18b6b30>, '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': '199fb4c72b90437b990b419b000001c5-1495077469.137364-1482554342', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:56:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 21:56:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 21:56:00 INFO - Using env: {'DISPLAY': ':0', 21:56:00 INFO - 'HOME': '/home/cltbld', 21:56:00 INFO - 'LANG': 'en_US.UTF-8', 21:56:00 INFO - 'LANGUAGE': 'en_US:en', 21:56:00 INFO - 'LOGNAME': 'cltbld', 21:56:00 INFO - 'MAIL': '/var/mail/cltbld', 21:56:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:56:00 INFO - 'MOZ_NO_REMOTE': '1', 21:56:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:56:00 INFO - 'NO_EM_RESTART': '1', 21:56:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:56:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:56:00 INFO - 'PWD': '/builds/slave/test', 21:56:00 INFO - 'SHELL': '/bin/bash', 21:56:00 INFO - 'SHLVL': '1', 21:56:00 INFO - 'TERM': 'linux', 21:56:00 INFO - 'TMOUT': '86400', 21:56:00 INFO - 'USER': 'cltbld', 21:56:00 INFO - 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1495077469.137364-1482554342', 21:56:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:56:00 INFO - '_': '/tools/buildbot/bin/python'} 21:56:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:56:00 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 21:56:00 INFO - Cleaning up... 21:56:00 INFO - Return code: 0 21:56:00 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 21:56:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 21:56:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:56:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 21:56:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:56:00 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/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 0x15451f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1712a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18b85c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18b57a0>, '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 0x18b66a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18b6b30>, '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': '199fb4c72b90437b990b419b000001c5-1495077469.137364-1482554342', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:56:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 21:56:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 21:56:00 INFO - Using env: {'DISPLAY': ':0', 21:56:00 INFO - 'HOME': '/home/cltbld', 21:56:00 INFO - 'LANG': 'en_US.UTF-8', 21:56:00 INFO - 'LANGUAGE': 'en_US:en', 21:56:00 INFO - 'LOGNAME': 'cltbld', 21:56:00 INFO - 'MAIL': '/var/mail/cltbld', 21:56:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:56:00 INFO - 'MOZ_NO_REMOTE': '1', 21:56:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:56:00 INFO - 'NO_EM_RESTART': '1', 21:56:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:56:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:56:00 INFO - 'PWD': '/builds/slave/test', 21:56:00 INFO - 'SHELL': '/bin/bash', 21:56:00 INFO - 'SHLVL': '1', 21:56:00 INFO - 'TERM': 'linux', 21:56:00 INFO - 'TMOUT': '86400', 21:56:00 INFO - 'USER': 'cltbld', 21:56:00 INFO - 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1495077469.137364-1482554342', 21:56:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:56:00 INFO - '_': '/tools/buildbot/bin/python'} 21:56:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:56:00 INFO - Downloading/unpacking psutil>=3.1.1 21:56:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:56:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:56:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:56:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:56:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:56:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:56:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:56:02 INFO - Installing collected packages: psutil 21:56:02 INFO - Running setup.py install for psutil 21:56:02 INFO - building 'psutil._psutil_linux' extension 21:56:02 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 21:56:02 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 21:56:02 INFO - building 'psutil._psutil_posix' extension 21:56:02 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 21:56:02 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 21:56:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:56:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:56:02 INFO - Successfully installed psutil 21:56:02 INFO - Cleaning up... 21:56:02 INFO - Return code: 0 21:56:02 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 21:56:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 21:56:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:56:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 21:56:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:56:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x15451f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1712a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18b85c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18b57a0>, '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 0x18b66a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18b6b30>, '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': '199fb4c72b90437b990b419b000001c5-1495077469.137364-1482554342', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:56:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 21:56:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 21:56:02 INFO - Using env: {'DISPLAY': ':0', 21:56:02 INFO - 'HOME': '/home/cltbld', 21:56:02 INFO - 'LANG': 'en_US.UTF-8', 21:56:02 INFO - 'LANGUAGE': 'en_US:en', 21:56:02 INFO - 'LOGNAME': 'cltbld', 21:56:02 INFO - 'MAIL': '/var/mail/cltbld', 21:56:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:56:02 INFO - 'MOZ_NO_REMOTE': '1', 21:56:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:56:02 INFO - 'NO_EM_RESTART': '1', 21:56:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:56:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:56:02 INFO - 'PWD': '/builds/slave/test', 21:56:02 INFO - 'SHELL': '/bin/bash', 21:56:02 INFO - 'SHLVL': '1', 21:56:02 INFO - 'TERM': 'linux', 21:56:02 INFO - 'TMOUT': '86400', 21:56:02 INFO - 'USER': 'cltbld', 21:56:02 INFO - 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1495077469.137364-1482554342', 21:56:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:56:02 INFO - '_': '/tools/buildbot/bin/python'} 21:56:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:56:02 INFO - Downloading/unpacking mozsystemmonitor==0.3 21:56:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:56:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:56:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:56:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:56:03 INFO - Downloading mozsystemmonitor-0.3.tar.gz 21:56:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:56:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 21:56:03 INFO - Installing collected packages: mozsystemmonitor 21:56:03 INFO - Running setup.py install for mozsystemmonitor 21:56:04 INFO - Successfully installed mozsystemmonitor 21:56:04 INFO - Cleaning up... 21:56:04 INFO - Return code: 0 21:56:04 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 21:56:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 21:56:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:56:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 21:56:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:56:04 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/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 0x15451f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1712a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18b85c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18b57a0>, '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 0x18b66a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18b6b30>, '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': '199fb4c72b90437b990b419b000001c5-1495077469.137364-1482554342', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:56:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 21:56:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 21:56:04 INFO - Using env: {'DISPLAY': ':0', 21:56:04 INFO - 'HOME': '/home/cltbld', 21:56:04 INFO - 'LANG': 'en_US.UTF-8', 21:56:04 INFO - 'LANGUAGE': 'en_US:en', 21:56:04 INFO - 'LOGNAME': 'cltbld', 21:56:04 INFO - 'MAIL': '/var/mail/cltbld', 21:56:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:56:04 INFO - 'MOZ_NO_REMOTE': '1', 21:56:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:56:04 INFO - 'NO_EM_RESTART': '1', 21:56:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:56:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:56:04 INFO - 'PWD': '/builds/slave/test', 21:56:04 INFO - 'SHELL': '/bin/bash', 21:56:04 INFO - 'SHLVL': '1', 21:56:04 INFO - 'TERM': 'linux', 21:56:04 INFO - 'TMOUT': '86400', 21:56:04 INFO - 'USER': 'cltbld', 21:56:04 INFO - 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1495077469.137364-1482554342', 21:56:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:56:04 INFO - '_': '/tools/buildbot/bin/python'} 21:56:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:56:04 INFO - Downloading/unpacking jsonschema==2.5.1 21:56:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:56:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:56:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:56:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:56:05 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:56:05 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 21:56:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:56:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:56:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:56:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:56:05 INFO - Downloading functools32-3.2.3-2.tar.gz 21:56:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:56:05 INFO - warning: no files found matching '*.txt' 21:56:05 INFO - no previously-included directories found matching 'build' 21:56:05 INFO - no previously-included directories found matching 'dist' 21:56:05 INFO - no previously-included directories found matching '.git*' 21:56:05 INFO - Installing collected packages: jsonschema, functools32 21:56:05 INFO - Running setup.py install for functools32 21:56:05 INFO - warning: no files found matching '*.txt' 21:56:05 INFO - no previously-included directories found matching 'build' 21:56:05 INFO - no previously-included directories found matching 'dist' 21:56:05 INFO - no previously-included directories found matching '.git*' 21:56:05 INFO - Successfully installed jsonschema functools32 21:56:05 INFO - Cleaning up... 21:56:05 INFO - Return code: 0 21:56:05 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 21:56:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 21:56:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:56:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 21:56:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:56:05 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/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 0x15451f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1712a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18b85c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18b57a0>, '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 0x18b66a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18b6b30>, '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': '199fb4c72b90437b990b419b000001c5-1495077469.137364-1482554342', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:56:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--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 21:56:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 21:56:05 INFO - Using env: {'DISPLAY': ':0', 21:56:05 INFO - 'HOME': '/home/cltbld', 21:56:05 INFO - 'LANG': 'en_US.UTF-8', 21:56:05 INFO - 'LANGUAGE': 'en_US:en', 21:56:05 INFO - 'LOGNAME': 'cltbld', 21:56:05 INFO - 'MAIL': '/var/mail/cltbld', 21:56:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:56:05 INFO - 'MOZ_NO_REMOTE': '1', 21:56:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:56:05 INFO - 'NO_EM_RESTART': '1', 21:56:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:56:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:56:05 INFO - 'PWD': '/builds/slave/test', 21:56:05 INFO - 'SHELL': '/bin/bash', 21:56:05 INFO - 'SHLVL': '1', 21:56:05 INFO - 'TERM': 'linux', 21:56:05 INFO - 'TMOUT': '86400', 21:56:05 INFO - 'USER': 'cltbld', 21:56:05 INFO - 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1495077469.137364-1482554342', 21:56:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:56:05 INFO - '_': '/tools/buildbot/bin/python'} 21:56:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:56:06 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 21:56:06 INFO - Cleaning up... 21:56:06 INFO - Return code: 0 21:56:06 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:56:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 21:56:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:56:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 21:56:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:56:06 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/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 0x15451f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1712a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18b85c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18b57a0>, '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 0x18b66a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18b6b30>, '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': '199fb4c72b90437b990b419b000001c5-1495077469.137364-1482554342', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:56:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 21:56:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 21:56:06 INFO - Using env: {'DISPLAY': ':0', 21:56:06 INFO - 'HOME': '/home/cltbld', 21:56:06 INFO - 'LANG': 'en_US.UTF-8', 21:56:06 INFO - 'LANGUAGE': 'en_US:en', 21:56:06 INFO - 'LOGNAME': 'cltbld', 21:56:06 INFO - 'MAIL': '/var/mail/cltbld', 21:56:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:56:06 INFO - 'MOZ_NO_REMOTE': '1', 21:56:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:56:06 INFO - 'NO_EM_RESTART': '1', 21:56:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:56:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:56:06 INFO - 'PWD': '/builds/slave/test', 21:56:06 INFO - 'SHELL': '/bin/bash', 21:56:06 INFO - 'SHLVL': '1', 21:56:06 INFO - 'TERM': 'linux', 21:56:06 INFO - 'TMOUT': '86400', 21:56:06 INFO - 'USER': 'cltbld', 21:56:06 INFO - 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1495077469.137364-1482554342', 21:56:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:56:06 INFO - '_': '/tools/buildbot/bin/python'} 21:56:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:56:06 INFO - Downloading/unpacking blobuploader==1.2.4 21:56:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:56:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:56:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:56:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:56:07 INFO - Downloading blobuploader-1.2.4.tar.gz 21:56:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:56:07 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:56:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:56:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:56:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:56:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:56:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:56:07 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:56:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:56:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:56:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:56:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:56:07 INFO - Downloading docopt-0.6.1.tar.gz 21:56:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:56:07 INFO - Installing collected packages: blobuploader, requests, docopt 21:56:07 INFO - Running setup.py install for blobuploader 21:56:08 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:56:08 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:56:08 INFO - Running setup.py install for requests 21:56:08 INFO - Running setup.py install for docopt 21:56:08 INFO - Successfully installed blobuploader requests docopt 21:56:08 INFO - Cleaning up... 21:56:08 INFO - Return code: 0 21:56:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:56:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 21:56:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:56:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 21:56:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:56:08 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/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 0x15451f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1712a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18b85c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18b57a0>, '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 0x18b66a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18b6b30>, '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': '199fb4c72b90437b990b419b000001c5-1495077469.137364-1482554342', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:56:08 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/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 21:56:08 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/pub --find-links http://pypi.pub.build.mozilla.org/pub 21:56:08 INFO - Using env: {'DISPLAY': ':0', 21:56:08 INFO - 'HOME': '/home/cltbld', 21:56:08 INFO - 'LANG': 'en_US.UTF-8', 21:56:08 INFO - 'LANGUAGE': 'en_US:en', 21:56:08 INFO - 'LOGNAME': 'cltbld', 21:56:08 INFO - 'MAIL': '/var/mail/cltbld', 21:56:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:56:08 INFO - 'MOZ_NO_REMOTE': '1', 21:56:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:56:08 INFO - 'NO_EM_RESTART': '1', 21:56:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:56:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:56:08 INFO - 'PWD': '/builds/slave/test', 21:56:08 INFO - 'SHELL': '/bin/bash', 21:56:08 INFO - 'SHLVL': '1', 21:56:08 INFO - 'TERM': 'linux', 21:56:08 INFO - 'TMOUT': '86400', 21:56:08 INFO - 'USER': 'cltbld', 21:56:08 INFO - 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1495077469.137364-1482554342', 21:56:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:56:08 INFO - '_': '/tools/buildbot/bin/python'} 21:56:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:56:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:56:08 INFO - Running setup.py (path:/tmp/pip-zNf56J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:56:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:56:08 INFO - Running setup.py (path:/tmp/pip-2uQd2j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:56:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:56:08 INFO - Running setup.py (path:/tmp/pip-d5xowv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:56:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:56:08 INFO - Running setup.py (path:/tmp/pip-64wxJa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:56:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:56:09 INFO - Running setup.py (path:/tmp/pip-3JLBxH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:56:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:56:09 INFO - Running setup.py (path:/tmp/pip-mihzF8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:56:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:56:09 INFO - Running setup.py (path:/tmp/pip-8be371-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:56:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:56:09 INFO - Running setup.py (path:/tmp/pip-RMVcrl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:56:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:56:09 INFO - Running setup.py (path:/tmp/pip-3vQfbg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:56:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:56:09 INFO - Running setup.py (path:/tmp/pip-b_VN1s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:56:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:56:09 INFO - Running setup.py (path:/tmp/pip-D8obh_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:56:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:56:09 INFO - Running setup.py (path:/tmp/pip-i8ilFU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:56:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:56:09 INFO - Running setup.py (path:/tmp/pip-G03nBn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:56:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:56:09 INFO - Running setup.py (path:/tmp/pip-_iagti-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:56:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:56:09 INFO - Running setup.py (path:/tmp/pip-wTsxJj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:56:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:56:09 INFO - Running setup.py (path:/tmp/pip-QDGbfY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:56:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:56:09 INFO - Running setup.py (path:/tmp/pip-GbI8iC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:56:09 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:56:09 INFO - Running setup.py install for manifestparser 21:56:10 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:56:10 INFO - Running setup.py install for mozcrash 21:56:10 INFO - Running setup.py install for mozdebug 21:56:10 INFO - Running setup.py install for mozdevice 21:56:10 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:56:10 INFO - Running setup.py install for mozfile 21:56:10 INFO - Running setup.py install for mozhttpd 21:56:10 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:56:10 INFO - Running setup.py install for mozinfo 21:56:10 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:56:10 INFO - Running setup.py install for mozInstall 21:56:10 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:56:10 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:56:10 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:56:10 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:56:10 INFO - Running setup.py install for mozleak 21:56:10 INFO - Running setup.py install for mozlog 21:56:10 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:56:11 INFO - Running setup.py install for moznetwork 21:56:11 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:56:11 INFO - Running setup.py install for mozprocess 21:56:11 INFO - Running setup.py install for mozprofile 21:56:11 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:56:11 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:56:11 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:56:11 INFO - Running setup.py install for mozrunner 21:56:11 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:56:11 INFO - Running setup.py install for mozscreenshot 21:56:11 INFO - Running setup.py install for moztest 21:56:11 INFO - Running setup.py install for mozversion 21:56:11 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:56:11 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:56:11 INFO - Cleaning up... 21:56:11 INFO - Return code: 0 21:56:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:56:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 21:56:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:56:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 21:56:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:56:11 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/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 0x15451f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1712a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18b85c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18b57a0>, '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 0x18b66a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18b6b30>, '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': '199fb4c72b90437b990b419b000001c5-1495077469.137364-1482554342', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:56:11 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/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 21:56:11 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/pub --find-links http://pypi.pub.build.mozilla.org/pub 21:56:11 INFO - Using env: {'DISPLAY': ':0', 21:56:11 INFO - 'HOME': '/home/cltbld', 21:56:11 INFO - 'LANG': 'en_US.UTF-8', 21:56:11 INFO - 'LANGUAGE': 'en_US:en', 21:56:11 INFO - 'LOGNAME': 'cltbld', 21:56:11 INFO - 'MAIL': '/var/mail/cltbld', 21:56:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:56:11 INFO - 'MOZ_NO_REMOTE': '1', 21:56:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:56:11 INFO - 'NO_EM_RESTART': '1', 21:56:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:56:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:56:11 INFO - 'PWD': '/builds/slave/test', 21:56:11 INFO - 'SHELL': '/bin/bash', 21:56:11 INFO - 'SHLVL': '1', 21:56:11 INFO - 'TERM': 'linux', 21:56:11 INFO - 'TMOUT': '86400', 21:56:11 INFO - 'USER': 'cltbld', 21:56:11 INFO - 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1495077469.137364-1482554342', 21:56:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:56:11 INFO - '_': '/tools/buildbot/bin/python'} 21:56:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:56:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:56:11 INFO - Running setup.py (path:/tmp/pip-WsUxvW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:56:12 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 21:56:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:56:12 INFO - Running setup.py (path:/tmp/pip-mOhedt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:56:12 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)) 21:56:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:56:12 INFO - Running setup.py (path:/tmp/pip-wQbvdl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:56:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 21:56:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:56:12 INFO - Running setup.py (path:/tmp/pip-60q2Wd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:56:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.50 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 21:56:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:56:12 INFO - Running setup.py (path:/tmp/pip-livHAR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:56:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 21:56:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:56:12 INFO - Running setup.py (path:/tmp/pip-hbab6z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:56:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 21:56:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:56:12 INFO - Running setup.py (path:/tmp/pip-s3clyv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:56:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 21:56:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:56:12 INFO - Running setup.py (path:/tmp/pip-OCPmhG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:56:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 21:56:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:56:12 INFO - Running setup.py (path:/tmp/pip-VCqYK0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:56:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 21:56:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:56:12 INFO - Running setup.py (path:/tmp/pip-XhD8n3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:56:12 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)) 21:56:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:56:12 INFO - Running setup.py (path:/tmp/pip-82ptvR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:56:12 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 21:56:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:56:12 INFO - Running setup.py (path:/tmp/pip-c5_jEp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:56:12 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)) 21:56:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:56:12 INFO - Running setup.py (path:/tmp/pip-3BmclU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:56:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 21:56:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:56:12 INFO - Running setup.py (path:/tmp/pip-g9InWF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:56:13 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)) 21:56:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:56:13 INFO - Running setup.py (path:/tmp/pip-5NZAwZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:56:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 21:56:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:56:13 INFO - Running setup.py (path:/tmp/pip-vFRhlQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:56:13 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)) 21:56:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:56:13 INFO - Running setup.py (path:/tmp/pip-RWRaRw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:56:13 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)) 21:56:13 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)) 21:56:13 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)) 21:56:13 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)) 21:56:13 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 21:56:13 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 21:56:13 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:56:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:56:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:56:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:56:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:56:14 INFO - Downloading blessings-1.6.tar.gz 21:56:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:56:14 INFO - Installing collected packages: blessings 21:56:14 INFO - Running setup.py install for blessings 21:56:14 INFO - Successfully installed blessings 21:56:14 INFO - Cleaning up... 21:56:14 INFO - Return code: 0 21:56:14 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:56:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:56:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:56:14 INFO - Reading from file tmpfile_stdout 21:56:14 INFO - Current package versions: 21:56:14 INFO - argparse == 1.2.1 21:56:14 INFO - blessings == 1.6 21:56:14 INFO - blobuploader == 1.2.4 21:56:14 INFO - docopt == 0.6.1 21:56:14 INFO - functools32 == 3.2.3-2 21:56:14 INFO - jsonschema == 2.5.1 21:56:14 INFO - manifestparser == 1.1 21:56:14 INFO - mozInstall == 1.12 21:56:14 INFO - mozcrash == 1.0 21:56:14 INFO - mozdebug == 0.1 21:56:14 INFO - mozdevice == 0.50 21:56:14 INFO - mozfile == 1.2 21:56:14 INFO - mozhttpd == 0.7 21:56:14 INFO - mozinfo == 0.9 21:56:14 INFO - mozleak == 0.1 21:56:14 INFO - mozlog == 3.4 21:56:14 INFO - moznetwork == 0.27 21:56:14 INFO - mozprocess == 0.25 21:56:14 INFO - mozprofile == 0.28 21:56:14 INFO - mozrunner == 6.13 21:56:14 INFO - mozscreenshot == 0.1 21:56:14 INFO - mozsystemmonitor == 0.3 21:56:14 INFO - moztest == 0.8 21:56:14 INFO - mozversion == 1.4 21:56:14 INFO - psutil == 3.1.1 21:56:14 INFO - requests == 1.2.3 21:56:14 INFO - wsgiref == 0.1.2 21:56:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:56:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 21:56:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:56:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 21:56:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:56:14 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/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 0x15451f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1712a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18b85c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18b57a0>, '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 0x18b66a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18b6b30>, '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': '199fb4c72b90437b990b419b000001c5-1495077469.137364-1482554342', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:56:14 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/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 21:56:14 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/pub --find-links http://pypi.pub.build.mozilla.org/pub 21:56:14 INFO - Using env: {'DISPLAY': ':0', 21:56:14 INFO - 'HOME': '/home/cltbld', 21:56:14 INFO - 'LANG': 'en_US.UTF-8', 21:56:14 INFO - 'LANGUAGE': 'en_US:en', 21:56:14 INFO - 'LOGNAME': 'cltbld', 21:56:14 INFO - 'MAIL': '/var/mail/cltbld', 21:56:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:56:14 INFO - 'MOZ_NO_REMOTE': '1', 21:56:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:56:14 INFO - 'NO_EM_RESTART': '1', 21:56:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:56:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:56:14 INFO - 'PWD': '/builds/slave/test', 21:56:14 INFO - 'SHELL': '/bin/bash', 21:56:14 INFO - 'SHLVL': '1', 21:56:14 INFO - 'TERM': 'linux', 21:56:14 INFO - 'TMOUT': '86400', 21:56:14 INFO - 'USER': 'cltbld', 21:56:14 INFO - 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1495077469.137364-1482554342', 21:56:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:56:14 INFO - '_': '/tools/buildbot/bin/python'} 21:56:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:56:14 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)) 21:56:14 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)) 21:56:14 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)) 21:56:14 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)) 21:56:14 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)) 21:56:14 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)) 21:56:14 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)) 21:56:14 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)) 21:56:14 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)) 21:56:14 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)) 21:56:14 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)) 21:56:14 INFO - Cleaning up... 21:56:14 INFO - Return code: 0 21:56:14 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:56:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 21:56:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:56:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 21:56:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:56:15 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/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 0x15451f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1712a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18b85c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18b57a0>, '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 0x18b66a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18b6b30>, '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': '199fb4c72b90437b990b419b000001c5-1495077469.137364-1482554342', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:56:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 21:56:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 21:56:15 INFO - Using env: {'DISPLAY': ':0', 21:56:15 INFO - 'HOME': '/home/cltbld', 21:56:15 INFO - 'LANG': 'en_US.UTF-8', 21:56:15 INFO - 'LANGUAGE': 'en_US:en', 21:56:15 INFO - 'LOGNAME': 'cltbld', 21:56:15 INFO - 'MAIL': '/var/mail/cltbld', 21:56:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:56:15 INFO - 'MOZ_NO_REMOTE': '1', 21:56:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:56:15 INFO - 'NO_EM_RESTART': '1', 21:56:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:56:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:56:15 INFO - 'PWD': '/builds/slave/test', 21:56:15 INFO - 'SHELL': '/bin/bash', 21:56:15 INFO - 'SHLVL': '1', 21:56:15 INFO - 'TERM': 'linux', 21:56:15 INFO - 'TMOUT': '86400', 21:56:15 INFO - 'USER': 'cltbld', 21:56:15 INFO - 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1495077469.137364-1482554342', 21:56:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:56:15 INFO - '_': '/tools/buildbot/bin/python'} 21:56:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:56:15 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 21:56:15 INFO - Cleaning up... 21:56:15 INFO - Return code: 0 21:56:15 INFO - Running post-action listener: _resource_record_post_action 21:56:15 INFO - Running post-action listener: _start_resource_monitoring 21:56:15 INFO - Starting resource monitoring. 21:56:15 INFO - [mozharness: 2017-05-18 04:56:15.251053Z] Finished create-virtualenv step (success) 21:56:15 INFO - [mozharness: 2017-05-18 04:56:15.251510Z] Running install step. 21:56:15 INFO - Running pre-action listener: _resource_record_pre_action 21:56:15 INFO - Running main action method: install 21:56:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:56:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:56:15 INFO - Reading from file tmpfile_stdout 21:56:15 INFO - Detecting whether we're running mozinstall >=1.0... 21:56:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:56:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:56:15 INFO - Reading from file tmpfile_stdout 21:56:15 INFO - Output received: 21:56:15 INFO - Usage: mozinstall [options] installer 21:56:15 INFO - Options: 21:56:15 INFO - -h, --help show this help message and exit 21:56:15 INFO - -d DEST, --destination=DEST 21:56:15 INFO - Directory to install application into. [default: 21:56:15 INFO - "/builds/slave/test"] 21:56:15 INFO - --app=APP Application being installed. [default: firefox] 21:56:15 INFO - mkdir: /builds/slave/test/build/application 21:56:15 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'] 21:56:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 21:56:32 INFO - Reading from file tmpfile_stdout 21:56:32 INFO - Output received: 21:56:32 INFO - /builds/slave/test/build/application/firefox/firefox 21:56:32 INFO - Running post-action listener: _resource_record_post_action 21:56:32 INFO - [mozharness: 2017-05-18 04:56:32.820323Z] Finished install step (success) 21:56:32 INFO - [mozharness: 2017-05-18 04:56:32.820601Z] Running run-tests step. 21:56:32 INFO - Running pre-action listener: _resource_record_pre_action 21:56:32 INFO - Running main action method: run_tests 21:56:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:56:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:56:32 INFO - Python 2.7.3 21:56:32 INFO - Return code: 0 21:56:32 INFO - grabbing minidump binary from tooltool 21:56:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 21:56:32 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 0x18b57a0>, '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 0x18b66a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18b6b30>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:56:32 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 21:56:32 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 21:56:32 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 21:56:32 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:56:32 INFO - Return code: 0 21:56:32 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 21:56:32 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:56:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:56:32 INFO - ENV: RUST_BACKTRACE is now 1 21:56:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 21:56:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:56:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Ng2ZE6IuS9S32HYlv8C-HA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-072', '--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 21:56:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Ng2ZE6IuS9S32HYlv8C-HA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-072 --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 21:56:32 INFO - Using env: {'DISPLAY': ':0', 21:56:32 INFO - 'HOME': '/home/cltbld', 21:56:32 INFO - 'LANG': 'en_US.UTF-8', 21:56:32 INFO - 'LANGUAGE': 'en_US:en', 21:56:32 INFO - 'LOGNAME': 'cltbld', 21:56:32 INFO - 'MAIL': '/var/mail/cltbld', 21:56:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:56:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 21:56:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:56:32 INFO - 'MOZ_NO_REMOTE': '1', 21:56:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:56:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:56:32 INFO - 'NO_EM_RESTART': '1', 21:56:32 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:56:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:56:32 INFO - 'PWD': '/builds/slave/test', 21:56:32 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:56:32 INFO - 'RUST_BACKTRACE': '1', 21:56:32 INFO - 'SHELL': '/bin/bash', 21:56:32 INFO - 'SHLVL': '1', 21:56:32 INFO - 'TERM': 'linux', 21:56:32 INFO - 'TMOUT': '86400', 21:56:32 INFO - 'USER': 'cltbld', 21:56:32 INFO - 'XDG_SESSION_COOKIE': '199fb4c72b90437b990b419b000001c5-1495077469.137364-1482554342', 21:56:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:56:32 INFO - '_': '/tools/buildbot/bin/python'} 21:56:32 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Ng2ZE6IuS9S32HYlv8C-HA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-072', '--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 21:56:33 INFO - mozversion application_buildid: 20170518040217 21:56:33 INFO - mozversion application_changeset: 0b529227685dc071774480f756bf41dff7068452 21:56:33 INFO - mozversion application_display_name: Nightly 21:56:33 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:56:33 INFO - mozversion application_name: Firefox 21:56:33 INFO - mozversion application_remotingname: firefox 21:56:33 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 21:56:33 INFO - mozversion application_vendor: Mozilla 21:56:33 INFO - mozversion application_version: 55.0a1 21:56:33 INFO - mozversion platform_buildid: 20170518040217 21:56:33 INFO - mozversion platform_changeset: 0b529227685dc071774480f756bf41dff7068452 21:56:33 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 21:56:33 INFO - mozversion platform_version: 55.0a1 21:56:33 INFO - using testdate: 1495083393 21:56:33 INFO - actual date: 1495083393 21:56:33 INFO - starting webserver on 'localhost:52238' 21:56:33 INFO - SUITE-START | Running 2 tests 21:56:33 INFO - TEST-START | dromaeo_css 21:56:33 INFO - operating with platform_type : linux_ 21:56:33 INFO - Initialising browser for dromaeo_css test... 21:56:33 INFO - TEST-INFO | started process 20026 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPZ3wGe/profile http://localhost:52238/getInfo.html) 21:56:33 INFO - PID 20026 | JavaScript warning: resource://gre/modules/addons/XPIProvider.jsm, line 2939: String.localeCompare is deprecated; use String.prototype.localeCompare instead 21:56:37 INFO - PID 20026 | __metrics Screen width/height:1600/1200 21:56:37 INFO - PID 20026 | colorDepth:24 21:56:37 INFO - PID 20026 | Browser inner width/height: 1024/695 21:56:37 INFO - PID 20026 | __metrics 21:56:39 INFO - TEST-INFO | 20026: exit 0 21:56:39 INFO - Browser initialized. 21:56:39 INFO - Running cycle 1/1 for dromaeo_css test... 21:56:39 INFO - TEST-INFO | started process 20207 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPZ3wGe/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:56:50 INFO - PID 20207 | RSS: Main: 168648704 21:56:50 INFO - PID 20207 | 21:59:55 INFO - PID 20207 | Cycle 1(1): loaded http://localhost:52238/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52238/tests/dromaeo/cssquery-ext.html) 21:59:57 INFO - PID 20207 | RSS: Main: 174731264 21:59:57 INFO - PID 20207 | 22:02:59 INFO - PID 20207 | Cycle 1(1): loaded http://localhost:52238/tests/dromaeo/cssquery-ext.html (next: http://localhost:52238/tests/dromaeo/cssquery-jquery.html) 22:02:59 INFO - PID 20207 | RSS: Main: 173760512 22:02:59 INFO - PID 20207 | 22:06:01 INFO - PID 20207 | Cycle 1(1): loaded http://localhost:52238/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52238/tests/dromaeo/cssquery-mootools.html) 22:06:02 INFO - PID 20207 | RSS: Main: 175734784 22:06:02 INFO - PID 20207 | 22:09:04 INFO - PID 20207 | Cycle 1(1): loaded http://localhost:52238/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52238/tests/dromaeo/cssquery-prototype.html) 22:09:04 INFO - PID 20207 | RSS: Main: 174186496 22:09:04 INFO - PID 20207 | 22:12:07 INFO - PID 20207 | Cycle 1(1): loaded http://localhost:52238/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52238/tests/dromaeo/cssquery-yui.html) 22:12:08 INFO - PID 20207 | RSS: Main: 174268416 22:12:08 INFO - PID 20207 | 22:15:10 INFO - PID 20207 | Cycle 1(1): loaded http://localhost:52238/tests/dromaeo/cssquery-yui.html (next: http://localhost:52238/tests/dromaeo/cssquery-dojo.html) 22:15:10 INFO - PID 20207 | RSS: Main: 181497856 22:15:10 INFO - PID 20207 | 22:15:10 INFO - PID 20207 | __start_tp_report 22:15:10 INFO - PID 20207 | _x_x_mozilla_page_load 22:15:10 INFO - PID 20207 | _x_x_mozilla_page_load_details 22:15:10 INFO - PID 20207 | |i|pagename|runs| 22:15:10 INFO - PID 20207 | |0;dojo.html;2665.2404064841526;2667.9599806002907;2668.7464690854363;2679.3971356444795;2711.7559419652225;5058.721770302632;5157.664751791131;5170.53465188133;5188.2995795567585;5229.947700522998;5154.5103215194495;5167.9224811627855;5224.63427560071;5262.210668399742;5286.101362768329;4323.313907576048;4496.145732310867;4618.699784514012;4625.861224163281;4668.813247470097;4694.624430045588;4713.646476514258;4724.055188962204;4735.6921800083055;4774.355462012636;4552.954470455286;4612.5156858530045;4646;4664.13713463007;4723.197056500386;4625.306204069383;4638.837640682594;4653.139169253665;4678.485366609671;4685.789139488697;4595.678302518825;4616.330632058366;4624.445066591997;4634.026854360554;4676.766161691936;5071.011152825201;5198.870028249286;5228.712420816853;5229.790808367661;5271.341082364705;5542.86142846428;5590.077637189899;5668.773249070074;5682.914756278659;5705.6006079574445;5668.943310566883;5671.8582035449035;5672.489475947144;5675.858103547403;5681.659100453986;5249.685018898802;5277.393099793535;5279.762410691528;5286.656367336111;5328.467153284718;5615.6630602164005;5687.146927960756;5705.971470142623;5782.710864456761;5831.591788574759;5561.833145005657;5573.470520300565;5573.665580065209;5573.972130139405;5603.495685388335;5464.480874316933;5528.944710552843;5587.720613969285;5608.915866262009;5630.352509461382;5598.216249725042;5615.129654903497;5617.129344951539;5637.182608521824;5673.8297851064535;5385.569154467712;5445.319335083114;5579.38626751057;5587.497125258747;5660.320761508646;4683.7892294846815;4727.64542659302;4731.574158325767;4767.094252092092;4773.37946067016;4036.3340048891605;4038.970062634068;4053.9257096869355;4057.634812866797;4086.896537934741;4531.274996000624;4575.428071491064;4642.651801114863;4691.929621055687;4735.431748190239;5654.830355089354;5664.830055098354;5669.688167150764;5704.344000440003;5720.08478643415;4678.485366609671;4685.109829132454;4686.554777296152;4696;4716.339712440261;4843.07981483517;4907.754612269444;4962.5533701967;4982.402111746541;4986.177280748636;5174;5222.112240918977;5248;5254.474552544715;5261.710605916558;5660.471672648444;5665.5750818689585;5670.8015219467125;5671.120976248688;5693.089105743061;4998.925016124834;5219.765110569958;5223.764930578209;5224.085784987688;5268.157094864803;5476.069068258326;5489.149181876815;5492.752826122754;5498.092814685692;5498.285222921155;5564.360098588552;5577.498025177753;5624.29696287964;5698.857528561653;5719.542436604978;5441.483059109379;5500.477454641803;5512.889742205213;5522.751476183662;5538.418466061005;5481.232627432083;5488.17677348401;5488.780448782004;5491.588130890119;5496.038193316233;5371.867824697951;5394.649347792381;5424.050791111461;5427.755750991136;5474.397816240131;5385.434529374359;5449.23710680513;5510.421405752499;5569.331680198402;5580.665160090408;5385.4076051635075;5388.892222155457;5392.649477783932;5396.568274538106;5428.4842939920645 22:15:10 INFO - PID 20207 | |1;ext.html;727.0657205490944;740.6222826358558;1027.8252697041503;1037.2842738510433;1154.411250262366;33002.33995320092;34146;34327.313453730945;34332.65667343329;34432.48351274733;31504.369912601735;31775;31920;32062.35875282499;32171.83914080432;6318.620882747027;6479.384458476449;6615.106960560335;6927.168739751237;6950.235474097845;7023.648817559128;7107.111611048619;7129.928700713004;7132.714691412337;7136.85726285474;7090.113735783028;7116.217216106224;7120.430365570742;7153.499255052148;7154.320339567733;7036.612986285752;7055.329743674342;7059.752908648173;7090.042844216016;7096.609686467243;7005.054317667101;7015.15818101826;7043.154821421411;7068.338940349014;7084.539504932214;32004.199895002577;32200.677993220237;32254.193645158823;32294.515582266285;32314;2960.9407811843644;2963.836988965606;2965.0808249442744;2997.8351190684502;2999.4151140527606;24603.261902142964;24616.630750538756;24625.63061554078;24681.876590616932;24759.62860557093;3105.1305634422397;3130.733887619555;3145.4652709039287;3147.401993621205;3147.6065491813524;137295.62704372927;137657;137715;137870;138595;37707.24585508274;39285;39362.80318598446;39535.40696889549;39797.44354963697;41603.7919810399;41659.1668166635;41678.749637510926;41728.58271417247;41763.58236417597;11128.666140015812;11183.664490065312;11207.215494915441;11212.551497940154;11235.887641123647;8862.689805856764;9201.539923003824;9217.078292170863;9241.491717955578;9254.537273136317;12582.622521324192;12608.81086783699;12609.684757881127;12611.369431528386;12795.488180472863;5255.106631872591;5270.657407268515;5277.683338999673;5369.087255166631;5408.972955135199;865.9350548708873;906.7628566019248;907.3920473282916;921.3090182363228;939.5302348825587;20188.59622807565;20929.26747563828;21044.579108417747;21302.36092917215;21508.462288442603;893.5442924108621;893.6068130022769;902.3818684201343;913.6025828764509;934.3039435620507;10652.414117223627;11138;11173.385463799406;11190.216684831983;11278.323300601991;167505;167929;167975.16012420104;168416;169046;38728.612713873066;39202.80398597989;39268.60731392707;39318.606813931496;39439.80280098581;1199.8200269959575;1237.7091383524864;1242.2174030360816;1245.2466257913832;1245.8816412440622;18766.437006889813;19297;20103.497412564804;20185.02526230066;20373.898130509253;29105.563416549194;29330.266743330732;29345.7065429343;29398.706012940453;29415;133799;135732.4627406642;155526;156454;156482;29876.070448375776;30167.547486787276;30397.544036839023;30593.847030764704;30719.846400767852;36477.63522364743;36871.815640921624;36976.260474789815;37599.248015040095;37723.43414848834;27602.861985689942;27831.920763780126;28352.716472835833;29094.563581546718;29274.707252927197;27377.589336159574;27809;28096;28343.716562834106;29159.70840291655;30016.84991575028;30882.69117308888;30992;31212.687873120976;31239.375212495168;26701.332466687712;27562.862185688944;27655.585166222925;28284.434311313245;28675.426491469636;20916.47708807292;22862;23101.65347519822;23129.190478333177;23189.3043208704 22:15:10 INFO - PID 20207 | |2;jquery.html;404.3651467196503;409.73162578511085;409.87703688893333;420.43661493598574;425.4086819321144;14609.05041172323;15403.075815451053;16389.18054097295;17089.14554272286;17102.572435689115;17194.226259818308;17324.307027718907;17340.393086241984;17359.82640173598;17458.912705436454;5364.70494122824;5382.5963052771;5409.810656627019;5553.278073850393;5561.360443548983;5402.756875940592;5485.067538518441;5489.204065410513;5500.477454641823;5501.807436739715;5251.159814429692;5395.973020134894;5466.753996070186;5469.808556700516;5498.862528436781;5410.972945135269;5429.131338985743;5438.619296649196;5451.809186678447;5463.453654634544;4834.782434790408;4931.0630980113665;4939.333190019337;4950.529699678525;4963.205887058053;21131.788682113136;21316.893415532977;21776.564468710538;21949.561008779736;21949.561008779896;1627.2921279243567;1665.8584020358285;1672.1304921440903;1672.774175486306;1673.4895856763683;13891.930540347335;13921.164730116225;14233.501827436094;14673.926630366886;14811.925940370229;2039.734834471524;2109.219588752156;2144.0887622760265;2145.4529095080657;2145.6674215496623;90633.54683226542;95023;95702.52148739282;95873.52063239709;96504.51747741217;10887.074598659045;10907.29102608328;11120.22158448917;11214.887851121384;11308.491117899714;15722.371105155895;15725.606859828596;15760.369585216693;15767.68464630724;15782.210889455482;6577;6702.195736511552;6823.044773731682;6929.618870962146;6931.792046238621;5867.325257595346;5920.703964801743;6049;6055.6063855849225;6066.332703402622;6811.863762724817;6880.311968803079;6915.446764258847;6925.203601585781;7091.1490621125795;2035.7760646328893;2062.6905964105204;2075.5952589245253;2090.560982193726;2164.2533326002504;834.3408707121428;863.3783675753448;878.4904755242072;889.6263569300779;899.0739538275586;16469.176541172892;17199.31202751901;17394;17410.303587856342;17611.38360157388;863.8833757442791;867.0808942520948;867.8394497018072;868.2749903830246;896.9013408525057;8962.641494340154;9085.636574537077;9286.72139835806;9325.253979681609;9441.622335106656;356375;360264;360429;390685;399184;75775.24224757683;76194.28422915068;77174.61412692901;80350;80494;1064.984025239622;1083.9999999999843;1102.5699977008974;1123.640435060789;1131.055568600228;17070.74393884068;17151.399701010403;17806.287748489915;18292.26830926748;18480.075996199866;36180.27639447249;37271;37977.240455190185;38517.6148238514;38630.6136938627;47163.528364715916;47343.28985065158;47373.763131184125;47447.28829067498;50409.49590504048;7950.920490795018;7976.880346794919;8043.8281663951575;8076.636551355321;8282.17178282167;12053.819192712292;12208.877911220774;12425.37873106359;12519.812202816784;12817.935910320388;10835.729106772395;11128.554857805597;11185.608503702331;11496.885031149915;11566.132540059361;9532.761680958032;9616.855747163658;9672.129508344002;9690;10252.692419227435;10522.421266830397;10729.570817167227;11026.558937642725;11085.944570277097;11239.595050618673;8236.299914507334;8325.625346859528;8588.699395521127;8602.61288242018;8718.476891386537;11039.392833393918;11171.38557379352;11176;11370;11595.362255076052 22:15:10 INFO - PID 20207 | |3;mootools.html;1258.5972488803584;1283.6213317071463;1307.4835440001207;1312.5274901035632;1321.3459337627876;9972.501374931251;10465.424401657916;10469.267151299402;10512.842307365396;10609.681709548706;10598.576056957712;10669.83995240072;10693.304935179209;10743.83884241737;10774.515146818392;2307.2962746362355;2361.5749165150264;2364.6689463475127;2364.9763502364926;2367.763223677627;2176.1295481807247;2193.0679461228915;2262.072550254396;2328.871912044837;2335.0309621507054;2250.9212177573786;2267.671187677786;2275.249167774639;2277.4534111813127;2279.430142464384;2156.5255643758346;2174.923877664274;2178.1287485005964;2200.5928903152967;2201.625723626987;2102.4954011037394;2115.2596591193114;2126.5640543688505;2126.946826329339;2134.7331583552054;10002.799944001152;10087.949560252226;10093.444860532667;10234.385936843813;10236.283460157792;5368.1679339702405;5468.070428027205;5518.255035570187;5527.972360138214;5548.500634942875;3350.9329813403597;3541.309444658267;3616.620254873253;3715;3731.421629647409;1037.3931250218632;1054.974449057811;1089.0906093412011;1096.5942601237514;1098.4068602954394;15007.399704011827;15105.697886042328;15151.772723409158;15266.618334541614;15276.923615381964;4641.559051890065;4819.421669399624;4886.633502487328;4905.779239934212;4914.434839993375;10997.230193886511;11011.394373309384;11028.393438360967;11034.724131896606;11036.944815276032;5307.548858347007;5321.361436627552;5329.493698098674;5331.120365139708;5334.653247538898;4872.853814385574;4934.7285899275885;4985.775640096204;4994.300797888299;5032.823851165265;3779.244151169777;3929.8428062877165;3942.5860284669698;3968.412634946045;4018.794361691481;1131.9830202546968;1146.140394703972;1163.2148299897535;1164.7554013657057;1171.1158075652997;698.6960672107649;723.6200994477941;728.8943103249999;729.0849983271067;743.3235755462504;6032.517398608101;6176.505879529627;6197.287311959182;6215.098810672517;6223.875522489616;839.3536976528039;841.8779277004923;850.1753299299669;852.071242345846;857.0972441180569;3374.9712927737496;3376.03782921871;3397.8301084945656;3411.812350320756;3425.743069269815;12826.55107071248;13201.141925774795;13224.801627975588;13256.005799564879;13258.867411325957;12819.102662813513;13138.671533211746;13343.73312533744;13371.732565348639;13387.933060334635;6796.932030679729;6885.380315771505;6925.099737034254;6935.3411425914455;6970.965145174242;6113.480354169946;6313.273973492924;6360.141380913517;6453.580517266362;6621.9337806621315;11793.115516336138;11994.520219191134;12028.63914082579;12071.215371000857;12079.818802717791;12001;12146.817797733218;12323.137380383287;12333.62999110028;12356.567520136752;8268;8516.70191543293;8547.188017138362;8585.742427727178;8587.184217499327;9461.337706360764;9796.118349348593;9803.411795292306;9806.607735690492;9808.950955245464;7927.682892684228;8321.417500774887;8361.83276334482;8388.286995605442;8534.82930341402;7496.550206987598;7712.190220027041;7834.960825195838;8108.83782324362;8228.547429891414;7557.168711441627;7678.232176782277;7697.499662521918;7697.769066928001;7706.190849960673;5300.549453296513;5307.4692530746615;5361.785528578813;5376.973115134399;5589.161625756169;5481.972590137024;5502.779888804403;5534.723263836711;5651.208830763779;5718.571107166896 22:15:10 INFO - PID 20207 | |4;prototype.html;365.26034779571364;384.43488072533364;387.72084099448404;390.8163163313243;397.85876014015025;5320.228566857813;5467.644603100801;5476.096444086726;5490.396056433789;5494.725263736807;5252;5288.867778305545;5309;5327.467253274671;5371.328583927009;4059.6752259819145;4063.2889244382263;4072.2669919414493;4088.6115818997146;4100.425940368351;3960.52473703156;4076.9184616307657;4080.367543030835;4097.569755175708;4109.691773117013;4048.271311163989;4057.5536690963972;4063.1061166543313;4065.2885744994655;4072.165206132736;4063.1670507546028;4071.145059537486;4090;4103.4870641169855;4103.712740108193;3585.731070169748;3593.317269718745;3603.72972027099;3610.1696609779633;3614.331348700499;5201;5247.134222853225;5258.55302299305;5274.314339135888;5279.366476022863;4754.66717329787;4760.904781904377;4769.642276829251;4776.49846766088;4783.354247176621;5517.420670829545;5670.319561652587;5671.546276297886;5730.885382292373;5743.425657434265;3990.4237826058834;3998.420229066798;4002.9199416011807;4018.4374187613757;4028.4158796974275;5884.794032208895;6007.549433792483;6022.247219097613;6039;6112.327643959161;4060;4067.572904845008;4074.959250407517;4077.7145599808323;4084.65280451159;4146.875593732193;4154.729942553724;4160.521540022875;4160.916781664349;4161.209370219649;4696.7416792076765;4720.268358404453;4772.2364421693055;4775.6657034007985;4781.163296423112;5705.486506214377;5736.713164341766;5740.196372507852;5742.569307301969;5745.540356771448;1407.8451370349253;1421.3319739722315;1428.4000719697751;1432.7994080828691;1434.2470203143432;927.9536023198813;953.3088510829732;957.4446820843893;960.7646126699003;962.4465932089076;4817.759112044384;4845.685030473008;4853.80584776605;4875.293082503017;4878.682885612424;5843.590948633555;5872.823815285548;5876.764929402776;5879.823605291848;5906.8818623627285;4679.722197382927;4809.735464549413;4824.973511125336;4843.2250839865455;4845.200541910615;3072.201227680819;3093.520504321834;3106.192389978622;3124.781265311452;3128.1084890806465;5413.834466213546;5416.891662166813;5422.295101636762;5436.646617969819;5443.700596467233;5886.676232807236;6072.605280656743;6090.786822461193;6110.694465276719;6130.601510901866;5454.61817672767;5473.124300111963;5475.342958844964;5477.561795056466;5478.506934375846;5785.710714464176;5906.586538942232;5921.792737254175;5948.821535353946;5952.666506756231;5860.736266867916;5868.4424979626865;5870.383609721089;5873.530117590668;5882.970585147047;5291.947080529146;5455.345358556999;5457.20870473787;5460.153676180198;5462.481064298885;4033.5159780825315;4057.5190055630073;4074.8166332514515;4076.5311989121633;4082;5873.853153671193;5973.253343332083;5983.371745966785;5984.431479009487;5988.520918326611;5724.627899186539;5741;5759.568032397503;5759.9136012959;5760.251167348218;5743.913841292468;5751.798687045934;5754.56840736938;5761.510271626791;5762.30852297727;5472.261244731911;5620.74706638194;5627.549796016391;5676.460736230051;5677.545796336366;5732.3121225453215;5773.393793651774;5776;5781.710914454345;5799.4780469757925;5482.616216864782;5583.692896890548;5594.216809646734;5598.772926440674;5626.521745651502 22:15:10 INFO - PID 20207 | |5;yui.html;741.4402126394572;757.6590534259583;760.9086909570852;763.8586861430636;773.2769860180731;11478.483468243929;11829.46767395467;13060.608181754551;13868.653283667913;13924.094933829307;15098.849011509881;15290.847091529082;15723.292451839667;15809.446669366545;15845.841541584581;831.8835363049178;852.4288726553224;852.9872051919226;854.1842540373927;855.6620135046653;901.0223907060847;901.6032945503957;903.056306160061;903.105925134119;903.6295119001211;942.9764255893589;945.8723072385243;948.0519480519481;949.2880339745191;949.2975198353204;935.9578818953096;937.6436953957486;938;944.8346539355654;945.0927109974399;694.3681250062419;695.1033167214338;695.7286658203304;696.5890124826326;696.7282759723712;14346.210958397283;14750.336234869457;15445.382184712598;15562.688746225125;15641.843581564153;15736.291866866019;15837.12895790731;15898.364065437368;15967.680646387123;16082.919585402115;12821.743565128738;12838.871611283861;12922.806157907638;13040.413181406859;13176.670583235496;3075.984620076885;3085.1053194573547;3093.5050391937184;3095.628524577065;3100.023492599824;65285;66208.66895665538;66320.66839665819;66326.66836665834;67611.66194169047;12026.819597706042;12199.75600488003;12253.326067066397;12297.139200256075;12311.384430778604;20804.271850485464;21298.57402851965;22486.100555977904;22722.43193920165;22829.7717022831;5880.8235752927485;6059.394060593993;6114.877702446015;6133.325334213233;6270.435660790551;3064.111407691789;3118.5789918361183;3122.5316202569343;3124.0940127363265;3136.5295205719326;3318.070940136766;3379.425497665403;3389.491576263531;3397.779144355609;3525.4183059794846;727.8144073261285;742.2874040920668;751.0724255544399;751.5077624156187;752.6913965274211;578.0231806198113;597.9461848433662;602.7588964414269;609.2658346692225;620.6245221640933;9397.389169703947;9516.429014259167;9580.18568421678;9624.566894489764;9973.252006099572;608.1273372710175;609.4058293164218;617.7251123250201;630.4326106504092;639.0701529274894;4068.16602596467;4157.750534967911;4249.851255206053;4300.591443812833;4322.589354011364;64675.35324646787;64747;65156;65632.34367656262;67373;55308.44691553033;55739.721301393234;55817.720911396;57936.71031644899;58717.11924321139;52073.21890171651;52306.738466307426;52780;53761.731191343795;54327.45672543224;8316.792080197802;8570.228679418633;8572.185642363966;8666.480011199348;8870;26075.217743467725;26340.4731905357;26420;26473.205803825917;27127.86436067807;31305.8434707825;31712.365752684356;32243;45277.773611131735;45433;14390.208538530482;14577.708445831237;14629.634259143606;14947.626309342353;15168.544943651708;15311.923440382727;15651.530454086396;15958.04251744899;16289;16622.916885415496;14480;14721.92639036798;14908.85091149118;15324.387024519341;15512.457064003158;14308.57074287773;14487.637809054437;15193.848061519244;15740.402833532797;16121.355145794038;13164.539241126899;13381.799273010718;13404.195748255135;13519.324033798468;13581.660458488617;9730.464824434725;9923.156531694887;9965.900340996497;10035.046670566284;10165.898341016791;12051;12835.743285134431;12931.741365172831;12952.740945180854;13055.673608159872 22:15:10 INFO - PID 20207 | __end_tp_report 22:15:10 INFO - PID 20207 | __start_cc_report 22:15:10 INFO - PID 20207 | _x_x_mozilla_cycle_collect,295 22:15:10 INFO - PID 20207 | __end_cc_report 22:15:10 INFO - PID 20207 | __startTimestamp1495084510662__endTimestamp 22:15:10 INFO - PID 20207 | 22:15:10 INFO - PID 20207 | ------- Summary: start ------- 22:15:10 INFO - PID 20207 | Number of tests: 6 22:15:10 INFO - PID 20207 | 22:15:10 INFO - PID 20207 | [#0] dojo.html Cycles:165 Average:5131.74 Median:5286.10 stddev:614.94 (11.6%) stddev-sans-first:585.60 22:15:10 INFO - PID 20207 | Values: 2665.2 2668.0 2668.7 2679.4 2711.8 5058.7 5157.7 5170.5 5188.3 5229.9 5154.5 5167.9 5224.6 5262.2 5286.1 4323.3 4496.1 4618.7 4625.9 4668.8 4694.6 4713.6 4724.1 4735.7 4774.4 4553.0 4612.5 4646.0 4664.1 4723.2 4625.3 4638.8 4653.1 4678.5 4685.8 4595.7 4616.3 4624.4 4634.0 4676.8 5071.0 5198.9 5228.7 5229.8 5271.3 5542.9 5590.1 5668.8 5682.9 5705.6 5668.9 5671.9 5672.5 5675.9 5681.7 5249.7 5277.4 5279.8 5286.7 5328.5 5615.7 5687.1 5706.0 5782.7 5831.6 5561.8 5573.5 5573.7 5574.0 5603.5 5464.5 5528.9 5587.7 5608.9 5630.4 5598.2 5615.1 5617.1 5637.2 5673.8 5385.6 5445.3 5579.4 5587.5 5660.3 4683.8 4727.6 4731.6 4767.1 4773.4 4036.3 4039.0 4053.9 4057.6 4086.9 4531.3 4575.4 4642.7 4691.9 4735.4 5654.8 5664.8 5669.7 5704.3 5720.1 4678.5 4685.1 4686.6 4696.0 4716.3 4843.1 4907.8 4962.6 4982.4 4986.2 5174.0 5222.1 5248.0 5254.5 5261.7 5660.5 5665.6 5670.8 5671.1 5693.1 4998.9 5219.8 5223.8 5224.1 5268.2 5476.1 5489.1 5492.8 5498.1 5498.3 5564.4 5577.5 5624.3 5698.9 5719.5 5441.5 5500.5 5512.9 5522.8 5538.4 5481.2 5488.2 5488.8 5491.6 5496.0 5371.9 5394.6 5424.1 5427.8 5474.4 5385.4 5449.2 5510.4 5569.3 5580.7 5385.4 5388.9 5392.6 5396.6 5428.5 22:15:10 INFO - PID 20207 | 22:15:10 INFO - PID 20207 | [#1] ext.html Cycles:180 Average:29620.25 Median:17048.57 stddev:39137.91 (229.6%) stddev-sans-first:39187.57 22:15:10 INFO - PID 20207 | Values: 727.1 740.6 1027.8 1037.3 1154.4 33002.3 34146.0 34327.3 34332.7 34432.5 31504.4 31775.0 31920.0 32062.4 32171.8 6318.6 6479.4 6615.1 6927.2 6950.2 7023.6 7107.1 7129.9 7132.7 7136.9 7090.1 7116.2 7120.4 7153.5 7154.3 7036.6 7055.3 7059.8 7090.0 7096.6 7005.1 7015.2 7043.2 7068.3 7084.5 32004.2 32200.7 32254.2 32294.5 32314.0 2960.9 2963.8 2965.1 2997.8 2999.4 24603.3 24616.6 24625.6 24681.9 24759.6 3105.1 3130.7 3145.5 3147.4 3147.6 137295.6 137657.0 137715.0 137870.0 138595.0 37707.2 39285.0 39362.8 39535.4 39797.4 41603.8 41659.2 41678.7 41728.6 41763.6 11128.7 11183.7 11207.2 11212.6 11235.9 8862.7 9201.5 9217.1 9241.5 9254.5 12582.6 12608.8 12609.7 12611.4 12795.5 5255.1 5270.7 5277.7 5369.1 5409.0 865.9 906.8 907.4 921.3 939.5 20188.6 20929.3 21044.6 21302.4 21508.5 893.5 893.6 902.4 913.6 934.3 10652.4 11138.0 11173.4 11190.2 11278.3 167505.0 167929.0 167975.2 168416.0 169046.0 38728.6 39202.8 39268.6 39318.6 39439.8 1199.8 1237.7 1242.2 1245.2 1245.9 18766.4 19297.0 20103.5 20185.0 20373.9 29105.6 29330.3 29345.7 29398.7 29415.0 133799.0 135732.5 155526.0 156454.0 156482.0 29876.1 30167.5 30397.5 30593.8 30719.8 36477.6 36871.8 36976.3 37599.2 37723.4 27602.9 27831.9 28352.7 29094.6 29274.7 27377.6 27809.0 28096.0 28343.7 29159.7 30016.8 30882.7 30992.0 31212.7 31239.4 26701.3 27562.9 27655.6 28284.4 28675.4 20916.5 22862.0 23101.7 23129.2 23189.3 22:15:10 INFO - PID 20207 | 22:15:10 INFO - PID 20207 | [#2] jquery.html Cycles:180 Average:24997.62 Median:199794.18 stddev:62397.03 (31.2%) stddev-sans-first:62544.75 22:15:10 INFO - PID 20207 | Values: 404.4 409.7 409.9 420.4 425.4 14609.1 15403.1 16389.2 17089.1 17102.6 17194.2 17324.3 17340.4 17359.8 17458.9 5364.7 5382.6 5409.8 5553.3 5561.4 5402.8 5485.1 5489.2 5500.5 5501.8 5251.2 5396.0 5466.8 5469.8 5498.9 5411.0 5429.1 5438.6 5451.8 5463.5 4834.8 4931.1 4939.3 4950.5 4963.2 21131.8 21316.9 21776.6 21949.6 21949.6 1627.3 1665.9 1672.1 1672.8 1673.5 13891.9 13921.2 14233.5 14673.9 14811.9 2039.7 2109.2 2144.1 2145.5 2145.7 90633.5 95023.0 95702.5 95873.5 96504.5 10887.1 10907.3 11120.2 11214.9 11308.5 15722.4 15725.6 15760.4 15767.7 15782.2 6577.0 6702.2 6823.0 6929.6 6931.8 5867.3 5920.7 6049.0 6055.6 6066.3 6811.9 6880.3 6915.4 6925.2 7091.1 2035.8 2062.7 2075.6 2090.6 2164.3 834.3 863.4 878.5 889.6 899.1 16469.2 17199.3 17394.0 17410.3 17611.4 863.9 867.1 867.8 868.3 896.9 8962.6 9085.6 9286.7 9325.3 9441.6 356375.0 360264.0 360429.0 390685.0 399184.0 75775.2 76194.3 77174.6 80350.0 80494.0 1065.0 1084.0 1102.6 1123.6 1131.1 17070.7 17151.4 17806.3 18292.3 18480.1 36180.3 37271.0 37977.2 38517.6 38630.6 47163.5 47343.3 47373.8 47447.3 50409.5 7950.9 7976.9 8043.8 8076.6 8282.2 12053.8 12208.9 12425.4 12519.8 12817.9 10835.7 11128.6 11185.6 11496.9 11566.1 9532.8 9616.9 9672.1 9690.0 10252.7 10522.4 10729.6 11026.6 11085.9 11239.6 8236.3 8325.6 8588.7 8602.6 8718.5 11039.4 11171.4 11176.0 11370.0 11595.4 22:15:10 INFO - PID 20207 | 22:15:10 INFO - PID 20207 | [#3] mootools.html Cycles:180 Average:6342.08 Median:3578.96 stddev:4060.58 (113.5%) stddev-sans-first:4054.00 22:15:10 INFO - PID 20207 | Values: 1258.6 1283.6 1307.5 1312.5 1321.3 9972.5 10465.4 10469.3 10512.8 10609.7 10598.6 10669.8 10693.3 10743.8 10774.5 2307.3 2361.6 2364.7 2365.0 2367.8 2176.1 2193.1 2262.1 2328.9 2335.0 2250.9 2267.7 2275.2 2277.5 2279.4 2156.5 2174.9 2178.1 2200.6 2201.6 2102.5 2115.3 2126.6 2126.9 2134.7 10002.8 10087.9 10093.4 10234.4 10236.3 5368.2 5468.1 5518.3 5528.0 5548.5 3350.9 3541.3 3616.6 3715.0 3731.4 1037.4 1055.0 1089.1 1096.6 1098.4 15007.4 15105.7 15151.8 15266.6 15276.9 4641.6 4819.4 4886.6 4905.8 4914.4 10997.2 11011.4 11028.4 11034.7 11036.9 5307.5 5321.4 5329.5 5331.1 5334.7 4872.9 4934.7 4985.8 4994.3 5032.8 3779.2 3929.8 3942.6 3968.4 4018.8 1132.0 1146.1 1163.2 1164.8 1171.1 698.7 723.6 728.9 729.1 743.3 6032.5 6176.5 6197.3 6215.1 6223.9 839.4 841.9 850.2 852.1 857.1 3375.0 3376.0 3397.8 3411.8 3425.7 12826.6 13201.1 13224.8 13256.0 13258.9 12819.1 13138.7 13343.7 13371.7 13387.9 6796.9 6885.4 6925.1 6935.3 6971.0 6113.5 6313.3 6360.1 6453.6 6621.9 11793.1 11994.5 12028.6 12071.2 12079.8 12001.0 12146.8 12323.1 12333.6 12356.6 8268.0 8516.7 8547.2 8585.7 8587.2 9461.3 9796.1 9803.4 9806.6 9809.0 7927.7 8321.4 8361.8 8388.3 8534.8 7496.6 7712.2 7835.0 8108.8 8228.5 7557.2 7678.2 7697.5 7697.8 7706.2 5300.5 5307.5 5361.8 5377.0 5589.2 5482.0 5502.8 5534.7 5651.2 5718.6 22:15:10 INFO - PID 20207 | 22:15:10 INFO - PID 20207 | [#4] prototype.html Cycles:180 Average:4697.81 Median:5349.40 stddev:1394.39 (26.1%) stddev-sans-first:1359.86 22:15:10 INFO - PID 20207 | Values: 365.3 384.4 387.7 390.8 397.9 5320.2 5467.6 5476.1 5490.4 5494.7 5252.0 5288.9 5309.0 5327.5 5371.3 4059.7 4063.3 4072.3 4088.6 4100.4 3960.5 4076.9 4080.4 4097.6 4109.7 4048.3 4057.6 4063.1 4065.3 4072.2 4063.2 4071.1 4090.0 4103.5 4103.7 3585.7 3593.3 3603.7 3610.2 3614.3 5201.0 5247.1 5258.6 5274.3 5279.4 4754.7 4760.9 4769.6 4776.5 4783.4 5517.4 5670.3 5671.5 5730.9 5743.4 3990.4 3998.4 4002.9 4018.4 4028.4 5884.8 6007.5 6022.2 6039.0 6112.3 4060.0 4067.6 4075.0 4077.7 4084.7 4146.9 4154.7 4160.5 4160.9 4161.2 4696.7 4720.3 4772.2 4775.7 4781.2 5705.5 5736.7 5740.2 5742.6 5745.5 1407.8 1421.3 1428.4 1432.8 1434.2 928.0 953.3 957.4 960.8 962.4 4817.8 4845.7 4853.8 4875.3 4878.7 5843.6 5872.8 5876.8 5879.8 5906.9 4679.7 4809.7 4825.0 4843.2 4845.2 3072.2 3093.5 3106.2 3124.8 3128.1 5413.8 5416.9 5422.3 5436.6 5443.7 5886.7 6072.6 6090.8 6110.7 6130.6 5454.6 5473.1 5475.3 5477.6 5478.5 5785.7 5906.6 5921.8 5948.8 5952.7 5860.7 5868.4 5870.4 5873.5 5883.0 5291.9 5455.3 5457.2 5460.2 5462.5 4033.5 4057.5 4074.8 4076.5 4082.0 5873.9 5973.3 5983.4 5984.4 5988.5 5724.6 5741.0 5759.6 5759.9 5760.3 5743.9 5751.8 5754.6 5761.5 5762.3 5472.3 5620.7 5627.5 5676.5 5677.5 5732.3 5773.4 5776.0 5781.7 5799.5 5482.6 5583.7 5594.2 5598.8 5626.5 22:15:10 INFO - PID 20207 | 22:15:10 INFO - PID 20207 | [#5] yui.html Cycles:180 Average:15393.17 Median:4112.96 stddev:18039.27 (438.6%) stddev-sans-first:18056.32 22:15:10 INFO - PID 20207 | Values: 741.4 757.7 760.9 763.9 773.3 11478.5 11829.5 13060.6 13868.7 13924.1 15098.8 15290.8 15723.3 15809.4 15845.8 831.9 852.4 853.0 854.2 855.7 901.0 901.6 903.1 903.1 903.6 943.0 945.9 948.1 949.3 949.3 936.0 937.6 938.0 944.8 945.1 694.4 695.1 695.7 696.6 696.7 14346.2 14750.3 15445.4 15562.7 15641.8 15736.3 15837.1 15898.4 15967.7 16082.9 12821.7 12838.9 12922.8 13040.4 13176.7 3076.0 3085.1 3093.5 3095.6 3100.0 65285.0 66208.7 66320.7 66326.7 67611.7 12026.8 12199.8 12253.3 12297.1 12311.4 20804.3 21298.6 22486.1 22722.4 22829.8 5880.8 6059.4 6114.9 6133.3 6270.4 3064.1 3118.6 3122.5 3124.1 3136.5 3318.1 3379.4 3389.5 3397.8 3525.4 727.8 742.3 751.1 751.5 752.7 578.0 597.9 602.8 609.3 620.6 9397.4 9516.4 9580.2 9624.6 9973.3 608.1 609.4 617.7 630.4 639.1 4068.2 4157.8 4249.9 4300.6 4322.6 64675.4 64747.0 65156.0 65632.3 67373.0 55308.4 55739.7 55817.7 57936.7 58717.1 52073.2 52306.7 52780.0 53761.7 54327.5 8316.8 8570.2 8572.2 8666.5 8870.0 26075.2 26340.5 26420.0 26473.2 27127.9 31305.8 31712.4 32243.0 45277.8 45433.0 14390.2 14577.7 14629.6 14947.6 15168.5 15311.9 15651.5 15958.0 16289.0 16622.9 14480.0 14721.9 14908.9 15324.4 15512.5 14308.6 14487.6 15193.8 15740.4 16121.4 13164.5 13381.8 13404.2 13519.3 13581.7 9730.5 9923.2 9965.9 10035.0 10165.9 12051.0 12835.7 12931.7 12952.7 13055.7 22:15:10 INFO - PID 20207 | -------- Summary: end -------- 22:15:10 INFO - PID 20207 | 22:15:11 INFO - TEST-INFO | 20207: exit 0 22:15:11 INFO - TEST-OK | dromaeo_css | took 1118457ms 22:15:11 INFO - TEST-START | kraken 22:15:11 INFO - operating with platform_type : linux_ 22:15:11 INFO - Initialising browser for kraken test... 22:15:11 INFO - TEST-INFO | started process 20633 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyFbzCm/profile http://localhost:52238/getInfo.html) 22:15:12 INFO - PID 20633 | JavaScript warning: resource://gre/modules/addons/XPIProvider.jsm, line 2939: String.localeCompare is deprecated; use String.prototype.localeCompare instead 22:15:15 INFO - PID 20633 | __metrics Screen width/height:1600/1200 22:15:15 INFO - PID 20633 | colorDepth:24 22:15:15 INFO - PID 20633 | Browser inner width/height: 1024/695 22:15:15 INFO - PID 20633 | __metrics 22:15:17 INFO - TEST-INFO | 20633: exit 0 22:15:17 INFO - Browser initialized. 22:15:17 INFO - Running cycle 1/1 for kraken test... 22:15:17 INFO - TEST-INFO | started process 20813 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyFbzCm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:15:29 INFO - PID 20813 | RSS: Main: 168562688 22:15:29 INFO - PID 20813 | 22:15:31 INFO - PID 20813 | Cycle 1(1): loaded http://localhost:52238/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52238/tests/kraken/driver.html?testName=audio-beat-detection) 22:15:33 INFO - PID 20813 | RSS: Main: 173596672 22:15:33 INFO - PID 20813 | 22:15:35 INFO - PID 20813 | Cycle 1(1): loaded http://localhost:52238/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52238/tests/kraken/driver.html?testName=audio-dft) 22:15:36 INFO - PID 20813 | RSS: Main: 173838336 22:15:36 INFO - PID 20813 | 22:15:39 INFO - PID 20813 | Cycle 1(1): loaded http://localhost:52238/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52238/tests/kraken/driver.html?testName=audio-fft) 22:15:39 INFO - PID 20813 | RSS: Main: 168476672 22:15:39 INFO - PID 20813 | 22:15:42 INFO - PID 20813 | Cycle 1(1): loaded http://localhost:52238/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52238/tests/kraken/driver.html?testName=audio-oscillator) 22:15:42 INFO - PID 20813 | RSS: Main: 169467904 22:15:42 INFO - PID 20813 | 22:15:44 INFO - PID 20813 | Cycle 1(1): loaded http://localhost:52238/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52238/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:15:45 INFO - PID 20813 | RSS: Main: 170074112 22:15:45 INFO - PID 20813 | 22:15:48 INFO - PID 20813 | Cycle 1(1): loaded http://localhost:52238/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52238/tests/kraken/driver.html?testName=imaging-darkroom) 22:15:49 INFO - PID 20813 | RSS: Main: 173998080 22:15:49 INFO - PID 20813 | 22:15:52 INFO - PID 20813 | Cycle 1(1): loaded http://localhost:52238/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52238/tests/kraken/driver.html?testName=imaging-desaturate) 22:15:53 INFO - PID 20813 | RSS: Main: 171376640 22:15:53 INFO - PID 20813 | 22:15:56 INFO - PID 20813 | Cycle 1(1): loaded http://localhost:52238/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52238/tests/kraken/driver.html?testName=json-parse-financial) 22:15:56 INFO - PID 20813 | RSS: Main: 172576768 22:15:56 INFO - PID 20813 | 22:15:58 INFO - PID 20813 | Cycle 1(1): loaded http://localhost:52238/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52238/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:15:59 INFO - PID 20813 | RSS: Main: 172503040 22:15:59 INFO - PID 20813 | 22:16:00 INFO - PID 20813 | Cycle 1(1): loaded http://localhost:52238/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52238/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:16:01 INFO - PID 20813 | RSS: Main: 172830720 22:16:01 INFO - PID 20813 | 22:16:03 INFO - PID 20813 | Cycle 1(1): loaded http://localhost:52238/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52238/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:16:04 INFO - PID 20813 | RSS: Main: 172847104 22:16:04 INFO - PID 20813 | 22:16:07 INFO - PID 20813 | Cycle 1(1): loaded http://localhost:52238/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52238/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:16:07 INFO - PID 20813 | RSS: Main: 172539904 22:16:07 INFO - PID 20813 | 22:16:11 INFO - PID 20813 | Cycle 1(1): loaded http://localhost:52238/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52238/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:16:11 INFO - PID 20813 | RSS: Main: 172589056 22:16:11 INFO - PID 20813 | 22:16:13 INFO - PID 20813 | Cycle 1(1): loaded http://localhost:52238/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52238/tests/kraken/driver.html?testName=ai-astar) 22:16:13 INFO - PID 20813 | RSS: Main: 174182400 22:16:13 INFO - PID 20813 | 22:16:13 INFO - PID 20813 | __start_tp_report 22:16:13 INFO - PID 20813 | _x_x_mozilla_page_load 22:16:13 INFO - PID 20813 | _x_x_mozilla_page_load_details 22:16:13 INFO - PID 20813 | |i|pagename|runs| 22:16:13 INFO - PID 20813 | |0;ai-astar;105;113;115;115;111;114;112;114;112;115 22:16:13 INFO - PID 20813 | |1;audio-beat-detection;153;124;126;169;122;124;123;137;147;126 22:16:13 INFO - PID 20813 | |2;audio-dft;165;165;162;163;163;166;170;168;162;162 22:16:13 INFO - PID 20813 | |3;audio-fft;78;75;74;104;76;77;76;76;92;76 22:16:13 INFO - PID 20813 | |4;audio-oscillator;84;84;101;84;83;84;97;83;83;106 22:16:13 INFO - PID 20813 | |5;imaging-gaussian-blur;114;117;115;114;115;117;115;117;120;114 22:16:13 INFO - PID 20813 | |6;imaging-darkroom;151;158;156;150;153;152;150;151;150;151 22:16:13 INFO - PID 20813 | |7;imaging-desaturate;95;96;94;95;95;94;99;97;95;94 22:16:13 INFO - PID 20813 | |8;json-parse-financial;56;55;55;55;56;56;55;60;55;55 22:16:13 INFO - PID 20813 | |9;json-stringify-tinderbox;56;56;55;56;58;55;56;58;56;56 22:16:13 INFO - PID 20813 | |10;stanford-crypto-aes;85;85;92;82;81;92;83;83;81;82 22:16:13 INFO - PID 20813 | |11;stanford-crypto-ccm;132;135;131;132;136;136;140;145;192;131 22:16:13 INFO - PID 20813 | |12;stanford-crypto-pbkdf2;186;199;193;198;199;197;199;199;187;197 22:16:13 INFO - PID 20813 | |13;stanford-crypto-sha256-iterative;78;73;76;73;75;76;75;76;76;75 22:16:13 INFO - PID 20813 | __end_tp_report 22:16:13 INFO - PID 20813 | __start_cc_report 22:16:13 INFO - PID 20813 | _x_x_mozilla_cycle_collect,800 22:16:13 INFO - PID 20813 | __end_cc_report 22:16:13 INFO - PID 20813 | __startTimestamp1495084573895__endTimestamp 22:16:13 INFO - PID 20813 | 22:16:13 INFO - PID 20813 | ------- Summary: start ------- 22:16:13 INFO - PID 20813 | Number of tests: 14 22:16:13 INFO - PID 20813 | 22:16:13 INFO - PID 20813 | [#0] ai-astar Cycles:10 Average:112.60 Median:114.00 stddev:3.03 (2.7%) stddev-sans-first:1.51 22:16:13 INFO - PID 20813 | Values: 105.0 113.0 115.0 115.0 111.0 114.0 112.0 114.0 112.0 115.0 22:16:13 INFO - PID 20813 | 22:16:13 INFO - PID 20813 | [#1] audio-beat-detection Cycles:10 Average:135.10 Median:131.50 stddev:16.14 (12.3%) stddev-sans-first:15.77 22:16:13 INFO - PID 20813 | Values: 153.0 124.0 126.0 169.0 122.0 124.0 123.0 137.0 147.0 126.0 22:16:13 INFO - PID 20813 | 22:16:13 INFO - PID 20813 | [#2] audio-dft Cycles:10 Average:164.60 Median:165.00 stddev:2.76 (1.7%) stddev-sans-first:2.92 22:16:13 INFO - PID 20813 | Values: 165.0 165.0 162.0 163.0 163.0 166.0 170.0 168.0 162.0 162.0 22:16:13 INFO - PID 20813 | 22:16:13 INFO - PID 20813 | [#3] audio-fft Cycles:10 Average:80.40 Median:76.00 stddev:9.75 (12.8%) stddev-sans-first:10.31 22:16:13 INFO - PID 20813 | Values: 78.0 75.0 74.0 104.0 76.0 77.0 76.0 76.0 92.0 76.0 22:16:13 INFO - PID 20813 | 22:16:13 INFO - PID 20813 | [#4] audio-oscillator Cycles:10 Average:88.90 Median:84.00 stddev:8.85 (10.5%) stddev-sans-first:9.21 22:16:13 INFO - PID 20813 | Values: 84.0 84.0 101.0 84.0 83.0 84.0 97.0 83.0 83.0 106.0 22:16:13 INFO - PID 20813 | 22:16:13 INFO - PID 20813 | [#5] imaging-gaussian-blur Cycles:10 Average:115.80 Median:116.00 stddev:1.93 (1.7%) stddev-sans-first:1.94 22:16:13 INFO - PID 20813 | Values: 114.0 117.0 115.0 114.0 115.0 117.0 115.0 117.0 120.0 114.0 22:16:13 INFO - PID 20813 | 22:16:13 INFO - PID 20813 | [#6] imaging-darkroom Cycles:10 Average:152.20 Median:151.50 stddev:2.74 (1.8%) stddev-sans-first:2.87 22:16:13 INFO - PID 20813 | Values: 151.0 158.0 156.0 150.0 153.0 152.0 150.0 151.0 150.0 151.0 22:16:13 INFO - PID 20813 | 22:16:13 INFO - PID 20813 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.00 stddev:1.58 (1.7%) stddev-sans-first:1.67 22:16:13 INFO - PID 20813 | Values: 95.0 96.0 94.0 95.0 95.0 94.0 99.0 97.0 95.0 94.0 22:16:13 INFO - PID 20813 | 22:16:13 INFO - PID 20813 | [#8] json-parse-financial Cycles:10 Average:55.80 Median:55.50 stddev:1.55 (2.8%) stddev-sans-first:1.64 22:16:13 INFO - PID 20813 | Values: 56.0 55.0 55.0 55.0 56.0 56.0 55.0 60.0 55.0 55.0 22:16:13 INFO - PID 20813 | 22:16:13 INFO - PID 20813 | [#9] json-stringify-tinderbox Cycles:10 Average:56.20 Median:56.00 stddev:1.03 (1.8%) stddev-sans-first:1.09 22:16:13 INFO - PID 20813 | Values: 56.0 56.0 55.0 56.0 58.0 55.0 56.0 58.0 56.0 56.0 22:16:13 INFO - PID 20813 | 22:16:13 INFO - PID 20813 | [#10] stanford-crypto-aes Cycles:10 Average:84.60 Median:84.00 stddev:4.14 (4.9%) stddev-sans-first:4.39 22:16:13 INFO - PID 20813 | Values: 85.0 85.0 92.0 82.0 81.0 92.0 83.0 83.0 81.0 82.0 22:16:13 INFO - PID 20813 | 22:16:13 INFO - PID 20813 | [#11] stanford-crypto-ccm Cycles:10 Average:141.00 Median:136.00 stddev:18.46 (13.6%) stddev-sans-first:19.29 22:16:13 INFO - PID 20813 | Values: 132.0 135.0 131.0 132.0 136.0 136.0 140.0 145.0 192.0 131.0 22:16:13 INFO - PID 20813 | 22:16:13 INFO - PID 20813 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:195.40 Median:198.50 stddev:5.04 (2.5%) stddev-sans-first:4.03 22:16:13 INFO - PID 20813 | Values: 186.0 199.0 193.0 198.0 199.0 197.0 199.0 199.0 187.0 197.0 22:16:13 INFO - PID 20813 | 22:16:13 INFO - PID 20813 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:75.30 Median:76.00 stddev:1.49 (2.0%) stddev-sans-first:1.22 22:16:13 INFO - PID 20813 | Values: 78.0 73.0 76.0 73.0 75.0 76.0 75.0 76.0 76.0 75.0 22:16:13 INFO - PID 20813 | -------- Summary: end -------- 22:16:13 INFO - PID 20813 | 22:16:14 INFO - TEST-INFO | 20813: exit 0 22:16:15 INFO - TEST-OK | kraken | took 63451ms 22:16:15 INFO - SUITE-END | took 1181s 22:16:15 INFO - Completed test suite (00:19:41) 22:16:15 INFO - javascript benchmark 22:16:15 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6690.235303952782, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2665.2404064841526, 2667.9599806002907, 2668.7464690854363, 2679.3971356444795, 2711.7559419652225, 5058.721770302632, 5157.664751791131, 5170.53465188133, 5188.2995795567585, 5229.947700522998, 5154.5103215194495, 5167.9224811627855, 5224.63427560071, 5262.210668399742, 5286.101362768329, 4323.313907576048, 4496.145732310867, 4618.699784514012, 4625.861224163281, 4668.813247470097, 4694.624430045588, 4713.646476514258, 4724.055188962204, 4735.6921800083055, 4774.355462012636, 4552.954470455286, 4612.5156858530045, 4646.0, 4664.13713463007, 4723.197056500386, 4625.306204069383, 4638.837640682594, 4653.139169253665, 4678.485366609671, 4685.789139488697, 4595.678302518825, 4616.330632058366, 4624.445066591997, 4634.026854360554, 4676.766161691936, 5071.011152825201, 5198.870028249286, 5228.712420816853, 5229.790808367661, 5271.341082364705, 5542.86142846428, 5590.077637189899, 5668.773249070074, 5682.914756278659, 5705.6006079574445, 5668.943310566883, 5671.8582035449035, 5672.489475947144, 5675.858103547403, 5681.659100453986, 5249.685018898802, 5277.393099793535, 5279.762410691528, 5286.656367336111, 5328.467153284718, 5615.6630602164005, 5687.146927960756, 5705.971470142623, 5782.710864456761, 5831.591788574759, 5561.833145005657, 5573.470520300565, 5573.665580065209, 5573.972130139405, 5603.495685388335, 5464.480874316933, 5528.944710552843, 5587.720613969285, 5608.915866262009, 5630.352509461382, 5598.216249725042, 5615.129654903497, 5617.129344951539, 5637.182608521824, 5673.8297851064535, 5385.569154467712, 5445.319335083114, 5579.38626751057, 5587.497125258747, 5660.320761508646, 4683.7892294846815, 4727.64542659302, 4731.574158325767, 4767.094252092092, 4773.37946067016, 4036.3340048891605, 4038.970062634068, 4053.9257096869355, 4057.634812866797, 4086.896537934741, 4531.274996000624, 4575.428071491064, 4642.651801114863, 4691.929621055687, 4735.431748190239, 5654.830355089354, 5664.830055098354, 5669.688167150764, 5704.344000440003, 5720.08478643415, 4678.485366609671, 4685.109829132454, 4686.554777296152, 4696.0, 4716.339712440261, 4843.07981483517, 4907.754612269444, 4962.5533701967, 4982.402111746541, 4986.177280748636, 5174.0, 5222.112240918977, 5248.0, 5254.474552544715, 5261.710605916558, 5660.471672648444, 5665.5750818689585, 5670.8015219467125, 5671.120976248688, 5693.089105743061, 4998.925016124834, 5219.765110569958, 5223.764930578209, 5224.085784987688, 5268.157094864803, 5476.069068258326, 5489.149181876815, 5492.752826122754, 5498.092814685692, 5498.285222921155, 5564.360098588552, 5577.498025177753, 5624.29696287964, 5698.857528561653, 5719.542436604978, 5441.483059109379, 5500.477454641803, 5512.889742205213, 5522.751476183662, 5538.418466061005, 5481.232627432083, 5488.17677348401, 5488.780448782004, 5491.588130890119, 5496.038193316233, 5371.867824697951, 5394.649347792381, 5424.050791111461, 5427.755750991136, 5474.397816240131, 5385.434529374359, 5449.23710680513, 5510.421405752499, 5569.331680198402, 5580.665160090408, 5385.4076051635075, 5388.892222155457, 5392.649477783932, 5396.568274538106, 5428.4842939920645], "value": 5086.216678715535, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [727.0657205490944, 740.6222826358558, 1027.8252697041503, 1037.2842738510433, 1154.411250262366, 33002.33995320092, 34146.0, 34327.313453730945, 34332.65667343329, 34432.48351274733, 31504.369912601735, 31775.0, 31920.0, 32062.35875282499, 32171.83914080432, 6318.620882747027, 6479.384458476449, 6615.106960560335, 6927.168739751237, 6950.235474097845, 7023.648817559128, 7107.111611048619, 7129.928700713004, 7132.714691412337, 7136.85726285474, 7090.113735783028, 7116.217216106224, 7120.430365570742, 7153.499255052148, 7154.320339567733, 7036.612986285752, 7055.329743674342, 7059.752908648173, 7090.042844216016, 7096.609686467243, 7005.054317667101, 7015.15818101826, 7043.154821421411, 7068.338940349014, 7084.539504932214, 32004.199895002577, 32200.677993220237, 32254.193645158823, 32294.515582266285, 32314.0, 2960.9407811843644, 2963.836988965606, 2965.0808249442744, 2997.8351190684502, 2999.4151140527606, 24603.261902142964, 24616.630750538756, 24625.63061554078, 24681.876590616932, 24759.62860557093, 3105.1305634422397, 3130.733887619555, 3145.4652709039287, 3147.401993621205, 3147.6065491813524, 137295.62704372927, 137657.0, 137715.0, 137870.0, 138595.0, 37707.24585508274, 39285.0, 39362.80318598446, 39535.40696889549, 39797.44354963697, 41603.7919810399, 41659.1668166635, 41678.749637510926, 41728.58271417247, 41763.58236417597, 11128.666140015812, 11183.664490065312, 11207.215494915441, 11212.551497940154, 11235.887641123647, 8862.689805856764, 9201.539923003824, 9217.078292170863, 9241.491717955578, 9254.537273136317, 12582.622521324192, 12608.81086783699, 12609.684757881127, 12611.369431528386, 12795.488180472863, 5255.106631872591, 5270.657407268515, 5277.683338999673, 5369.087255166631, 5408.972955135199, 865.9350548708873, 906.7628566019248, 907.3920473282916, 921.3090182363228, 939.5302348825587, 20188.59622807565, 20929.26747563828, 21044.579108417747, 21302.36092917215, 21508.462288442603, 893.5442924108621, 893.6068130022769, 902.3818684201343, 913.6025828764509, 934.3039435620507, 10652.414117223627, 11138.0, 11173.385463799406, 11190.216684831983, 11278.323300601991, 167505.0, 167929.0, 167975.16012420104, 168416.0, 169046.0, 38728.612713873066, 39202.80398597989, 39268.60731392707, 39318.606813931496, 39439.80280098581, 1199.8200269959575, 1237.7091383524864, 1242.2174030360816, 1245.2466257913832, 1245.8816412440622, 18766.437006889813, 19297.0, 20103.497412564804, 20185.02526230066, 20373.898130509253, 29105.563416549194, 29330.266743330732, 29345.7065429343, 29398.706012940453, 29415.0, 133799.0, 135732.4627406642, 155526.0, 156454.0, 156482.0, 29876.070448375776, 30167.547486787276, 30397.544036839023, 30593.847030764704, 30719.846400767852, 36477.63522364743, 36871.815640921624, 36976.260474789815, 37599.248015040095, 37723.43414848834, 27602.861985689942, 27831.920763780126, 28352.716472835833, 29094.563581546718, 29274.707252927197, 27377.589336159574, 27809.0, 28096.0, 28343.716562834106, 29159.70840291655, 30016.84991575028, 30882.69117308888, 30992.0, 31212.687873120976, 31239.375212495168, 26701.332466687712, 27562.862185688944, 27655.585166222925, 28284.434311313245, 28675.426491469636, 20916.47708807292, 22862.0, 23101.65347519822, 23129.190478333177, 23189.3043208704], "value": 14364.745355775982, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [404.3651467196503, 409.73162578511085, 409.87703688893333, 420.43661493598574, 425.4086819321144, 14609.05041172323, 15403.075815451053, 16389.18054097295, 17089.14554272286, 17102.572435689115, 17194.226259818308, 17324.307027718907, 17340.393086241984, 17359.82640173598, 17458.912705436454, 5364.70494122824, 5382.5963052771, 5409.810656627019, 5553.278073850393, 5561.360443548983, 5402.756875940592, 5485.067538518441, 5489.204065410513, 5500.477454641823, 5501.807436739715, 5251.159814429692, 5395.973020134894, 5466.753996070186, 5469.808556700516, 5498.862528436781, 5410.972945135269, 5429.131338985743, 5438.619296649196, 5451.809186678447, 5463.453654634544, 4834.782434790408, 4931.0630980113665, 4939.333190019337, 4950.529699678525, 4963.205887058053, 21131.788682113136, 21316.893415532977, 21776.564468710538, 21949.561008779736, 21949.561008779896, 1627.2921279243567, 1665.8584020358285, 1672.1304921440903, 1672.774175486306, 1673.4895856763683, 13891.930540347335, 13921.164730116225, 14233.501827436094, 14673.926630366886, 14811.925940370229, 2039.734834471524, 2109.219588752156, 2144.0887622760265, 2145.4529095080657, 2145.6674215496623, 90633.54683226542, 95023.0, 95702.52148739282, 95873.52063239709, 96504.51747741217, 10887.074598659045, 10907.29102608328, 11120.22158448917, 11214.887851121384, 11308.491117899714, 15722.371105155895, 15725.606859828596, 15760.369585216693, 15767.68464630724, 15782.210889455482, 6577.0, 6702.195736511552, 6823.044773731682, 6929.618870962146, 6931.792046238621, 5867.325257595346, 5920.703964801743, 6049.0, 6055.6063855849225, 6066.332703402622, 6811.863762724817, 6880.311968803079, 6915.446764258847, 6925.203601585781, 7091.1490621125795, 2035.7760646328893, 2062.6905964105204, 2075.5952589245253, 2090.560982193726, 2164.2533326002504, 834.3408707121428, 863.3783675753448, 878.4904755242072, 889.6263569300779, 899.0739538275586, 16469.176541172892, 17199.31202751901, 17394.0, 17410.303587856342, 17611.38360157388, 863.8833757442791, 867.0808942520948, 867.8394497018072, 868.2749903830246, 896.9013408525057, 8962.641494340154, 9085.636574537077, 9286.72139835806, 9325.253979681609, 9441.622335106656, 356375.0, 360264.0, 360429.0, 390685.0, 399184.0, 75775.24224757683, 76194.28422915068, 77174.61412692901, 80350.0, 80494.0, 1064.984025239622, 1083.9999999999843, 1102.5699977008974, 1123.640435060789, 1131.055568600228, 17070.74393884068, 17151.399701010403, 17806.287748489915, 18292.26830926748, 18480.075996199866, 36180.27639447249, 37271.0, 37977.240455190185, 38517.6148238514, 38630.6136938627, 47163.528364715916, 47343.28985065158, 47373.763131184125, 47447.28829067498, 50409.49590504048, 7950.920490795018, 7976.880346794919, 8043.8281663951575, 8076.636551355321, 8282.17178282167, 12053.819192712292, 12208.877911220774, 12425.37873106359, 12519.812202816784, 12817.935910320388, 10835.729106772395, 11128.554857805597, 11185.608503702331, 11496.885031149915, 11566.132540059361, 9532.761680958032, 9616.855747163658, 9672.129508344002, 9690.0, 10252.692419227435, 10522.421266830397, 10729.570817167227, 11026.558937642725, 11085.944570277097, 11239.595050618673, 8236.299914507334, 8325.625346859528, 8588.699395521127, 8602.61288242018, 8718.476891386537, 11039.392833393918, 11171.38557379352, 11176.0, 11370.0, 11595.362255076052], "value": 8733.304336998377, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1258.5972488803584, 1283.6213317071463, 1307.4835440001207, 1312.5274901035632, 1321.3459337627876, 9972.501374931251, 10465.424401657916, 10469.267151299402, 10512.842307365396, 10609.681709548706, 10598.576056957712, 10669.83995240072, 10693.304935179209, 10743.83884241737, 10774.515146818392, 2307.2962746362355, 2361.5749165150264, 2364.6689463475127, 2364.9763502364926, 2367.763223677627, 2176.1295481807247, 2193.0679461228915, 2262.072550254396, 2328.871912044837, 2335.0309621507054, 2250.9212177573786, 2267.671187677786, 2275.249167774639, 2277.4534111813127, 2279.430142464384, 2156.5255643758346, 2174.923877664274, 2178.1287485005964, 2200.5928903152967, 2201.625723626987, 2102.4954011037394, 2115.2596591193114, 2126.5640543688505, 2126.946826329339, 2134.7331583552054, 10002.799944001152, 10087.949560252226, 10093.444860532667, 10234.385936843813, 10236.283460157792, 5368.1679339702405, 5468.070428027205, 5518.255035570187, 5527.972360138214, 5548.500634942875, 3350.9329813403597, 3541.309444658267, 3616.620254873253, 3715.0, 3731.421629647409, 1037.3931250218632, 1054.974449057811, 1089.0906093412011, 1096.5942601237514, 1098.4068602954394, 15007.399704011827, 15105.697886042328, 15151.772723409158, 15266.618334541614, 15276.923615381964, 4641.559051890065, 4819.421669399624, 4886.633502487328, 4905.779239934212, 4914.434839993375, 10997.230193886511, 11011.394373309384, 11028.393438360967, 11034.724131896606, 11036.944815276032, 5307.548858347007, 5321.361436627552, 5329.493698098674, 5331.120365139708, 5334.653247538898, 4872.853814385574, 4934.7285899275885, 4985.775640096204, 4994.300797888299, 5032.823851165265, 3779.244151169777, 3929.8428062877165, 3942.5860284669698, 3968.412634946045, 4018.794361691481, 1131.9830202546968, 1146.140394703972, 1163.2148299897535, 1164.7554013657057, 1171.1158075652997, 698.6960672107649, 723.6200994477941, 728.8943103249999, 729.0849983271067, 743.3235755462504, 6032.517398608101, 6176.505879529627, 6197.287311959182, 6215.098810672517, 6223.875522489616, 839.3536976528039, 841.8779277004923, 850.1753299299669, 852.071242345846, 857.0972441180569, 3374.9712927737496, 3376.03782921871, 3397.8301084945656, 3411.812350320756, 3425.743069269815, 12826.55107071248, 13201.141925774795, 13224.801627975588, 13256.005799564879, 13258.867411325957, 12819.102662813513, 13138.671533211746, 13343.73312533744, 13371.732565348639, 13387.933060334635, 6796.932030679729, 6885.380315771505, 6925.099737034254, 6935.3411425914455, 6970.965145174242, 6113.480354169946, 6313.273973492924, 6360.141380913517, 6453.580517266362, 6621.9337806621315, 11793.115516336138, 11994.520219191134, 12028.63914082579, 12071.215371000857, 12079.818802717791, 12001.0, 12146.817797733218, 12323.137380383287, 12333.62999110028, 12356.567520136752, 8268.0, 8516.70191543293, 8547.188017138362, 8585.742427727178, 8587.184217499327, 9461.337706360764, 9796.118349348593, 9803.411795292306, 9806.607735690492, 9808.950955245464, 7927.682892684228, 8321.417500774887, 8361.83276334482, 8388.286995605442, 8534.82930341402, 7496.550206987598, 7712.190220027041, 7834.960825195838, 8108.83782324362, 8228.547429891414, 7557.168711441627, 7678.232176782277, 7697.499662521918, 7697.769066928001, 7706.190849960673, 5300.549453296513, 5307.4692530746615, 5361.785528578813, 5376.973115134399, 5589.161625756169, 5481.972590137024, 5502.779888804403, 5534.723263836711, 5651.208830763779, 5718.571107166896], "value": 4786.875319262792, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [365.26034779571364, 384.43488072533364, 387.72084099448404, 390.8163163313243, 397.85876014015025, 5320.228566857813, 5467.644603100801, 5476.096444086726, 5490.396056433789, 5494.725263736807, 5252.0, 5288.867778305545, 5309.0, 5327.467253274671, 5371.328583927009, 4059.6752259819145, 4063.2889244382263, 4072.2669919414493, 4088.6115818997146, 4100.425940368351, 3960.52473703156, 4076.9184616307657, 4080.367543030835, 4097.569755175708, 4109.691773117013, 4048.271311163989, 4057.5536690963972, 4063.1061166543313, 4065.2885744994655, 4072.165206132736, 4063.1670507546028, 4071.145059537486, 4090.0, 4103.4870641169855, 4103.712740108193, 3585.731070169748, 3593.317269718745, 3603.72972027099, 3610.1696609779633, 3614.331348700499, 5201.0, 5247.134222853225, 5258.55302299305, 5274.314339135888, 5279.366476022863, 4754.66717329787, 4760.904781904377, 4769.642276829251, 4776.49846766088, 4783.354247176621, 5517.420670829545, 5670.319561652587, 5671.546276297886, 5730.885382292373, 5743.425657434265, 3990.4237826058834, 3998.420229066798, 4002.9199416011807, 4018.4374187613757, 4028.4158796974275, 5884.794032208895, 6007.549433792483, 6022.247219097613, 6039.0, 6112.327643959161, 4060.0, 4067.572904845008, 4074.959250407517, 4077.7145599808323, 4084.65280451159, 4146.875593732193, 4154.729942553724, 4160.521540022875, 4160.916781664349, 4161.209370219649, 4696.7416792076765, 4720.268358404453, 4772.2364421693055, 4775.6657034007985, 4781.163296423112, 5705.486506214377, 5736.713164341766, 5740.196372507852, 5742.569307301969, 5745.540356771448, 1407.8451370349253, 1421.3319739722315, 1428.4000719697751, 1432.7994080828691, 1434.2470203143432, 927.9536023198813, 953.3088510829732, 957.4446820843893, 960.7646126699003, 962.4465932089076, 4817.759112044384, 4845.685030473008, 4853.80584776605, 4875.293082503017, 4878.682885612424, 5843.590948633555, 5872.823815285548, 5876.764929402776, 5879.823605291848, 5906.8818623627285, 4679.722197382927, 4809.735464549413, 4824.973511125336, 4843.2250839865455, 4845.200541910615, 3072.201227680819, 3093.520504321834, 3106.192389978622, 3124.781265311452, 3128.1084890806465, 5413.834466213546, 5416.891662166813, 5422.295101636762, 5436.646617969819, 5443.700596467233, 5886.676232807236, 6072.605280656743, 6090.786822461193, 6110.694465276719, 6130.601510901866, 5454.61817672767, 5473.124300111963, 5475.342958844964, 5477.561795056466, 5478.506934375846, 5785.710714464176, 5906.586538942232, 5921.792737254175, 5948.821535353946, 5952.666506756231, 5860.736266867916, 5868.4424979626865, 5870.383609721089, 5873.530117590668, 5882.970585147047, 5291.947080529146, 5455.345358556999, 5457.20870473787, 5460.153676180198, 5462.481064298885, 4033.5159780825315, 4057.5190055630073, 4074.8166332514515, 4076.5311989121633, 4082.0, 5873.853153671193, 5973.253343332083, 5983.371745966785, 5984.431479009487, 5988.520918326611, 5724.627899186539, 5741.0, 5759.568032397503, 5759.9136012959, 5760.251167348218, 5743.913841292468, 5751.798687045934, 5754.56840736938, 5761.510271626791, 5762.30852297727, 5472.261244731911, 5620.74706638194, 5627.549796016391, 5676.460736230051, 5677.545796336366, 5732.3121225453215, 5773.393793651774, 5776.0, 5781.710914454345, 5799.4780469757925, 5482.616216864782, 5583.692896890548, 5594.216809646734, 5598.772926440674, 5626.521745651502], "value": 4269.492591400002, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [741.4402126394572, 757.6590534259583, 760.9086909570852, 763.8586861430636, 773.2769860180731, 11478.483468243929, 11829.46767395467, 13060.608181754551, 13868.653283667913, 13924.094933829307, 15098.849011509881, 15290.847091529082, 15723.292451839667, 15809.446669366545, 15845.841541584581, 831.8835363049178, 852.4288726553224, 852.9872051919226, 854.1842540373927, 855.6620135046653, 901.0223907060847, 901.6032945503957, 903.056306160061, 903.105925134119, 903.6295119001211, 942.9764255893589, 945.8723072385243, 948.0519480519481, 949.2880339745191, 949.2975198353204, 935.9578818953096, 937.6436953957486, 938.0, 944.8346539355654, 945.0927109974399, 694.3681250062419, 695.1033167214338, 695.7286658203304, 696.5890124826326, 696.7282759723712, 14346.210958397283, 14750.336234869457, 15445.382184712598, 15562.688746225125, 15641.843581564153, 15736.291866866019, 15837.12895790731, 15898.364065437368, 15967.680646387123, 16082.919585402115, 12821.743565128738, 12838.871611283861, 12922.806157907638, 13040.413181406859, 13176.670583235496, 3075.984620076885, 3085.1053194573547, 3093.5050391937184, 3095.628524577065, 3100.023492599824, 65285.0, 66208.66895665538, 66320.66839665819, 66326.66836665834, 67611.66194169047, 12026.819597706042, 12199.75600488003, 12253.326067066397, 12297.139200256075, 12311.384430778604, 20804.271850485464, 21298.57402851965, 22486.100555977904, 22722.43193920165, 22829.7717022831, 5880.8235752927485, 6059.394060593993, 6114.877702446015, 6133.325334213233, 6270.435660790551, 3064.111407691789, 3118.5789918361183, 3122.5316202569343, 3124.0940127363265, 3136.5295205719326, 3318.070940136766, 3379.425497665403, 3389.491576263531, 3397.779144355609, 3525.4183059794846, 727.8144073261285, 742.2874040920668, 751.0724255544399, 751.5077624156187, 752.6913965274211, 578.0231806198113, 597.9461848433662, 602.7588964414269, 609.2658346692225, 620.6245221640933, 9397.389169703947, 9516.429014259167, 9580.18568421678, 9624.566894489764, 9973.252006099572, 608.1273372710175, 609.4058293164218, 617.7251123250201, 630.4326106504092, 639.0701529274894, 4068.16602596467, 4157.750534967911, 4249.851255206053, 4300.591443812833, 4322.589354011364, 64675.35324646787, 64747.0, 65156.0, 65632.34367656262, 67373.0, 55308.44691553033, 55739.721301393234, 55817.720911396, 57936.71031644899, 58717.11924321139, 52073.21890171651, 52306.738466307426, 52780.0, 53761.731191343795, 54327.45672543224, 8316.792080197802, 8570.228679418633, 8572.185642363966, 8666.480011199348, 8870.0, 26075.217743467725, 26340.4731905357, 26420.0, 26473.205803825917, 27127.86436067807, 31305.8434707825, 31712.365752684356, 32243.0, 45277.773611131735, 45433.0, 14390.208538530482, 14577.708445831237, 14629.634259143606, 14947.626309342353, 15168.544943651708, 15311.923440382727, 15651.530454086396, 15958.04251744899, 16289.0, 16622.916885415496, 14480.0, 14721.92639036798, 14908.85091149118, 15324.387024519341, 15512.457064003158, 14308.57074287773, 14487.637809054437, 15193.848061519244, 15740.402833532797, 16121.355145794038, 13164.539241126899, 13381.799273010718, 13404.195748255135, 13519.324033798468, 13581.660458488617, 9730.464824434725, 9923.156531694887, 9965.900340996497, 10035.046670566284, 10165.898341016791, 12051.0, 12835.743285134431, 12931.741365172831, 12952.740945180854, 13055.673608159872], "value": 6875.7033490300755, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1553.2999999999997, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 113.0, 115.0, 115.0, 111.0, 114.0, 112.0, 114.0, 112.0, 115.0], "value": 112.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 124.0, 126.0, 169.0, 122.0, 124.0, 123.0, 137.0, 147.0, 126.0], "value": 135.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 165.0, 162.0, 163.0, 163.0, 166.0, 170.0, 168.0, 162.0, 162.0], "value": 164.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 75.0, 74.0, 104.0, 76.0, 77.0, 76.0, 76.0, 92.0, 76.0], "value": 80.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 101.0, 84.0, 83.0, 84.0, 97.0, 83.0, 83.0, 106.0], "value": 88.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 117.0, 115.0, 114.0, 115.0, 117.0, 115.0, 117.0, 120.0, 114.0], "value": 115.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 158.0, 156.0, 150.0, 153.0, 152.0, 150.0, 151.0, 150.0, 151.0], "value": 152.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 94.0, 95.0, 95.0, 94.0, 99.0, 97.0, 95.0, 94.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 55.0, 55.0, 55.0, 56.0, 56.0, 55.0, 60.0, 55.0, 55.0], "value": 55.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 55.0, 56.0, 58.0, 55.0, 56.0, 58.0, 56.0, 56.0], "value": 56.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 92.0, 82.0, 81.0, 92.0, 83.0, 83.0, 81.0, 82.0], "value": 84.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 135.0, 131.0, 132.0, 136.0, 136.0, 140.0, 145.0, 192.0, 131.0], "value": 141.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 199.0, 193.0, 198.0, 199.0, 197.0, 199.0, 199.0, 187.0, 197.0], "value": 195.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 73.0, 76.0, 73.0, 75.0, 76.0, 75.0, 76.0, 76.0, 75.0], "value": 75.3, "unit": "score"}]}]} 22:16:15 INFO - Return code: 0 22:16:15 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 22:16:15 INFO - # TBPL SUCCESS # 22:16:15 INFO - Running post-action listener: _resource_record_post_action 22:16:15 INFO - [mozharness: 2017-05-18 05:16:15.180139Z] Finished run-tests step (success) 22:16:15 INFO - Running post-run listener: _resource_record_post_run 22:16:15 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 8192; Write bytes: 421679104; Read time: 44; Write time: 245180 22:16:15 INFO - TinderboxPrint: CPU usage
13.3% 22:16:15 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 44 22:16:15 INFO - TinderboxPrint: I/O write bytes / time
421,679,104 / 245,180 22:16:15 INFO - TinderboxPrint: CPU idle
8,293.0 (86.7%) 22:16:15 INFO - TinderboxPrint: CPU user
1,219.5 (12.7%) 22:16:15 INFO - TinderboxPrint: Swap in / out
0 / 0 22:16:15 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 4096; Write bytes: 98934784; Read time: 32; Write time: 63060 22:16:15 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 0; Write bytes: 322179072; Read time: 0; Write time: 182092 22:16:15 INFO - Running post-run listener: _upload_blobber_files 22:16:15 INFO - Blob upload gear active. 22:16:15 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 22:16:15 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 22:16:15 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', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 22:16:15 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 -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 22:16:16 INFO - (blobuploader) - INFO - Open directory for files ... 22:16:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 22:16:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:16:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:16:19 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 22:16:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:16:19 INFO - (blobuploader) - INFO - Done attempting. 22:16:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 22:16:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:16:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:16:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 22:16:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:16:20 INFO - (blobuploader) - INFO - Done attempting. 22:16:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 22:16:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:16:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:16:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 22:16:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:16:21 INFO - (blobuploader) - INFO - Done attempting. 22:16:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 22:16:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:16:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:16:23 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 22:16:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:16:23 INFO - (blobuploader) - INFO - Done attempting. 22:16:23 INFO - (blobuploader) - INFO - Iteration through files over. 22:16:23 INFO - Return code: 0 22:16:23 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 22:16:23 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 22:16:23 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/472c275e0df64f64759217659a7f25c1a8a8ac2502bc51b76c6f7f41d8507527ca5611577e898a80105c84b1c71fe3f1c36a893b3b682c6546289b05c7bf81e5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5ce73eab30a1c4f4e855cf0697984ba644725a47d8a2daaf9110e545f6235460a3bf137ac2141b5aaebed5a4851fad0a73e469d86c153d9297c02f0e61f63039", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a4df1bc469fea47626ff131e03a7b5ed293dbdd7f8a5f99e2a611466fc61871649369a96e8155bb1aa18a5d8d59da5599420cb44d84e5f4b73e7daa9120ce80d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4b45a861b66ea1d493ca36ff2ed6b0f2d49173230062c2517dd4ec184d0c6784dfe03f0fdd8956048f40d6e36e02f713c6403792b6e514d90114b689a1b6407a"} 22:16:23 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 22:16:23 INFO - Writing to file /builds/slave/test/properties/blobber_files 22:16:23 INFO - Contents: 22:16:23 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/472c275e0df64f64759217659a7f25c1a8a8ac2502bc51b76c6f7f41d8507527ca5611577e898a80105c84b1c71fe3f1c36a893b3b682c6546289b05c7bf81e5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5ce73eab30a1c4f4e855cf0697984ba644725a47d8a2daaf9110e545f6235460a3bf137ac2141b5aaebed5a4851fad0a73e469d86c153d9297c02f0e61f63039", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a4df1bc469fea47626ff131e03a7b5ed293dbdd7f8a5f99e2a611466fc61871649369a96e8155bb1aa18a5d8d59da5599420cb44d84e5f4b73e7daa9120ce80d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4b45a861b66ea1d493ca36ff2ed6b0f2d49173230062c2517dd4ec184d0c6784dfe03f0fdd8956048f40d6e36e02f713c6403792b6e514d90114b689a1b6407a"} 22:16:23 INFO - Running post-run listener: copy_logs_to_upload_dir 22:16:23 INFO - Copying logs to upload dir... 22:16:23 INFO - mkdir: /builds/slave/test/build/upload/logs 22:16:23 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1259.103343 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2017-05-17 22:16:22.100817) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-17 22:16:22.105876) ========= 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=199fb4c72b90437b990b419b000001c5-1495077469.137364-1482554342 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/472c275e0df64f64759217659a7f25c1a8a8ac2502bc51b76c6f7f41d8507527ca5611577e898a80105c84b1c71fe3f1c36a893b3b682c6546289b05c7bf81e5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5ce73eab30a1c4f4e855cf0697984ba644725a47d8a2daaf9110e545f6235460a3bf137ac2141b5aaebed5a4851fad0a73e469d86c153d9297c02f0e61f63039", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a4df1bc469fea47626ff131e03a7b5ed293dbdd7f8a5f99e2a611466fc61871649369a96e8155bb1aa18a5d8d59da5599420cb44d84e5f4b73e7daa9120ce80d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4b45a861b66ea1d493ca36ff2ed6b0f2d49173230062c2517dd4ec184d0c6784dfe03f0fdd8956048f40d6e36e02f713c6403792b6e514d90114b689a1b6407a"} build_url:https://queue.taskcluster.net/v1/task/Ng2ZE6IuS9S32HYlv8C-HA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011324 build_url: 'https://queue.taskcluster.net/v1/task/Ng2ZE6IuS9S32HYlv8C-HA/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/472c275e0df64f64759217659a7f25c1a8a8ac2502bc51b76c6f7f41d8507527ca5611577e898a80105c84b1c71fe3f1c36a893b3b682c6546289b05c7bf81e5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5ce73eab30a1c4f4e855cf0697984ba644725a47d8a2daaf9110e545f6235460a3bf137ac2141b5aaebed5a4851fad0a73e469d86c153d9297c02f0e61f63039", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a4df1bc469fea47626ff131e03a7b5ed293dbdd7f8a5f99e2a611466fc61871649369a96e8155bb1aa18a5d8d59da5599420cb44d84e5f4b73e7daa9120ce80d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4b45a861b66ea1d493ca36ff2ed6b0f2d49173230062c2517dd4ec184d0c6784dfe03f0fdd8956048f40d6e36e02f713c6403792b6e514d90114b689a1b6407a"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-17 22:16:22.130248) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-17 22:16:22.130640) ========= 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=199fb4c72b90437b990b419b000001c5-1495077469.137364-1482554342 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004496 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-17 22:16:22.215637) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-17 22:16:22.215957) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-17 22:16:22.216338) ========= ========= Total master_lag: 0.16 =========