builder: mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s slave: talos-linux64-ix-045 starttime: 1495112494.58 results: success (0) revision: cf4e37d17683e0cbe134debc1d3685fb3f84e3d1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-18 06:01:34.580454) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-18 06:01:34.581602) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-18 06:01:34.581883) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-18 06:01:34.762928) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-18 06:01:34.763239) ========= 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=4300f881736b422476174874000001bc-1495109824.691067-1273252931 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-18 06:01:34-- 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% 225M=0s 2017-05-18 06:01:34 (225 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.144565 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-18 06:01:34.942465) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-18 06:01:34.942815) ========= 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=4300f881736b422476174874000001bc-1495109824.691067-1273252931 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022010 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-18 06:01:35.008931) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-18 06:01:35.009260) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev cf4e37d17683e0cbe134debc1d3685fb3f84e3d1 --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 cf4e37d17683e0cbe134debc1d3685fb3f84e3d1 --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=4300f881736b422476174874000001bc-1495109824.691067-1273252931 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-18 06:01:34,967 truncating revision to first 12 chars 2017-05-18 06:01:34,967 Setting DEBUG logging. 2017-05-18 06:01:34,967 attempt 1/10 2017-05-18 06:01:34,967 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/cf4e37d17683?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-18 06:01:35,862 unpacking tar archive at: mozilla-central-cf4e37d17683/testing/mozharness/ program finished with exit code 0 elapsedTime=1.221841 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-18 06:01:36.250277) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-18 06:01:36.250623) ========= script_repo_revision: cf4e37d17683e0cbe134debc1d3685fb3f84e3d1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-18 06:01:36.251016) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-18 06:01:36.251284) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-18 06:01:36.281122) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2017-05-18 06:01:36.281500) ========= /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=4300f881736b422476174874000001bc-1495109824.691067-1273252931 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:01:36 INFO - MultiFileLogger online at 20170518 06:01:36 in /builds/slave/test 06:01:36 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 06:01:36 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:01:36 INFO - {'append_to_log': False, 06:01:36 INFO - 'base_work_dir': '/builds/slave/test', 06:01:36 INFO - 'blob_upload_branch': 'Firefox', 06:01:36 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:01:36 INFO - 'branch': 'Firefox', 06:01:36 INFO - 'buildbot_json_path': 'buildprops.json', 06:01:36 INFO - 'config_files': ('talos/linux_config.py',), 06:01:36 INFO - 'default_actions': ('clobber', 06:01:36 INFO - 'read-buildbot-config', 06:01:36 INFO - 'download-and-extract', 06:01:36 INFO - 'populate-webroot', 06:01:36 INFO - 'create-virtualenv', 06:01:36 INFO - 'install', 06:01:36 INFO - 'run-tests'), 06:01:36 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:01:36 INFO - 'download_minidump_stackwalk': True, 06:01:36 INFO - 'download_symbols': 'ondemand', 06:01:36 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:01:36 INFO - 'tooltool.py': '/tools/tooltool.py', 06:01:36 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:01:36 INFO - '/tools/misc-python/virtualenv.py')}, 06:01:36 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:01:36 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:01:36 INFO - 'gecko_profile': False, 06:01:36 INFO - 'gecko_profile_interval': 0, 06:01:36 INFO - 'installer_path': 'installer.exe', 06:01:36 INFO - 'log_level': 'info', 06:01:36 INFO - 'log_name': 'talos', 06:01:36 INFO - 'log_to_console': True, 06:01:36 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:01:36 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:01:36 INFO - 'opt_config_files': (), 06:01:36 INFO - 'pip_index': False, 06:01:36 INFO - 'suite': 'dromaeojs-e10s', 06:01:36 INFO - 'system_bits': '32', 06:01:36 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:01:36 INFO - 'title': 'talos-linux64-ix-045', 06:01:36 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:01:36 INFO - 'use_talos_json': True, 06:01:36 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:01:36 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:01:36 INFO - 'work_dir': 'build'} 06:01:36 INFO - [mozharness: 2017-05-18 13:01:36.332023Z] Running clobber step. 06:01:36 INFO - Running pre-action listener: _resource_record_pre_action 06:01:36 INFO - Running main action method: clobber 06:01:36 INFO - rmtree: /builds/slave/test/build 06:01:36 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:01:37 INFO - Running post-action listener: _resource_record_post_action 06:01:37 INFO - [mozharness: 2017-05-18 13:01:37.348157Z] Finished clobber step (success) 06:01:37 INFO - [mozharness: 2017-05-18 13:01:37.348257Z] Running read-buildbot-config step. 06:01:37 INFO - Running pre-action listener: _resource_record_pre_action 06:01:37 INFO - Running main action method: read_buildbot_config 06:01:37 INFO - Using buildbot properties: 06:01:37 INFO - { 06:01:37 INFO - "project": "", 06:01:37 INFO - "product": "firefox", 06:01:37 INFO - "who": "cbook@mozilla.com", 06:01:37 INFO - "installer_path": "public/build/target.tar.bz2", 06:01:37 INFO - "builddir": "mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s", 06:01:37 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 06:01:37 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo-sequential mozilla-central talos dromaeojs-e10s", 06:01:37 INFO - "stage_platform": "linux64-styloseq", 06:01:37 INFO - "basedir": "/builds/slave/test", 06:01:37 INFO - "buildnumber": 10, 06:01:37 INFO - "platform": "ubuntu64_hw_styloseq", 06:01:37 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 06:01:37 INFO - "slavebuilddir": "test", 06:01:37 INFO - "taskId": "DJ8UQY7tQxiECWHL7322Lw", 06:01:37 INFO - "branch": "mozilla-central", 06:01:37 INFO - "script_repo_revision": "production", 06:01:37 INFO - "revision": "cf4e37d17683e0cbe134debc1d3685fb3f84e3d1", 06:01:37 INFO - "slavename": "talos-linux64-ix-045", 06:01:37 INFO - "repo_path": "mozilla-central" 06:01:37 INFO - } 06:01:37 INFO - Finding installer, test and symbols from parent task. 06:01:37 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DJ8UQY7tQxiECWHL7322Lw'}, attempt #1 06:01:37 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DJ8UQY7tQxiECWHL7322Lw'}, attempt #1 06:01:38 INFO - Task dependencies: bO24eL5IQH2H4y0xcThplw 06:01:38 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bO24eL5IQH2H4y0xcThplw'}, attempt #1 06:01:38 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/bO24eL5IQH2H4y0xcThplw/artifacts/public/build/target.tar.bz2 06:01:38 INFO - Set test_url: https://queue.taskcluster.net/v1/task/bO24eL5IQH2H4y0xcThplw/artifacts/public/build/test_packages.json 06:01:38 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/bO24eL5IQH2H4y0xcThplw/artifacts/public/build/target.crashreporter-symbols.zip 06:01:38 INFO - Running post-action listener: _resource_record_post_action 06:01:38 INFO - [mozharness: 2017-05-18 13:01:38.710515Z] Finished read-buildbot-config step (success) 06:01:38 INFO - [mozharness: 2017-05-18 13:01:38.710737Z] Running download-and-extract step. 06:01:38 INFO - Running pre-action listener: _resource_record_pre_action 06:01:38 INFO - Running main action method: download_and_extract 06:01:38 INFO - mkdir: /builds/slave/test/build/tests 06:01:38 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')]} 06:01:38 INFO - trying https://queue.taskcluster.net/v1/task/bO24eL5IQH2H4y0xcThplw/artifacts/public/build/target.test_packages.json 06:01:38 INFO - Downloading https://queue.taskcluster.net/v1/task/bO24eL5IQH2H4y0xcThplw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 06:01:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bO24eL5IQH2H4y0xcThplw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 06:01:39 INFO - Downloaded 986 bytes. 06:01:39 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 06:01:39 INFO - Using the following test package requirements: 06:01:39 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 06:01:39 INFO - u'common': [u'target.common.tests.zip'], 06:01:39 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 06:01:39 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 06:01:39 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 06:01:39 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 06:01:39 INFO - u'mozbase': [u'target.common.tests.zip'], 06:01:39 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 06:01:39 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 06:01:39 INFO - u'web-platform': [u'target.common.tests.zip', 06:01:39 INFO - u'target.web-platform.tests.zip'], 06:01:39 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 06:01:39 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 06:01:39 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bO24eL5IQH2H4y0xcThplw/artifacts/public/build/target.common.tests.zip 06:01:39 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bO24eL5IQH2H4y0xcThplw/artifacts/public/build/target.common.tests.zip'}, attempt #1 06:01:39 INFO - Fetch https://queue.taskcluster.net/v1/task/bO24eL5IQH2H4y0xcThplw/artifacts/public/build/target.common.tests.zip into memory 06:01:40 INFO - Content-Length response header: 62462532 06:01:40 INFO - Bytes received: 62462532 06:01:51 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 06:01:51 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bO24eL5IQH2H4y0xcThplw/artifacts/public/build/target.common.tests.zip 06:01:51 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bO24eL5IQH2H4y0xcThplw/artifacts/public/build/target.common.tests.zip'}, attempt #1 06:01:51 INFO - Fetch https://queue.taskcluster.net/v1/task/bO24eL5IQH2H4y0xcThplw/artifacts/public/build/target.common.tests.zip into memory 06:01:53 INFO - Content-Length response header: 62462532 06:01:53 INFO - Bytes received: 62462532 06:02:04 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bO24eL5IQH2H4y0xcThplw/artifacts/public/build/target.talos.tests.zip 06:02:04 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bO24eL5IQH2H4y0xcThplw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 06:02:04 INFO - Fetch https://queue.taskcluster.net/v1/task/bO24eL5IQH2H4y0xcThplw/artifacts/public/build/target.talos.tests.zip into memory 06:02:05 INFO - Content-Length response header: 14410001 06:02:05 INFO - Bytes received: 14410001 06:02: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')]} 06:02:05 INFO - trying https://queue.taskcluster.net/v1/task/bO24eL5IQH2H4y0xcThplw/artifacts/public/build/target.tar.bz2 06:02:05 INFO - Downloading https://queue.taskcluster.net/v1/task/bO24eL5IQH2H4y0xcThplw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 06:02:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bO24eL5IQH2H4y0xcThplw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 06:02:07 INFO - Downloaded 59758369 bytes. 06:02:07 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bO24eL5IQH2H4y0xcThplw/artifacts/public/build/target.tar.bz2 06:02:07 INFO - mkdir: /builds/slave/test/properties 06:02:07 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:02:07 INFO - Writing to file /builds/slave/test/properties/build_url 06:02:07 INFO - Contents: 06:02:07 INFO - build_url:https://queue.taskcluster.net/v1/task/bO24eL5IQH2H4y0xcThplw/artifacts/public/build/target.tar.bz2 06:02:07 INFO - Running post-action listener: _resource_record_post_action 06:02:07 INFO - Running post-action listener: set_extra_try_arguments 06:02:07 INFO - [mozharness: 2017-05-18 13:02:07.063231Z] Finished download-and-extract step (success) 06:02:07 INFO - [mozharness: 2017-05-18 13:02:07.063329Z] Running populate-webroot step. 06:02:07 INFO - Running pre-action listener: _resource_record_pre_action 06:02:07 INFO - Running main action method: populate_webroot 06:02:07 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:02:07 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:02:07 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:02:07 INFO - '--tppagecycles', 06:02:07 INFO - '7'], 06:02:07 INFO - 'tests': ['tsvgm']}}, 06:02:07 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:02:07 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:02:07 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:02:07 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:02:07 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:02:07 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:02:07 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 06:02:07 INFO - 'talos_options': ['--disable-e10s'], 06:02:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:02:07 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 06:02:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:02:07 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 06:02:07 INFO - 'talos_options': ['--disable-e10s'], 06:02:07 INFO - 'tests': ['damp', 'tps']}, 06:02:07 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 06:02:07 INFO - 'tests': ['damp', 'tps']}, 06:02:07 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:02:07 INFO - 'tests': ['dromaeo_dom']}, 06:02:07 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:02:07 INFO - 'g4': {'talos_options': ['--disable-e10s'], 06:02:07 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 06:02:07 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 06:02:07 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 06:02:07 INFO - 'tests': ['ts_paint', 'tp5o']}, 06:02:07 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:02:07 INFO - 'tests': ['a11yr', 06:02:07 INFO - 'ts_paint', 06:02:07 INFO - 'tpaint', 06:02:07 INFO - 'sessionrestore', 06:02:07 INFO - 'sessionrestore_no_auto_restore', 06:02:07 INFO - 'tabpaint']}, 06:02:07 INFO - 'other-e10s': {'tests': ['a11yr', 06:02:07 INFO - 'ts_paint', 06:02:07 INFO - 'tpaint', 06:02:07 INFO - 'sessionrestore', 06:02:07 INFO - 'sessionrestore_no_auto_restore', 06:02:07 INFO - 'tabpaint']}, 06:02:07 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:02:07 INFO - 'ts_paint', 06:02:07 INFO - 'tpaint', 06:02:07 INFO - 'sessionrestore', 06:02:07 INFO - 'sessionrestore_no_auto_restore', 06:02:07 INFO - 'tabpaint']}, 06:02:07 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:02:07 INFO - 'ts_paint', 06:02:07 INFO - 'tpaint', 06:02:07 INFO - 'sessionrestore', 06:02:07 INFO - 'sessionrestore_no_auto_restore', 06:02:07 INFO - 'tabpaint']}, 06:02:07 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:02:07 INFO - 'tests': ['a11yr', 06:02:07 INFO - 'ts_paint', 06:02:07 INFO - 'tpaint', 06:02:07 INFO - 'sessionrestore', 06:02:07 INFO - 'sessionrestore_no_auto_restore', 06:02:07 INFO - 'tabpaint']}, 06:02:07 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:02:07 INFO - 'tests': ['a11yr', 06:02:07 INFO - 'ts_paint', 06:02:07 INFO - 'tpaint', 06:02:07 INFO - 'sessionrestore', 06:02:07 INFO - 'sessionrestore_no_auto_restore', 06:02:07 INFO - 'tabpaint']}, 06:02:07 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 06:02:07 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 06:02:07 INFO - 'bloom_basic_ref']}, 06:02:07 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:02:07 INFO - 'tests': ['tsvgx', 06:02:07 INFO - 'tsvgr_opacity', 06:02:07 INFO - 'tart', 06:02:07 INFO - 'tscrollx', 06:02:07 INFO - 'cart', 06:02:07 INFO - 'tsvg_static']}, 06:02:07 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:02:07 INFO - 'tsvgr_opacity', 06:02:07 INFO - 'tart', 06:02:07 INFO - 'tscrollx', 06:02:07 INFO - 'cart', 06:02:07 INFO - 'tsvg_static']}, 06:02:07 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 06:02:07 INFO - 'talos_options': ['--disable-e10s'], 06:02:07 INFO - 'tests': ['tp5o']}, 06:02:07 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 06:02:07 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 06:02:07 INFO - 'talos_options': ['--disable-e10s', 06:02:07 INFO - '--xperf_path', 06:02:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:02:07 INFO - 'tests': ['tp5n']}, 06:02:07 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 06:02:07 INFO - 'talos_options': ['--xperf_path', 06:02:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:02:07 INFO - 'tests': ['tp5n']}}, 06:02:07 INFO - 'talos.zip': {'path': '', 06:02:07 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:02:07 INFO - Running post-action listener: _resource_record_post_action 06:02:07 INFO - [mozharness: 2017-05-18 13:02:07.077519Z] Finished populate-webroot step (success) 06:02:07 INFO - [mozharness: 2017-05-18 13:02:07.077608Z] Running create-virtualenv step. 06:02:07 INFO - Running pre-action listener: _resource_record_pre_action 06:02:07 INFO - Running main action method: create_virtualenv 06:02:07 INFO - Creating virtualenv /builds/slave/test/build/venv 06:02:07 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 06:02:07 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:02:07 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:02:07 INFO - Using real prefix '/usr' 06:02:07 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:02:07 INFO - Installing distribute.............................................................................................................................................................................................done. 06:02:09 INFO - Installing pip.................done. 06:02:09 INFO - Return code: 0 06:02:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 06:02:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 06:02:09 INFO - Reading from file tmpfile_stdout 06:02:09 INFO - Output received: 06:02:09 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) 06:02:09 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:02:09 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')]} 06:02:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:02:09 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')]} 06:02:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:02:09 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 0x18821f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a4fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bf55c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bf27a0>, '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 0x1bf36a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bf3b30>, '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': '4300f881736b422476174874000001bc-1495109824.691067-1273252931', '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 06:02:09 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 06:02:09 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 06:02:09 INFO - Using env: {'DISPLAY': ':0', 06:02:09 INFO - 'HOME': '/home/cltbld', 06:02:09 INFO - 'LANG': 'en_US.UTF-8', 06:02:09 INFO - 'LANGUAGE': 'en_US:en', 06:02:09 INFO - 'LOGNAME': 'cltbld', 06:02:09 INFO - 'MAIL': '/var/mail/cltbld', 06:02:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:02:09 INFO - 'MOZ_NO_REMOTE': '1', 06:02:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:02:09 INFO - 'NO_EM_RESTART': '1', 06:02:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:02:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:02:09 INFO - 'PWD': '/builds/slave/test', 06:02:09 INFO - 'SHELL': '/bin/bash', 06:02:09 INFO - 'SHLVL': '1', 06:02:09 INFO - 'TERM': 'linux', 06:02:09 INFO - 'TMOUT': '86400', 06:02:09 INFO - 'USER': 'cltbld', 06:02:09 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1495109824.691067-1273252931', 06:02:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:02:09 INFO - '_': '/tools/buildbot/bin/python'} 06:02:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:02:10 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 06:02:10 INFO - Cleaning up... 06:02:10 INFO - Return code: 0 06:02:10 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:02:10 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')]} 06:02:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:02:10 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')]} 06:02:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:02:10 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 0x18821f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a4fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bf55c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bf27a0>, '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 0x1bf36a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bf3b30>, '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': '4300f881736b422476174874000001bc-1495109824.691067-1273252931', '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 06:02:10 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 06:02:10 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 06:02:10 INFO - Using env: {'DISPLAY': ':0', 06:02:10 INFO - 'HOME': '/home/cltbld', 06:02:10 INFO - 'LANG': 'en_US.UTF-8', 06:02:10 INFO - 'LANGUAGE': 'en_US:en', 06:02:10 INFO - 'LOGNAME': 'cltbld', 06:02:10 INFO - 'MAIL': '/var/mail/cltbld', 06:02:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:02:10 INFO - 'MOZ_NO_REMOTE': '1', 06:02:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:02:10 INFO - 'NO_EM_RESTART': '1', 06:02:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:02:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:02:10 INFO - 'PWD': '/builds/slave/test', 06:02:10 INFO - 'SHELL': '/bin/bash', 06:02:10 INFO - 'SHLVL': '1', 06:02:10 INFO - 'TERM': 'linux', 06:02:10 INFO - 'TMOUT': '86400', 06:02:10 INFO - 'USER': 'cltbld', 06:02:10 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1495109824.691067-1273252931', 06:02:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:02:10 INFO - '_': '/tools/buildbot/bin/python'} 06:02:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:02:10 INFO - Downloading/unpacking psutil>=3.1.1 06:02:10 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 06:02:10 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 06:02:10 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 06:02:10 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 06:02:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:02:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:02:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:02:11 INFO - Installing collected packages: psutil 06:02:11 INFO - Running setup.py install for psutil 06:02:11 INFO - building 'psutil._psutil_linux' extension 06:02:11 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 06:02:11 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 06:02:11 INFO - building 'psutil._psutil_posix' extension 06:02:11 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 06:02:11 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 06:02:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:02:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:02:11 INFO - Successfully installed psutil 06:02:11 INFO - Cleaning up... 06:02:12 INFO - Return code: 0 06:02:12 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:02:12 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')]} 06:02:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:02:12 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')]} 06:02:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:02:12 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 0x18821f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a4fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bf55c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bf27a0>, '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 0x1bf36a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bf3b30>, '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': '4300f881736b422476174874000001bc-1495109824.691067-1273252931', '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 06:02:12 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 06:02:12 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 06:02:12 INFO - Using env: {'DISPLAY': ':0', 06:02:12 INFO - 'HOME': '/home/cltbld', 06:02:12 INFO - 'LANG': 'en_US.UTF-8', 06:02:12 INFO - 'LANGUAGE': 'en_US:en', 06:02:12 INFO - 'LOGNAME': 'cltbld', 06:02:12 INFO - 'MAIL': '/var/mail/cltbld', 06:02:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:02:12 INFO - 'MOZ_NO_REMOTE': '1', 06:02:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:02:12 INFO - 'NO_EM_RESTART': '1', 06:02:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:02:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:02:12 INFO - 'PWD': '/builds/slave/test', 06:02:12 INFO - 'SHELL': '/bin/bash', 06:02:12 INFO - 'SHLVL': '1', 06:02:12 INFO - 'TERM': 'linux', 06:02:12 INFO - 'TMOUT': '86400', 06:02:12 INFO - 'USER': 'cltbld', 06:02:12 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1495109824.691067-1273252931', 06:02:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:02:12 INFO - '_': '/tools/buildbot/bin/python'} 06:02:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:02:12 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:02:12 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 06:02:12 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 06:02:12 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 06:02:12 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 06:02:13 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:02:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:02:13 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:02:13 INFO - Installing collected packages: mozsystemmonitor 06:02:13 INFO - Running setup.py install for mozsystemmonitor 06:02:13 INFO - Successfully installed mozsystemmonitor 06:02:13 INFO - Cleaning up... 06:02:13 INFO - Return code: 0 06:02:13 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:02:13 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')]} 06:02:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:02:13 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')]} 06:02:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:02:13 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 0x18821f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a4fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bf55c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bf27a0>, '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 0x1bf36a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bf3b30>, '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': '4300f881736b422476174874000001bc-1495109824.691067-1273252931', '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 06:02:13 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 06:02:13 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 06:02:13 INFO - Using env: {'DISPLAY': ':0', 06:02:13 INFO - 'HOME': '/home/cltbld', 06:02:13 INFO - 'LANG': 'en_US.UTF-8', 06:02:13 INFO - 'LANGUAGE': 'en_US:en', 06:02:13 INFO - 'LOGNAME': 'cltbld', 06:02:13 INFO - 'MAIL': '/var/mail/cltbld', 06:02:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:02:13 INFO - 'MOZ_NO_REMOTE': '1', 06:02:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:02:13 INFO - 'NO_EM_RESTART': '1', 06:02:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:02:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:02:13 INFO - 'PWD': '/builds/slave/test', 06:02:13 INFO - 'SHELL': '/bin/bash', 06:02:13 INFO - 'SHLVL': '1', 06:02:13 INFO - 'TERM': 'linux', 06:02:13 INFO - 'TMOUT': '86400', 06:02:13 INFO - 'USER': 'cltbld', 06:02:13 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1495109824.691067-1273252931', 06:02:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:02:13 INFO - '_': '/tools/buildbot/bin/python'} 06:02:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:02:13 INFO - Downloading/unpacking jsonschema==2.5.1 06:02: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 06:02: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 06:02: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 06:02: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 06:02:14 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:02:14 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:02:14 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 06:02:14 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 06:02:14 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 06:02:14 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 06:02:14 INFO - Downloading functools32-3.2.3-2.tar.gz 06:02:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:02:15 INFO - warning: no files found matching '*.txt' 06:02:15 INFO - no previously-included directories found matching 'build' 06:02:15 INFO - no previously-included directories found matching 'dist' 06:02:15 INFO - no previously-included directories found matching '.git*' 06:02:15 INFO - Installing collected packages: jsonschema, functools32 06:02:15 INFO - Running setup.py install for functools32 06:02:15 INFO - warning: no files found matching '*.txt' 06:02:15 INFO - no previously-included directories found matching 'build' 06:02:15 INFO - no previously-included directories found matching 'dist' 06:02:15 INFO - no previously-included directories found matching '.git*' 06:02:15 INFO - Successfully installed jsonschema functools32 06:02:15 INFO - Cleaning up... 06:02:15 INFO - Return code: 0 06:02:15 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 06:02:15 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')]} 06:02:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:02:15 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')]} 06:02:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:02: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', '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 0x18821f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a4fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bf55c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bf27a0>, '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 0x1bf36a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bf3b30>, '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': '4300f881736b422476174874000001bc-1495109824.691067-1273252931', '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 06:02: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 06:02: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 functools32==3.2.3-2 06:02:15 INFO - Using env: {'DISPLAY': ':0', 06:02:15 INFO - 'HOME': '/home/cltbld', 06:02:15 INFO - 'LANG': 'en_US.UTF-8', 06:02:15 INFO - 'LANGUAGE': 'en_US:en', 06:02:15 INFO - 'LOGNAME': 'cltbld', 06:02:15 INFO - 'MAIL': '/var/mail/cltbld', 06:02:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:02:15 INFO - 'MOZ_NO_REMOTE': '1', 06:02:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:02:15 INFO - 'NO_EM_RESTART': '1', 06:02:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:02:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:02:15 INFO - 'PWD': '/builds/slave/test', 06:02:15 INFO - 'SHELL': '/bin/bash', 06:02:15 INFO - 'SHLVL': '1', 06:02:15 INFO - 'TERM': 'linux', 06:02:15 INFO - 'TMOUT': '86400', 06:02:15 INFO - 'USER': 'cltbld', 06:02:15 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1495109824.691067-1273252931', 06:02:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:02:15 INFO - '_': '/tools/buildbot/bin/python'} 06:02:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:02:15 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 06:02:15 INFO - Cleaning up... 06:02:15 INFO - Return code: 0 06:02:15 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:02:15 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')]} 06:02:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:02:15 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')]} 06:02:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:02: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', '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 0x18821f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a4fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bf55c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bf27a0>, '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 0x1bf36a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bf3b30>, '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': '4300f881736b422476174874000001bc-1495109824.691067-1273252931', '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 06:02: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 06:02: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 blobuploader==1.2.4 06:02:15 INFO - Using env: {'DISPLAY': ':0', 06:02:15 INFO - 'HOME': '/home/cltbld', 06:02:15 INFO - 'LANG': 'en_US.UTF-8', 06:02:15 INFO - 'LANGUAGE': 'en_US:en', 06:02:15 INFO - 'LOGNAME': 'cltbld', 06:02:15 INFO - 'MAIL': '/var/mail/cltbld', 06:02:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:02:15 INFO - 'MOZ_NO_REMOTE': '1', 06:02:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:02:15 INFO - 'NO_EM_RESTART': '1', 06:02:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:02:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:02:15 INFO - 'PWD': '/builds/slave/test', 06:02:15 INFO - 'SHELL': '/bin/bash', 06:02:15 INFO - 'SHLVL': '1', 06:02:15 INFO - 'TERM': 'linux', 06:02:15 INFO - 'TMOUT': '86400', 06:02:15 INFO - 'USER': 'cltbld', 06:02:15 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1495109824.691067-1273252931', 06:02:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:02:15 INFO - '_': '/tools/buildbot/bin/python'} 06:02:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:02:15 INFO - Downloading/unpacking blobuploader==1.2.4 06:02:15 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 06:02:15 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 06:02:15 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 06:02:15 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 06:02:16 INFO - Downloading blobuploader-1.2.4.tar.gz 06:02:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:02:16 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:02:16 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 06:02:16 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 06:02:16 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 06:02:16 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 06:02:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:02:17 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:02:17 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 06:02:17 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 06:02:17 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 06:02:17 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 06:02:17 INFO - Downloading docopt-0.6.1.tar.gz 06:02:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:02:17 INFO - Installing collected packages: blobuploader, requests, docopt 06:02:17 INFO - Running setup.py install for blobuploader 06:02:17 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:02:17 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:02:17 INFO - Running setup.py install for requests 06:02:17 INFO - Running setup.py install for docopt 06:02:17 INFO - Successfully installed blobuploader requests docopt 06:02:17 INFO - Cleaning up... 06:02:17 INFO - Return code: 0 06:02:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:02:17 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')]} 06:02:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:02:17 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')]} 06:02:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:02:17 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 0x18821f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a4fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bf55c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bf27a0>, '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 0x1bf36a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bf3b30>, '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': '4300f881736b422476174874000001bc-1495109824.691067-1273252931', '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 06:02:17 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 06:02:17 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 06:02:17 INFO - Using env: {'DISPLAY': ':0', 06:02:17 INFO - 'HOME': '/home/cltbld', 06:02:17 INFO - 'LANG': 'en_US.UTF-8', 06:02:17 INFO - 'LANGUAGE': 'en_US:en', 06:02:17 INFO - 'LOGNAME': 'cltbld', 06:02:17 INFO - 'MAIL': '/var/mail/cltbld', 06:02:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:02:17 INFO - 'MOZ_NO_REMOTE': '1', 06:02:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:02:17 INFO - 'NO_EM_RESTART': '1', 06:02:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:02:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:02:17 INFO - 'PWD': '/builds/slave/test', 06:02:17 INFO - 'SHELL': '/bin/bash', 06:02:17 INFO - 'SHLVL': '1', 06:02:17 INFO - 'TERM': 'linux', 06:02:17 INFO - 'TMOUT': '86400', 06:02:17 INFO - 'USER': 'cltbld', 06:02:17 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1495109824.691067-1273252931', 06:02:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:02:17 INFO - '_': '/tools/buildbot/bin/python'} 06:02:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:02:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:02:18 INFO - Running setup.py (path:/tmp/pip-F61Ujq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:02:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:02:18 INFO - Running setup.py (path:/tmp/pip-5Z3j5R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:02:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:02:18 INFO - Running setup.py (path:/tmp/pip-enmCCG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:02:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:02:18 INFO - Running setup.py (path:/tmp/pip-7wIVZ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:02:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:02:18 INFO - Running setup.py (path:/tmp/pip-BiSTNk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:02:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:02:18 INFO - Running setup.py (path:/tmp/pip-u8gg1D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:02:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:02:18 INFO - Running setup.py (path:/tmp/pip-ACBtGg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:02:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:02:18 INFO - Running setup.py (path:/tmp/pip-HDq68Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:02:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:02:18 INFO - Running setup.py (path:/tmp/pip-j5gTjT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:02:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:02:18 INFO - Running setup.py (path:/tmp/pip-1XQ3Pv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:02:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:02:18 INFO - Running setup.py (path:/tmp/pip-3oS4ts-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:02:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:02:18 INFO - Running setup.py (path:/tmp/pip-HzDG4h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:02:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:02:19 INFO - Running setup.py (path:/tmp/pip-tMA2ZM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:02:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:02:19 INFO - Running setup.py (path:/tmp/pip-3w2Td5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:02:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:02:19 INFO - Running setup.py (path:/tmp/pip-Ni8oCZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:02:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:02:19 INFO - Running setup.py (path:/tmp/pip-bxYFio-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:02:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:02:19 INFO - Running setup.py (path:/tmp/pip-klFlve-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:02:19 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:02:19 INFO - Running setup.py install for manifestparser 06:02:19 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:02:19 INFO - Running setup.py install for mozcrash 06:02:19 INFO - Running setup.py install for mozdebug 06:02:19 INFO - Running setup.py install for mozdevice 06:02:19 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:02:19 INFO - Running setup.py install for mozfile 06:02:19 INFO - Running setup.py install for mozhttpd 06:02:19 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:02:19 INFO - Running setup.py install for mozinfo 06:02:20 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:02:20 INFO - Running setup.py install for mozInstall 06:02:20 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:02:20 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:02:20 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:02:20 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:02:20 INFO - Running setup.py install for mozleak 06:02:20 INFO - Running setup.py install for mozlog 06:02:20 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:02:20 INFO - Running setup.py install for moznetwork 06:02:20 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:02:20 INFO - Running setup.py install for mozprocess 06:02:20 INFO - Running setup.py install for mozprofile 06:02:20 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:02:20 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:02:20 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:02:20 INFO - Running setup.py install for mozrunner 06:02:20 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:02:20 INFO - Running setup.py install for mozscreenshot 06:02:20 INFO - Running setup.py install for moztest 06:02:21 INFO - Running setup.py install for mozversion 06:02:21 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:02:21 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:02:21 INFO - Cleaning up... 06:02:21 INFO - Return code: 0 06:02:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:02:21 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')]} 06:02:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:02:21 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')]} 06:02:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:02:21 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 0x18821f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a4fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bf55c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bf27a0>, '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 0x1bf36a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bf3b30>, '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': '4300f881736b422476174874000001bc-1495109824.691067-1273252931', '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 06:02:21 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 06:02:21 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 06:02:21 INFO - Using env: {'DISPLAY': ':0', 06:02:21 INFO - 'HOME': '/home/cltbld', 06:02:21 INFO - 'LANG': 'en_US.UTF-8', 06:02:21 INFO - 'LANGUAGE': 'en_US:en', 06:02:21 INFO - 'LOGNAME': 'cltbld', 06:02:21 INFO - 'MAIL': '/var/mail/cltbld', 06:02:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:02:21 INFO - 'MOZ_NO_REMOTE': '1', 06:02:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:02:21 INFO - 'NO_EM_RESTART': '1', 06:02:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:02:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:02:21 INFO - 'PWD': '/builds/slave/test', 06:02:21 INFO - 'SHELL': '/bin/bash', 06:02:21 INFO - 'SHLVL': '1', 06:02:21 INFO - 'TERM': 'linux', 06:02:21 INFO - 'TMOUT': '86400', 06:02:21 INFO - 'USER': 'cltbld', 06:02:21 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1495109824.691067-1273252931', 06:02:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:02:21 INFO - '_': '/tools/buildbot/bin/python'} 06:02:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:02:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:02:21 INFO - Running setup.py (path:/tmp/pip-C4qESK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:02:21 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)) 06:02:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:02:21 INFO - Running setup.py (path:/tmp/pip-VXR5G9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:02:21 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)) 06:02:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:02:21 INFO - Running setup.py (path:/tmp/pip-9Jd6CE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:02:21 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)) 06:02:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:02:21 INFO - Running setup.py (path:/tmp/pip-lo5t14-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:02:21 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)) 06:02:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:02:21 INFO - Running setup.py (path:/tmp/pip-k67iD6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:02:21 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)) 06:02:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:02:21 INFO - Running setup.py (path:/tmp/pip-DPplTz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:02:21 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)) 06:02:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:02:21 INFO - Running setup.py (path:/tmp/pip-7BNxgD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:02:21 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)) 06:02:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:02:21 INFO - Running setup.py (path:/tmp/pip-2mvpWf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:02:21 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)) 06:02:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:02:21 INFO - Running setup.py (path:/tmp/pip-osWgzY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:02:22 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)) 06:02:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:02:22 INFO - Running setup.py (path:/tmp/pip-ccUfsW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:02:22 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)) 06:02:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:02:22 INFO - Running setup.py (path:/tmp/pip-hwRbQk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:02:22 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)) 06:02:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:02:22 INFO - Running setup.py (path:/tmp/pip-gqcBhA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:02:22 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)) 06:02:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:02:22 INFO - Running setup.py (path:/tmp/pip-Ynw0VQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:02:22 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)) 06:02:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:02:22 INFO - Running setup.py (path:/tmp/pip-FaxX82-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:02:22 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)) 06:02:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:02:22 INFO - Running setup.py (path:/tmp/pip-O_P5ZY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:02:22 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)) 06:02:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:02:22 INFO - Running setup.py (path:/tmp/pip-MkUNra-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:02:22 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)) 06:02:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:02:22 INFO - Running setup.py (path:/tmp/pip-w5wmZm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:02:22 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)) 06:02:22 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)) 06:02:22 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)) 06:02:22 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)) 06:02:22 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)) 06:02:22 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)) 06:02:22 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:02:22 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 06:02:22 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 06:02:22 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 06:02:22 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 06:02:23 INFO - Downloading blessings-1.6.tar.gz 06:02:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:02:23 INFO - Installing collected packages: blessings 06:02:23 INFO - Running setup.py install for blessings 06:02:23 INFO - Successfully installed blessings 06:02:23 INFO - Cleaning up... 06:02:23 INFO - Return code: 0 06:02:23 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:02:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:02:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:02:24 INFO - Reading from file tmpfile_stdout 06:02:24 INFO - Current package versions: 06:02:24 INFO - argparse == 1.2.1 06:02:24 INFO - blessings == 1.6 06:02:24 INFO - blobuploader == 1.2.4 06:02:24 INFO - docopt == 0.6.1 06:02:24 INFO - functools32 == 3.2.3-2 06:02:24 INFO - jsonschema == 2.5.1 06:02:24 INFO - manifestparser == 1.1 06:02:24 INFO - mozInstall == 1.12 06:02:24 INFO - mozcrash == 1.0 06:02:24 INFO - mozdebug == 0.1 06:02:24 INFO - mozdevice == 0.50 06:02:24 INFO - mozfile == 1.2 06:02:24 INFO - mozhttpd == 0.7 06:02:24 INFO - mozinfo == 0.9 06:02:24 INFO - mozleak == 0.1 06:02:24 INFO - mozlog == 3.4 06:02:24 INFO - moznetwork == 0.27 06:02:24 INFO - mozprocess == 0.25 06:02:24 INFO - mozprofile == 0.28 06:02:24 INFO - mozrunner == 6.13 06:02:24 INFO - mozscreenshot == 0.1 06:02:24 INFO - mozsystemmonitor == 0.3 06:02:24 INFO - moztest == 0.8 06:02:24 INFO - mozversion == 1.4 06:02:24 INFO - psutil == 3.1.1 06:02:24 INFO - requests == 1.2.3 06:02:24 INFO - wsgiref == 0.1.2 06:02:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:02:24 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')]} 06:02:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:02:24 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')]} 06:02:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:02:24 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 0x18821f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a4fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bf55c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bf27a0>, '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 0x1bf36a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bf3b30>, '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': '4300f881736b422476174874000001bc-1495109824.691067-1273252931', '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 06:02:24 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 06:02:24 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 06:02:24 INFO - Using env: {'DISPLAY': ':0', 06:02:24 INFO - 'HOME': '/home/cltbld', 06:02:24 INFO - 'LANG': 'en_US.UTF-8', 06:02:24 INFO - 'LANGUAGE': 'en_US:en', 06:02:24 INFO - 'LOGNAME': 'cltbld', 06:02:24 INFO - 'MAIL': '/var/mail/cltbld', 06:02:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:02:24 INFO - 'MOZ_NO_REMOTE': '1', 06:02:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:02:24 INFO - 'NO_EM_RESTART': '1', 06:02:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:02:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:02:24 INFO - 'PWD': '/builds/slave/test', 06:02:24 INFO - 'SHELL': '/bin/bash', 06:02:24 INFO - 'SHLVL': '1', 06:02:24 INFO - 'TERM': 'linux', 06:02:24 INFO - 'TMOUT': '86400', 06:02:24 INFO - 'USER': 'cltbld', 06:02:24 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1495109824.691067-1273252931', 06:02:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:02:24 INFO - '_': '/tools/buildbot/bin/python'} 06:02:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:02:24 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)) 06:02:24 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)) 06:02:24 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)) 06:02:24 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)) 06:02:24 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)) 06:02:24 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)) 06:02:24 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)) 06:02:24 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)) 06:02:24 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)) 06:02:24 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)) 06:02:24 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)) 06:02:24 INFO - Cleaning up... 06:02:24 INFO - Return code: 0 06:02:24 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:02:24 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')]} 06:02:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:02:24 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')]} 06:02:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:02:24 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 0x18821f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a4fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bf55c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bf27a0>, '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 0x1bf36a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bf3b30>, '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': '4300f881736b422476174874000001bc-1495109824.691067-1273252931', '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 06:02:24 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 06:02:24 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 06:02:24 INFO - Using env: {'DISPLAY': ':0', 06:02:24 INFO - 'HOME': '/home/cltbld', 06:02:24 INFO - 'LANG': 'en_US.UTF-8', 06:02:24 INFO - 'LANGUAGE': 'en_US:en', 06:02:24 INFO - 'LOGNAME': 'cltbld', 06:02:24 INFO - 'MAIL': '/var/mail/cltbld', 06:02:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:02:24 INFO - 'MOZ_NO_REMOTE': '1', 06:02:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:02:24 INFO - 'NO_EM_RESTART': '1', 06:02:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:02:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:02:24 INFO - 'PWD': '/builds/slave/test', 06:02:24 INFO - 'SHELL': '/bin/bash', 06:02:24 INFO - 'SHLVL': '1', 06:02:24 INFO - 'TERM': 'linux', 06:02:24 INFO - 'TMOUT': '86400', 06:02:24 INFO - 'USER': 'cltbld', 06:02:24 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1495109824.691067-1273252931', 06:02:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:02:24 INFO - '_': '/tools/buildbot/bin/python'} 06:02:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:02:24 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:02:24 INFO - Cleaning up... 06:02:24 INFO - Return code: 0 06:02:24 INFO - Running post-action listener: _resource_record_post_action 06:02:24 INFO - Running post-action listener: _start_resource_monitoring 06:02:24 INFO - Starting resource monitoring. 06:02:24 INFO - [mozharness: 2017-05-18 13:02:24.628762Z] Finished create-virtualenv step (success) 06:02:24 INFO - [mozharness: 2017-05-18 13:02:24.629286Z] Running install step. 06:02:24 INFO - Running pre-action listener: _resource_record_pre_action 06:02:24 INFO - Running main action method: install 06:02:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:02:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:02:24 INFO - Reading from file tmpfile_stdout 06:02:24 INFO - Detecting whether we're running mozinstall >=1.0... 06:02:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:02:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:02:24 INFO - Reading from file tmpfile_stdout 06:02:24 INFO - Output received: 06:02:24 INFO - Usage: mozinstall [options] installer 06:02:24 INFO - Options: 06:02:24 INFO - -h, --help show this help message and exit 06:02:24 INFO - -d DEST, --destination=DEST 06:02:24 INFO - Directory to install application into. [default: 06:02:24 INFO - "/builds/slave/test"] 06:02:24 INFO - --app=APP Application being installed. [default: firefox] 06:02:24 INFO - mkdir: /builds/slave/test/build/application 06:02:24 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'] 06:02:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 06:02:42 INFO - Reading from file tmpfile_stdout 06:02:42 INFO - Output received: 06:02:42 INFO - /builds/slave/test/build/application/firefox/firefox 06:02:42 INFO - Running post-action listener: _resource_record_post_action 06:02:42 INFO - [mozharness: 2017-05-18 13:02:42.192151Z] Finished install step (success) 06:02:42 INFO - [mozharness: 2017-05-18 13:02:42.192431Z] Running run-tests step. 06:02:42 INFO - Running pre-action listener: _resource_record_pre_action 06:02:42 INFO - Running main action method: run_tests 06:02:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:02:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:02:42 INFO - Python 2.7.3 06:02:42 INFO - Return code: 0 06:02:42 INFO - grabbing minidump binary from tooltool 06:02:42 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')]} 06:02:42 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 0x1bf27a0>, '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 0x1bf36a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bf3b30>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:02:42 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 06:02:42 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 06:02:42 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 06:02:42 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:02:42 INFO - Return code: 0 06:02:42 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:02:42 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:02:42 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:02:42 INFO - ENV: RUST_BACKTRACE is now 1 06:02:42 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:02:42 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:02:42 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/bO24eL5IQH2H4y0xcThplw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-045', '--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 06:02:42 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/bO24eL5IQH2H4y0xcThplw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-045 --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 06:02:42 INFO - Using env: {'DISPLAY': ':0', 06:02:42 INFO - 'HOME': '/home/cltbld', 06:02:42 INFO - 'LANG': 'en_US.UTF-8', 06:02:42 INFO - 'LANGUAGE': 'en_US:en', 06:02:42 INFO - 'LOGNAME': 'cltbld', 06:02:42 INFO - 'MAIL': '/var/mail/cltbld', 06:02:42 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:02:42 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:02:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:02:42 INFO - 'MOZ_NO_REMOTE': '1', 06:02:42 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:02:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:02:42 INFO - 'NO_EM_RESTART': '1', 06:02:42 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:02:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:02:42 INFO - 'PWD': '/builds/slave/test', 06:02:42 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:02:42 INFO - 'RUST_BACKTRACE': '1', 06:02:42 INFO - 'SHELL': '/bin/bash', 06:02:42 INFO - 'SHLVL': '1', 06:02:42 INFO - 'TERM': 'linux', 06:02:42 INFO - 'TMOUT': '86400', 06:02:42 INFO - 'USER': 'cltbld', 06:02:42 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1495109824.691067-1273252931', 06:02:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:02:42 INFO - '_': '/tools/buildbot/bin/python'} 06:02:42 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/bO24eL5IQH2H4y0xcThplw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-045', '--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 06:02:42 INFO - mozversion application_buildid: 20170518121756 06:02:42 INFO - mozversion application_changeset: cf4e37d17683e0cbe134debc1d3685fb3f84e3d1 06:02:42 INFO - mozversion application_display_name: Nightly 06:02:42 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:02:42 INFO - mozversion application_name: Firefox 06:02:42 INFO - mozversion application_remotingname: firefox 06:02:42 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 06:02:42 INFO - mozversion application_vendor: Mozilla 06:02:42 INFO - mozversion application_version: 55.0a1 06:02:42 INFO - mozversion platform_buildid: 20170518121756 06:02:42 INFO - mozversion platform_changeset: cf4e37d17683e0cbe134debc1d3685fb3f84e3d1 06:02:42 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 06:02:42 INFO - mozversion platform_version: 55.0a1 06:02:42 INFO - using testdate: 1495112562 06:02:42 INFO - actual date: 1495112562 06:02:42 INFO - starting webserver on 'localhost:56686' 06:02:42 INFO - SUITE-START | Running 2 tests 06:02:42 INFO - TEST-START | dromaeo_css 06:02:42 INFO - operating with platform_type : linux_ 06:02:42 INFO - Initialising browser for dromaeo_css test... 06:02:42 INFO - TEST-INFO | started process 12049 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5vdmCA/profile http://localhost:56686/getInfo.html) 06:02:43 INFO - PID 12049 | JavaScript warning: resource://gre/modules/addons/XPIProvider.jsm, line 2941: String.localeCompare is deprecated; use String.prototype.localeCompare instead 06:02:46 INFO - PID 12049 | __metrics Screen width/height:1600/1200 06:02:46 INFO - PID 12049 | colorDepth:24 06:02:46 INFO - PID 12049 | Browser inner width/height: 1024/695 06:02:46 INFO - PID 12049 | __metrics 06:02:48 INFO - TEST-INFO | 12049: exit 0 06:02:48 INFO - Browser initialized. 06:02:48 INFO - Running cycle 1/1 for dromaeo_css test... 06:02:48 INFO - TEST-INFO | started process 12229 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5vdmCA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:03:00 INFO - PID 12229 | RSS: Main: 169005056 06:03:00 INFO - PID 12229 | 06:06:05 INFO - PID 12229 | Cycle 1(1): loaded http://localhost:56686/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56686/tests/dromaeo/cssquery-ext.html) 06:06:07 INFO - PID 12229 | RSS: Main: 175259648 06:06:07 INFO - PID 12229 | 06:09:09 INFO - PID 12229 | Cycle 1(1): loaded http://localhost:56686/tests/dromaeo/cssquery-ext.html (next: http://localhost:56686/tests/dromaeo/cssquery-jquery.html) 06:09:09 INFO - PID 12229 | RSS: Main: 173207552 06:09:09 INFO - PID 12229 | 06:12:11 INFO - PID 12229 | Cycle 1(1): loaded http://localhost:56686/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56686/tests/dromaeo/cssquery-mootools.html) 06:12:12 INFO - PID 12229 | RSS: Main: 176234496 06:12:12 INFO - PID 12229 | 06:15:14 INFO - PID 12229 | Cycle 1(1): loaded http://localhost:56686/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56686/tests/dromaeo/cssquery-prototype.html) 06:15:14 INFO - PID 12229 | RSS: Main: 173940736 06:15:14 INFO - PID 12229 | 06:18:17 INFO - PID 12229 | Cycle 1(1): loaded http://localhost:56686/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56686/tests/dromaeo/cssquery-yui.html) 06:18:18 INFO - PID 12229 | RSS: Main: 174215168 06:18:18 INFO - PID 12229 | 06:21:20 INFO - PID 12229 | Cycle 1(1): loaded http://localhost:56686/tests/dromaeo/cssquery-yui.html (next: http://localhost:56686/tests/dromaeo/cssquery-dojo.html) 06:21:20 INFO - PID 12229 | RSS: Main: 181899264 06:21:20 INFO - PID 12229 | 06:21:20 INFO - PID 12229 | __start_tp_report 06:21:20 INFO - PID 12229 | _x_x_mozilla_page_load 06:21:20 INFO - PID 12229 | _x_x_mozilla_page_load_details 06:21:20 INFO - PID 12229 | |i|pagename|runs| 06:21:20 INFO - PID 12229 | |0;dojo.html;2719.238613188307;2741.0406357774796;2762.074704973834;2764.7235276472347;2776.9583456248147;5222.086134926382;5255.159174532076;5260.289860868782;5303.814366497173;5346.4118946915805;5203.68777873327;5313.946860531393;5326.094563924133;5340.412554618989;5341.519263266306;4624.884377890563;4631.745254011028;4641.164590373732;4702;4734.668573199878;4659.277811939138;4724.149653062447;4763.2378819388905;4785.234362502;4807.951920480786;4566.155261276641;4721.480637129947;4732.716037037789;4745.881352966187;4775.5463230993;4669.2529195328925;4676.579107880307;4722.480527142046;4761.8095276188915;4770.809167633325;4633.837815676435;4671.556202160789;4693.108309421199;4705.341252224657;4746.240601503743;5231.110711179071;5232.7122008289525;5233.058049551079;5254.500822421864;5340.25236466895;5502.972485137549;5596.608237423341;5679.659220446786;5759.971200144015;5780.595358324919;5781.71091445426;5785.82642520725;5786.768529258825;5788.42115788422;5831.766729330864;5309.920351194735;5338.172583249602;5341.359036915517;5364.356277246678;5377.085895397791;5798.652080875161;5819.447152520504;5820.126980952891;5859.619124756877;5907.084401917709;5567.415421380697;5575.080111781511;5606.271184746039;5609;5655.943440565624;5724.8282551523525;5760.510356619734;5763.164341170507;5798.594098413155;5807;5574.163875418639;5693;5695.7152142392715;5709.229254050733;5722.456366645162;5695.060315047971;5711.143328500758;5714.228579141763;5717.428257174332;5719.656820590778;4733.195356789354;4793.01743142655;4855.223164293767;4912.214045752734;4914.213725803854;4170.541240463546;4175.979120104441;4181.205570941512;4211.642010429086;4221.598948099926;4737.549932756451;4815.133276010281;4819.518048195152;4839.959408727141;4875.902481950341;5530.944690553123;5620.100783874642;5686.09022556389;5763;5776.046952252831;4789.2337226044365;4805.063012712558;4815.277708343777;4833.903321933612;4865.221564549655;5045.621578381636;5062.873428164326;5087.847364579068;5093.745312734349;5133.537981581676;5129.435762066244;5207.6875387476875;5264.552513036435;5266.97366513165;5283.831475684418;5679.46045125729;5696.8006119785605;5698.974184646803;5699.829005129853;5702.572307077069;5149.613778966517;5180.585553155814;5194.532492075731;5236.502532259429;5241.266222728745;5633.352164501135;5644.435556444487;5696.914546281892;5723.456271654186;5726.169705392778;5637.43625637433;5749.683767392834;5757.222774925332;5771.394003629558;5771.653700777967;5464.890702185855;5527.364353099445;5538.252335934759;5608.6073974821375;5621.269234999424;5560.082586373203;5589.664620122806;5605.215269862141;5608.943910560843;5621.55027597783;5469.097598896296;5509.146082357241;5524.254225679482;5526.917096243479;5548.334199896039;5454.918176227439;5539.778408863762;5583.218349431002;5646.35066967304;5664.745086471201;5472.644278121909;5474.698891561003;5474.972625136849;5480.534154596904;5521.3926468087675 06:21:20 INFO - PID 12229 | |1;ext.html;715.9964200178998;738.5494848142632;767.8579462799382;1067.8344856547233;1080.1790639114272;30833.537496937563;31669.20826979321;31672;31752.20619484514;31803.84098079512;34543.30913381731;34826.82586587063;34928.301433971305;35039;35069.298614027764;6681.966590167042;6816.931830681704;6897.655117244155;7002.229754726976;7023.61370124643;6854.177498700163;6901.516893817435;6908.654567271641;6910.067140935985;6931.61876096817;6896.482763792736;6921.238663746984;6966.12923384577;6974.372306492414;6980.650967451633;6859.416949559293;6872.656367181671;6895.75864844733;6897.827554311132;6935.271796461375;6747.966260168717;6786.083878676414;6789.490788190906;6800.387965083117;6807.081044059088;31594.842025789952;31782.046538603878;31819.522707159413;31877;31880.681193188004;3044.3302473455806;3090.381923615286;3111.066679995992;3119.844007799601;3122;24296.514069718683;24426.267211983668;24467.388315292083;24488.265352039467;24504.754952450425;2761.9309517262027;2766.6541682289712;2776.639036925207;2777.652793400825;2793.832370057803;142446;143472;143630;145440;146080.99999999892;38352.80823595864;38407.42388864169;38423.615763842565;38436.80781596074;38451.42322865159;40039.1992160161;40079.39880901789;40086.39870401946;40102;40208.59791402107;11302.208845380745;11354.602588909349;11457.197996140358;11489;11502.539898404137;8936.597853096626;9035.548222588845;9103.590338434786;9131.26949844011;9143;12446.25322480636;12462.189957652723;12480.375981200903;12498.437570309357;12619.747605047847;5360.544353729899;5424.213489044067;5437.809676661377;5484.122540393518;5487.204355368449;882.6381183714647;913.6756451459769;918.205752024494;925.167349385545;944.0370821761765;20050.197992080153;20756;21476.78523214779;21695.783042169376;21790.346289611338;967.3083745122271;981.1316984468797;991.7867658453467;993.458565082032;1017.0998666180336;11033.558657653604;11247.212695111428;11370.147238956946;11401;11528.481218345194;168854;170116;170506;170902.14548927423;171361;40670.59329406727;40850.59149408468;41130.1773964519;41242;41256.58743412527;1204.265398107154;1230.4708975140775;1236.1532350340046;1242.5278394210143;1249.3066348176667;19982.90008549948;20023.799762002775;20468.181272748923;21413.250536231157;21565.35303940884;29730.851345743133;30026;30065.398692026476;30085.54871676883;30091.849540752155;143161;143671;143753;144057;144136;28626.427471450872;28896.42207155803;29003.41993160167;29154.27114322074;29179.124626261248;35374.46938295979;35642.46536302009;35692.82153589215;35761.64238357583;35887.64112358948;26048;26567.202983910513;27125.72874271232;27223.319417014733;27228.183154505397;27335.04327348533;28059;28323.150305490868;28375.858120709265;28814;31571.842140789147;31733.206669832514;31874;31941.520877187326;31971;27262.863685681445;27301.453970920073;27729.584056238768;27957.72042279551;28927.276818078873;21778.56442871102;22496;22642.43393915165;22724.318270451913;22812 06:21:20 INFO - PID 12229 | |2;jquery.html;422.1451560589803;423.6695377605468;424.77274658057945;428.8520460441148;444.44888338460316;16917.915410422946;17725.11374431278;17770.911145444272;18076.457706268833;18568;17194;17281.654366912655;17344.046077465733;17711.46865594031;18393.149061895427;5252.3697156341295;5324.467553244684;5522.585806064541;5551.77792888284;5563.721813909308;5197.220416937471;5398.24424580559;5433.320834895638;5528.612997090206;5532.834014979557;5375.43557926418;5378.569714422837;5391.137418013119;5396.865078373053;5412.729363531827;5267.789288428458;5369.677819330814;5381.219723140142;5406.08096623573;5460.372057213432;4926.605871530269;4937.0372777308085;4937.086638971766;4938.604911607063;4961.18140506816;21515.67726484104;21851.672224916638;22012.009459574358;22242.221522246804;22313.553728925493;1659.7842280503457;1661.9750703739332;1703.7699910512047;1708.4874537638782;1711.5806627376248;14600.780988285183;14654.340554674958;14999.550013499613;15074.24628768568;15080.170590617512;2140.7752186020557;2147.076756994492;2150.139944022388;2160.6542953127423;2162.243214874781;86909.56545217297;87832.56083719604;88260.11739882584;88423;89663;10822.296550724177;10940.781184376427;11052.944735276433;11294.94352528232;11498.482568284448;15786.237408453475;15806.525804225892;15808.130552819704;15811.972221805547;15865.365385384686;6930.688119034656;7000.92999070013;7073.92926070743;7190.784276471714;7258.020167277456;6284.560080794392;6296.779612713533;6441.742330306829;6469.482441404676;6501.804945851537;6879.89680154798;7068.617457176583;7167.820804479929;7180.964095179491;7217.566945983258;2085.301424022939;2098.31804663485;2122.1405330841035;2122.936311910645;2197.2419515267206;845.7166849105496;878.9384743068051;880.6785523284084;885.8449771289999;900.909909009107;15938.521844344688;16198;16435.753463698053;16828.579285517717;16931.238094285785;868.9529117413501;873.4933738431695;883.6951251818112;886.3396769406833;896.5293221058996;8708.651653933772;8903.73288801337;9164.90835091654;9408.388454750419;10895.291806032583;378098;383902;391181;396184;398986;75469.62265188749;77707.61146194233;78078;80908;81171;1063.5373612478597;1081.4916989014994;1117;1121.8765935747224;1128.8250321200228;16901.746473802657;17225.913870431068;17775.555611109827;17802.376916808367;17830.46508604744;37217.81391093027;37297.6270237305;38142.23715525618;38256.61743382642;38495.422568660935;48308.75845620749;50329.245061324844;50558.7472062652;50577.618945701215;50781.43305100395;7959.80100497469;8086.757397278091;8384.874226886725;8413.579321034047;8522.70170544028;11446.656600302003;12946.223226606433;13229.669258268621;13292.734145316846;13305.667358315732;10754.623588174376;10916.727081823017;10998.450077495932;11153.72115697114;11316.434178291218;10292.125169360688;10403.167746580104;10520.421376824348;10531.842022369518;10573.788524229627;10305.381677099398;10366;10480.947595261974;10514.211434142622;10686.679399618024;8142.307903828241;8336.499810011175;8356.080831108695;8400.28597569189;8488.787780305294;9897.851532226878;10021.899781002097;10093.495325233856;10148.492575371054;10688.625898093529 06:21:20 INFO - PID 12229 | |3;mootools.html;1283.1402960016787;1332.9999999999993;1339.3303348325837;1345.1122259308859;1347.6698208938808;10078.798424031524;10506.737331566705;10522.842157367637;10633.308834925743;10928.672139835799;10552.577896884135;10737.087347575465;10761.892381076186;10763.892361076387;10764.407957562331;2246.9438264043447;2280.8175345972363;2287.6797248385237;2296.3111066680012;2300.8619482831;2153.6984822124837;2229.3423440085135;2230;2236.2620335289316;2240.0591751464344;2225.721784776903;2227.610168220563;2276.2602154299834;2290.4044948313476;2290.6449500327394;2136.4445244236454;2177.433867194533;2192.287506560366;2195.4182141732454;2198.681191227271;2091.7699053104147;2185.158713895146;2204.6252137136726;2242.932712018642;2246.3597874605657;10269.794604107876;10332.58669653213;10340.482975851177;10344.431056291976;10348.94825525875;5676.148577713335;5806.564507661942;5871.500922421599;5883.852903677443;5891.970540147315;3080.152957936563;3250.366178595175;3340.048086295394;3345.983270083634;3359;1064.5369264369947;1077.617445806743;1087.320424734541;1101.1720249165978;1103.227740581588;15283.770743438858;15416.845831541654;15417.845821541754;15437.614059648486;15451.227438628137;4586.4725556561425;4854.126257273654;5009.774560144802;5027.4469808321055;5081.568066714371;10821.513031913426;10827.512761925575;10843.1867609928;10849.783004340026;10850.782984340427;5711.171880077365;5737.684427356452;5752.539796816244;5766.913496297559;5769.798057067983;5116.897662046738;5194.92207616886;5229.424763276036;5276.947230527646;5289.629725919149;3723.7579557328686;3861.575226725058;3862.6523612874416;3882.602263185251;3931.567527571965;1054.7995880782628;1077.256692881909;1082.107261509258;1083.4907593431076;1112.3659514076899;717.078554058033;726.3426598927979;734.9118105827228;738.770980995893;749.7600767754267;5597.664140151523;5723.141528770634;5732.197492351074;5765.308163020464;5777.422257774189;531.6416555700223;545.4191286280098;551.0301868711098;555.7721334252936;561.7977528089884;3633.3823250047553;3943.1325108476663;3956.1098752780395;4006.318925782624;4142.523609784853;12903.806442903364;13780.862191378159;13806.516771912935;13811.033227674166;13835.239061851695;13117.475300987853;13469.326533673277;13676.93161534186;13701.794473082911;13733.176009439465;7228.385587225145;7398;7405.1484079330485;7405.333519983227;7411.777646670716;6104.084387341934;6171.413715697002;6176.104464852661;6237.157983672146;6385.489160867212;11646.825297620711;11940;11988.700282493008;12122.818157727464;12132.332721700392;11852.822207666719;12172.452239649414;12184.451699673358;12195.939020304842;12399.938000309941;8446.704365347183;8518.74443766688;8543.487390756574;8548.74353769388;8622.396432249683;9487;9741.756456088655;9818.214542836698;9868.555914983986;9886.703398898044;8153.6738530458115;8213.219744124299;8372.33021358302;8486.70296539643;8730.34522410809;8049.87925181111;8182.427230093836;8203.261706446448;8373.330133589176;8523.105073967145;7464.290892365217;7486.213947535431;7522.172561018174;7578.204288549843;7662.272084151997;5007.499250074963;5357.651752636066;5428.240046393429;5444.074507333842;5729.627574207663;5565.415631358649;5595.496405323541;5672.404397538199;5820.796272130455;5908.261467316585 06:21:20 INFO - PID 12229 | |4;prototype.html;382.2774955334418;382.3022983055923;383.6317135549872;390.0288282177379;391.56340680141653;5411.485908838664;5498.80754173604;5526.281583394163;5574.832755017346;5586.469285417884;5393.1910213468;5458.372287186975;5465.480779325968;5491.203775452567;5500.752466139023;4200.012996945716;4326.156399502099;4328.935065974013;4368.759718215497;4376.824927002932;4319.308910574308;4336.653067754588;4357.607815296623;4359.760213188273;4367.716098453606;4328.242557552431;4332.1119170569955;4343.153085148398;4346.326319420479;4352.173087113439;4277.5528094476995;4303.440552728157;4307.5261721210645;4341.02326976431;4346.500152482457;3932.1742434088874;3945.0926286954164;3949.763014219156;3953.466282051944;3959.6436320731273;5362.302900622933;5385.973070134663;5395.7032363220005;5398.6220964532495;5405.324334458192;4996.225585034325;5143.434222235551;5157.30376399185;5162.819301324474;5172.663776854492;5827.329857066449;5854.5023672987845;5862.20860183874;5877.471027607493;5887.735051922674;4435.911281774379;4439.400680908068;4440.200763862504;4448.377227188196;4448.377227188196;6033.668148251844;6129.693515324216;6129.938700612981;6153.815385538441;6216.7824126155365;4555.157295900269;4585.830613193681;4589.151007063704;4589.816407343736;4595.149897268949;4603.102395032936;4634.814607415666;4644.651651126179;4650.581447669726;4670;5091.745412729349;5122.897542049138;5130.666506677054;5146.922796158061;5171.9482805171465;5846.795362162304;5851.531877449794;5857.0335894577765;5868.149118377812;5873.647581145145;1574.4410734189198;1593.3148746039315;1615.886887917858;1624.301550333368;1624.659655783983;1116.1461481966303;1149.2644707387278;1151.441550847838;1151.8329842173005;1158.5423757615695;4902.681325713888;4951.678140920829;4958.950410495849;4961.305417241589;4965.453800081988;5918.556108291896;5971.373005834412;5980.910286345708;5994.610350327302;5995;4804.54356836107;4889.682170658896;4905.705657660552;4930;4963.6525443218625;3129.3741251749743;3161.8893338733033;3168.8890888818783;3176.4747026114296;3193.552902593639;5511.5039646432015;5540.506771952638;5544.140658197985;5547.417521160301;5575.303087114111;5955.493783028404;6033.456988870935;6146.692665366714;6190.288116866618;6197.163382943245;5451.863703407367;5500.80747173847;5541.224228608079;5542.196381524656;5569.164625306155;5982.042873140276;5997.190379298739;6005.489533389711;6030.668313242638;6034.366391528826;5716.028275193144;5897.439743224387;5918.23063001807;5934.940650593611;5961.672108034099;5515.172724091419;5538.446155384429;5540.7783688652;5547.944520554743;5567.749451274622;4019.618136277049;4064.1262128642484;4067.4102255172243;4081.5102187736475;4092.140650463436;6003.309619393651;6014.248218972629;6024.084345175671;6045.395460454095;6057.697115144313;5838.416158384128;5852.5317974561085;5860.619059761102;5861.183033259703;5877.265341832271;5751.511121554715;5753.712314384347;5795.594308398372;5838.708064596668;5858.619189752652;5717.17101020358;5740.770369185186;5763.510101641407;5778.306603207642;5788.305403351625;5796.710164491674;5864.9413505866105;5897.5576831736935;5899.203607512931;5915.171875937458;5638.661680299195;5707.429257074259;5707.800226992035;5720;5729.255196824386 06:21:20 INFO - PID 12229 | |5;yui.html;750.2534977697192;762.9732959346422;772.9149793522715;785.8860465232541;790.652113070249;12782.55261065863;13235.470581176765;13250.271235082068;16102.516924492254;16783.748243776354;15378.23108844559;15565.53303400897;16224;16308.103054332007;16322.102284374354;896.7085697148436;916.1662886773038;921.6037104045258;921.8893732752045;923.6905636611709;924.4268553496842;933.8599210118468;934.686879895236;936.3258453913205;941.4586612697726;969.4958621516807;973.352720440906;974.5030034682328;977.5796407544752;979.6816034788686;963.2197919685008;963.5326866469757;965.4400447740329;969.5443141723379;973.3770386952356;711.0720509734793;711.6441779110445;712.7897270305273;714.8927660850862;716.6273537760387;13944.16335019902;14453.421863125463;14464.566063018126;14656.70686586273;14689.412423503047;13653.931730341284;13811.654708632264;14355.928220358936;14495.347709353104;14503.70992580153;12842.678933026657;12972.610821675366;12989.285589292585;13211.282533270612;13368.398422070934;3073.1548824073334;3083.491223948046;3106.301082256497;3107.9533806992913;3108.5958825352786;66996.66501667461;67092.66453667749;67170.66414667944;67351;70374.29625703729;12636.30500322491;12903.096783225272;12925.289109098901;12928;12980.675483112998;22393.32820015402;22911.31266062021;23086.769132308797;23265.302040938797;23289.417764556023;6213.627182369072;6309.652969086745;6338.809835704937;6382.968085159545;6398.136251606066;2982.507886198753;3010.1120169550036;3027.909162725122;3042.710942460507;3052.328487732695;3468.8959331220103;3527.9294414112087;3540.044188069207;3541.4687796830167;3560.483729859156;678.8879834827198;681.2948598200838;686.255412877024;687.0209950820062;687.4637782529635;604.8760004199129;613.8802933427938;619.2197830733219;629.0626965820985;635.253577046968;9544.761380965392;9753.463559504153;9876.506174691236;10054.798904022025;10200.3369780964;520.8489538034004;525.6425630571172;526.18178732072;530.3317819547398;535.0369335196631;4343.69594128408;4368.827769480139;4438.822447102079;4533.478649955231;4541.43232095988;62693.37306626967;63840.36159638437;64181;65650.0152497713;67204.6639766798;56426;56779;60144.699276504216;60162;60260;52899.206511902354;52952;53045;53722.46277537253;55813.37213081137;9032.819343613222;9118.908810911806;9136.771580710536;9141.451512909247;9418.293627978066;26000.47999039971;26344.73655263423;26391.868040659672;26450.206493805217;26633;31517;31781.523277150398;31980.20049498781;31983.36033279368;33118.5032224512;12033.217840840667;12093.153479256367;12248.326342050916;12383.75232495363;12403.503859845505;11856.525738970344;11902.821457678316;11972.76054478923;12010.579629713267;12197.573084941985;10845.295055821347;11025.669229923114;11070.667879963614;11118.833217501582;11359.091272697999;12089.093318001009;12134.271943683407;12237.632871013884;12244.326562039174;12350.505979760708;10883.401412922365;11210.887891120985;11225.887741122811;11338.14963877729;11454.08367330595;8413.411061225901;8504.787380315542;8563.272121869712;8621.69824056155;8782.473051616924;9215.677451289173;9345.345825792401;9354;9357.625694972397;9432.434053956784 06:21:20 INFO - PID 12229 | __end_tp_report 06:21:20 INFO - PID 12229 | __start_cc_report 06:21:20 INFO - PID 12229 | _x_x_mozilla_cycle_collect,274 06:21:20 INFO - PID 12229 | __end_cc_report 06:21:20 INFO - PID 12229 | __startTimestamp1495113680505__endTimestamp 06:21:20 INFO - PID 12229 | 06:21:20 INFO - PID 12229 | ------- Summary: start ------- 06:21:20 INFO - PID 12229 | Number of tests: 6 06:21:20 INFO - PID 12229 | 06:21:20 INFO - PID 12229 | [#0] dojo.html Cycles:165 Average:5219.59 Median:5346.41 stddev:612.87 (11.5%) stddev-sans-first:582.51 06:21:20 INFO - PID 12229 | Values: 2719.2 2741.0 2762.1 2764.7 2777.0 5222.1 5255.2 5260.3 5303.8 5346.4 5203.7 5313.9 5326.1 5340.4 5341.5 4624.9 4631.7 4641.2 4702.0 4734.7 4659.3 4724.1 4763.2 4785.2 4808.0 4566.2 4721.5 4732.7 4745.9 4775.5 4669.3 4676.6 4722.5 4761.8 4770.8 4633.8 4671.6 4693.1 4705.3 4746.2 5231.1 5232.7 5233.1 5254.5 5340.3 5503.0 5596.6 5679.7 5760.0 5780.6 5781.7 5785.8 5786.8 5788.4 5831.8 5309.9 5338.2 5341.4 5364.4 5377.1 5798.7 5819.4 5820.1 5859.6 5907.1 5567.4 5575.1 5606.3 5609.0 5655.9 5724.8 5760.5 5763.2 5798.6 5807.0 5574.2 5693.0 5695.7 5709.2 5722.5 5695.1 5711.1 5714.2 5717.4 5719.7 4733.2 4793.0 4855.2 4912.2 4914.2 4170.5 4176.0 4181.2 4211.6 4221.6 4737.5 4815.1 4819.5 4840.0 4875.9 5530.9 5620.1 5686.1 5763.0 5776.0 4789.2 4805.1 4815.3 4833.9 4865.2 5045.6 5062.9 5087.8 5093.7 5133.5 5129.4 5207.7 5264.6 5267.0 5283.8 5679.5 5696.8 5699.0 5699.8 5702.6 5149.6 5180.6 5194.5 5236.5 5241.3 5633.4 5644.4 5696.9 5723.5 5726.2 5637.4 5749.7 5757.2 5771.4 5771.7 5464.9 5527.4 5538.3 5608.6 5621.3 5560.1 5589.7 5605.2 5608.9 5621.6 5469.1 5509.1 5524.3 5526.9 5548.3 5454.9 5539.8 5583.2 5646.4 5664.7 5472.6 5474.7 5475.0 5480.5 5521.4 06:21:20 INFO - PID 12229 | 06:21:20 INFO - PID 12229 | [#1] ext.html Cycles:180 Average:29672.73 Median:3100.72 stddev:39499.88 (1273.9%) stddev-sans-first:39550.84 06:21:20 INFO - PID 12229 | Values: 716.0 738.5 767.9 1067.8 1080.2 30833.5 31669.2 31672.0 31752.2 31803.8 34543.3 34826.8 34928.3 35039.0 35069.3 6682.0 6816.9 6897.7 7002.2 7023.6 6854.2 6901.5 6908.7 6910.1 6931.6 6896.5 6921.2 6966.1 6974.4 6980.7 6859.4 6872.7 6895.8 6897.8 6935.3 6748.0 6786.1 6789.5 6800.4 6807.1 31594.8 31782.0 31819.5 31877.0 31880.7 3044.3 3090.4 3111.1 3119.8 3122.0 24296.5 24426.3 24467.4 24488.3 24504.8 2761.9 2766.7 2776.6 2777.7 2793.8 142446.0 143472.0 143630.0 145440.0 146081.0 38352.8 38407.4 38423.6 38436.8 38451.4 40039.2 40079.4 40086.4 40102.0 40208.6 11302.2 11354.6 11457.2 11489.0 11502.5 8936.6 9035.5 9103.6 9131.3 9143.0 12446.3 12462.2 12480.4 12498.4 12619.7 5360.5 5424.2 5437.8 5484.1 5487.2 882.6 913.7 918.2 925.2 944.0 20050.2 20756.0 21476.8 21695.8 21790.3 967.3 981.1 991.8 993.5 1017.1 11033.6 11247.2 11370.1 11401.0 11528.5 168854.0 170116.0 170506.0 170902.1 171361.0 40670.6 40850.6 41130.2 41242.0 41256.6 1204.3 1230.5 1236.2 1242.5 1249.3 19982.9 20023.8 20468.2 21413.3 21565.4 29730.9 30026.0 30065.4 30085.5 30091.8 143161.0 143671.0 143753.0 144057.0 144136.0 28626.4 28896.4 29003.4 29154.3 29179.1 35374.5 35642.5 35692.8 35761.6 35887.6 26048.0 26567.2 27125.7 27223.3 27228.2 27335.0 28059.0 28323.2 28375.9 28814.0 31571.8 31733.2 31874.0 31941.5 31971.0 27262.9 27301.5 27729.6 27957.7 28927.3 21778.6 22496.0 22642.4 22724.3 22812.0 06:21:20 INFO - PID 12229 | 06:21:20 INFO - PID 12229 | [#2] jquery.html Cycles:180 Average:25421.00 Median:211198.71 stddev:64725.67 (30.6%) stddev-sans-first:64880.03 06:21:20 INFO - PID 12229 | Values: 422.1 423.7 424.8 428.9 444.4 16917.9 17725.1 17770.9 18076.5 18568.0 17194.0 17281.7 17344.0 17711.5 18393.1 5252.4 5324.5 5522.6 5551.8 5563.7 5197.2 5398.2 5433.3 5528.6 5532.8 5375.4 5378.6 5391.1 5396.9 5412.7 5267.8 5369.7 5381.2 5406.1 5460.4 4926.6 4937.0 4937.1 4938.6 4961.2 21515.7 21851.7 22012.0 22242.2 22313.6 1659.8 1662.0 1703.8 1708.5 1711.6 14600.8 14654.3 14999.6 15074.2 15080.2 2140.8 2147.1 2150.1 2160.7 2162.2 86909.6 87832.6 88260.1 88423.0 89663.0 10822.3 10940.8 11052.9 11294.9 11498.5 15786.2 15806.5 15808.1 15812.0 15865.4 6930.7 7000.9 7073.9 7190.8 7258.0 6284.6 6296.8 6441.7 6469.5 6501.8 6879.9 7068.6 7167.8 7181.0 7217.6 2085.3 2098.3 2122.1 2122.9 2197.2 845.7 878.9 880.7 885.8 900.9 15938.5 16198.0 16435.8 16828.6 16931.2 869.0 873.5 883.7 886.3 896.5 8708.7 8903.7 9164.9 9408.4 10895.3 378098.0 383902.0 391181.0 396184.0 398986.0 75469.6 77707.6 78078.0 80908.0 81171.0 1063.5 1081.5 1117.0 1121.9 1128.8 16901.7 17225.9 17775.6 17802.4 17830.5 37217.8 37297.6 38142.2 38256.6 38495.4 48308.8 50329.2 50558.7 50577.6 50781.4 7959.8 8086.8 8384.9 8413.6 8522.7 11446.7 12946.2 13229.7 13292.7 13305.7 10754.6 10916.7 10998.5 11153.7 11316.4 10292.1 10403.2 10520.4 10531.8 10573.8 10305.4 10366.0 10480.9 10514.2 10686.7 8142.3 8336.5 8356.1 8400.3 8488.8 9897.9 10021.9 10093.5 10148.5 10688.6 06:21:20 INFO - PID 12229 | 06:21:20 INFO - PID 12229 | [#3] mootools.html Cycles:180 Average:6408.52 Median:3678.57 stddev:4126.86 (112.2%) stddev-sans-first:4120.46 06:21:20 INFO - PID 12229 | Values: 1283.1 1333.0 1339.3 1345.1 1347.7 10078.8 10506.7 10522.8 10633.3 10928.7 10552.6 10737.1 10761.9 10763.9 10764.4 2246.9 2280.8 2287.7 2296.3 2300.9 2153.7 2229.3 2230.0 2236.3 2240.1 2225.7 2227.6 2276.3 2290.4 2290.6 2136.4 2177.4 2192.3 2195.4 2198.7 2091.8 2185.2 2204.6 2242.9 2246.4 10269.8 10332.6 10340.5 10344.4 10348.9 5676.1 5806.6 5871.5 5883.9 5892.0 3080.2 3250.4 3340.0 3346.0 3359.0 1064.5 1077.6 1087.3 1101.2 1103.2 15283.8 15416.8 15417.8 15437.6 15451.2 4586.5 4854.1 5009.8 5027.4 5081.6 10821.5 10827.5 10843.2 10849.8 10850.8 5711.2 5737.7 5752.5 5766.9 5769.8 5116.9 5194.9 5229.4 5276.9 5289.6 3723.8 3861.6 3862.7 3882.6 3931.6 1054.8 1077.3 1082.1 1083.5 1112.4 717.1 726.3 734.9 738.8 749.8 5597.7 5723.1 5732.2 5765.3 5777.4 531.6 545.4 551.0 555.8 561.8 3633.4 3943.1 3956.1 4006.3 4142.5 12903.8 13780.9 13806.5 13811.0 13835.2 13117.5 13469.3 13676.9 13701.8 13733.2 7228.4 7398.0 7405.1 7405.3 7411.8 6104.1 6171.4 6176.1 6237.2 6385.5 11646.8 11940.0 11988.7 12122.8 12132.3 11852.8 12172.5 12184.5 12195.9 12399.9 8446.7 8518.7 8543.5 8548.7 8622.4 9487.0 9741.8 9818.2 9868.6 9886.7 8153.7 8213.2 8372.3 8486.7 8730.3 8049.9 8182.4 8203.3 8373.3 8523.1 7464.3 7486.2 7522.2 7578.2 7662.3 5007.5 5357.7 5428.2 5444.1 5729.6 5565.4 5595.5 5672.4 5820.8 5908.3 06:21:20 INFO - PID 12229 | 06:21:20 INFO - PID 12229 | [#4] prototype.html Cycles:180 Average:4867.69 Median:5408.41 stddev:1371.85 (25.4%) stddev-sans-first:1333.75 06:21:20 INFO - PID 12229 | Values: 382.3 382.3 383.6 390.0 391.6 5411.5 5498.8 5526.3 5574.8 5586.5 5393.2 5458.4 5465.5 5491.2 5500.8 4200.0 4326.2 4328.9 4368.8 4376.8 4319.3 4336.7 4357.6 4359.8 4367.7 4328.2 4332.1 4343.2 4346.3 4352.2 4277.6 4303.4 4307.5 4341.0 4346.5 3932.2 3945.1 3949.8 3953.5 3959.6 5362.3 5386.0 5395.7 5398.6 5405.3 4996.2 5143.4 5157.3 5162.8 5172.7 5827.3 5854.5 5862.2 5877.5 5887.7 4435.9 4439.4 4440.2 4448.4 4448.4 6033.7 6129.7 6129.9 6153.8 6216.8 4555.2 4585.8 4589.2 4589.8 4595.1 4603.1 4634.8 4644.7 4650.6 4670.0 5091.7 5122.9 5130.7 5146.9 5171.9 5846.8 5851.5 5857.0 5868.1 5873.6 1574.4 1593.3 1615.9 1624.3 1624.7 1116.1 1149.3 1151.4 1151.8 1158.5 4902.7 4951.7 4959.0 4961.3 4965.5 5918.6 5971.4 5980.9 5994.6 5995.0 4804.5 4889.7 4905.7 4930.0 4963.7 3129.4 3161.9 3168.9 3176.5 3193.6 5511.5 5540.5 5544.1 5547.4 5575.3 5955.5 6033.5 6146.7 6190.3 6197.2 5451.9 5500.8 5541.2 5542.2 5569.2 5982.0 5997.2 6005.5 6030.7 6034.4 5716.0 5897.4 5918.2 5934.9 5961.7 5515.2 5538.4 5540.8 5547.9 5567.7 4019.6 4064.1 4067.4 4081.5 4092.1 6003.3 6014.2 6024.1 6045.4 6057.7 5838.4 5852.5 5860.6 5861.2 5877.3 5751.5 5753.7 5795.6 5838.7 5858.6 5717.2 5740.8 5763.5 5778.3 5788.3 5796.7 5864.9 5897.6 5899.2 5915.2 5638.7 5707.4 5707.8 5720.0 5729.3 06:21:20 INFO - PID 12229 | 06:21:20 INFO - PID 12229 | [#5] yui.html Cycles:180 Average:14849.21 Median:4537.46 stddev:18143.60 (399.9%) stddev-sans-first:18163.60 06:21:20 INFO - PID 12229 | Values: 750.3 763.0 772.9 785.9 790.7 12782.6 13235.5 13250.3 16102.5 16783.7 15378.2 15565.5 16224.0 16308.1 16322.1 896.7 916.2 921.6 921.9 923.7 924.4 933.9 934.7 936.3 941.5 969.5 973.4 974.5 977.6 979.7 963.2 963.5 965.4 969.5 973.4 711.1 711.6 712.8 714.9 716.6 13944.2 14453.4 14464.6 14656.7 14689.4 13653.9 13811.7 14355.9 14495.3 14503.7 12842.7 12972.6 12989.3 13211.3 13368.4 3073.2 3083.5 3106.3 3108.0 3108.6 66996.7 67092.7 67170.7 67351.0 70374.3 12636.3 12903.1 12925.3 12928.0 12980.7 22393.3 22911.3 23086.8 23265.3 23289.4 6213.6 6309.7 6338.8 6383.0 6398.1 2982.5 3010.1 3027.9 3042.7 3052.3 3468.9 3527.9 3540.0 3541.5 3560.5 678.9 681.3 686.3 687.0 687.5 604.9 613.9 619.2 629.1 635.3 9544.8 9753.5 9876.5 10054.8 10200.3 520.8 525.6 526.2 530.3 535.0 4343.7 4368.8 4438.8 4533.5 4541.4 62693.4 63840.4 64181.0 65650.0 67204.7 56426.0 56779.0 60144.7 60162.0 60260.0 52899.2 52952.0 53045.0 53722.5 55813.4 9032.8 9118.9 9136.8 9141.5 9418.3 26000.5 26344.7 26391.9 26450.2 26633.0 31517.0 31781.5 31980.2 31983.4 33118.5 12033.2 12093.2 12248.3 12383.8 12403.5 11856.5 11902.8 11972.8 12010.6 12197.6 10845.3 11025.7 11070.7 11118.8 11359.1 12089.1 12134.3 12237.6 12244.3 12350.5 10883.4 11210.9 11225.9 11338.1 11454.1 8413.4 8504.8 8563.3 8621.7 8782.5 9215.7 9345.3 9354.0 9357.6 9432.4 06:21:20 INFO - PID 12229 | -------- Summary: end -------- 06:21:20 INFO - PID 12229 | 06:21:21 INFO - TEST-INFO | 12229: exit 0 06:21:21 INFO - TEST-OK | dromaeo_css | took 1118933ms 06:21:21 INFO - TEST-START | kraken 06:21:21 INFO - operating with platform_type : linux_ 06:21:21 INFO - Initialising browser for kraken test... 06:21:21 INFO - TEST-INFO | started process 12653 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPablzb/profile http://localhost:56686/getInfo.html) 06:21:21 INFO - PID 12653 | JavaScript warning: resource://gre/modules/addons/XPIProvider.jsm, line 2941: String.localeCompare is deprecated; use String.prototype.localeCompare instead 06:21:25 INFO - PID 12653 | __metrics Screen width/height:1600/1200 06:21:25 INFO - PID 12653 | colorDepth:24 06:21:25 INFO - PID 12653 | Browser inner width/height: 1024/695 06:21:25 INFO - PID 12653 | __metrics 06:21:27 INFO - TEST-INFO | 12653: exit 0 06:21:27 INFO - Browser initialized. 06:21:27 INFO - Running cycle 1/1 for kraken test... 06:21:27 INFO - TEST-INFO | started process 12832 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPablzb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:21:38 INFO - PID 12832 | RSS: Main: 168562688 06:21:38 INFO - PID 12832 | 06:21:41 INFO - PID 12832 | Cycle 1(1): loaded http://localhost:56686/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56686/tests/kraken/driver.html?testName=audio-beat-detection) 06:21:42 INFO - PID 12832 | RSS: Main: 173846528 06:21:42 INFO - PID 12832 | 06:21:45 INFO - PID 12832 | Cycle 1(1): loaded http://localhost:56686/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56686/tests/kraken/driver.html?testName=audio-dft) 06:21:45 INFO - PID 12832 | RSS: Main: 173260800 06:21:45 INFO - PID 12832 | 06:21:48 INFO - PID 12832 | Cycle 1(1): loaded http://localhost:56686/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56686/tests/kraken/driver.html?testName=audio-fft) 06:21:49 INFO - PID 12832 | RSS: Main: 168611840 06:21:49 INFO - PID 12832 | 06:21:51 INFO - PID 12832 | Cycle 1(1): loaded http://localhost:56686/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56686/tests/kraken/driver.html?testName=audio-oscillator) 06:21:52 INFO - PID 12832 | RSS: Main: 169017344 06:21:52 INFO - PID 12832 | 06:21:54 INFO - PID 12832 | Cycle 1(1): loaded http://localhost:56686/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56686/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:21:55 INFO - PID 12832 | RSS: Main: 169570304 06:21:55 INFO - PID 12832 | 06:21:58 INFO - PID 12832 | Cycle 1(1): loaded http://localhost:56686/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56686/tests/kraken/driver.html?testName=imaging-darkroom) 06:21:58 INFO - PID 12832 | RSS: Main: 173236224 06:21:58 INFO - PID 12832 | 06:22:02 INFO - PID 12832 | Cycle 1(1): loaded http://localhost:56686/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56686/tests/kraken/driver.html?testName=imaging-desaturate) 06:22:03 INFO - PID 12832 | RSS: Main: 171278336 06:22:03 INFO - PID 12832 | 06:22:05 INFO - PID 12832 | Cycle 1(1): loaded http://localhost:56686/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56686/tests/kraken/driver.html?testName=json-parse-financial) 06:22:06 INFO - PID 12832 | RSS: Main: 172040192 06:22:06 INFO - PID 12832 | 06:22:08 INFO - PID 12832 | Cycle 1(1): loaded http://localhost:56686/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56686/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:22:08 INFO - PID 12832 | RSS: Main: 172261376 06:22:08 INFO - PID 12832 | 06:22:10 INFO - PID 12832 | Cycle 1(1): loaded http://localhost:56686/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56686/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:22:11 INFO - PID 12832 | RSS: Main: 171954176 06:22:11 INFO - PID 12832 | 06:22:13 INFO - PID 12832 | Cycle 1(1): loaded http://localhost:56686/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56686/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:22:14 INFO - PID 12832 | RSS: Main: 172122112 06:22:14 INFO - PID 12832 | 06:22:16 INFO - PID 12832 | Cycle 1(1): loaded http://localhost:56686/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56686/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:22:17 INFO - PID 12832 | RSS: Main: 172195840 06:22:17 INFO - PID 12832 | 06:22:20 INFO - PID 12832 | Cycle 1(1): loaded http://localhost:56686/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56686/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:22:21 INFO - PID 12832 | RSS: Main: 172122112 06:22:21 INFO - PID 12832 | 06:22:23 INFO - PID 12832 | Cycle 1(1): loaded http://localhost:56686/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56686/tests/kraken/driver.html?testName=ai-astar) 06:22:23 INFO - PID 12832 | RSS: Main: 173305856 06:22:23 INFO - PID 12832 | 06:22:23 INFO - PID 12832 | __start_tp_report 06:22:23 INFO - PID 12832 | _x_x_mozilla_page_load 06:22:23 INFO - PID 12832 | _x_x_mozilla_page_load_details 06:22:23 INFO - PID 12832 | |i|pagename|runs| 06:22:23 INFO - PID 12832 | |0;ai-astar;105;114;111;113;113;110;112;111;112;111 06:22:23 INFO - PID 12832 | |1;audio-beat-detection;151;125;124;177;122;125;126;124;144;124 06:22:23 INFO - PID 12832 | |2;audio-dft;166;167;167;164;165;166;176;166;164;164 06:22:23 INFO - PID 12832 | |3;audio-fft;77;76;78;112;77;76;77;76;105;76 06:22:23 INFO - PID 12832 | |4;audio-oscillator;83;86;116;84;85;84;101;85;83;112 06:22:23 INFO - PID 12832 | |5;imaging-gaussian-blur;114;115;114;115;114;114;115;115;117;114 06:22:23 INFO - PID 12832 | |6;imaging-darkroom;151;155;156;150;150;151;151;152;152;150 06:22:23 INFO - PID 12832 | |7;imaging-desaturate;95;95;95;96;94;96;95;94;94;99 06:22:23 INFO - PID 12832 | |8;json-parse-financial;56;54;54;55;55;58;56;55;55;55 06:22:23 INFO - PID 12832 | |9;json-stringify-tinderbox;55;55;55;56;56;55;55;57;56;55 06:22:23 INFO - PID 12832 | |10;stanford-crypto-aes;85;83;81;90;84;82;88;81;81;82 06:22:23 INFO - PID 12832 | |11;stanford-crypto-ccm;138;142;133;142;135;139;134;137;189;134 06:22:23 INFO - PID 12832 | |12;stanford-crypto-pbkdf2;189;195;198;189;187;202;199;192;194;209 06:22:23 INFO - PID 12832 | |13;stanford-crypto-sha256-iterative;75;76;74;80;77;74;81;75;78;77 06:22:23 INFO - PID 12832 | __end_tp_report 06:22:23 INFO - PID 12832 | __start_cc_report 06:22:23 INFO - PID 12832 | _x_x_mozilla_cycle_collect,763 06:22:23 INFO - PID 12832 | __end_cc_report 06:22:23 INFO - PID 12832 | __startTimestamp1495113743564__endTimestamp 06:22:23 INFO - PID 12832 | 06:22:23 INFO - PID 12832 | ------- Summary: start ------- 06:22:23 INFO - PID 12832 | Number of tests: 14 06:22:23 INFO - PID 12832 | 06:22:23 INFO - PID 12832 | [#0] ai-astar Cycles:10 Average:111.20 Median:112.00 stddev:2.49 (2.2%) stddev-sans-first:1.27 06:22:23 INFO - PID 12832 | Values: 105.0 114.0 111.0 113.0 113.0 110.0 112.0 111.0 112.0 111.0 06:22:23 INFO - PID 12832 | 06:22:23 INFO - PID 12832 | [#1] audio-beat-detection Cycles:10 Average:134.20 Median:125.50 stddev:17.97 (14.3%) stddev-sans-first:18.01 06:22:23 INFO - PID 12832 | Values: 151.0 125.0 124.0 177.0 122.0 125.0 126.0 124.0 144.0 124.0 06:22:23 INFO - PID 12832 | 06:22:23 INFO - PID 12832 | [#2] audio-dft Cycles:10 Average:166.50 Median:166.00 stddev:3.54 (2.1%) stddev-sans-first:3.75 06:22:23 INFO - PID 12832 | Values: 166.0 167.0 167.0 164.0 165.0 166.0 176.0 166.0 164.0 164.0 06:22:23 INFO - PID 12832 | 06:22:23 INFO - PID 12832 | [#3] audio-fft Cycles:10 Average:83.00 Median:76.50 stddev:13.56 (17.7%) stddev-sans-first:14.20 06:22:23 INFO - PID 12832 | Values: 77.0 76.0 78.0 112.0 77.0 76.0 77.0 76.0 105.0 76.0 06:22:23 INFO - PID 12832 | 06:22:23 INFO - PID 12832 | [#4] audio-oscillator Cycles:10 Average:91.90 Median:84.00 stddev:12.83 (15.3%) stddev-sans-first:13.20 06:22:23 INFO - PID 12832 | Values: 83.0 86.0 116.0 84.0 85.0 84.0 101.0 85.0 83.0 112.0 06:22:23 INFO - PID 12832 | 06:22:23 INFO - PID 12832 | [#5] imaging-gaussian-blur Cycles:10 Average:114.70 Median:115.00 stddev:0.95 (0.8%) stddev-sans-first:0.97 06:22:23 INFO - PID 12832 | Values: 114.0 115.0 114.0 115.0 114.0 114.0 115.0 115.0 117.0 114.0 06:22:23 INFO - PID 12832 | 06:22:23 INFO - PID 12832 | [#6] imaging-darkroom Cycles:10 Average:151.80 Median:151.50 stddev:2.10 (1.4%) stddev-sans-first:2.20 06:22:23 INFO - PID 12832 | Values: 151.0 155.0 156.0 150.0 150.0 151.0 151.0 152.0 152.0 150.0 06:22:23 INFO - PID 12832 | 06:22:23 INFO - PID 12832 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:1.49 (1.6%) stddev-sans-first:1.58 06:22:23 INFO - PID 12832 | Values: 95.0 95.0 95.0 96.0 94.0 96.0 95.0 94.0 94.0 99.0 06:22:23 INFO - PID 12832 | 06:22:23 INFO - PID 12832 | [#8] json-parse-financial Cycles:10 Average:55.30 Median:55.00 stddev:1.16 (2.1%) stddev-sans-first:1.20 06:22:23 INFO - PID 12832 | Values: 56.0 54.0 54.0 55.0 55.0 58.0 56.0 55.0 55.0 55.0 06:22:23 INFO - PID 12832 | 06:22:23 INFO - PID 12832 | [#9] json-stringify-tinderbox Cycles:10 Average:55.50 Median:55.50 stddev:0.71 (1.3%) stddev-sans-first:0.73 06:22:23 INFO - PID 12832 | Values: 55.0 55.0 55.0 56.0 56.0 55.0 55.0 57.0 56.0 55.0 06:22:23 INFO - PID 12832 | 06:22:23 INFO - PID 12832 | [#10] stanford-crypto-aes Cycles:10 Average:83.70 Median:83.50 stddev:3.13 (3.7%) stddev-sans-first:3.28 06:22:23 INFO - PID 12832 | Values: 85.0 83.0 81.0 90.0 84.0 82.0 88.0 81.0 81.0 82.0 06:22:23 INFO - PID 12832 | 06:22:23 INFO - PID 12832 | [#11] stanford-crypto-ccm Cycles:10 Average:142.30 Median:138.50 stddev:16.72 (12.1%) stddev-sans-first:17.66 06:22:23 INFO - PID 12832 | Values: 138.0 142.0 133.0 142.0 135.0 139.0 134.0 137.0 189.0 134.0 06:22:23 INFO - PID 12832 | 06:22:23 INFO - PID 12832 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:195.40 Median:196.50 stddev:6.79 (3.5%) stddev-sans-first:6.79 06:22:23 INFO - PID 12832 | Values: 189.0 195.0 198.0 189.0 187.0 202.0 199.0 192.0 194.0 209.0 06:22:23 INFO - PID 12832 | 06:22:23 INFO - PID 12832 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:76.70 Median:77.00 stddev:2.41 (3.1%) stddev-sans-first:2.47 06:22:23 INFO - PID 12832 | Values: 75.0 76.0 74.0 80.0 77.0 74.0 81.0 75.0 78.0 77.0 06:22:23 INFO - PID 12832 | -------- Summary: end -------- 06:22:23 INFO - PID 12832 | 06:22:24 INFO - TEST-INFO | 12832: exit 0 06:22:24 INFO - TEST-OK | kraken | took 63274ms 06:22:24 INFO - SUITE-END | took 1182s 06:22:24 INFO - Completed test suite (00:19:42) 06:22:24 INFO - javascript benchmark 06:22:24 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6714.37954988504, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2719.238613188307, 2741.0406357774796, 2762.074704973834, 2764.7235276472347, 2776.9583456248147, 5222.086134926382, 5255.159174532076, 5260.289860868782, 5303.814366497173, 5346.4118946915805, 5203.68777873327, 5313.946860531393, 5326.094563924133, 5340.412554618989, 5341.519263266306, 4624.884377890563, 4631.745254011028, 4641.164590373732, 4702.0, 4734.668573199878, 4659.277811939138, 4724.149653062447, 4763.2378819388905, 4785.234362502, 4807.951920480786, 4566.155261276641, 4721.480637129947, 4732.716037037789, 4745.881352966187, 4775.5463230993, 4669.2529195328925, 4676.579107880307, 4722.480527142046, 4761.8095276188915, 4770.809167633325, 4633.837815676435, 4671.556202160789, 4693.108309421199, 4705.341252224657, 4746.240601503743, 5231.110711179071, 5232.7122008289525, 5233.058049551079, 5254.500822421864, 5340.25236466895, 5502.972485137549, 5596.608237423341, 5679.659220446786, 5759.971200144015, 5780.595358324919, 5781.71091445426, 5785.82642520725, 5786.768529258825, 5788.42115788422, 5831.766729330864, 5309.920351194735, 5338.172583249602, 5341.359036915517, 5364.356277246678, 5377.085895397791, 5798.652080875161, 5819.447152520504, 5820.126980952891, 5859.619124756877, 5907.084401917709, 5567.415421380697, 5575.080111781511, 5606.271184746039, 5609.0, 5655.943440565624, 5724.8282551523525, 5760.510356619734, 5763.164341170507, 5798.594098413155, 5807.0, 5574.163875418639, 5693.0, 5695.7152142392715, 5709.229254050733, 5722.456366645162, 5695.060315047971, 5711.143328500758, 5714.228579141763, 5717.428257174332, 5719.656820590778, 4733.195356789354, 4793.01743142655, 4855.223164293767, 4912.214045752734, 4914.213725803854, 4170.541240463546, 4175.979120104441, 4181.205570941512, 4211.642010429086, 4221.598948099926, 4737.549932756451, 4815.133276010281, 4819.518048195152, 4839.959408727141, 4875.902481950341, 5530.944690553123, 5620.100783874642, 5686.09022556389, 5763.0, 5776.046952252831, 4789.2337226044365, 4805.063012712558, 4815.277708343777, 4833.903321933612, 4865.221564549655, 5045.621578381636, 5062.873428164326, 5087.847364579068, 5093.745312734349, 5133.537981581676, 5129.435762066244, 5207.6875387476875, 5264.552513036435, 5266.97366513165, 5283.831475684418, 5679.46045125729, 5696.8006119785605, 5698.974184646803, 5699.829005129853, 5702.572307077069, 5149.613778966517, 5180.585553155814, 5194.532492075731, 5236.502532259429, 5241.266222728745, 5633.352164501135, 5644.435556444487, 5696.914546281892, 5723.456271654186, 5726.169705392778, 5637.43625637433, 5749.683767392834, 5757.222774925332, 5771.394003629558, 5771.653700777967, 5464.890702185855, 5527.364353099445, 5538.252335934759, 5608.6073974821375, 5621.269234999424, 5560.082586373203, 5589.664620122806, 5605.215269862141, 5608.943910560843, 5621.55027597783, 5469.097598896296, 5509.146082357241, 5524.254225679482, 5526.917096243479, 5548.334199896039, 5454.918176227439, 5539.778408863762, 5583.218349431002, 5646.35066967304, 5664.745086471201, 5472.644278121909, 5474.698891561003, 5474.972625136849, 5480.534154596904, 5521.3926468087675], "value": 5175.195731105821, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [715.9964200178998, 738.5494848142632, 767.8579462799382, 1067.8344856547233, 1080.1790639114272, 30833.537496937563, 31669.20826979321, 31672.0, 31752.20619484514, 31803.84098079512, 34543.30913381731, 34826.82586587063, 34928.301433971305, 35039.0, 35069.298614027764, 6681.966590167042, 6816.931830681704, 6897.655117244155, 7002.229754726976, 7023.61370124643, 6854.177498700163, 6901.516893817435, 6908.654567271641, 6910.067140935985, 6931.61876096817, 6896.482763792736, 6921.238663746984, 6966.12923384577, 6974.372306492414, 6980.650967451633, 6859.416949559293, 6872.656367181671, 6895.75864844733, 6897.827554311132, 6935.271796461375, 6747.966260168717, 6786.083878676414, 6789.490788190906, 6800.387965083117, 6807.081044059088, 31594.842025789952, 31782.046538603878, 31819.522707159413, 31877.0, 31880.681193188004, 3044.3302473455806, 3090.381923615286, 3111.066679995992, 3119.844007799601, 3122.0, 24296.514069718683, 24426.267211983668, 24467.388315292083, 24488.265352039467, 24504.754952450425, 2761.9309517262027, 2766.6541682289712, 2776.639036925207, 2777.652793400825, 2793.832370057803, 142446.0, 143472.0, 143630.0, 145440.0, 146080.99999999892, 38352.80823595864, 38407.42388864169, 38423.615763842565, 38436.80781596074, 38451.42322865159, 40039.1992160161, 40079.39880901789, 40086.39870401946, 40102.0, 40208.59791402107, 11302.208845380745, 11354.602588909349, 11457.197996140358, 11489.0, 11502.539898404137, 8936.597853096626, 9035.548222588845, 9103.590338434786, 9131.26949844011, 9143.0, 12446.25322480636, 12462.189957652723, 12480.375981200903, 12498.437570309357, 12619.747605047847, 5360.544353729899, 5424.213489044067, 5437.809676661377, 5484.122540393518, 5487.204355368449, 882.6381183714647, 913.6756451459769, 918.205752024494, 925.167349385545, 944.0370821761765, 20050.197992080153, 20756.0, 21476.78523214779, 21695.783042169376, 21790.346289611338, 967.3083745122271, 981.1316984468797, 991.7867658453467, 993.458565082032, 1017.0998666180336, 11033.558657653604, 11247.212695111428, 11370.147238956946, 11401.0, 11528.481218345194, 168854.0, 170116.0, 170506.0, 170902.14548927423, 171361.0, 40670.59329406727, 40850.59149408468, 41130.1773964519, 41242.0, 41256.58743412527, 1204.265398107154, 1230.4708975140775, 1236.1532350340046, 1242.5278394210143, 1249.3066348176667, 19982.90008549948, 20023.799762002775, 20468.181272748923, 21413.250536231157, 21565.35303940884, 29730.851345743133, 30026.0, 30065.398692026476, 30085.54871676883, 30091.849540752155, 143161.0, 143671.0, 143753.0, 144057.0, 144136.0, 28626.427471450872, 28896.42207155803, 29003.41993160167, 29154.27114322074, 29179.124626261248, 35374.46938295979, 35642.46536302009, 35692.82153589215, 35761.64238357583, 35887.64112358948, 26048.0, 26567.202983910513, 27125.72874271232, 27223.319417014733, 27228.183154505397, 27335.04327348533, 28059.0, 28323.150305490868, 28375.858120709265, 28814.0, 31571.842140789147, 31733.206669832514, 31874.0, 31941.520877187326, 31971.0, 27262.863685681445, 27301.453970920073, 27729.584056238768, 27957.72042279551, 28927.276818078873, 21778.56442871102, 22496.0, 22642.43393915165, 22724.318270451913, 22812.0], "value": 14314.308864570494, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [422.1451560589803, 423.6695377605468, 424.77274658057945, 428.8520460441148, 444.44888338460316, 16917.915410422946, 17725.11374431278, 17770.911145444272, 18076.457706268833, 18568.0, 17194.0, 17281.654366912655, 17344.046077465733, 17711.46865594031, 18393.149061895427, 5252.3697156341295, 5324.467553244684, 5522.585806064541, 5551.77792888284, 5563.721813909308, 5197.220416937471, 5398.24424580559, 5433.320834895638, 5528.612997090206, 5532.834014979557, 5375.43557926418, 5378.569714422837, 5391.137418013119, 5396.865078373053, 5412.729363531827, 5267.789288428458, 5369.677819330814, 5381.219723140142, 5406.08096623573, 5460.372057213432, 4926.605871530269, 4937.0372777308085, 4937.086638971766, 4938.604911607063, 4961.18140506816, 21515.67726484104, 21851.672224916638, 22012.009459574358, 22242.221522246804, 22313.553728925493, 1659.7842280503457, 1661.9750703739332, 1703.7699910512047, 1708.4874537638782, 1711.5806627376248, 14600.780988285183, 14654.340554674958, 14999.550013499613, 15074.24628768568, 15080.170590617512, 2140.7752186020557, 2147.076756994492, 2150.139944022388, 2160.6542953127423, 2162.243214874781, 86909.56545217297, 87832.56083719604, 88260.11739882584, 88423.0, 89663.0, 10822.296550724177, 10940.781184376427, 11052.944735276433, 11294.94352528232, 11498.482568284448, 15786.237408453475, 15806.525804225892, 15808.130552819704, 15811.972221805547, 15865.365385384686, 6930.688119034656, 7000.92999070013, 7073.92926070743, 7190.784276471714, 7258.020167277456, 6284.560080794392, 6296.779612713533, 6441.742330306829, 6469.482441404676, 6501.804945851537, 6879.89680154798, 7068.617457176583, 7167.820804479929, 7180.964095179491, 7217.566945983258, 2085.301424022939, 2098.31804663485, 2122.1405330841035, 2122.936311910645, 2197.2419515267206, 845.7166849105496, 878.9384743068051, 880.6785523284084, 885.8449771289999, 900.909909009107, 15938.521844344688, 16198.0, 16435.753463698053, 16828.579285517717, 16931.238094285785, 868.9529117413501, 873.4933738431695, 883.6951251818112, 886.3396769406833, 896.5293221058996, 8708.651653933772, 8903.73288801337, 9164.90835091654, 9408.388454750419, 10895.291806032583, 378098.0, 383902.0, 391181.0, 396184.0, 398986.0, 75469.62265188749, 77707.61146194233, 78078.0, 80908.0, 81171.0, 1063.5373612478597, 1081.4916989014994, 1117.0, 1121.8765935747224, 1128.8250321200228, 16901.746473802657, 17225.913870431068, 17775.555611109827, 17802.376916808367, 17830.46508604744, 37217.81391093027, 37297.6270237305, 38142.23715525618, 38256.61743382642, 38495.422568660935, 48308.75845620749, 50329.245061324844, 50558.7472062652, 50577.618945701215, 50781.43305100395, 7959.80100497469, 8086.757397278091, 8384.874226886725, 8413.579321034047, 8522.70170544028, 11446.656600302003, 12946.223226606433, 13229.669258268621, 13292.734145316846, 13305.667358315732, 10754.623588174376, 10916.727081823017, 10998.450077495932, 11153.72115697114, 11316.434178291218, 10292.125169360688, 10403.167746580104, 10520.421376824348, 10531.842022369518, 10573.788524229627, 10305.381677099398, 10366.0, 10480.947595261974, 10514.211434142622, 10686.679399618024, 8142.307903828241, 8336.499810011175, 8356.080831108695, 8400.28597569189, 8488.787780305294, 9897.851532226878, 10021.899781002097, 10093.495325233856, 10148.492575371054, 10688.625898093529], "value": 8813.493917175547, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1283.1402960016787, 1332.9999999999993, 1339.3303348325837, 1345.1122259308859, 1347.6698208938808, 10078.798424031524, 10506.737331566705, 10522.842157367637, 10633.308834925743, 10928.672139835799, 10552.577896884135, 10737.087347575465, 10761.892381076186, 10763.892361076387, 10764.407957562331, 2246.9438264043447, 2280.8175345972363, 2287.6797248385237, 2296.3111066680012, 2300.8619482831, 2153.6984822124837, 2229.3423440085135, 2230.0, 2236.2620335289316, 2240.0591751464344, 2225.721784776903, 2227.610168220563, 2276.2602154299834, 2290.4044948313476, 2290.6449500327394, 2136.4445244236454, 2177.433867194533, 2192.287506560366, 2195.4182141732454, 2198.681191227271, 2091.7699053104147, 2185.158713895146, 2204.6252137136726, 2242.932712018642, 2246.3597874605657, 10269.794604107876, 10332.58669653213, 10340.482975851177, 10344.431056291976, 10348.94825525875, 5676.148577713335, 5806.564507661942, 5871.500922421599, 5883.852903677443, 5891.970540147315, 3080.152957936563, 3250.366178595175, 3340.048086295394, 3345.983270083634, 3359.0, 1064.5369264369947, 1077.617445806743, 1087.320424734541, 1101.1720249165978, 1103.227740581588, 15283.770743438858, 15416.845831541654, 15417.845821541754, 15437.614059648486, 15451.227438628137, 4586.4725556561425, 4854.126257273654, 5009.774560144802, 5027.4469808321055, 5081.568066714371, 10821.513031913426, 10827.512761925575, 10843.1867609928, 10849.783004340026, 10850.782984340427, 5711.171880077365, 5737.684427356452, 5752.539796816244, 5766.913496297559, 5769.798057067983, 5116.897662046738, 5194.92207616886, 5229.424763276036, 5276.947230527646, 5289.629725919149, 3723.7579557328686, 3861.575226725058, 3862.6523612874416, 3882.602263185251, 3931.567527571965, 1054.7995880782628, 1077.256692881909, 1082.107261509258, 1083.4907593431076, 1112.3659514076899, 717.078554058033, 726.3426598927979, 734.9118105827228, 738.770980995893, 749.7600767754267, 5597.664140151523, 5723.141528770634, 5732.197492351074, 5765.308163020464, 5777.422257774189, 531.6416555700223, 545.4191286280098, 551.0301868711098, 555.7721334252936, 561.7977528089884, 3633.3823250047553, 3943.1325108476663, 3956.1098752780395, 4006.318925782624, 4142.523609784853, 12903.806442903364, 13780.862191378159, 13806.516771912935, 13811.033227674166, 13835.239061851695, 13117.475300987853, 13469.326533673277, 13676.93161534186, 13701.794473082911, 13733.176009439465, 7228.385587225145, 7398.0, 7405.1484079330485, 7405.333519983227, 7411.777646670716, 6104.084387341934, 6171.413715697002, 6176.104464852661, 6237.157983672146, 6385.489160867212, 11646.825297620711, 11940.0, 11988.700282493008, 12122.818157727464, 12132.332721700392, 11852.822207666719, 12172.452239649414, 12184.451699673358, 12195.939020304842, 12399.938000309941, 8446.704365347183, 8518.74443766688, 8543.487390756574, 8548.74353769388, 8622.396432249683, 9487.0, 9741.756456088655, 9818.214542836698, 9868.555914983986, 9886.703398898044, 8153.6738530458115, 8213.219744124299, 8372.33021358302, 8486.70296539643, 8730.34522410809, 8049.87925181111, 8182.427230093836, 8203.261706446448, 8373.330133589176, 8523.105073967145, 7464.290892365217, 7486.213947535431, 7522.172561018174, 7578.204288549843, 7662.272084151997, 5007.499250074963, 5357.651752636066, 5428.240046393429, 5444.074507333842, 5729.627574207663, 5565.415631358649, 5595.496405323541, 5672.404397538199, 5820.796272130455, 5908.261467316585], "value": 4772.207016353303, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [382.2774955334418, 382.3022983055923, 383.6317135549872, 390.0288282177379, 391.56340680141653, 5411.485908838664, 5498.80754173604, 5526.281583394163, 5574.832755017346, 5586.469285417884, 5393.1910213468, 5458.372287186975, 5465.480779325968, 5491.203775452567, 5500.752466139023, 4200.012996945716, 4326.156399502099, 4328.935065974013, 4368.759718215497, 4376.824927002932, 4319.308910574308, 4336.653067754588, 4357.607815296623, 4359.760213188273, 4367.716098453606, 4328.242557552431, 4332.1119170569955, 4343.153085148398, 4346.326319420479, 4352.173087113439, 4277.5528094476995, 4303.440552728157, 4307.5261721210645, 4341.02326976431, 4346.500152482457, 3932.1742434088874, 3945.0926286954164, 3949.763014219156, 3953.466282051944, 3959.6436320731273, 5362.302900622933, 5385.973070134663, 5395.7032363220005, 5398.6220964532495, 5405.324334458192, 4996.225585034325, 5143.434222235551, 5157.30376399185, 5162.819301324474, 5172.663776854492, 5827.329857066449, 5854.5023672987845, 5862.20860183874, 5877.471027607493, 5887.735051922674, 4435.911281774379, 4439.400680908068, 4440.200763862504, 4448.377227188196, 4448.377227188196, 6033.668148251844, 6129.693515324216, 6129.938700612981, 6153.815385538441, 6216.7824126155365, 4555.157295900269, 4585.830613193681, 4589.151007063704, 4589.816407343736, 4595.149897268949, 4603.102395032936, 4634.814607415666, 4644.651651126179, 4650.581447669726, 4670.0, 5091.745412729349, 5122.897542049138, 5130.666506677054, 5146.922796158061, 5171.9482805171465, 5846.795362162304, 5851.531877449794, 5857.0335894577765, 5868.149118377812, 5873.647581145145, 1574.4410734189198, 1593.3148746039315, 1615.886887917858, 1624.301550333368, 1624.659655783983, 1116.1461481966303, 1149.2644707387278, 1151.441550847838, 1151.8329842173005, 1158.5423757615695, 4902.681325713888, 4951.678140920829, 4958.950410495849, 4961.305417241589, 4965.453800081988, 5918.556108291896, 5971.373005834412, 5980.910286345708, 5994.610350327302, 5995.0, 4804.54356836107, 4889.682170658896, 4905.705657660552, 4930.0, 4963.6525443218625, 3129.3741251749743, 3161.8893338733033, 3168.8890888818783, 3176.4747026114296, 3193.552902593639, 5511.5039646432015, 5540.506771952638, 5544.140658197985, 5547.417521160301, 5575.303087114111, 5955.493783028404, 6033.456988870935, 6146.692665366714, 6190.288116866618, 6197.163382943245, 5451.863703407367, 5500.80747173847, 5541.224228608079, 5542.196381524656, 5569.164625306155, 5982.042873140276, 5997.190379298739, 6005.489533389711, 6030.668313242638, 6034.366391528826, 5716.028275193144, 5897.439743224387, 5918.23063001807, 5934.940650593611, 5961.672108034099, 5515.172724091419, 5538.446155384429, 5540.7783688652, 5547.944520554743, 5567.749451274622, 4019.618136277049, 4064.1262128642484, 4067.4102255172243, 4081.5102187736475, 4092.140650463436, 6003.309619393651, 6014.248218972629, 6024.084345175671, 6045.395460454095, 6057.697115144313, 5838.416158384128, 5852.5317974561085, 5860.619059761102, 5861.183033259703, 5877.265341832271, 5751.511121554715, 5753.712314384347, 5795.594308398372, 5838.708064596668, 5858.619189752652, 5717.17101020358, 5740.770369185186, 5763.510101641407, 5778.306603207642, 5788.305403351625, 5796.710164491674, 5864.9413505866105, 5897.5576831736935, 5899.203607512931, 5915.171875937458, 5638.661680299195, 5707.429257074259, 5707.800226992035, 5720.0, 5729.255196824386], "value": 4454.183684540324, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [750.2534977697192, 762.9732959346422, 772.9149793522715, 785.8860465232541, 790.652113070249, 12782.55261065863, 13235.470581176765, 13250.271235082068, 16102.516924492254, 16783.748243776354, 15378.23108844559, 15565.53303400897, 16224.0, 16308.103054332007, 16322.102284374354, 896.7085697148436, 916.1662886773038, 921.6037104045258, 921.8893732752045, 923.6905636611709, 924.4268553496842, 933.8599210118468, 934.686879895236, 936.3258453913205, 941.4586612697726, 969.4958621516807, 973.352720440906, 974.5030034682328, 977.5796407544752, 979.6816034788686, 963.2197919685008, 963.5326866469757, 965.4400447740329, 969.5443141723379, 973.3770386952356, 711.0720509734793, 711.6441779110445, 712.7897270305273, 714.8927660850862, 716.6273537760387, 13944.16335019902, 14453.421863125463, 14464.566063018126, 14656.70686586273, 14689.412423503047, 13653.931730341284, 13811.654708632264, 14355.928220358936, 14495.347709353104, 14503.70992580153, 12842.678933026657, 12972.610821675366, 12989.285589292585, 13211.282533270612, 13368.398422070934, 3073.1548824073334, 3083.491223948046, 3106.301082256497, 3107.9533806992913, 3108.5958825352786, 66996.66501667461, 67092.66453667749, 67170.66414667944, 67351.0, 70374.29625703729, 12636.30500322491, 12903.096783225272, 12925.289109098901, 12928.0, 12980.675483112998, 22393.32820015402, 22911.31266062021, 23086.769132308797, 23265.302040938797, 23289.417764556023, 6213.627182369072, 6309.652969086745, 6338.809835704937, 6382.968085159545, 6398.136251606066, 2982.507886198753, 3010.1120169550036, 3027.909162725122, 3042.710942460507, 3052.328487732695, 3468.8959331220103, 3527.9294414112087, 3540.044188069207, 3541.4687796830167, 3560.483729859156, 678.8879834827198, 681.2948598200838, 686.255412877024, 687.0209950820062, 687.4637782529635, 604.8760004199129, 613.8802933427938, 619.2197830733219, 629.0626965820985, 635.253577046968, 9544.761380965392, 9753.463559504153, 9876.506174691236, 10054.798904022025, 10200.3369780964, 520.8489538034004, 525.6425630571172, 526.18178732072, 530.3317819547398, 535.0369335196631, 4343.69594128408, 4368.827769480139, 4438.822447102079, 4533.478649955231, 4541.43232095988, 62693.37306626967, 63840.36159638437, 64181.0, 65650.0152497713, 67204.6639766798, 56426.0, 56779.0, 60144.699276504216, 60162.0, 60260.0, 52899.206511902354, 52952.0, 53045.0, 53722.46277537253, 55813.37213081137, 9032.819343613222, 9118.908810911806, 9136.771580710536, 9141.451512909247, 9418.293627978066, 26000.47999039971, 26344.73655263423, 26391.868040659672, 26450.206493805217, 26633.0, 31517.0, 31781.523277150398, 31980.20049498781, 31983.36033279368, 33118.5032224512, 12033.217840840667, 12093.153479256367, 12248.326342050916, 12383.75232495363, 12403.503859845505, 11856.525738970344, 11902.821457678316, 11972.76054478923, 12010.579629713267, 12197.573084941985, 10845.295055821347, 11025.669229923114, 11070.667879963614, 11118.833217501582, 11359.091272697999, 12089.093318001009, 12134.271943683407, 12237.632871013884, 12244.326562039174, 12350.505979760708, 10883.401412922365, 11210.887891120985, 11225.887741122811, 11338.14963877729, 11454.08367330595, 8413.411061225901, 8504.787380315542, 8563.272121869712, 8621.69824056155, 8782.473051616924, 9215.677451289173, 9345.345825792401, 9354.0, 9357.625694972397, 9432.434053956784], "value": 6601.960551915474, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1557.5, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 114.0, 111.0, 113.0, 113.0, 110.0, 112.0, 111.0, 112.0, 111.0], "value": 111.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 125.0, 124.0, 177.0, 122.0, 125.0, 126.0, 124.0, 144.0, 124.0], "value": 134.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 167.0, 167.0, 164.0, 165.0, 166.0, 176.0, 166.0, 164.0, 164.0], "value": 166.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 78.0, 112.0, 77.0, 76.0, 77.0, 76.0, 105.0, 76.0], "value": 83.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 86.0, 116.0, 84.0, 85.0, 84.0, 101.0, 85.0, 83.0, 112.0], "value": 91.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 115.0, 114.0, 115.0, 114.0, 114.0, 115.0, 115.0, 117.0, 114.0], "value": 114.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 155.0, 156.0, 150.0, 150.0, 151.0, 151.0, 152.0, 152.0, 150.0], "value": 151.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 96.0, 94.0, 96.0, 95.0, 94.0, 94.0, 99.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 54.0, 54.0, 55.0, 55.0, 58.0, 56.0, 55.0, 55.0, 55.0], "value": 55.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 55.0, 56.0, 56.0, 55.0, 55.0, 57.0, 56.0, 55.0], "value": 55.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 83.0, 81.0, 90.0, 84.0, 82.0, 88.0, 81.0, 81.0, 82.0], "value": 83.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 142.0, 133.0, 142.0, 135.0, 139.0, 134.0, 137.0, 189.0, 134.0], "value": 142.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [189.0, 195.0, 198.0, 189.0, 187.0, 202.0, 199.0, 192.0, 194.0, 209.0], "value": 195.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 74.0, 80.0, 77.0, 74.0, 81.0, 75.0, 78.0, 77.0], "value": 76.7, "unit": "score"}]}]} 06:22:24 INFO - Return code: 0 06:22:24 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:22:24 INFO - # TBPL SUCCESS # 06:22:24 INFO - Running post-action listener: _resource_record_post_action 06:22:24 INFO - [mozharness: 2017-05-18 13:22:24.846351Z] Finished run-tests step (success) 06:22:24 INFO - Running post-run listener: _resource_record_post_run 06:22:24 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 8192; Write bytes: 433086464; Read time: 44; Write time: 244224 06:22:24 INFO - TinderboxPrint: CPU usage
13.3% 06:22:24 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 44 06:22:24 INFO - TinderboxPrint: I/O write bytes / time
433,086,464 / 244,224 06:22:24 INFO - TinderboxPrint: CPU idle
8,300.6 (86.7%) 06:22:24 INFO - TinderboxPrint: CPU user
1,219.9 (12.7%) 06:22:24 INFO - TinderboxPrint: Swap in / out
0 / 0 06:22:24 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 4096; Write bytes: 103124992; Read time: 32; Write time: 95176 06:22:24 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 0; Write bytes: 329961472; Read time: 0; Write time: 149048 06:22:25 INFO - Running post-run listener: _upload_blobber_files 06:22:25 INFO - Blob upload gear active. 06:22:25 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:22:25 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 06:22:25 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'] 06:22:25 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 06:22:25 INFO - (blobuploader) - INFO - Open directory for files ... 06:22:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 06:22:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:22:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:22:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 06:22:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:22:26 INFO - (blobuploader) - INFO - Done attempting. 06:22:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:22:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:22:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:22:29 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:22:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:22:29 INFO - (blobuploader) - INFO - Done attempting. 06:22:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 06:22:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:22:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:22:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 06:22:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:22:30 INFO - (blobuploader) - INFO - Done attempting. 06:22:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 06:22:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:22:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:22:31 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 06:22:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:22:31 INFO - (blobuploader) - INFO - Done attempting. 06:22:31 INFO - (blobuploader) - INFO - Iteration through files over. 06:22:31 INFO - Return code: 0 06:22:31 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:22:31 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:22:31 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a264dc9bd70a993d2bcc7892274a5356e8e33124008ad9e0bd5551864bb4b953812193745d47a366842162aa819a2cdbb890eac0fac97e265204b2996ee4b31d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/496c74af741c4a66269fee6eec0801c2936eb22f83d061a02ca5eb4707af7ff63e0857fea4c2e142b39696d7f6228ea5ddf2227fadc71d5a8a1367e73798f968", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5daaecd3b7f421b5e1934263413ab5534c2dfd9fda2235bc10412649e47558e2f9e7b5cf0c085350935bb0e7ab8253e365af415eaab7aed514b5ad157d8a3111", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7d9aec811c8da208e1148ff44efaee22b80b50be167c4f70ffca21ca8de2d59ea562d96816628dffcc791a56c545d75fec69f1b2c61e051b60304e8a19c5d79c"} 06:22:31 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:22:31 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:22:31 INFO - Contents: 06:22:31 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a264dc9bd70a993d2bcc7892274a5356e8e33124008ad9e0bd5551864bb4b953812193745d47a366842162aa819a2cdbb890eac0fac97e265204b2996ee4b31d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/496c74af741c4a66269fee6eec0801c2936eb22f83d061a02ca5eb4707af7ff63e0857fea4c2e142b39696d7f6228ea5ddf2227fadc71d5a8a1367e73798f968", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5daaecd3b7f421b5e1934263413ab5534c2dfd9fda2235bc10412649e47558e2f9e7b5cf0c085350935bb0e7ab8253e365af415eaab7aed514b5ad157d8a3111", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7d9aec811c8da208e1148ff44efaee22b80b50be167c4f70ffca21ca8de2d59ea562d96816628dffcc791a56c545d75fec69f1b2c61e051b60304e8a19c5d79c"} 06:22:31 INFO - Running post-run listener: copy_logs_to_upload_dir 06:22:31 INFO - Copying logs to upload dir... 06:22:31 INFO - mkdir: /builds/slave/test/build/upload/logs 06:22:31 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1255.171132 ========= master_lag: 0.32 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2017-05-18 06:22:31.773956) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-18 06:22:31.777744) ========= 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=4300f881736b422476174874000001bc-1495109824.691067-1273252931 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/a264dc9bd70a993d2bcc7892274a5356e8e33124008ad9e0bd5551864bb4b953812193745d47a366842162aa819a2cdbb890eac0fac97e265204b2996ee4b31d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/496c74af741c4a66269fee6eec0801c2936eb22f83d061a02ca5eb4707af7ff63e0857fea4c2e142b39696d7f6228ea5ddf2227fadc71d5a8a1367e73798f968", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5daaecd3b7f421b5e1934263413ab5534c2dfd9fda2235bc10412649e47558e2f9e7b5cf0c085350935bb0e7ab8253e365af415eaab7aed514b5ad157d8a3111", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7d9aec811c8da208e1148ff44efaee22b80b50be167c4f70ffca21ca8de2d59ea562d96816628dffcc791a56c545d75fec69f1b2c61e051b60304e8a19c5d79c"} build_url:https://queue.taskcluster.net/v1/task/bO24eL5IQH2H4y0xcThplw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011225 build_url: 'https://queue.taskcluster.net/v1/task/bO24eL5IQH2H4y0xcThplw/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a264dc9bd70a993d2bcc7892274a5356e8e33124008ad9e0bd5551864bb4b953812193745d47a366842162aa819a2cdbb890eac0fac97e265204b2996ee4b31d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/496c74af741c4a66269fee6eec0801c2936eb22f83d061a02ca5eb4707af7ff63e0857fea4c2e142b39696d7f6228ea5ddf2227fadc71d5a8a1367e73798f968", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5daaecd3b7f421b5e1934263413ab5534c2dfd9fda2235bc10412649e47558e2f9e7b5cf0c085350935bb0e7ab8253e365af415eaab7aed514b5ad157d8a3111", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7d9aec811c8da208e1148ff44efaee22b80b50be167c4f70ffca21ca8de2d59ea562d96816628dffcc791a56c545d75fec69f1b2c61e051b60304e8a19c5d79c"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-18 06:22:31.801931) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-18 06:22:31.802273) ========= 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=4300f881736b422476174874000001bc-1495109824.691067-1273252931 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004632 ========= master_lag: 0.15 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-18 06:22:31.959359) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-18 06:22:31.959707) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-18 06:22:31.960080) ========= ========= Total master_lag: 0.58 =========