builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-059 starttime: 1495210139.72 results: success (0) revision: 52b207e50972b74546b89775b6dd7c182ff6ff6a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-19 09:08:59.718757) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-19 09:08:59.719146) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-19 09:08:59.719419) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-19 09:08:59.754104) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-19 09:08:59.754362) ========= 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=3a3620fb28aea1604ab609ef000001d2-1495209908.476903-1416049578 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-19 09:09:01-- 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% 94.4M=0s 2017-05-19 09:09:01 (94.4 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.181186 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-19 09:08:59.962219) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-19 09:08:59.962500) ========= 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=3a3620fb28aea1604ab609ef000001d2-1495209908.476903-1416049578 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016885 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-19 09:09:00.021070) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-19 09:09:00.021368) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 52b207e50972b74546b89775b6dd7c182ff6ff6a --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 52b207e50972b74546b89775b6dd7c182ff6ff6a --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=3a3620fb28aea1604ab609ef000001d2-1495209908.476903-1416049578 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-19 09:09:02,041 truncating revision to first 12 chars 2017-05-19 09:09:02,041 Setting DEBUG logging. 2017-05-19 09:09:02,041 attempt 1/10 2017-05-19 09:09:02,041 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/52b207e50972?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-19 09:09:03,289 unpacking tar archive at: mozilla-central-52b207e50972/testing/mozharness/ program finished with exit code 0 elapsedTime=1.559528 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-19 09:09:01.599995) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-19 09:09:01.600310) ========= script_repo_revision: 52b207e50972b74546b89775b6dd7c182ff6ff6a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-19 09:09:01.600712) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-19 09:09:01.600982) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-19 09:09:01.609185) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2017-05-19 09:09:01.609452) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=3a3620fb28aea1604ab609ef000001d2-1495209908.476903-1416049578 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:09:03 INFO - MultiFileLogger online at 20170519 09:09:03 in /builds/slave/test 09:09:03 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 09:09:03 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:09:03 INFO - {'append_to_log': False, 09:09:03 INFO - 'base_work_dir': '/builds/slave/test', 09:09:03 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 09:09:03 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:09:03 INFO - 'branch': 'Firefox-Non-PGO', 09:09:03 INFO - 'buildbot_json_path': 'buildprops.json', 09:09:03 INFO - 'config_files': ('talos/linux_config.py',), 09:09:03 INFO - 'default_actions': ('clobber', 09:09:03 INFO - 'read-buildbot-config', 09:09:03 INFO - 'download-and-extract', 09:09:03 INFO - 'populate-webroot', 09:09:03 INFO - 'create-virtualenv', 09:09:03 INFO - 'install', 09:09:03 INFO - 'run-tests'), 09:09:03 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:09:03 INFO - 'download_minidump_stackwalk': True, 09:09:03 INFO - 'download_symbols': 'ondemand', 09:09:03 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:09:03 INFO - 'tooltool.py': '/tools/tooltool.py', 09:09:03 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:09:03 INFO - '/tools/misc-python/virtualenv.py')}, 09:09:03 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:09:03 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:09:03 INFO - 'gecko_profile': False, 09:09:03 INFO - 'gecko_profile_interval': 0, 09:09:03 INFO - 'installer_path': 'installer.exe', 09:09:03 INFO - 'log_level': 'info', 09:09:03 INFO - 'log_name': 'talos', 09:09:03 INFO - 'log_to_console': True, 09:09:03 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:09:03 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:09:03 INFO - 'opt_config_files': (), 09:09:03 INFO - 'pip_index': False, 09:09:03 INFO - 'suite': 'dromaeojs-e10s', 09:09:03 INFO - 'system_bits': '32', 09:09:03 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:09:03 INFO - 'title': 'talos-linux64-ix-059', 09:09:03 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:09:03 INFO - 'use_talos_json': True, 09:09:03 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:09:03 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:09:03 INFO - 'work_dir': 'build'} 09:09:03 INFO - [mozharness: 2017-05-19 16:09:03.724413Z] Running clobber step. 09:09:03 INFO - Running pre-action listener: _resource_record_pre_action 09:09:03 INFO - Running main action method: clobber 09:09:03 INFO - rmtree: /builds/slave/test/build 09:09:03 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:09:05 INFO - Running post-action listener: _resource_record_post_action 09:09:05 INFO - [mozharness: 2017-05-19 16:09:05.273337Z] Finished clobber step (success) 09:09:05 INFO - [mozharness: 2017-05-19 16:09:05.273437Z] Running read-buildbot-config step. 09:09:05 INFO - Running pre-action listener: _resource_record_pre_action 09:09:05 INFO - Running main action method: read_buildbot_config 09:09:05 INFO - Using buildbot properties: 09:09:05 INFO - { 09:09:05 INFO - "project": "", 09:09:05 INFO - "product": "firefox", 09:09:05 INFO - "who": "ryanvm@gmail.com", 09:09:05 INFO - "installer_path": "public/build/target.tar.bz2", 09:09:05 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 09:09:05 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 09:09:05 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 09:09:05 INFO - "stage_platform": "linux64", 09:09:05 INFO - "basedir": "/builds/slave/test", 09:09:05 INFO - "buildnumber": 618, 09:09:05 INFO - "platform": "ubuntu64_hw", 09:09:05 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 09:09:05 INFO - "slavebuilddir": "test", 09:09:05 INFO - "taskId": "XHoooSlgTZG-AwoEOuf7LA", 09:09:05 INFO - "branch": "mozilla-central", 09:09:05 INFO - "script_repo_revision": "production", 09:09:05 INFO - "revision": "52b207e50972b74546b89775b6dd7c182ff6ff6a", 09:09:05 INFO - "slavename": "talos-linux64-ix-059", 09:09:05 INFO - "repo_path": "mozilla-central" 09:09:05 INFO - } 09:09:05 INFO - Finding installer, test and symbols from parent task. 09:09:05 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XHoooSlgTZG-AwoEOuf7LA'}, attempt #1 09:09:05 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XHoooSlgTZG-AwoEOuf7LA'}, attempt #1 09:09:06 INFO - Task dependencies: EkjcKEopRE6rzIoE54jPzQ 09:09:06 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EkjcKEopRE6rzIoE54jPzQ'}, attempt #1 09:09:06 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/EkjcKEopRE6rzIoE54jPzQ/artifacts/public/build/target.tar.bz2 09:09:06 INFO - Set test_url: https://queue.taskcluster.net/v1/task/EkjcKEopRE6rzIoE54jPzQ/artifacts/public/build/test_packages.json 09:09:06 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/EkjcKEopRE6rzIoE54jPzQ/artifacts/public/build/target.crashreporter-symbols.zip 09:09:06 INFO - Running post-action listener: _resource_record_post_action 09:09:06 INFO - [mozharness: 2017-05-19 16:09:06.621553Z] Finished read-buildbot-config step (success) 09:09:06 INFO - [mozharness: 2017-05-19 16:09:06.621773Z] Running download-and-extract step. 09:09:06 INFO - Running pre-action listener: _resource_record_pre_action 09:09:06 INFO - Running main action method: download_and_extract 09:09:06 INFO - mkdir: /builds/slave/test/build/tests 09:09:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:09:06 INFO - trying https://queue.taskcluster.net/v1/task/EkjcKEopRE6rzIoE54jPzQ/artifacts/public/build/target.test_packages.json 09:09:06 INFO - Downloading https://queue.taskcluster.net/v1/task/EkjcKEopRE6rzIoE54jPzQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 09:09:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EkjcKEopRE6rzIoE54jPzQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 09:09:07 INFO - Downloaded 986 bytes. 09:09:07 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 09:09:07 INFO - Using the following test package requirements: 09:09:07 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 09:09:07 INFO - u'common': [u'target.common.tests.zip'], 09:09:07 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 09:09:07 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 09:09:07 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 09:09:07 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 09:09:07 INFO - u'mozbase': [u'target.common.tests.zip'], 09:09:07 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 09:09:07 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 09:09:07 INFO - u'web-platform': [u'target.common.tests.zip', 09:09:07 INFO - u'target.web-platform.tests.zip'], 09:09:07 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 09:09:07 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 09:09:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/EkjcKEopRE6rzIoE54jPzQ/artifacts/public/build/target.common.tests.zip 09:09:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EkjcKEopRE6rzIoE54jPzQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 09:09:07 INFO - Fetch https://queue.taskcluster.net/v1/task/EkjcKEopRE6rzIoE54jPzQ/artifacts/public/build/target.common.tests.zip into memory 09:09:08 INFO - Content-Length response header: 62469130 09:09:08 INFO - Bytes received: 62469130 09:09:19 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 09:09:19 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/EkjcKEopRE6rzIoE54jPzQ/artifacts/public/build/target.common.tests.zip 09:09:19 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EkjcKEopRE6rzIoE54jPzQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 09:09:19 INFO - Fetch https://queue.taskcluster.net/v1/task/EkjcKEopRE6rzIoE54jPzQ/artifacts/public/build/target.common.tests.zip into memory 09:09:20 INFO - Content-Length response header: 62469130 09:09:20 INFO - Bytes received: 62469130 09:09:32 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/EkjcKEopRE6rzIoE54jPzQ/artifacts/public/build/target.talos.tests.zip 09:09:32 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EkjcKEopRE6rzIoE54jPzQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 09:09:32 INFO - Fetch https://queue.taskcluster.net/v1/task/EkjcKEopRE6rzIoE54jPzQ/artifacts/public/build/target.talos.tests.zip into memory 09:09:33 INFO - Content-Length response header: 14410008 09:09:33 INFO - Bytes received: 14410008 09:09:33 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')]} 09:09:33 INFO - trying https://queue.taskcluster.net/v1/task/EkjcKEopRE6rzIoE54jPzQ/artifacts/public/build/target.tar.bz2 09:09:33 INFO - Downloading https://queue.taskcluster.net/v1/task/EkjcKEopRE6rzIoE54jPzQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 09:09:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EkjcKEopRE6rzIoE54jPzQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 09:09:35 INFO - Downloaded 58086128 bytes. 09:09:35 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/EkjcKEopRE6rzIoE54jPzQ/artifacts/public/build/target.tar.bz2 09:09:35 INFO - mkdir: /builds/slave/test/properties 09:09:35 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:09:35 INFO - Writing to file /builds/slave/test/properties/build_url 09:09:35 INFO - Contents: 09:09:35 INFO - build_url:https://queue.taskcluster.net/v1/task/EkjcKEopRE6rzIoE54jPzQ/artifacts/public/build/target.tar.bz2 09:09:35 INFO - Running post-action listener: _resource_record_post_action 09:09:35 INFO - Running post-action listener: set_extra_try_arguments 09:09:35 INFO - [mozharness: 2017-05-19 16:09:35.277381Z] Finished download-and-extract step (success) 09:09:35 INFO - [mozharness: 2017-05-19 16:09:35.277608Z] Running populate-webroot step. 09:09:35 INFO - Running pre-action listener: _resource_record_pre_action 09:09:35 INFO - Running main action method: populate_webroot 09:09:35 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:09:35 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:09:35 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:09:35 INFO - '--tppagecycles', 09:09:35 INFO - '7'], 09:09:35 INFO - 'tests': ['tsvgm']}}, 09:09:35 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:09:35 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:09:35 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:09:35 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:09:35 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:09:35 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:09:35 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 09:09:35 INFO - 'talos_options': ['--disable-e10s'], 09:09:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:09:35 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 09:09:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:09:35 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 09:09:35 INFO - 'talos_options': ['--disable-e10s'], 09:09:35 INFO - 'tests': ['damp', 'tps']}, 09:09:35 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 09:09:35 INFO - 'tests': ['damp', 'tps']}, 09:09:35 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:09:35 INFO - 'tests': ['dromaeo_dom']}, 09:09:35 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:09:35 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:09:35 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 09:09:35 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 09:09:35 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 09:09:35 INFO - 'tests': ['ts_paint', 'tp5o']}, 09:09:35 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:09:35 INFO - 'tests': ['a11yr', 09:09:35 INFO - 'ts_paint', 09:09:35 INFO - 'tpaint', 09:09:35 INFO - 'sessionrestore', 09:09:35 INFO - 'sessionrestore_no_auto_restore', 09:09:35 INFO - 'tabpaint']}, 09:09:35 INFO - 'other-e10s': {'tests': ['a11yr', 09:09:35 INFO - 'ts_paint', 09:09:35 INFO - 'tpaint', 09:09:35 INFO - 'sessionrestore', 09:09:35 INFO - 'sessionrestore_no_auto_restore', 09:09:35 INFO - 'tabpaint']}, 09:09:35 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:09:35 INFO - 'ts_paint', 09:09:35 INFO - 'tpaint', 09:09:35 INFO - 'sessionrestore', 09:09:35 INFO - 'sessionrestore_no_auto_restore', 09:09:35 INFO - 'tabpaint']}, 09:09:35 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:09:35 INFO - 'ts_paint', 09:09:35 INFO - 'tpaint', 09:09:35 INFO - 'sessionrestore', 09:09:35 INFO - 'sessionrestore_no_auto_restore', 09:09:35 INFO - 'tabpaint']}, 09:09:35 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:09:35 INFO - 'tests': ['a11yr', 09:09:35 INFO - 'ts_paint', 09:09:35 INFO - 'tpaint', 09:09:35 INFO - 'sessionrestore', 09:09:35 INFO - 'sessionrestore_no_auto_restore', 09:09:35 INFO - 'tabpaint']}, 09:09:35 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:09:35 INFO - 'tests': ['a11yr', 09:09:35 INFO - 'ts_paint', 09:09:35 INFO - 'tpaint', 09:09:35 INFO - 'sessionrestore', 09:09:35 INFO - 'sessionrestore_no_auto_restore', 09:09:35 INFO - 'tabpaint']}, 09:09:35 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 09:09:35 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 09:09:35 INFO - 'bloom_basic_ref']}, 09:09:35 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:09:35 INFO - 'tests': ['tsvgx', 09:09:35 INFO - 'tsvgr_opacity', 09:09:35 INFO - 'tart', 09:09:35 INFO - 'tscrollx', 09:09:35 INFO - 'cart', 09:09:35 INFO - 'tsvg_static']}, 09:09:35 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:09:35 INFO - 'tsvgr_opacity', 09:09:35 INFO - 'tart', 09:09:35 INFO - 'tscrollx', 09:09:35 INFO - 'cart', 09:09:35 INFO - 'tsvg_static']}, 09:09:35 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 09:09:35 INFO - 'talos_options': ['--disable-e10s'], 09:09:35 INFO - 'tests': ['tp5o']}, 09:09:35 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 09:09:35 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 09:09:35 INFO - 'talos_options': ['--disable-e10s', 09:09:35 INFO - '--xperf_path', 09:09:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:09:35 INFO - 'tests': ['tp5n']}, 09:09:35 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 09:09:35 INFO - 'talos_options': ['--xperf_path', 09:09:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:09:35 INFO - 'tests': ['tp5n']}}, 09:09:35 INFO - 'talos.zip': {'path': '', 09:09:35 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:09:35 INFO - Running post-action listener: _resource_record_post_action 09:09:35 INFO - [mozharness: 2017-05-19 16:09:35.295419Z] Finished populate-webroot step (success) 09:09:35 INFO - [mozharness: 2017-05-19 16:09:35.295507Z] Running create-virtualenv step. 09:09:35 INFO - Running pre-action listener: _resource_record_pre_action 09:09:35 INFO - Running main action method: create_virtualenv 09:09:35 INFO - Creating virtualenv /builds/slave/test/build/venv 09:09:35 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 09:09:35 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:09:35 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:09:35 INFO - Using real prefix '/usr' 09:09:35 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:09:35 INFO - Installing distribute.............................................................................................................................................................................................done. 09:09:37 INFO - Installing pip.................done. 09:09:37 INFO - Return code: 0 09:09:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:09:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:09:38 INFO - Reading from file tmpfile_stdout 09:09:38 INFO - Output received: 09:09:38 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) 09:09:38 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:09: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')]} 09:09:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:09: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')]} 09:09:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:09:38 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 0x1b521f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d1fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ec55c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ec27a0>, '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 0x1ec36a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ec3b30>, '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': '3a3620fb28aea1604ab609ef000001d2-1495209908.476903-1416049578', '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 09:09:38 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 09:09:38 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 09:09:38 INFO - Using env: {'DISPLAY': ':0', 09:09:38 INFO - 'HOME': '/home/cltbld', 09:09:38 INFO - 'LANG': 'en_US.UTF-8', 09:09:38 INFO - 'LANGUAGE': 'en_US:en', 09:09:38 INFO - 'LOGNAME': 'cltbld', 09:09:38 INFO - 'MAIL': '/var/mail/cltbld', 09:09:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:09:38 INFO - 'MOZ_NO_REMOTE': '1', 09:09:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:09:38 INFO - 'NO_EM_RESTART': '1', 09:09:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:09:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:09:38 INFO - 'PWD': '/builds/slave/test', 09:09:38 INFO - 'SHELL': '/bin/bash', 09:09:38 INFO - 'SHLVL': '1', 09:09:38 INFO - 'TERM': 'linux', 09:09:38 INFO - 'TMOUT': '86400', 09:09:38 INFO - 'USER': 'cltbld', 09:09:38 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1495209908.476903-1416049578', 09:09:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:09:38 INFO - '_': '/tools/buildbot/bin/python'} 09:09:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:09:38 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 09:09:38 INFO - Cleaning up... 09:09:38 INFO - Return code: 0 09:09:38 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:09: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')]} 09:09:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:09: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')]} 09:09:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:09:38 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 0x1b521f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d1fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ec55c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ec27a0>, '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 0x1ec36a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ec3b30>, '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': '3a3620fb28aea1604ab609ef000001d2-1495209908.476903-1416049578', '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 09:09:38 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 09:09:38 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 09:09:38 INFO - Using env: {'DISPLAY': ':0', 09:09:38 INFO - 'HOME': '/home/cltbld', 09:09:38 INFO - 'LANG': 'en_US.UTF-8', 09:09:38 INFO - 'LANGUAGE': 'en_US:en', 09:09:38 INFO - 'LOGNAME': 'cltbld', 09:09:38 INFO - 'MAIL': '/var/mail/cltbld', 09:09:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:09:38 INFO - 'MOZ_NO_REMOTE': '1', 09:09:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:09:38 INFO - 'NO_EM_RESTART': '1', 09:09:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:09:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:09:38 INFO - 'PWD': '/builds/slave/test', 09:09:38 INFO - 'SHELL': '/bin/bash', 09:09:38 INFO - 'SHLVL': '1', 09:09:38 INFO - 'TERM': 'linux', 09:09:38 INFO - 'TMOUT': '86400', 09:09:38 INFO - 'USER': 'cltbld', 09:09:38 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1495209908.476903-1416049578', 09:09:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:09:38 INFO - '_': '/tools/buildbot/bin/python'} 09:09:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:09:38 INFO - Downloading/unpacking psutil>=3.1.1 09:09:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:09:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:09:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:09:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:09:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:09:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:09:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:09:39 INFO - Installing collected packages: psutil 09:09:39 INFO - Running setup.py install for psutil 09:09:39 INFO - building 'psutil._psutil_linux' extension 09:09:39 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 09:09:39 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 09:09:39 INFO - building 'psutil._psutil_posix' extension 09:09:39 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 09:09:40 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 09:09:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:09:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:09:40 INFO - Successfully installed psutil 09:09:40 INFO - Cleaning up... 09:09:40 INFO - Return code: 0 09:09:40 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:09:40 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')]} 09:09:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:09:40 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')]} 09:09:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:09:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x1b521f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d1fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ec55c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ec27a0>, '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 0x1ec36a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ec3b30>, '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': '3a3620fb28aea1604ab609ef000001d2-1495209908.476903-1416049578', '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 09:09:40 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 09:09:40 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 09:09:40 INFO - Using env: {'DISPLAY': ':0', 09:09:40 INFO - 'HOME': '/home/cltbld', 09:09:40 INFO - 'LANG': 'en_US.UTF-8', 09:09:40 INFO - 'LANGUAGE': 'en_US:en', 09:09:40 INFO - 'LOGNAME': 'cltbld', 09:09:40 INFO - 'MAIL': '/var/mail/cltbld', 09:09:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:09:40 INFO - 'MOZ_NO_REMOTE': '1', 09:09:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:09:40 INFO - 'NO_EM_RESTART': '1', 09:09:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:09:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:09:40 INFO - 'PWD': '/builds/slave/test', 09:09:40 INFO - 'SHELL': '/bin/bash', 09:09:40 INFO - 'SHLVL': '1', 09:09:40 INFO - 'TERM': 'linux', 09:09:40 INFO - 'TMOUT': '86400', 09:09:40 INFO - 'USER': 'cltbld', 09:09:40 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1495209908.476903-1416049578', 09:09:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:09:40 INFO - '_': '/tools/buildbot/bin/python'} 09:09:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:09:40 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:09:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:09:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:09:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:09:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:09:41 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:09:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:09:41 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:09:41 INFO - Installing collected packages: mozsystemmonitor 09:09:41 INFO - Running setup.py install for mozsystemmonitor 09:09:41 INFO - Successfully installed mozsystemmonitor 09:09:41 INFO - Cleaning up... 09:09:41 INFO - Return code: 0 09:09:41 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:09:41 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')]} 09:09:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:09:41 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')]} 09:09:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:09:41 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 0x1b521f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d1fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ec55c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ec27a0>, '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 0x1ec36a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ec3b30>, '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': '3a3620fb28aea1604ab609ef000001d2-1495209908.476903-1416049578', '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 09:09:41 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 09:09:41 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 09:09:41 INFO - Using env: {'DISPLAY': ':0', 09:09:41 INFO - 'HOME': '/home/cltbld', 09:09:41 INFO - 'LANG': 'en_US.UTF-8', 09:09:41 INFO - 'LANGUAGE': 'en_US:en', 09:09:41 INFO - 'LOGNAME': 'cltbld', 09:09:41 INFO - 'MAIL': '/var/mail/cltbld', 09:09:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:09:41 INFO - 'MOZ_NO_REMOTE': '1', 09:09:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:09:41 INFO - 'NO_EM_RESTART': '1', 09:09:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:09:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:09:41 INFO - 'PWD': '/builds/slave/test', 09:09:41 INFO - 'SHELL': '/bin/bash', 09:09:41 INFO - 'SHLVL': '1', 09:09:41 INFO - 'TERM': 'linux', 09:09:41 INFO - 'TMOUT': '86400', 09:09:41 INFO - 'USER': 'cltbld', 09:09:41 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1495209908.476903-1416049578', 09:09:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:09:41 INFO - '_': '/tools/buildbot/bin/python'} 09:09:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:09:41 INFO - Downloading/unpacking jsonschema==2.5.1 09:09:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:09:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:09:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:09:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:09:43 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:09:43 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:09:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:09:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:09:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:09:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:09:43 INFO - Downloading functools32-3.2.3-2.tar.gz 09:09:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:09:43 INFO - warning: no files found matching '*.txt' 09:09:43 INFO - no previously-included directories found matching 'build' 09:09:43 INFO - no previously-included directories found matching 'dist' 09:09:43 INFO - no previously-included directories found matching '.git*' 09:09:43 INFO - Installing collected packages: jsonschema, functools32 09:09:43 INFO - Running setup.py install for functools32 09:09:43 INFO - warning: no files found matching '*.txt' 09:09:43 INFO - no previously-included directories found matching 'build' 09:09:43 INFO - no previously-included directories found matching 'dist' 09:09:43 INFO - no previously-included directories found matching '.git*' 09:09:43 INFO - Successfully installed jsonschema functools32 09:09:43 INFO - Cleaning up... 09:09:43 INFO - Return code: 0 09:09:43 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:09:43 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')]} 09:09:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:09:43 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')]} 09:09:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:09:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x1b521f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d1fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ec55c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ec27a0>, '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 0x1ec36a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ec3b30>, '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': '3a3620fb28aea1604ab609ef000001d2-1495209908.476903-1416049578', '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 09:09:43 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 09:09:43 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 09:09:43 INFO - Using env: {'DISPLAY': ':0', 09:09:43 INFO - 'HOME': '/home/cltbld', 09:09:43 INFO - 'LANG': 'en_US.UTF-8', 09:09:43 INFO - 'LANGUAGE': 'en_US:en', 09:09:43 INFO - 'LOGNAME': 'cltbld', 09:09:43 INFO - 'MAIL': '/var/mail/cltbld', 09:09:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:09:43 INFO - 'MOZ_NO_REMOTE': '1', 09:09:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:09:43 INFO - 'NO_EM_RESTART': '1', 09:09:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:09:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:09:43 INFO - 'PWD': '/builds/slave/test', 09:09:43 INFO - 'SHELL': '/bin/bash', 09:09:43 INFO - 'SHLVL': '1', 09:09:43 INFO - 'TERM': 'linux', 09:09:43 INFO - 'TMOUT': '86400', 09:09:43 INFO - 'USER': 'cltbld', 09:09:43 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1495209908.476903-1416049578', 09:09:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:09:43 INFO - '_': '/tools/buildbot/bin/python'} 09:09:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:09:43 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:09:43 INFO - Cleaning up... 09:09:43 INFO - Return code: 0 09:09:43 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:09:43 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')]} 09:09:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:09:43 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')]} 09:09:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:09:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x1b521f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d1fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ec55c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ec27a0>, '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 0x1ec36a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ec3b30>, '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': '3a3620fb28aea1604ab609ef000001d2-1495209908.476903-1416049578', '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 09:09:43 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 09:09:43 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 09:09:43 INFO - Using env: {'DISPLAY': ':0', 09:09:43 INFO - 'HOME': '/home/cltbld', 09:09:43 INFO - 'LANG': 'en_US.UTF-8', 09:09:43 INFO - 'LANGUAGE': 'en_US:en', 09:09:43 INFO - 'LOGNAME': 'cltbld', 09:09:43 INFO - 'MAIL': '/var/mail/cltbld', 09:09:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:09:43 INFO - 'MOZ_NO_REMOTE': '1', 09:09:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:09:43 INFO - 'NO_EM_RESTART': '1', 09:09:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:09:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:09:43 INFO - 'PWD': '/builds/slave/test', 09:09:43 INFO - 'SHELL': '/bin/bash', 09:09:43 INFO - 'SHLVL': '1', 09:09:43 INFO - 'TERM': 'linux', 09:09:43 INFO - 'TMOUT': '86400', 09:09:43 INFO - 'USER': 'cltbld', 09:09:43 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1495209908.476903-1416049578', 09:09:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:09:43 INFO - '_': '/tools/buildbot/bin/python'} 09:09:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:09:43 INFO - Downloading/unpacking blobuploader==1.2.4 09:09:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:09:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:09:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:09:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:09:44 INFO - Downloading blobuploader-1.2.4.tar.gz 09:09:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:09:45 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:09:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:09:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:09:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:09:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:09:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:09:45 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:09:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:09:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:09:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:09:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:09:45 INFO - Downloading docopt-0.6.1.tar.gz 09:09:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:09:45 INFO - Installing collected packages: blobuploader, requests, docopt 09:09:45 INFO - Running setup.py install for blobuploader 09:09:45 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:09:45 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:09:45 INFO - Running setup.py install for requests 09:09:46 INFO - Running setup.py install for docopt 09:09:46 INFO - Successfully installed blobuploader requests docopt 09:09:46 INFO - Cleaning up... 09:09:46 INFO - Return code: 0 09:09:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:09:46 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')]} 09:09:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:09:46 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')]} 09:09:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:09:46 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 0x1b521f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d1fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ec55c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ec27a0>, '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 0x1ec36a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ec3b30>, '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': '3a3620fb28aea1604ab609ef000001d2-1495209908.476903-1416049578', '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 09:09:46 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 09:09:46 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 09:09:46 INFO - Using env: {'DISPLAY': ':0', 09:09:46 INFO - 'HOME': '/home/cltbld', 09:09:46 INFO - 'LANG': 'en_US.UTF-8', 09:09:46 INFO - 'LANGUAGE': 'en_US:en', 09:09:46 INFO - 'LOGNAME': 'cltbld', 09:09:46 INFO - 'MAIL': '/var/mail/cltbld', 09:09:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:09:46 INFO - 'MOZ_NO_REMOTE': '1', 09:09:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:09:46 INFO - 'NO_EM_RESTART': '1', 09:09:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:09:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:09:46 INFO - 'PWD': '/builds/slave/test', 09:09:46 INFO - 'SHELL': '/bin/bash', 09:09:46 INFO - 'SHLVL': '1', 09:09:46 INFO - 'TERM': 'linux', 09:09:46 INFO - 'TMOUT': '86400', 09:09:46 INFO - 'USER': 'cltbld', 09:09:46 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1495209908.476903-1416049578', 09:09:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:09:46 INFO - '_': '/tools/buildbot/bin/python'} 09:09:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:09:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:09:46 INFO - Running setup.py (path:/tmp/pip-zGdn_b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:09:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:09:46 INFO - Running setup.py (path:/tmp/pip-WsJlfA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:09:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:09:46 INFO - Running setup.py (path:/tmp/pip-DjlNrX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:09:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:09:46 INFO - Running setup.py (path:/tmp/pip-dTuH5y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:09:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:09:46 INFO - Running setup.py (path:/tmp/pip-UG0To9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:09:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:09:46 INFO - Running setup.py (path:/tmp/pip-1I6qMf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:09:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:09:46 INFO - Running setup.py (path:/tmp/pip-Xdif0b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:09:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:09:47 INFO - Running setup.py (path:/tmp/pip-mLldQZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:09:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:09:47 INFO - Running setup.py (path:/tmp/pip-dKg62f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:09:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:09:47 INFO - Running setup.py (path:/tmp/pip-2pQW2r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:09:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:09:47 INFO - Running setup.py (path:/tmp/pip-bXBbGp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:09:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:09:47 INFO - Running setup.py (path:/tmp/pip-0CZDf_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:09:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:09:47 INFO - Running setup.py (path:/tmp/pip-XRMvlU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:09:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:09:47 INFO - Running setup.py (path:/tmp/pip-fJclXu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:09:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:09:47 INFO - Running setup.py (path:/tmp/pip-jXAvEx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:09:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:09:47 INFO - Running setup.py (path:/tmp/pip-NAKos0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:09:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:09:47 INFO - Running setup.py (path:/tmp/pip-9DrPZB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:09:47 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:09:47 INFO - Running setup.py install for manifestparser 09:09:47 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:09:47 INFO - Running setup.py install for mozcrash 09:09:47 INFO - Running setup.py install for mozdebug 09:09:48 INFO - Running setup.py install for mozdevice 09:09:48 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:09:48 INFO - Running setup.py install for mozfile 09:09:48 INFO - Running setup.py install for mozhttpd 09:09:48 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:09:48 INFO - Running setup.py install for mozinfo 09:09:48 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:09:48 INFO - Running setup.py install for mozInstall 09:09:48 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:09:48 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:09:48 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:09:48 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:09:48 INFO - Running setup.py install for mozleak 09:09:48 INFO - Running setup.py install for mozlog 09:09:48 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:09:48 INFO - Running setup.py install for moznetwork 09:09:48 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:09:48 INFO - Running setup.py install for mozprocess 09:09:49 INFO - Running setup.py install for mozprofile 09:09:49 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:09:49 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:09:49 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:09:49 INFO - Running setup.py install for mozrunner 09:09:49 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:09:49 INFO - Running setup.py install for mozscreenshot 09:09:49 INFO - Running setup.py install for moztest 09:09:49 INFO - Running setup.py install for mozversion 09:09:49 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:09:49 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:09:49 INFO - Cleaning up... 09:09:49 INFO - Return code: 0 09:09:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:09:49 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')]} 09:09:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:09:49 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')]} 09:09:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:09:49 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 0x1b521f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d1fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ec55c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ec27a0>, '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 0x1ec36a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ec3b30>, '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': '3a3620fb28aea1604ab609ef000001d2-1495209908.476903-1416049578', '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 09:09:49 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 09:09:49 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 09:09:49 INFO - Using env: {'DISPLAY': ':0', 09:09:49 INFO - 'HOME': '/home/cltbld', 09:09:49 INFO - 'LANG': 'en_US.UTF-8', 09:09:49 INFO - 'LANGUAGE': 'en_US:en', 09:09:49 INFO - 'LOGNAME': 'cltbld', 09:09:49 INFO - 'MAIL': '/var/mail/cltbld', 09:09:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:09:49 INFO - 'MOZ_NO_REMOTE': '1', 09:09:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:09:49 INFO - 'NO_EM_RESTART': '1', 09:09:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:09:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:09:49 INFO - 'PWD': '/builds/slave/test', 09:09:49 INFO - 'SHELL': '/bin/bash', 09:09:49 INFO - 'SHLVL': '1', 09:09:49 INFO - 'TERM': 'linux', 09:09:49 INFO - 'TMOUT': '86400', 09:09:49 INFO - 'USER': 'cltbld', 09:09:49 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1495209908.476903-1416049578', 09:09:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:09:49 INFO - '_': '/tools/buildbot/bin/python'} 09:09:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:09:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:09:49 INFO - Running setup.py (path:/tmp/pip-03ZDU0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:09:49 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)) 09:09:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:09:49 INFO - Running setup.py (path:/tmp/pip-mThPj4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:09:49 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)) 09:09:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:09:49 INFO - Running setup.py (path:/tmp/pip-gh3hg_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:09:50 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)) 09:09:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:09:50 INFO - Running setup.py (path:/tmp/pip-rj71nc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:09:50 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)) 09:09:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:09:50 INFO - Running setup.py (path:/tmp/pip-qrBevq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:09:50 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)) 09:09:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:09:50 INFO - Running setup.py (path:/tmp/pip-SnORZc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:09:50 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)) 09:09:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:09:50 INFO - Running setup.py (path:/tmp/pip-aEtdti-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:09:50 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)) 09:09:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:09:50 INFO - Running setup.py (path:/tmp/pip-nQ203I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:09:50 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)) 09:09:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:09:50 INFO - Running setup.py (path:/tmp/pip-7KKXio-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:09:50 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)) 09:09:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:09:50 INFO - Running setup.py (path:/tmp/pip-9bXcBC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:09:50 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)) 09:09:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:09:50 INFO - Running setup.py (path:/tmp/pip-kU4ilo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:09:50 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)) 09:09:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:09:50 INFO - Running setup.py (path:/tmp/pip-2Rbtaf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:09:50 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)) 09:09:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:09:50 INFO - Running setup.py (path:/tmp/pip-dBR5ra-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:09:50 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)) 09:09:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:09:50 INFO - Running setup.py (path:/tmp/pip-lSIvBh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:09:50 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)) 09:09:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:09:50 INFO - Running setup.py (path:/tmp/pip-lho7vq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:09:50 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)) 09:09:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:09:50 INFO - Running setup.py (path:/tmp/pip-lXJGov-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:09:50 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)) 09:09:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:09:50 INFO - Running setup.py (path:/tmp/pip-meHspd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:09:51 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)) 09:09:51 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)) 09:09:51 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)) 09:09:51 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)) 09:09:51 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)) 09:09:51 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)) 09:09:51 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:09:51 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 09:09:51 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 09:09:51 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 09:09:51 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 09:09:52 INFO - Downloading blessings-1.6.tar.gz 09:09:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:09:52 INFO - Installing collected packages: blessings 09:09:52 INFO - Running setup.py install for blessings 09:09:52 INFO - Successfully installed blessings 09:09:52 INFO - Cleaning up... 09:09:52 INFO - Return code: 0 09:09:52 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:09:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:09:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:09:52 INFO - Reading from file tmpfile_stdout 09:09:52 INFO - Current package versions: 09:09:52 INFO - argparse == 1.2.1 09:09:52 INFO - blessings == 1.6 09:09:52 INFO - blobuploader == 1.2.4 09:09:52 INFO - docopt == 0.6.1 09:09:52 INFO - functools32 == 3.2.3-2 09:09:52 INFO - jsonschema == 2.5.1 09:09:52 INFO - manifestparser == 1.1 09:09:52 INFO - mozInstall == 1.12 09:09:52 INFO - mozcrash == 1.0 09:09:52 INFO - mozdebug == 0.1 09:09:52 INFO - mozdevice == 0.50 09:09:52 INFO - mozfile == 1.2 09:09:52 INFO - mozhttpd == 0.7 09:09:52 INFO - mozinfo == 0.9 09:09:52 INFO - mozleak == 0.1 09:09:52 INFO - mozlog == 3.4 09:09:52 INFO - moznetwork == 0.27 09:09:52 INFO - mozprocess == 0.25 09:09:52 INFO - mozprofile == 0.28 09:09:52 INFO - mozrunner == 6.13 09:09:52 INFO - mozscreenshot == 0.1 09:09:52 INFO - mozsystemmonitor == 0.3 09:09:52 INFO - moztest == 0.8 09:09:52 INFO - mozversion == 1.4 09:09:52 INFO - psutil == 3.1.1 09:09:52 INFO - requests == 1.2.3 09:09:52 INFO - wsgiref == 0.1.2 09:09:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:09:52 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')]} 09:09:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:09:52 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')]} 09:09:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:09:52 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 0x1b521f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d1fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ec55c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ec27a0>, '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 0x1ec36a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ec3b30>, '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': '3a3620fb28aea1604ab609ef000001d2-1495209908.476903-1416049578', '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 09:09:52 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 09:09:52 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 09:09:52 INFO - Using env: {'DISPLAY': ':0', 09:09:52 INFO - 'HOME': '/home/cltbld', 09:09:52 INFO - 'LANG': 'en_US.UTF-8', 09:09:52 INFO - 'LANGUAGE': 'en_US:en', 09:09:52 INFO - 'LOGNAME': 'cltbld', 09:09:52 INFO - 'MAIL': '/var/mail/cltbld', 09:09:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:09:52 INFO - 'MOZ_NO_REMOTE': '1', 09:09:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:09:52 INFO - 'NO_EM_RESTART': '1', 09:09:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:09:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:09:52 INFO - 'PWD': '/builds/slave/test', 09:09:52 INFO - 'SHELL': '/bin/bash', 09:09:52 INFO - 'SHLVL': '1', 09:09:52 INFO - 'TERM': 'linux', 09:09:52 INFO - 'TMOUT': '86400', 09:09:52 INFO - 'USER': 'cltbld', 09:09:52 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1495209908.476903-1416049578', 09:09:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:09:52 INFO - '_': '/tools/buildbot/bin/python'} 09:09:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:09:52 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)) 09:09:52 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)) 09:09:52 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)) 09:09:52 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)) 09:09:52 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)) 09:09:52 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)) 09:09:52 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)) 09:09:52 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)) 09:09:52 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)) 09:09:52 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)) 09:09:52 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)) 09:09:52 INFO - Cleaning up... 09:09:52 INFO - Return code: 0 09:09:52 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:09:52 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')]} 09:09:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:09:52 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')]} 09:09:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:09:52 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 0x1b521f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d1fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ec55c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ec27a0>, '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 0x1ec36a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ec3b30>, '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': '3a3620fb28aea1604ab609ef000001d2-1495209908.476903-1416049578', '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 09:09:52 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 09:09:52 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 09:09:52 INFO - Using env: {'DISPLAY': ':0', 09:09:52 INFO - 'HOME': '/home/cltbld', 09:09:52 INFO - 'LANG': 'en_US.UTF-8', 09:09:52 INFO - 'LANGUAGE': 'en_US:en', 09:09:52 INFO - 'LOGNAME': 'cltbld', 09:09:52 INFO - 'MAIL': '/var/mail/cltbld', 09:09:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:09:52 INFO - 'MOZ_NO_REMOTE': '1', 09:09:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:09:52 INFO - 'NO_EM_RESTART': '1', 09:09:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:09:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:09:52 INFO - 'PWD': '/builds/slave/test', 09:09:52 INFO - 'SHELL': '/bin/bash', 09:09:52 INFO - 'SHLVL': '1', 09:09:52 INFO - 'TERM': 'linux', 09:09:52 INFO - 'TMOUT': '86400', 09:09:52 INFO - 'USER': 'cltbld', 09:09:52 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1495209908.476903-1416049578', 09:09:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:09:52 INFO - '_': '/tools/buildbot/bin/python'} 09:09:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:09:53 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:09:53 INFO - Cleaning up... 09:09:53 INFO - Return code: 0 09:09:53 INFO - Running post-action listener: _resource_record_post_action 09:09:53 INFO - Running post-action listener: _start_resource_monitoring 09:09:53 INFO - Starting resource monitoring. 09:09:53 INFO - [mozharness: 2017-05-19 16:09:53.072929Z] Finished create-virtualenv step (success) 09:09:53 INFO - [mozharness: 2017-05-19 16:09:53.073382Z] Running install step. 09:09:53 INFO - Running pre-action listener: _resource_record_pre_action 09:09:53 INFO - Running main action method: install 09:09:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:09:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:09:53 INFO - Reading from file tmpfile_stdout 09:09:53 INFO - Detecting whether we're running mozinstall >=1.0... 09:09:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:09:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:09:53 INFO - Reading from file tmpfile_stdout 09:09:53 INFO - Output received: 09:09:53 INFO - Usage: mozinstall [options] installer 09:09:53 INFO - Options: 09:09:53 INFO - -h, --help show this help message and exit 09:09:53 INFO - -d DEST, --destination=DEST 09:09:53 INFO - Directory to install application into. [default: 09:09:53 INFO - "/builds/slave/test"] 09:09:53 INFO - --app=APP Application being installed. [default: firefox] 09:09:53 INFO - mkdir: /builds/slave/test/build/application 09:09:53 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'] 09:09:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 09:10:10 INFO - Reading from file tmpfile_stdout 09:10:10 INFO - Output received: 09:10:10 INFO - /builds/slave/test/build/application/firefox/firefox 09:10:10 INFO - Running post-action listener: _resource_record_post_action 09:10:10 INFO - [mozharness: 2017-05-19 16:10:10.163227Z] Finished install step (success) 09:10:10 INFO - [mozharness: 2017-05-19 16:10:10.163504Z] Running run-tests step. 09:10:10 INFO - Running pre-action listener: _resource_record_pre_action 09:10:10 INFO - Running main action method: run_tests 09:10:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:10:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:10:10 INFO - Python 2.7.3 09:10:10 INFO - Return code: 0 09:10:10 INFO - grabbing minidump binary from tooltool 09:10: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')]} 09:10:10 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 0x1ec27a0>, '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 0x1ec36a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ec3b30>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:10:10 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 09:10:10 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 09:10:10 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 09:10:10 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:10:10 INFO - Return code: 0 09:10:10 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:10:10 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:10:10 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:10:10 INFO - ENV: RUST_BACKTRACE is now 1 09:10:10 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:10:10 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:10:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EkjcKEopRE6rzIoE54jPzQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-059', '--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 09:10:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/EkjcKEopRE6rzIoE54jPzQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-059 --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 09:10:10 INFO - Using env: {'DISPLAY': ':0', 09:10:10 INFO - 'HOME': '/home/cltbld', 09:10:10 INFO - 'LANG': 'en_US.UTF-8', 09:10:10 INFO - 'LANGUAGE': 'en_US:en', 09:10:10 INFO - 'LOGNAME': 'cltbld', 09:10:10 INFO - 'MAIL': '/var/mail/cltbld', 09:10:10 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:10:10 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:10:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:10:10 INFO - 'MOZ_NO_REMOTE': '1', 09:10:10 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:10:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:10:10 INFO - 'NO_EM_RESTART': '1', 09:10:10 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:10:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:10:10 INFO - 'PWD': '/builds/slave/test', 09:10:10 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:10:10 INFO - 'RUST_BACKTRACE': '1', 09:10:10 INFO - 'SHELL': '/bin/bash', 09:10:10 INFO - 'SHLVL': '1', 09:10:10 INFO - 'TERM': 'linux', 09:10:10 INFO - 'TMOUT': '86400', 09:10:10 INFO - 'USER': 'cltbld', 09:10:10 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1495209908.476903-1416049578', 09:10:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:10:10 INFO - '_': '/tools/buildbot/bin/python'} 09:10:10 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EkjcKEopRE6rzIoE54jPzQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-059', '--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 09:10:10 INFO - mozversion application_buildid: 20170519153810 09:10:10 INFO - mozversion application_changeset: 52b207e50972b74546b89775b6dd7c182ff6ff6a 09:10:10 INFO - mozversion application_display_name: Nightly 09:10:10 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:10:10 INFO - mozversion application_name: Firefox 09:10:10 INFO - mozversion application_remotingname: firefox 09:10:10 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 09:10:10 INFO - mozversion application_vendor: Mozilla 09:10:10 INFO - mozversion application_version: 55.0a1 09:10:10 INFO - mozversion platform_buildid: 20170519153810 09:10:10 INFO - mozversion platform_changeset: 52b207e50972b74546b89775b6dd7c182ff6ff6a 09:10:10 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 09:10:10 INFO - mozversion platform_version: 55.0a1 09:10:10 INFO - using testdate: 1495210210 09:10:10 INFO - actual date: 1495210210 09:10:10 INFO - starting webserver on 'localhost:33527' 09:10:10 INFO - SUITE-START | Running 2 tests 09:10:10 INFO - TEST-START | dromaeo_css 09:10:10 INFO - operating with platform_type : linux_ 09:10:10 INFO - Initialising browser for dromaeo_css test... 09:10:10 INFO - TEST-INFO | started process 6944 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkla1RY/profile http://localhost:33527/getInfo.html) 09:10:10 INFO - PID 6944 | JavaScript warning: resource://gre/modules/addons/XPIProvider.jsm, line 2941: String.localeCompare is deprecated; use String.prototype.localeCompare instead 09:10:14 INFO - PID 6944 | __metrics Screen width/height:1600/1200 09:10:14 INFO - PID 6944 | colorDepth:24 09:10:14 INFO - PID 6944 | Browser inner width/height: 1024/695 09:10:14 INFO - PID 6944 | __metrics 09:10:15 INFO - TEST-INFO | 6944: exit 0 09:10:15 INFO - Browser initialized. 09:10:15 INFO - Running cycle 1/1 for dromaeo_css test... 09:10:15 INFO - TEST-INFO | started process 7106 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkla1RY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:10:27 INFO - PID 7106 | RSS: Main: 164835328 09:10:27 INFO - PID 7106 | 09:13:32 INFO - PID 7106 | Cycle 1(1): loaded http://localhost:33527/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33527/tests/dromaeo/cssquery-ext.html) 09:13:33 INFO - PID 7106 | RSS: Main: 171376640 09:13:33 INFO - PID 7106 | 09:16:35 INFO - PID 7106 | Cycle 1(1): loaded http://localhost:33527/tests/dromaeo/cssquery-ext.html (next: http://localhost:33527/tests/dromaeo/cssquery-jquery.html) 09:16:36 INFO - PID 7106 | RSS: Main: 170852352 09:16:36 INFO - PID 7106 | 09:19:38 INFO - PID 7106 | Cycle 1(1): loaded http://localhost:33527/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33527/tests/dromaeo/cssquery-mootools.html) 09:19:38 INFO - PID 7106 | RSS: Main: 173334528 09:19:38 INFO - PID 7106 | 09:22:40 INFO - PID 7106 | Cycle 1(1): loaded http://localhost:33527/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33527/tests/dromaeo/cssquery-prototype.html) 09:22:41 INFO - PID 7106 | RSS: Main: 172142592 09:22:41 INFO - PID 7106 | 09:25:43 INFO - PID 7106 | Cycle 1(1): loaded http://localhost:33527/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33527/tests/dromaeo/cssquery-yui.html) 09:25:44 INFO - PID 7106 | RSS: Main: 171155456 09:25:44 INFO - PID 7106 | 09:28:46 INFO - PID 7106 | Cycle 1(1): loaded http://localhost:33527/tests/dromaeo/cssquery-yui.html (next: http://localhost:33527/tests/dromaeo/cssquery-dojo.html) 09:28:46 INFO - PID 7106 | RSS: Main: 173936640 09:28:46 INFO - PID 7106 | 09:28:46 INFO - PID 7106 | __start_tp_report 09:28:46 INFO - PID 7106 | _x_x_mozilla_page_load 09:28:46 INFO - PID 7106 | _x_x_mozilla_page_load_details 09:28:46 INFO - PID 7106 | |i|pagename|runs| 09:28:46 INFO - PID 7106 | |0;dojo.html;2636.736326367363;2649.8277611955223;2665.560182569876;2694.676638803344;2696.3933115049113;5091.694498330103;5141.97160567886;5190.92213616796;5191.143461328886;5253.474652534745;5145.871353216172;5167.844964651057;5192.532672059514;5302.840914772563;5309.123994540896;4415.116976604676;4620.768961551926;4707.576318131368;4730.692504987173;4749.928751068736;4739.0758802033615;4762.166620841356;4767.996973332476;4781.880452988686;4789.377380940473;4606.98646297814;4670.789814458358;4697.342372067913;4703;4810.158222311099;4644.419447569054;4667.206574882278;4672.3925889634465;4708.176069187878;4708.552687494716;4680.110778951988;4688.29675548667;4691.179043667379;4695.483496815382;4713.457952335491;5089.847304580869;5191.5846732261325;5221.034108689904;5236.345456817898;5293.761780719877;5605.467480589337;5629.831105066854;5662.037453632893;5667.291588551431;5706.543476521868;5610.887782244373;5657.8019769308285;5661.5187709044785;5663.801766938137;5672.517835983905;5218.843434696965;5222.686638801684;5235.3717553893775;5239.18792587142;5287.048331300326;5719.942800572025;5762.88474230513;5815.069588865761;5842.444967728059;5866.648001119861;5595.440455954372;5607.271054762937;5607.8878422432135;5623.859403514863;5650.321961364581;5500.4499550044675;5567.137093750475;5568.888622227614;5572.749226284827;5705.372409035002;5435.266239057755;5512.751926163332;5528.336599607992;5547.278853748987;5550.000999820071;5523.171524271311;5529.751161197756;5530.861728456821;5539.889202215933;5551.694656793915;4636.281376386598;4640.303954406866;4652.325412815123;4653.441587009581;4656.8602941911795;4077.7757223353;4108;4112.897177570525;4128.153728485713;4139.648129908931;4616.676832621684;4657.347971284023;4702.4592171899985;4726.929096063493;4747.833825816149;5613.129964855454;5625.662460252398;5675.744591493392;5684.289463817023;5688.857778555569;4603.217453032992;4707.246840505502;4740.525947405301;4749.881252968704;4755.881102972453;5028.84913452597;5030.496950304941;5038.470960549163;5039.974800125976;5083.796648134107;5044.319016932667;5109.131447653982;5236.136037553761;5238.476152384807;5280.76236569363;5663.66018038919;5713.085906254979;5726.312842458931;5742;5764.106563482667;5244.868878278074;5252.107141785829;5267.341582302212;5269.947300527099;5283.128283833278;5474.534664553557;5537.473939975695;5576.302962129734;5598.608097433141;5625.690587017753;5586.916196257141;5623.325200975909;5707.9429205709075;5716.9142462862255;5721.8569535761935;5475.835724928259;5485.204645326485;5487.204355368529;5499.752511136929;5505.834824955257;5459.372172200247;5470.617056805985;5489.505944464858;5501.037318469332;5547.833564993057;5333.093374126331;5389;5425.918611220914;5490.6431081979545;5527.088030474926;5566.025945459609;5587.469190426903;5592.105263157875;5594.468525490072;5629;5306.389765177054;5360.839174824761;5383.515483606494;5385.13837785968;5420.945790542202 09:28:46 INFO - PID 7106 | |1;ext.html;707.8336590901138;730.8794048981919;755.5919803306215;969.2730452160883;992.6128809764189;32095.35809283816;33152;33268.667313326856;33315.833420832925;33324.33351332972;35224.471632925524;35483.11292217689;35509.28981420377;35559.82220088902;35588.644113558854;6533.705983230742;6742.662866856662;6748.426383757386;6875.79372618821;7018.929810701904;6813.318668133172;6814.897776533356;6896.620685862275;6910.689018994132;6923.930760692404;6893.931060689404;6931.584104953694;6955.721771129149;6961.930380696204;6982.720691172347;6845.520813543054;6855.897161542556;6905.896411553831;6910.550814197111;6918.965405172942;6659.9001014984815;6691.197056353269;6725.2602213756445;6726.630035348054;6743.763968261136;31504;31726.682733172605;31796.682033179604;31805.84097079523;31849.044528664177;3051.374468234029;3076.6769489203534;3083.2291927018246;3086.2284428892776;3099.705527974839;24337.269881903572;24402.14592489272;24488.877555612286;24534.87732561326;24567.017319307208;3060.8010479318773;3098.721115099652;3121.2821051158135;3139.199504126456;3157.321175947159;145069;145563;149542;154306.22846885805;157492;38666.613333866866;39136.19435627018;39359.60640393559;39389.80305098514;39593.80203098966;41116.79441602833;41185.382219266736;41269;41273.793631032255;41439.37840932389;12301.32342721141;12337.50649974009;12403.441845116991;12408.689782755322;12428.316442595564;9916.652917147865;9928;10016.899831001596;10018.098371146632;10070.647527336509;12611.873881261254;12621.495140194473;12723.109382343333;12725.809112863315;12750.80873786894;5348.358197016305;5355.678659280456;5388.2725832012175;5498.670079795145;5545.694986775766;820.2289847543409;895.1183084661603;904.4030939579977;906.496894223699;917.958691858868;20842.1663133476;21407.357779266647;21522.246721364678;21688.34934951954;21991.670124948138;966.4491239993137;966.5988614724951;1003.7490627343165;1006.5621454667244;1009.4145395670494;11129.944350278358;11287.435628218556;11399.886001140048;11406.828897566544;11521.366324852046;176106;176280;176771;177549.1122544379;177645;40303.1939361217;40382;40512.59487405147;40832;40895.795521022206;1218.7075101975463;1241.3979220078254;1243.4839541590138;1247.6631309546553;1249.369068620359;19964.3012494562;20549.178032878517;21063.368098957057;21191.50751948662;21231.78768212298;29548.409031819672;29605.703942960296;29654.40691186121;29660.25849353697;29689.554656679735;142568.28715856353;142902;143866.28066859598;143925.28037359746;144062;28750.856245718638;28948.97357184977;29222.123336299945;31129.37741245208;31353;36015.81992090023;36068.27863442769;36279.27441451209;36473.63526364809;36711.26577468489;26234.344141396617;27484.862575686995;28042.373008454193;28067.298317542223;28693.856530717214;27647.72352276532;27852.86073569619;28799.42401152007;29347.70652293535;29474;30875;30907.536386953765;30920;31042.223944400666;31100.844495777375;27615.44769104647;27644.308892277855;28349.716502834708;28390;29060.56409153822;22020.779792201873;22621.321360359216;23023.309300721005;23056;23079.4230144241 09:28:46 INFO - PID 7106 | |2;jquery.html;410.82129273765895;426.4888337468983;431.09039925756656;437.4750299640432;442.88927768057965;16835.57911052224;17622.64754704905;17662.205200765948;18239;18926.62146757064;18893.811061889377;18896;19065.428037158872;19185.808141918576;19202;5329.173978033411;5376.247325374451;5478.205660179272;5495.890082198373;5517.227588137664;5397.946020539804;5471.671699698031;5479.068558345071;5479.109707151027;5481.808136715215;5372.167314066306;5399.406065332811;5491.148871924838;5499.862503437406;5520.365158006841;5475.835724928239;5480.369757477902;5486.067368547317;5488.945110548883;5513.476219759116;4889.633277504166;4995.300657907896;5014.07239660664;5014.548690617826;5031.421386540558;21615.243466478598;21895.890520547295;22133.225337113287;22151.33545993607;22216.555668886693;1601.479519156279;1656.34574343135;1670.0981470006182;1672.0552887618458;1680.3278688524565;15096.396144154221;15110;15189.696206075816;15431.922840385838;15435;2040.9795902040937;2120.247312204176;2145.0776166248506;2169.7396312442606;2173.0330003148606;83688.58155709243;88087.55956220243;91226;96952;98245;10996.28524145928;11027.558897644165;11102.222844400814;11293.604723834791;11344.376059316652;15767.68464630724;15826.208689565476;15833.52499425019;15847.286872090783;15988.600284992735;7563.357114645317;7759.57322347265;7854.607269636495;7967.322777563856;8002.79993000168;6805.557638753465;7015.508914376047;7028.543144695578;7387.298206670358;7509.662065207079;7051.5063945523325;7081.256468070881;7125;7140.143942422968;7148.857022859618;2083.718697975754;2115.7989990950837;2115.862468939514;2118.682197670362;2164.166795783603;852.9317654587618;876.2726936642572;876.307716903639;886.3529623374973;908.6047569307373;16230.727698122273;16664.75002874958;17007.064611446243;17121.743173852403;17679.469615911545;875.1817051057282;877.8288233794349;879.2877769006997;885.6767279942775;904.8280826643048;9116.225120864801;9380.718578442658;9747.902520974842;9789.46157961319;9872.851907221397;343040;344913;347491;348150;348282;77718;80133.59933200297;82969.58515207506;83051.58474207591;83824;1089.4716062709579;1089.8692156941217;1145.9770804583861;1149.9655010349702;1155.526234243956;17755.911220443813;18126.093695315445;18668.7199692002;18698.158582864075;19022.1440035196;39043;39489.60510394859;40050.39924401195;40381.39427908525;40832.1833563333;51542;52164.217536737735;52204.47795521996;52580;53954;7554.735584254525;7619.314261716472;7703.691852325845;7709.2290770922455;7864.292213700565;12320.938395307967;12524.812127817908;12621.558245461365;12851.678708032374;12936;9988.400695958266;10050.396976181453;11027.117830573374;11109.555617775199;11179.60871369498;9006.50464224474;9709.56306966174;9923.801523969625;10511.684649460529;10532.104771094542;10168.542415591464;10586.4706764663;11223.214374993671;11263.605773797877;11401.144914131308;7467.813304667427;7504.43716721259;7619.238076192558;7735.110462296908;7879.0939042010905;10581.682549523219;10664;10793.29843560166;10817.621383251548;10948.397838118979 09:28:46 INFO - PID 7106 | |3;mootools.html;1266.8099785032246;1325.4168166006962;1326.734653069385;1331.26780270851;1340.9061365704401;10041.246906482016;10339.741506462342;10457.21570882183;10460.99999999999;10639.202059845504;10350.534225959831;10589;10589.78820423591;10591.735206619838;10597.258191926569;2262.1177740681146;2294.724633044037;2299.4021554395895;2303.8272129590264;2321.1875843454823;2178.8583742056794;2236.317923033474;2236.9217077402295;2255.875926824024;2256.4810093678466;2261.728592568894;2268.0474200835606;2294.73610534789;2321.9071237150492;2323.3726893738767;2172.2614311134134;2184.224600266898;2209.1384360099573;2227.231605096239;2233.184887516045;2067.410787925449;2227.13141874669;2235.5417139486367;2242.473018840571;2254;10310.587576496931;10316.535755891004;10387.428691421968;10408.271421000532;10424.113950314233;5472.808451704172;5679.375268720438;5717.285339332583;5719.885602287931;5749.8275051748515;3108.362785628941;3321.551590535271;3402.3705614461155;3414.829258537063;3492.912677183065;1080.5049527217986;1098.2861140258815;1118.2284223885574;1121.7980763462574;1128.2948157401624;14712.705745885023;14862.554123376316;15058.472953446686;15084.17037062961;15094.924525377413;4828.179209534387;5023.171176755867;5133.768980395891;5156.74216289184;5177.171652535576;12116.69708257283;12137.635870923887;12206.08454365926;12214.633560993185;12239.632811015685;5587.161925711176;5609.775608975677;5631.605787594911;5632.746526406321;5638.351589567253;5098.97450512745;5117.795288188431;5122.974385128051;5288.312519372457;5324.148136298174;4120.052387950788;4123.301028835231;4154.231467178582;4155.8961025974595;4158.004158004175;1289.954851580209;1297.0661123990712;1303.843538775353;1327.9336033198495;1333.300017490825;700.6041586503609;717.089296593334;724.1382754522102;730.7515444748811;739.8705226585326;5413.242146099549;5445.754941027663;5528.198411230349;5582.97208513963;5609.49514543693;537.9704116273642;556.7244214114039;556.9387367389584;562.4291344285554;562.5330975290499;3176.8093914365213;3203.7757356985253;3211.0687900509056;3239.5464634951127;3286.556314897506;12493.375331233401;13038.543650972171;13149.60551183466;13179.73640527184;13313.733725325634;12792.552260670831;12951.417186226454;13030.80453793194;13078.54225102136;13094.279814610289;7212.350888420067;7487.026686530825;7542.094948606093;7660.885086723703;7696.576688282198;5725.141228815711;5761.596688231783;5835.299764028344;5863.296404431496;5923.141144534105;11411.885881141083;11662.533498660297;11720.355380454157;11790.469428875549;11835.881641183478;11909.642710718692;12044.277343359427;12088.818667719815;12221.205621634565;12258.080643951562;8188.303994160563;8289.668413263402;8318.168183181633;8412.369072319723;8420.663173473238;9442.055794420503;9505.334626576074;9512.429254244767;9561.61753529851;9602.615895364386;8205.466644668077;8220.506769593843;8247.752567422987;8328.417010809186;8456.83086338282;8036.718714844952;8046.275835174628;8071.556064416513;8091.514509129471;8363.623636936474;7260.636968151465;7337.192908780136;7375.262473752582;7424.517406368785;7486.5508069516;4945.554900059012;4955.554000140005;5067.5185857343495;5220.608454366014;5412.7564259607625;5459.836204913859;5505.779768809202;5544;5590.664560126405;5666.631668941505 09:28:46 INFO - PID 7106 | |4;prototype.html;361.4451816461732;380.2528032416302;380.4027676547821;381.5383386102817;390.3734506117682;5360.65155764875;5527.55779537637;5537.667739935601;5551.278333816598;5553.16702494626;5253.44838791927;5349.598780091489;5358.910025090218;5377.704226267554;5380.112281473562;4077.429159917614;4086.5504794472586;4087.7138600297844;4088.303354108049;4089.488813898263;3943.388774739906;4067.4781635386103;4079.7348172368847;4095.8771236862794;4098.979505102485;4047.2107938951917;4049.8177582008734;4056.533498647649;4062.821781683323;4071.307877660805;4067.491563554556;4073.1446396256674;4073.4133825021026;4085.468889044435;4086.734362266443;3491.458823882302;3554.3779838528153;3566.1797786508987;3568.2685049564775;3568.4468907319406;5287.947120528823;5318.494742999409;5348.652337598043;5362.249285100089;5362.678239305654;4775.474697783241;4798.208295631217;4807.471178170398;4809.591184749301;4816.638752093607;5623.550115990711;5691.8616276744815;5752.252207213078;5758.848230353946;5763.501489612689;3909.98045009776;3920.2159568086213;3952.920941581181;3960.7029472789654;3983.50206224222;5911.970440147772;6049.516038716892;6064.484518815906;6100.68835200434;6132.50939924805;4035.1324465240114;4043.292423825819;4050.10897602527;4062.207869465426;4069.145479449349;4092.3043082676018;4113.670906327487;4115.333290017547;4129.070959034193;4129.359949207877;4690.108879312919;4752.215884379108;4761.095561775318;4776.785044672998;4796.400449943757;5766.18365214956;5769.88460230793;5773.278340207474;5773.971130144322;5786.07422812348;1405.1779708870424;1419.822522184727;1420.9573712788633;1423.5160045584344;1427.664498842771;886.3662481325883;940.3558562384789;944.1408318430333;946.2619157057507;947.3557980573139;4886.853394398174;4899.853004409873;4905.656604037683;4910.680805747615;4927.87680307988;5830.271216097988;5910.734016969247;5945.732442040118;5979.312379076462;5979.804039192179;4738.862672958534;4858.8299409521205;4873.4882837301575;4878.0975519529;4897.853064408074;3135.717785399325;3143.009951865155;3175.539546765706;3177.7755571100324;3180.3957248122783;5421.376541697677;5483.7806487740845;5485.917711234335;5518.227448157261;5536.916946245809;6070.332263451017;6085.756569737161;6117.357677443893;6132.233470816148;6153.969230153821;5509.889802203934;5519.751611177427;5551.750171242223;5559.388467268597;5578.804741834017;5621.915671264853;5891.469767720926;5934.525237981037;5968.4926781224085;5975.462208401264;5873.119032145212;5873.882522349614;5876.559258055749;5877.441643043904;5924.911126333022;5357.437469065692;5494.1758736189895;5511.779528818803;5520.365158006881;5521.116621340727;4030.5969403059457;4048.7773172475795;4052.2908491014546;4054.412110244057;4082.632563069338;5898.292204935436;5910.7931222407005;6043.728032238472;6057.303410107894;6060.303215038911;5727.1695604138;5741.1388291756575;5747.27581725489;5783.508401785895;5812.593118481665;5732.5413966881715;5748.827535173951;5796.768129274782;5803.7968671096305;5809.564282678732;5585.804496842591;5618.410066943075;5667.2349232854685;5704.714764261687;5725.599208055396;5788.421157884178;5808.564357673107;5817.76728930838;5842.298924129132;5846.766129354778;5461.15352120422;5632.014397480507;5635.577331700221;5640.915386269127;5659.745311461076 09:28:46 INFO - PID 7106 | |5;yui.html;750.1036261667302;755.8775218800081;764.7572694371643;766.6626684258925;783.8706613408788;11852.170348075639;12342.691432714175;12411.007119430447;12849.229046257231;13010.4145313461;14275.71448571028;14822.925885370585;14887.032342897704;14903.850961490381;15042;840.4369072721261;868.8392647360226;868.9000764912053;873.9213470787628;876.8465518534263;922.6955104815428;923.187594916476;929.4237572704933;931.0317270039151;931.8089791592707;963.9180669643089;965.7971825916566;966.6954909203614;967.5452537307455;969.1326262994615;939.6899023322287;957.1194501059008;959.4962644611564;959.6161535385867;962.6390103711109;699.3146716218084;699.9475039372016;700.7022015643331;702.1363722621154;711.1288671377521;13700.314984250846;14077.71844563103;14284.285785710777;14562.70874582513;14585.19781412022;14882.181480018595;15138.243087845674;15370.538883833391;15738.527844164693;15958.521244362571;11520.423978801027;11577.421128943519;11694.298342099417;11716.062714982781;11986.64040078799;3060.648025477054;3074.8001379910233;3093.2576181716227;3100.2559385747486;3110.5956225690743;73723.63138184328;74842.25157748461;75007.62496187484;76430;77552;12827.166234194747;12999.350032498338;13054.804177937338;13057.738845223043;13080.869191308155;23113.7688623115;23266.3020109397;23301.650475242885;23772;23788.52422951566;5974.820755377345;6188.907166392508;6357.936420635827;6380.968095159495;6386.169797926333;2849.4301139771715;2921.109061736191;2922.473954688134;2927.0340787540063;2930.164903002634;3512.1395258161915;3635.5455568053994;3645.3802853514967;3686.4654625079215;3783.659470647655;772.1043589436227;784.1609477858636;786.5320134519951;787.4684587903257;788.0779487999055;609.2962628164477;618.1469571990714;619.6127420362274;628.0641843652925;647.4302613699914;9509.5720692569;10337.689869303933;10515.158787296998;10698.679039628823;10886.40124793128;614.1064750787593;630.2531500172311;631.6715308039794;641.6470940982441;655.8262060553957;4526.207913615104;4599.885002874888;4658.324542941255;4664.86005419838;4794.808207671724;56792.43207567954;57543.712281438326;57623.71188144032;58056.129158062664;59687.40312596905;50249.74875125601;51440.48559514432;52145.478545214064;52226.73886630542;52400.21399679008;46957.530424696;47027;47404;47830.5216947833;49175;9690;9953.258179818647;10101.69694909154;10148.898511015092;10408.427536485566;25597.104101356363;25743;25783.226503204933;26165;26866.32834179161;40456.3931541033;43519;43960.1425907315;44036.779816100716;44489;13330.533431329857;13613.52352667652;13680.110792798834;13795.172289662652;14005.389380220997;13780.793288100887;14264.714705706036;14363.712725745218;14491.420343186155;14524.201168935388;13572.185668859505;14160.645983850074;14369.856301436852;14485.565433037025;14579.052361596463;13872.583822485341;14025.509107181608;14582.125072495684;14644.19456929879;14722.926385368004;12683.11218214716;13137.802932955821;13212.405441755336;13295.135816171918;13536;9948.900510995087;10199.796004079728;10233.539490722786;10486.685399438029;10655.840162397726;10439.321444106108;10842.837357439486;11342.035926945971;12076.698082547655;12852.293123877902 09:28:46 INFO - PID 7106 | __end_tp_report 09:28:46 INFO - PID 7106 | __start_cc_report 09:28:46 INFO - PID 7106 | _x_x_mozilla_cycle_collect,273 09:28:46 INFO - PID 7106 | __end_cc_report 09:28:46 INFO - PID 7106 | __startTimestamp1495211326608__endTimestamp 09:28:46 INFO - PID 7106 | 09:28:46 INFO - PID 7106 | ------- Summary: start ------- 09:28:46 INFO - PID 7106 | Number of tests: 6 09:28:46 INFO - PID 7106 | 09:28:46 INFO - PID 7106 | [#0] dojo.html Cycles:165 Average:5151.66 Median:5293.76 stddev:611.02 (11.5%) stddev-sans-first:580.17 09:28:46 INFO - PID 7106 | Values: 2636.7 2649.8 2665.6 2694.7 2696.4 5091.7 5142.0 5190.9 5191.1 5253.5 5145.9 5167.8 5192.5 5302.8 5309.1 4415.1 4620.8 4707.6 4730.7 4749.9 4739.1 4762.2 4768.0 4781.9 4789.4 4607.0 4670.8 4697.3 4703.0 4810.2 4644.4 4667.2 4672.4 4708.2 4708.6 4680.1 4688.3 4691.2 4695.5 4713.5 5089.8 5191.6 5221.0 5236.3 5293.8 5605.5 5629.8 5662.0 5667.3 5706.5 5610.9 5657.8 5661.5 5663.8 5672.5 5218.8 5222.7 5235.4 5239.2 5287.0 5719.9 5762.9 5815.1 5842.4 5866.6 5595.4 5607.3 5607.9 5623.9 5650.3 5500.4 5567.1 5568.9 5572.7 5705.4 5435.3 5512.8 5528.3 5547.3 5550.0 5523.2 5529.8 5530.9 5539.9 5551.7 4636.3 4640.3 4652.3 4653.4 4656.9 4077.8 4108.0 4112.9 4128.2 4139.6 4616.7 4657.3 4702.5 4726.9 4747.8 5613.1 5625.7 5675.7 5684.3 5688.9 4603.2 4707.2 4740.5 4749.9 4755.9 5028.8 5030.5 5038.5 5040.0 5083.8 5044.3 5109.1 5236.1 5238.5 5280.8 5663.7 5713.1 5726.3 5742.0 5764.1 5244.9 5252.1 5267.3 5269.9 5283.1 5474.5 5537.5 5576.3 5598.6 5625.7 5586.9 5623.3 5707.9 5716.9 5721.9 5475.8 5485.2 5487.2 5499.8 5505.8 5459.4 5470.6 5489.5 5501.0 5547.8 5333.1 5389.0 5425.9 5490.6 5527.1 5566.0 5587.5 5592.1 5594.5 5629.0 5306.4 5360.8 5383.5 5385.1 5420.9 09:28:46 INFO - PID 7106 | 09:28:46 INFO - PID 7106 | [#1] ext.html Cycles:180 Average:30251.74 Median:30913.77 stddev:40624.45 (131.4%) stddev-sans-first:40677.84 09:28:46 INFO - PID 7106 | Values: 707.8 730.9 755.6 969.3 992.6 32095.4 33152.0 33268.7 33315.8 33324.3 35224.5 35483.1 35509.3 35559.8 35588.6 6533.7 6742.7 6748.4 6875.8 7018.9 6813.3 6814.9 6896.6 6910.7 6923.9 6893.9 6931.6 6955.7 6961.9 6982.7 6845.5 6855.9 6905.9 6910.6 6919.0 6659.9 6691.2 6725.3 6726.6 6743.8 31504.0 31726.7 31796.7 31805.8 31849.0 3051.4 3076.7 3083.2 3086.2 3099.7 24337.3 24402.1 24488.9 24534.9 24567.0 3060.8 3098.7 3121.3 3139.2 3157.3 145069.0 145563.0 149542.0 154306.2 157492.0 38666.6 39136.2 39359.6 39389.8 39593.8 41116.8 41185.4 41269.0 41273.8 41439.4 12301.3 12337.5 12403.4 12408.7 12428.3 9916.7 9928.0 10016.9 10018.1 10070.6 12611.9 12621.5 12723.1 12725.8 12750.8 5348.4 5355.7 5388.3 5498.7 5545.7 820.2 895.1 904.4 906.5 918.0 20842.2 21407.4 21522.2 21688.3 21991.7 966.4 966.6 1003.7 1006.6 1009.4 11129.9 11287.4 11399.9 11406.8 11521.4 176106.0 176280.0 176771.0 177549.1 177645.0 40303.2 40382.0 40512.6 40832.0 40895.8 1218.7 1241.4 1243.5 1247.7 1249.4 19964.3 20549.2 21063.4 21191.5 21231.8 29548.4 29605.7 29654.4 29660.3 29689.6 142568.3 142902.0 143866.3 143925.3 144062.0 28750.9 28949.0 29222.1 31129.4 31353.0 36015.8 36068.3 36279.3 36473.6 36711.3 26234.3 27484.9 28042.4 28067.3 28693.9 27647.7 27852.9 28799.4 29347.7 29474.0 30875.0 30907.5 30920.0 31042.2 31100.8 27615.4 27644.3 28349.7 28390.0 29060.6 22020.8 22621.3 23023.3 23056.0 23079.4 09:28:46 INFO - PID 7106 | 09:28:46 INFO - PID 7106 | [#2] jquery.html Cycles:180 Average:24627.09 Median:20621.50 stddev:58166.48 (282.1%) stddev-sans-first:58301.23 09:28:46 INFO - PID 7106 | Values: 410.8 426.5 431.1 437.5 442.9 16835.6 17622.6 17662.2 18239.0 18926.6 18893.8 18896.0 19065.4 19185.8 19202.0 5329.2 5376.2 5478.2 5495.9 5517.2 5397.9 5471.7 5479.1 5479.1 5481.8 5372.2 5399.4 5491.1 5499.9 5520.4 5475.8 5480.4 5486.1 5488.9 5513.5 4889.6 4995.3 5014.1 5014.5 5031.4 21615.2 21895.9 22133.2 22151.3 22216.6 1601.5 1656.3 1670.1 1672.1 1680.3 15096.4 15110.0 15189.7 15431.9 15435.0 2041.0 2120.2 2145.1 2169.7 2173.0 83688.6 88087.6 91226.0 96952.0 98245.0 10996.3 11027.6 11102.2 11293.6 11344.4 15767.7 15826.2 15833.5 15847.3 15988.6 7563.4 7759.6 7854.6 7967.3 8002.8 6805.6 7015.5 7028.5 7387.3 7509.7 7051.5 7081.3 7125.0 7140.1 7148.9 2083.7 2115.8 2115.9 2118.7 2164.2 852.9 876.3 876.3 886.4 908.6 16230.7 16664.8 17007.1 17121.7 17679.5 875.2 877.8 879.3 885.7 904.8 9116.2 9380.7 9747.9 9789.5 9872.9 343040.0 344913.0 347491.0 348150.0 348282.0 77718.0 80133.6 82969.6 83051.6 83824.0 1089.5 1089.9 1146.0 1150.0 1155.5 17755.9 18126.1 18668.7 18698.2 19022.1 39043.0 39489.6 40050.4 40381.4 40832.2 51542.0 52164.2 52204.5 52580.0 53954.0 7554.7 7619.3 7703.7 7709.2 7864.3 12320.9 12524.8 12621.6 12851.7 12936.0 9988.4 10050.4 11027.1 11109.6 11179.6 9006.5 9709.6 9923.8 10511.7 10532.1 10168.5 10586.5 11223.2 11263.6 11401.1 7467.8 7504.4 7619.2 7735.1 7879.1 10581.7 10664.0 10793.3 10817.6 10948.4 09:28:46 INFO - PID 7106 | 09:28:46 INFO - PID 7106 | [#3] mootools.html Cycles:180 Average:6331.59 Median:3304.05 stddev:4061.93 (122.9%) stddev-sans-first:4055.50 09:28:46 INFO - PID 7106 | Values: 1266.8 1325.4 1326.7 1331.3 1340.9 10041.2 10339.7 10457.2 10461.0 10639.2 10350.5 10589.0 10589.8 10591.7 10597.3 2262.1 2294.7 2299.4 2303.8 2321.2 2178.9 2236.3 2236.9 2255.9 2256.5 2261.7 2268.0 2294.7 2321.9 2323.4 2172.3 2184.2 2209.1 2227.2 2233.2 2067.4 2227.1 2235.5 2242.5 2254.0 10310.6 10316.5 10387.4 10408.3 10424.1 5472.8 5679.4 5717.3 5719.9 5749.8 3108.4 3321.6 3402.4 3414.8 3492.9 1080.5 1098.3 1118.2 1121.8 1128.3 14712.7 14862.6 15058.5 15084.2 15094.9 4828.2 5023.2 5133.8 5156.7 5177.2 12116.7 12137.6 12206.1 12214.6 12239.6 5587.2 5609.8 5631.6 5632.7 5638.4 5099.0 5117.8 5123.0 5288.3 5324.1 4120.1 4123.3 4154.2 4155.9 4158.0 1290.0 1297.1 1303.8 1327.9 1333.3 700.6 717.1 724.1 730.8 739.9 5413.2 5445.8 5528.2 5583.0 5609.5 538.0 556.7 556.9 562.4 562.5 3176.8 3203.8 3211.1 3239.5 3286.6 12493.4 13038.5 13149.6 13179.7 13313.7 12792.6 12951.4 13030.8 13078.5 13094.3 7212.4 7487.0 7542.1 7660.9 7696.6 5725.1 5761.6 5835.3 5863.3 5923.1 11411.9 11662.5 11720.4 11790.5 11835.9 11909.6 12044.3 12088.8 12221.2 12258.1 8188.3 8289.7 8318.2 8412.4 8420.7 9442.1 9505.3 9512.4 9561.6 9602.6 8205.5 8220.5 8247.8 8328.4 8456.8 8036.7 8046.3 8071.6 8091.5 8363.6 7260.6 7337.2 7375.3 7424.5 7486.6 4945.6 4955.6 5067.5 5220.6 5412.8 5459.8 5505.8 5544.0 5590.7 5666.6 09:28:46 INFO - PID 7106 | 09:28:46 INFO - PID 7106 | [#4] prototype.html Cycles:180 Average:4718.64 Median:5378.91 stddev:1413.06 (26.3%) stddev-sans-first:1378.66 09:28:46 INFO - PID 7106 | Values: 361.4 380.3 380.4 381.5 390.4 5360.7 5527.6 5537.7 5551.3 5553.2 5253.4 5349.6 5358.9 5377.7 5380.1 4077.4 4086.6 4087.7 4088.3 4089.5 3943.4 4067.5 4079.7 4095.9 4099.0 4047.2 4049.8 4056.5 4062.8 4071.3 4067.5 4073.1 4073.4 4085.5 4086.7 3491.5 3554.4 3566.2 3568.3 3568.4 5287.9 5318.5 5348.7 5362.2 5362.7 4775.5 4798.2 4807.5 4809.6 4816.6 5623.6 5691.9 5752.3 5758.8 5763.5 3910.0 3920.2 3952.9 3960.7 3983.5 5912.0 6049.5 6064.5 6100.7 6132.5 4035.1 4043.3 4050.1 4062.2 4069.1 4092.3 4113.7 4115.3 4129.1 4129.4 4690.1 4752.2 4761.1 4776.8 4796.4 5766.2 5769.9 5773.3 5774.0 5786.1 1405.2 1419.8 1421.0 1423.5 1427.7 886.4 940.4 944.1 946.3 947.4 4886.9 4899.9 4905.7 4910.7 4927.9 5830.3 5910.7 5945.7 5979.3 5979.8 4738.9 4858.8 4873.5 4878.1 4897.9 3135.7 3143.0 3175.5 3177.8 3180.4 5421.4 5483.8 5485.9 5518.2 5536.9 6070.3 6085.8 6117.4 6132.2 6154.0 5509.9 5519.8 5551.8 5559.4 5578.8 5621.9 5891.5 5934.5 5968.5 5975.5 5873.1 5873.9 5876.6 5877.4 5924.9 5357.4 5494.2 5511.8 5520.4 5521.1 4030.6 4048.8 4052.3 4054.4 4082.6 5898.3 5910.8 6043.7 6057.3 6060.3 5727.2 5741.1 5747.3 5783.5 5812.6 5732.5 5748.8 5796.8 5803.8 5809.6 5585.8 5618.4 5667.2 5704.7 5725.6 5788.4 5808.6 5817.8 5842.3 5846.8 5461.2 5632.0 5635.6 5640.9 5659.7 09:28:46 INFO - PID 7106 | 09:28:46 INFO - PID 7106 | [#5] yui.html Cycles:180 Average:15195.30 Median:3311.37 stddev:17878.67 (539.9%) stddev-sans-first:17895.92 09:28:46 INFO - PID 7106 | Values: 750.1 755.9 764.8 766.7 783.9 11852.2 12342.7 12411.0 12849.2 13010.4 14275.7 14822.9 14887.0 14903.9 15042.0 840.4 868.8 868.9 873.9 876.8 922.7 923.2 929.4 931.0 931.8 963.9 965.8 966.7 967.5 969.1 939.7 957.1 959.5 959.6 962.6 699.3 699.9 700.7 702.1 711.1 13700.3 14077.7 14284.3 14562.7 14585.2 14882.2 15138.2 15370.5 15738.5 15958.5 11520.4 11577.4 11694.3 11716.1 11986.6 3060.6 3074.8 3093.3 3100.3 3110.6 73723.6 74842.3 75007.6 76430.0 77552.0 12827.2 12999.4 13054.8 13057.7 13080.9 23113.8 23266.3 23301.7 23772.0 23788.5 5974.8 6188.9 6357.9 6381.0 6386.2 2849.4 2921.1 2922.5 2927.0 2930.2 3512.1 3635.5 3645.4 3686.5 3783.7 772.1 784.2 786.5 787.5 788.1 609.3 618.1 619.6 628.1 647.4 9509.6 10337.7 10515.2 10698.7 10886.4 614.1 630.3 631.7 641.6 655.8 4526.2 4599.9 4658.3 4664.9 4794.8 56792.4 57543.7 57623.7 58056.1 59687.4 50249.7 51440.5 52145.5 52226.7 52400.2 46957.5 47027.0 47404.0 47830.5 49175.0 9690.0 9953.3 10101.7 10148.9 10408.4 25597.1 25743.0 25783.2 26165.0 26866.3 40456.4 43519.0 43960.1 44036.8 44489.0 13330.5 13613.5 13680.1 13795.2 14005.4 13780.8 14264.7 14363.7 14491.4 14524.2 13572.2 14160.6 14369.9 14485.6 14579.1 13872.6 14025.5 14582.1 14644.2 14722.9 12683.1 13137.8 13212.4 13295.1 13536.0 9948.9 10199.8 10233.5 10486.7 10655.8 10439.3 10842.8 11342.0 12076.7 12852.3 09:28:46 INFO - PID 7106 | -------- Summary: end -------- 09:28:46 INFO - PID 7106 | 09:28:47 INFO - TEST-INFO | 7106: exit 0 09:28:47 INFO - TEST-OK | dromaeo_css | took 1117046ms 09:28:47 INFO - TEST-START | kraken 09:28:47 INFO - operating with platform_type : linux_ 09:28:47 INFO - Initialising browser for kraken test... 09:28:47 INFO - TEST-INFO | started process 7504 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqhhUpB/profile http://localhost:33527/getInfo.html) 09:28:47 INFO - PID 7504 | JavaScript warning: resource://gre/modules/addons/XPIProvider.jsm, line 2941: String.localeCompare is deprecated; use String.prototype.localeCompare instead 09:28:51 INFO - PID 7504 | __metrics Screen width/height:1600/1200 09:28:51 INFO - PID 7504 | colorDepth:24 09:28:51 INFO - PID 7504 | Browser inner width/height: 1024/695 09:28:51 INFO - PID 7504 | __metrics 09:28:52 INFO - TEST-INFO | 7504: exit 0 09:28:52 INFO - Browser initialized. 09:28:52 INFO - Running cycle 1/1 for kraken test... 09:28:52 INFO - TEST-INFO | started process 7672 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqhhUpB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:29:04 INFO - PID 7672 | RSS: Main: 164720640 09:29:04 INFO - PID 7672 | 09:29:06 INFO - PID 7672 | Cycle 1(1): loaded http://localhost:33527/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33527/tests/kraken/driver.html?testName=audio-beat-detection) 09:29:07 INFO - PID 7672 | RSS: Main: 168857600 09:29:07 INFO - PID 7672 | 09:29:10 INFO - PID 7672 | Cycle 1(1): loaded http://localhost:33527/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33527/tests/kraken/driver.html?testName=audio-dft) 09:29:11 INFO - PID 7672 | RSS: Main: 168357888 09:29:11 INFO - PID 7672 | 09:29:14 INFO - PID 7672 | Cycle 1(1): loaded http://localhost:33527/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33527/tests/kraken/driver.html?testName=audio-fft) 09:29:14 INFO - PID 7672 | RSS: Main: 164466688 09:29:14 INFO - PID 7672 | 09:29:17 INFO - PID 7672 | Cycle 1(1): loaded http://localhost:33527/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33527/tests/kraken/driver.html?testName=audio-oscillator) 09:29:17 INFO - PID 7672 | RSS: Main: 165535744 09:29:17 INFO - PID 7672 | 09:29:19 INFO - PID 7672 | Cycle 1(1): loaded http://localhost:33527/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33527/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:29:20 INFO - PID 7672 | RSS: Main: 165593088 09:29:20 INFO - PID 7672 | 09:29:23 INFO - PID 7672 | Cycle 1(1): loaded http://localhost:33527/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33527/tests/kraken/driver.html?testName=imaging-darkroom) 09:29:24 INFO - PID 7672 | RSS: Main: 169586688 09:29:24 INFO - PID 7672 | 09:29:27 INFO - PID 7672 | Cycle 1(1): loaded http://localhost:33527/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33527/tests/kraken/driver.html?testName=imaging-desaturate) 09:29:28 INFO - PID 7672 | RSS: Main: 167362560 09:29:28 INFO - PID 7672 | 09:29:31 INFO - PID 7672 | Cycle 1(1): loaded http://localhost:33527/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33527/tests/kraken/driver.html?testName=json-parse-financial) 09:29:31 INFO - PID 7672 | RSS: Main: 168235008 09:29:31 INFO - PID 7672 | 09:29:33 INFO - PID 7672 | Cycle 1(1): loaded http://localhost:33527/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33527/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:29:34 INFO - PID 7672 | RSS: Main: 168648704 09:29:34 INFO - PID 7672 | 09:29:35 INFO - PID 7672 | Cycle 1(1): loaded http://localhost:33527/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33527/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:29:36 INFO - PID 7672 | RSS: Main: 168341504 09:29:36 INFO - PID 7672 | 09:29:38 INFO - PID 7672 | Cycle 1(1): loaded http://localhost:33527/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33527/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:29:39 INFO - PID 7672 | RSS: Main: 167768064 09:29:39 INFO - PID 7672 | 09:29:41 INFO - PID 7672 | Cycle 1(1): loaded http://localhost:33527/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33527/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:29:42 INFO - PID 7672 | RSS: Main: 169074688 09:29:42 INFO - PID 7672 | 09:29:45 INFO - PID 7672 | Cycle 1(1): loaded http://localhost:33527/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33527/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:29:46 INFO - PID 7672 | RSS: Main: 168701952 09:29:46 INFO - PID 7672 | 09:29:48 INFO - PID 7672 | Cycle 1(1): loaded http://localhost:33527/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33527/tests/kraken/driver.html?testName=ai-astar) 09:29:48 INFO - PID 7672 | RSS: Main: 169672704 09:29:48 INFO - PID 7672 | 09:29:48 INFO - PID 7672 | __start_tp_report 09:29:48 INFO - PID 7672 | _x_x_mozilla_page_load 09:29:48 INFO - PID 7672 | _x_x_mozilla_page_load_details 09:29:48 INFO - PID 7672 | |i|pagename|runs| 09:29:48 INFO - PID 7672 | |0;ai-astar;109;112;112;113;111;111;112;113;114;112 09:29:48 INFO - PID 7672 | |1;audio-beat-detection;149;126;128;177;135;130;124;129;150;127 09:29:48 INFO - PID 7672 | |2;audio-dft;164;168;165;165;164;166;169;168;164;164 09:29:48 INFO - PID 7672 | |3;audio-fft;77;75;77;111;76;76;78;78;96;75 09:29:48 INFO - PID 7672 | |4;audio-oscillator;85;83;100;84;84;83;99;83;85;104 09:29:48 INFO - PID 7672 | |5;imaging-gaussian-blur;114;115;115;114;115;115;114;114;114;128 09:29:48 INFO - PID 7672 | |6;imaging-darkroom;153;152;150;151;150;151;151;150;153;150 09:29:48 INFO - PID 7672 | |7;imaging-desaturate;95;95;95;95;95;95;95;94;94;95 09:29:48 INFO - PID 7672 | |8;json-parse-financial;55;60;61;56;55;56;57;55;57;57 09:29:48 INFO - PID 7672 | |9;json-stringify-tinderbox;57;56;55;57;56;56;56;56;56;56 09:29:48 INFO - PID 7672 | |10;stanford-crypto-aes;83;83;84;84;92;90;84;82;84;83 09:29:48 INFO - PID 7672 | |11;stanford-crypto-ccm;135;133;133;141;146;132;142;134;177;130 09:29:48 INFO - PID 7672 | |12;stanford-crypto-pbkdf2;198;199;200;196;196;187;203;197;187;192 09:29:48 INFO - PID 7672 | |13;stanford-crypto-sha256-iterative;77;74;75;75;76;74;75;72;77;76 09:29:48 INFO - PID 7672 | __end_tp_report 09:29:48 INFO - PID 7672 | __start_cc_report 09:29:48 INFO - PID 7672 | _x_x_mozilla_cycle_collect,776 09:29:48 INFO - PID 7672 | __end_cc_report 09:29:48 INFO - PID 7672 | __startTimestamp1495211388549__endTimestamp 09:29:48 INFO - PID 7672 | 09:29:48 INFO - PID 7672 | ------- Summary: start ------- 09:29:48 INFO - PID 7672 | Number of tests: 14 09:29:48 INFO - PID 7672 | 09:29:48 INFO - PID 7672 | [#0] ai-astar Cycles:10 Average:111.90 Median:112.00 stddev:1.37 (1.2%) stddev-sans-first:0.97 09:29:48 INFO - PID 7672 | Values: 109.0 112.0 112.0 113.0 111.0 111.0 112.0 113.0 114.0 112.0 09:29:48 INFO - PID 7672 | 09:29:48 INFO - PID 7672 | [#1] audio-beat-detection Cycles:10 Average:137.50 Median:132.50 stddev:16.66 (12.6%) stddev-sans-first:17.14 09:29:48 INFO - PID 7672 | Values: 149.0 126.0 128.0 177.0 135.0 130.0 124.0 129.0 150.0 127.0 09:29:48 INFO - PID 7672 | 09:29:48 INFO - PID 7672 | [#2] audio-dft Cycles:10 Average:165.70 Median:165.50 stddev:1.95 (1.2%) stddev-sans-first:1.96 09:29:48 INFO - PID 7672 | Values: 164.0 168.0 165.0 165.0 164.0 166.0 169.0 168.0 164.0 164.0 09:29:48 INFO - PID 7672 | 09:29:48 INFO - PID 7672 | [#3] audio-fft Cycles:10 Average:81.90 Median:77.00 stddev:11.97 (15.5%) stddev-sans-first:12.56 09:29:48 INFO - PID 7672 | Values: 77.0 75.0 77.0 111.0 76.0 76.0 78.0 78.0 96.0 75.0 09:29:48 INFO - PID 7672 | 09:29:48 INFO - PID 7672 | [#4] audio-oscillator Cycles:10 Average:89.00 Median:84.00 stddev:8.41 (10.0%) stddev-sans-first:8.79 09:29:48 INFO - PID 7672 | Values: 85.0 83.0 100.0 84.0 84.0 83.0 99.0 83.0 85.0 104.0 09:29:48 INFO - PID 7672 | 09:29:48 INFO - PID 7672 | [#5] imaging-gaussian-blur Cycles:10 Average:115.80 Median:115.00 stddev:4.32 (3.8%) stddev-sans-first:4.53 09:29:48 INFO - PID 7672 | Values: 114.0 115.0 115.0 114.0 115.0 115.0 114.0 114.0 114.0 128.0 09:29:48 INFO - PID 7672 | 09:29:48 INFO - PID 7672 | [#6] imaging-darkroom Cycles:10 Average:151.10 Median:151.00 stddev:1.20 (0.8%) stddev-sans-first:1.05 09:29:48 INFO - PID 7672 | Values: 153.0 152.0 150.0 151.0 150.0 151.0 151.0 150.0 153.0 150.0 09:29:48 INFO - PID 7672 | 09:29:48 INFO - PID 7672 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 09:29:48 INFO - PID 7672 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 94.0 94.0 95.0 09:29:48 INFO - PID 7672 | 09:29:48 INFO - PID 7672 | [#8] json-parse-financial Cycles:10 Average:56.90 Median:57.00 stddev:2.08 (3.6%) stddev-sans-first:2.09 09:29:48 INFO - PID 7672 | Values: 55.0 60.0 61.0 56.0 55.0 56.0 57.0 55.0 57.0 57.0 09:29:48 INFO - PID 7672 | 09:29:48 INFO - PID 7672 | [#9] json-stringify-tinderbox Cycles:10 Average:56.10 Median:56.00 stddev:0.57 (1.0%) stddev-sans-first:0.50 09:29:48 INFO - PID 7672 | Values: 57.0 56.0 55.0 57.0 56.0 56.0 56.0 56.0 56.0 56.0 09:29:48 INFO - PID 7672 | 09:29:48 INFO - PID 7672 | [#10] stanford-crypto-aes Cycles:10 Average:84.90 Median:84.00 stddev:3.31 (3.9%) stddev-sans-first:3.44 09:29:48 INFO - PID 7672 | Values: 83.0 83.0 84.0 84.0 92.0 90.0 84.0 82.0 84.0 83.0 09:29:48 INFO - PID 7672 | 09:29:48 INFO - PID 7672 | [#11] stanford-crypto-ccm Cycles:10 Average:140.30 Median:138.00 stddev:13.87 (10.1%) stddev-sans-first:14.58 09:29:48 INFO - PID 7672 | Values: 135.0 133.0 133.0 141.0 146.0 132.0 142.0 134.0 177.0 130.0 09:29:48 INFO - PID 7672 | 09:29:48 INFO - PID 7672 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:195.50 Median:197.50 stddev:5.32 (2.7%) stddev-sans-first:5.56 09:29:48 INFO - PID 7672 | Values: 198.0 199.0 200.0 196.0 196.0 187.0 203.0 197.0 187.0 192.0 09:29:48 INFO - PID 7672 | 09:29:48 INFO - PID 7672 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:75.10 Median:75.50 stddev:1.52 (2.0%) stddev-sans-first:1.45 09:29:48 INFO - PID 7672 | Values: 77.0 74.0 75.0 75.0 76.0 74.0 75.0 72.0 77.0 76.0 09:29:48 INFO - PID 7672 | -------- Summary: end -------- 09:29:48 INFO - PID 7672 | 09:29:49 INFO - TEST-INFO | 7672: exit 0 09:29:49 INFO - TEST-OK | kraken | took 62168ms 09:29:49 INFO - SUITE-END | took 1179s 09:29:49 INFO - Completed test suite (00:19:39) 09:29:49 INFO - javascript benchmark 09:29:49 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6719.713765660407, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2636.736326367363, 2649.8277611955223, 2665.560182569876, 2694.676638803344, 2696.3933115049113, 5091.694498330103, 5141.97160567886, 5190.92213616796, 5191.143461328886, 5253.474652534745, 5145.871353216172, 5167.844964651057, 5192.532672059514, 5302.840914772563, 5309.123994540896, 4415.116976604676, 4620.768961551926, 4707.576318131368, 4730.692504987173, 4749.928751068736, 4739.0758802033615, 4762.166620841356, 4767.996973332476, 4781.880452988686, 4789.377380940473, 4606.98646297814, 4670.789814458358, 4697.342372067913, 4703.0, 4810.158222311099, 4644.419447569054, 4667.206574882278, 4672.3925889634465, 4708.176069187878, 4708.552687494716, 4680.110778951988, 4688.29675548667, 4691.179043667379, 4695.483496815382, 4713.457952335491, 5089.847304580869, 5191.5846732261325, 5221.034108689904, 5236.345456817898, 5293.761780719877, 5605.467480589337, 5629.831105066854, 5662.037453632893, 5667.291588551431, 5706.543476521868, 5610.887782244373, 5657.8019769308285, 5661.5187709044785, 5663.801766938137, 5672.517835983905, 5218.843434696965, 5222.686638801684, 5235.3717553893775, 5239.18792587142, 5287.048331300326, 5719.942800572025, 5762.88474230513, 5815.069588865761, 5842.444967728059, 5866.648001119861, 5595.440455954372, 5607.271054762937, 5607.8878422432135, 5623.859403514863, 5650.321961364581, 5500.4499550044675, 5567.137093750475, 5568.888622227614, 5572.749226284827, 5705.372409035002, 5435.266239057755, 5512.751926163332, 5528.336599607992, 5547.278853748987, 5550.000999820071, 5523.171524271311, 5529.751161197756, 5530.861728456821, 5539.889202215933, 5551.694656793915, 4636.281376386598, 4640.303954406866, 4652.325412815123, 4653.441587009581, 4656.8602941911795, 4077.7757223353, 4108.0, 4112.897177570525, 4128.153728485713, 4139.648129908931, 4616.676832621684, 4657.347971284023, 4702.4592171899985, 4726.929096063493, 4747.833825816149, 5613.129964855454, 5625.662460252398, 5675.744591493392, 5684.289463817023, 5688.857778555569, 4603.217453032992, 4707.246840505502, 4740.525947405301, 4749.881252968704, 4755.881102972453, 5028.84913452597, 5030.496950304941, 5038.470960549163, 5039.974800125976, 5083.796648134107, 5044.319016932667, 5109.131447653982, 5236.136037553761, 5238.476152384807, 5280.76236569363, 5663.66018038919, 5713.085906254979, 5726.312842458931, 5742.0, 5764.106563482667, 5244.868878278074, 5252.107141785829, 5267.341582302212, 5269.947300527099, 5283.128283833278, 5474.534664553557, 5537.473939975695, 5576.302962129734, 5598.608097433141, 5625.690587017753, 5586.916196257141, 5623.325200975909, 5707.9429205709075, 5716.9142462862255, 5721.8569535761935, 5475.835724928259, 5485.204645326485, 5487.204355368529, 5499.752511136929, 5505.834824955257, 5459.372172200247, 5470.617056805985, 5489.505944464858, 5501.037318469332, 5547.833564993057, 5333.093374126331, 5389.0, 5425.918611220914, 5490.6431081979545, 5527.088030474926, 5566.025945459609, 5587.469190426903, 5592.105263157875, 5594.468525490072, 5629.0, 5306.389765177054, 5360.839174824761, 5383.515483606494, 5385.13837785968, 5420.945790542202], "value": 5106.485198137861, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [707.8336590901138, 730.8794048981919, 755.5919803306215, 969.2730452160883, 992.6128809764189, 32095.35809283816, 33152.0, 33268.667313326856, 33315.833420832925, 33324.33351332972, 35224.471632925524, 35483.11292217689, 35509.28981420377, 35559.82220088902, 35588.644113558854, 6533.705983230742, 6742.662866856662, 6748.426383757386, 6875.79372618821, 7018.929810701904, 6813.318668133172, 6814.897776533356, 6896.620685862275, 6910.689018994132, 6923.930760692404, 6893.931060689404, 6931.584104953694, 6955.721771129149, 6961.930380696204, 6982.720691172347, 6845.520813543054, 6855.897161542556, 6905.896411553831, 6910.550814197111, 6918.965405172942, 6659.9001014984815, 6691.197056353269, 6725.2602213756445, 6726.630035348054, 6743.763968261136, 31504.0, 31726.682733172605, 31796.682033179604, 31805.84097079523, 31849.044528664177, 3051.374468234029, 3076.6769489203534, 3083.2291927018246, 3086.2284428892776, 3099.705527974839, 24337.269881903572, 24402.14592489272, 24488.877555612286, 24534.87732561326, 24567.017319307208, 3060.8010479318773, 3098.721115099652, 3121.2821051158135, 3139.199504126456, 3157.321175947159, 145069.0, 145563.0, 149542.0, 154306.22846885805, 157492.0, 38666.613333866866, 39136.19435627018, 39359.60640393559, 39389.80305098514, 39593.80203098966, 41116.79441602833, 41185.382219266736, 41269.0, 41273.793631032255, 41439.37840932389, 12301.32342721141, 12337.50649974009, 12403.441845116991, 12408.689782755322, 12428.316442595564, 9916.652917147865, 9928.0, 10016.899831001596, 10018.098371146632, 10070.647527336509, 12611.873881261254, 12621.495140194473, 12723.109382343333, 12725.809112863315, 12750.80873786894, 5348.358197016305, 5355.678659280456, 5388.2725832012175, 5498.670079795145, 5545.694986775766, 820.2289847543409, 895.1183084661603, 904.4030939579977, 906.496894223699, 917.958691858868, 20842.1663133476, 21407.357779266647, 21522.246721364678, 21688.34934951954, 21991.670124948138, 966.4491239993137, 966.5988614724951, 1003.7490627343165, 1006.5621454667244, 1009.4145395670494, 11129.944350278358, 11287.435628218556, 11399.886001140048, 11406.828897566544, 11521.366324852046, 176106.0, 176280.0, 176771.0, 177549.1122544379, 177645.0, 40303.1939361217, 40382.0, 40512.59487405147, 40832.0, 40895.795521022206, 1218.7075101975463, 1241.3979220078254, 1243.4839541590138, 1247.6631309546553, 1249.369068620359, 19964.3012494562, 20549.178032878517, 21063.368098957057, 21191.50751948662, 21231.78768212298, 29548.409031819672, 29605.703942960296, 29654.40691186121, 29660.25849353697, 29689.554656679735, 142568.28715856353, 142902.0, 143866.28066859598, 143925.28037359746, 144062.0, 28750.856245718638, 28948.97357184977, 29222.123336299945, 31129.37741245208, 31353.0, 36015.81992090023, 36068.27863442769, 36279.27441451209, 36473.63526364809, 36711.26577468489, 26234.344141396617, 27484.862575686995, 28042.373008454193, 28067.298317542223, 28693.856530717214, 27647.72352276532, 27852.86073569619, 28799.42401152007, 29347.70652293535, 29474.0, 30875.0, 30907.536386953765, 30920.0, 31042.223944400666, 31100.844495777375, 27615.44769104647, 27644.308892277855, 28349.716502834708, 28390.0, 29060.56409153822, 22020.779792201873, 22621.321360359216, 23023.309300721005, 23056.0, 23079.4230144241], "value": 14505.392192941319, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [410.82129273765895, 426.4888337468983, 431.09039925756656, 437.4750299640432, 442.88927768057965, 16835.57911052224, 17622.64754704905, 17662.205200765948, 18239.0, 18926.62146757064, 18893.811061889377, 18896.0, 19065.428037158872, 19185.808141918576, 19202.0, 5329.173978033411, 5376.247325374451, 5478.205660179272, 5495.890082198373, 5517.227588137664, 5397.946020539804, 5471.671699698031, 5479.068558345071, 5479.109707151027, 5481.808136715215, 5372.167314066306, 5399.406065332811, 5491.148871924838, 5499.862503437406, 5520.365158006841, 5475.835724928239, 5480.369757477902, 5486.067368547317, 5488.945110548883, 5513.476219759116, 4889.633277504166, 4995.300657907896, 5014.07239660664, 5014.548690617826, 5031.421386540558, 21615.243466478598, 21895.890520547295, 22133.225337113287, 22151.33545993607, 22216.555668886693, 1601.479519156279, 1656.34574343135, 1670.0981470006182, 1672.0552887618458, 1680.3278688524565, 15096.396144154221, 15110.0, 15189.696206075816, 15431.922840385838, 15435.0, 2040.9795902040937, 2120.247312204176, 2145.0776166248506, 2169.7396312442606, 2173.0330003148606, 83688.58155709243, 88087.55956220243, 91226.0, 96952.0, 98245.0, 10996.28524145928, 11027.558897644165, 11102.222844400814, 11293.604723834791, 11344.376059316652, 15767.68464630724, 15826.208689565476, 15833.52499425019, 15847.286872090783, 15988.600284992735, 7563.357114645317, 7759.57322347265, 7854.607269636495, 7967.322777563856, 8002.79993000168, 6805.557638753465, 7015.508914376047, 7028.543144695578, 7387.298206670358, 7509.662065207079, 7051.5063945523325, 7081.256468070881, 7125.0, 7140.143942422968, 7148.857022859618, 2083.718697975754, 2115.7989990950837, 2115.862468939514, 2118.682197670362, 2164.166795783603, 852.9317654587618, 876.2726936642572, 876.307716903639, 886.3529623374973, 908.6047569307373, 16230.727698122273, 16664.75002874958, 17007.064611446243, 17121.743173852403, 17679.469615911545, 875.1817051057282, 877.8288233794349, 879.2877769006997, 885.6767279942775, 904.8280826643048, 9116.225120864801, 9380.718578442658, 9747.902520974842, 9789.46157961319, 9872.851907221397, 343040.0, 344913.0, 347491.0, 348150.0, 348282.0, 77718.0, 80133.59933200297, 82969.58515207506, 83051.58474207591, 83824.0, 1089.4716062709579, 1089.8692156941217, 1145.9770804583861, 1149.9655010349702, 1155.526234243956, 17755.911220443813, 18126.093695315445, 18668.7199692002, 18698.158582864075, 19022.1440035196, 39043.0, 39489.60510394859, 40050.39924401195, 40381.39427908525, 40832.1833563333, 51542.0, 52164.217536737735, 52204.47795521996, 52580.0, 53954.0, 7554.735584254525, 7619.314261716472, 7703.691852325845, 7709.2290770922455, 7864.292213700565, 12320.938395307967, 12524.812127817908, 12621.558245461365, 12851.678708032374, 12936.0, 9988.400695958266, 10050.396976181453, 11027.117830573374, 11109.555617775199, 11179.60871369498, 9006.50464224474, 9709.56306966174, 9923.801523969625, 10511.684649460529, 10532.104771094542, 10168.542415591464, 10586.4706764663, 11223.214374993671, 11263.605773797877, 11401.144914131308, 7467.813304667427, 7504.43716721259, 7619.238076192558, 7735.110462296908, 7879.0939042010905, 10581.682549523219, 10664.0, 10793.29843560166, 10817.621383251548, 10948.397838118979], "value": 8902.58965378522, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1266.8099785032246, 1325.4168166006962, 1326.734653069385, 1331.26780270851, 1340.9061365704401, 10041.246906482016, 10339.741506462342, 10457.21570882183, 10460.99999999999, 10639.202059845504, 10350.534225959831, 10589.0, 10589.78820423591, 10591.735206619838, 10597.258191926569, 2262.1177740681146, 2294.724633044037, 2299.4021554395895, 2303.8272129590264, 2321.1875843454823, 2178.8583742056794, 2236.317923033474, 2236.9217077402295, 2255.875926824024, 2256.4810093678466, 2261.728592568894, 2268.0474200835606, 2294.73610534789, 2321.9071237150492, 2323.3726893738767, 2172.2614311134134, 2184.224600266898, 2209.1384360099573, 2227.231605096239, 2233.184887516045, 2067.410787925449, 2227.13141874669, 2235.5417139486367, 2242.473018840571, 2254.0, 10310.587576496931, 10316.535755891004, 10387.428691421968, 10408.271421000532, 10424.113950314233, 5472.808451704172, 5679.375268720438, 5717.285339332583, 5719.885602287931, 5749.8275051748515, 3108.362785628941, 3321.551590535271, 3402.3705614461155, 3414.829258537063, 3492.912677183065, 1080.5049527217986, 1098.2861140258815, 1118.2284223885574, 1121.7980763462574, 1128.2948157401624, 14712.705745885023, 14862.554123376316, 15058.472953446686, 15084.17037062961, 15094.924525377413, 4828.179209534387, 5023.171176755867, 5133.768980395891, 5156.74216289184, 5177.171652535576, 12116.69708257283, 12137.635870923887, 12206.08454365926, 12214.633560993185, 12239.632811015685, 5587.161925711176, 5609.775608975677, 5631.605787594911, 5632.746526406321, 5638.351589567253, 5098.97450512745, 5117.795288188431, 5122.974385128051, 5288.312519372457, 5324.148136298174, 4120.052387950788, 4123.301028835231, 4154.231467178582, 4155.8961025974595, 4158.004158004175, 1289.954851580209, 1297.0661123990712, 1303.843538775353, 1327.9336033198495, 1333.300017490825, 700.6041586503609, 717.089296593334, 724.1382754522102, 730.7515444748811, 739.8705226585326, 5413.242146099549, 5445.754941027663, 5528.198411230349, 5582.97208513963, 5609.49514543693, 537.9704116273642, 556.7244214114039, 556.9387367389584, 562.4291344285554, 562.5330975290499, 3176.8093914365213, 3203.7757356985253, 3211.0687900509056, 3239.5464634951127, 3286.556314897506, 12493.375331233401, 13038.543650972171, 13149.60551183466, 13179.73640527184, 13313.733725325634, 12792.552260670831, 12951.417186226454, 13030.80453793194, 13078.54225102136, 13094.279814610289, 7212.350888420067, 7487.026686530825, 7542.094948606093, 7660.885086723703, 7696.576688282198, 5725.141228815711, 5761.596688231783, 5835.299764028344, 5863.296404431496, 5923.141144534105, 11411.885881141083, 11662.533498660297, 11720.355380454157, 11790.469428875549, 11835.881641183478, 11909.642710718692, 12044.277343359427, 12088.818667719815, 12221.205621634565, 12258.080643951562, 8188.303994160563, 8289.668413263402, 8318.168183181633, 8412.369072319723, 8420.663173473238, 9442.055794420503, 9505.334626576074, 9512.429254244767, 9561.61753529851, 9602.615895364386, 8205.466644668077, 8220.506769593843, 8247.752567422987, 8328.417010809186, 8456.83086338282, 8036.718714844952, 8046.275835174628, 8071.556064416513, 8091.514509129471, 8363.623636936474, 7260.636968151465, 7337.192908780136, 7375.262473752582, 7424.517406368785, 7486.5508069516, 4945.554900059012, 4955.554000140005, 5067.5185857343495, 5220.608454366014, 5412.7564259607625, 5459.836204913859, 5505.779768809202, 5544.0, 5590.664560126405, 5666.631668941505], "value": 4745.359077974693, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [361.4451816461732, 380.2528032416302, 380.4027676547821, 381.5383386102817, 390.3734506117682, 5360.65155764875, 5527.55779537637, 5537.667739935601, 5551.278333816598, 5553.16702494626, 5253.44838791927, 5349.598780091489, 5358.910025090218, 5377.704226267554, 5380.112281473562, 4077.429159917614, 4086.5504794472586, 4087.7138600297844, 4088.303354108049, 4089.488813898263, 3943.388774739906, 4067.4781635386103, 4079.7348172368847, 4095.8771236862794, 4098.979505102485, 4047.2107938951917, 4049.8177582008734, 4056.533498647649, 4062.821781683323, 4071.307877660805, 4067.491563554556, 4073.1446396256674, 4073.4133825021026, 4085.468889044435, 4086.734362266443, 3491.458823882302, 3554.3779838528153, 3566.1797786508987, 3568.2685049564775, 3568.4468907319406, 5287.947120528823, 5318.494742999409, 5348.652337598043, 5362.249285100089, 5362.678239305654, 4775.474697783241, 4798.208295631217, 4807.471178170398, 4809.591184749301, 4816.638752093607, 5623.550115990711, 5691.8616276744815, 5752.252207213078, 5758.848230353946, 5763.501489612689, 3909.98045009776, 3920.2159568086213, 3952.920941581181, 3960.7029472789654, 3983.50206224222, 5911.970440147772, 6049.516038716892, 6064.484518815906, 6100.68835200434, 6132.50939924805, 4035.1324465240114, 4043.292423825819, 4050.10897602527, 4062.207869465426, 4069.145479449349, 4092.3043082676018, 4113.670906327487, 4115.333290017547, 4129.070959034193, 4129.359949207877, 4690.108879312919, 4752.215884379108, 4761.095561775318, 4776.785044672998, 4796.400449943757, 5766.18365214956, 5769.88460230793, 5773.278340207474, 5773.971130144322, 5786.07422812348, 1405.1779708870424, 1419.822522184727, 1420.9573712788633, 1423.5160045584344, 1427.664498842771, 886.3662481325883, 940.3558562384789, 944.1408318430333, 946.2619157057507, 947.3557980573139, 4886.853394398174, 4899.853004409873, 4905.656604037683, 4910.680805747615, 4927.87680307988, 5830.271216097988, 5910.734016969247, 5945.732442040118, 5979.312379076462, 5979.804039192179, 4738.862672958534, 4858.8299409521205, 4873.4882837301575, 4878.0975519529, 4897.853064408074, 3135.717785399325, 3143.009951865155, 3175.539546765706, 3177.7755571100324, 3180.3957248122783, 5421.376541697677, 5483.7806487740845, 5485.917711234335, 5518.227448157261, 5536.916946245809, 6070.332263451017, 6085.756569737161, 6117.357677443893, 6132.233470816148, 6153.969230153821, 5509.889802203934, 5519.751611177427, 5551.750171242223, 5559.388467268597, 5578.804741834017, 5621.915671264853, 5891.469767720926, 5934.525237981037, 5968.4926781224085, 5975.462208401264, 5873.119032145212, 5873.882522349614, 5876.559258055749, 5877.441643043904, 5924.911126333022, 5357.437469065692, 5494.1758736189895, 5511.779528818803, 5520.365158006881, 5521.116621340727, 4030.5969403059457, 4048.7773172475795, 4052.2908491014546, 4054.412110244057, 4082.632563069338, 5898.292204935436, 5910.7931222407005, 6043.728032238472, 6057.303410107894, 6060.303215038911, 5727.1695604138, 5741.1388291756575, 5747.27581725489, 5783.508401785895, 5812.593118481665, 5732.5413966881715, 5748.827535173951, 5796.768129274782, 5803.7968671096305, 5809.564282678732, 5585.804496842591, 5618.410066943075, 5667.2349232854685, 5704.714764261687, 5725.599208055396, 5788.421157884178, 5808.564357673107, 5817.76728930838, 5842.298924129132, 5846.766129354778, 5461.15352120422, 5632.014397480507, 5635.577331700221, 5640.915386269127, 5659.745311461076], "value": 4280.682218636086, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [750.1036261667302, 755.8775218800081, 764.7572694371643, 766.6626684258925, 783.8706613408788, 11852.170348075639, 12342.691432714175, 12411.007119430447, 12849.229046257231, 13010.4145313461, 14275.71448571028, 14822.925885370585, 14887.032342897704, 14903.850961490381, 15042.0, 840.4369072721261, 868.8392647360226, 868.9000764912053, 873.9213470787628, 876.8465518534263, 922.6955104815428, 923.187594916476, 929.4237572704933, 931.0317270039151, 931.8089791592707, 963.9180669643089, 965.7971825916566, 966.6954909203614, 967.5452537307455, 969.1326262994615, 939.6899023322287, 957.1194501059008, 959.4962644611564, 959.6161535385867, 962.6390103711109, 699.3146716218084, 699.9475039372016, 700.7022015643331, 702.1363722621154, 711.1288671377521, 13700.314984250846, 14077.71844563103, 14284.285785710777, 14562.70874582513, 14585.19781412022, 14882.181480018595, 15138.243087845674, 15370.538883833391, 15738.527844164693, 15958.521244362571, 11520.423978801027, 11577.421128943519, 11694.298342099417, 11716.062714982781, 11986.64040078799, 3060.648025477054, 3074.8001379910233, 3093.2576181716227, 3100.2559385747486, 3110.5956225690743, 73723.63138184328, 74842.25157748461, 75007.62496187484, 76430.0, 77552.0, 12827.166234194747, 12999.350032498338, 13054.804177937338, 13057.738845223043, 13080.869191308155, 23113.7688623115, 23266.3020109397, 23301.650475242885, 23772.0, 23788.52422951566, 5974.820755377345, 6188.907166392508, 6357.936420635827, 6380.968095159495, 6386.169797926333, 2849.4301139771715, 2921.109061736191, 2922.473954688134, 2927.0340787540063, 2930.164903002634, 3512.1395258161915, 3635.5455568053994, 3645.3802853514967, 3686.4654625079215, 3783.659470647655, 772.1043589436227, 784.1609477858636, 786.5320134519951, 787.4684587903257, 788.0779487999055, 609.2962628164477, 618.1469571990714, 619.6127420362274, 628.0641843652925, 647.4302613699914, 9509.5720692569, 10337.689869303933, 10515.158787296998, 10698.679039628823, 10886.40124793128, 614.1064750787593, 630.2531500172311, 631.6715308039794, 641.6470940982441, 655.8262060553957, 4526.207913615104, 4599.885002874888, 4658.324542941255, 4664.86005419838, 4794.808207671724, 56792.43207567954, 57543.712281438326, 57623.71188144032, 58056.129158062664, 59687.40312596905, 50249.74875125601, 51440.48559514432, 52145.478545214064, 52226.73886630542, 52400.21399679008, 46957.530424696, 47027.0, 47404.0, 47830.5216947833, 49175.0, 9690.0, 9953.258179818647, 10101.69694909154, 10148.898511015092, 10408.427536485566, 25597.104101356363, 25743.0, 25783.226503204933, 26165.0, 26866.32834179161, 40456.3931541033, 43519.0, 43960.1425907315, 44036.779816100716, 44489.0, 13330.533431329857, 13613.52352667652, 13680.110792798834, 13795.172289662652, 14005.389380220997, 13780.793288100887, 14264.714705706036, 14363.712725745218, 14491.420343186155, 14524.201168935388, 13572.185668859505, 14160.645983850074, 14369.856301436852, 14485.565433037025, 14579.052361596463, 13872.583822485341, 14025.509107181608, 14582.125072495684, 14644.19456929879, 14722.926385368004, 12683.11218214716, 13137.802932955821, 13212.405441755336, 13295.135816171918, 13536.0, 9948.900510995087, 10199.796004079728, 10233.539490722786, 10486.685399438029, 10655.840162397726, 10439.321444106108, 10842.837357439486, 11342.035926945971, 12076.698082547655, 12852.293123877902], "value": 6872.62295249709, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1556.4999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 112.0, 112.0, 113.0, 111.0, 111.0, 112.0, 113.0, 114.0, 112.0], "value": 111.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 126.0, 128.0, 177.0, 135.0, 130.0, 124.0, 129.0, 150.0, 127.0], "value": 137.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 168.0, 165.0, 165.0, 164.0, 166.0, 169.0, 168.0, 164.0, 164.0], "value": 165.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 75.0, 77.0, 111.0, 76.0, 76.0, 78.0, 78.0, 96.0, 75.0], "value": 81.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 83.0, 100.0, 84.0, 84.0, 83.0, 99.0, 83.0, 85.0, 104.0], "value": 89.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 115.0, 115.0, 114.0, 115.0, 115.0, 114.0, 114.0, 114.0, 128.0], "value": 115.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 152.0, 150.0, 151.0, 150.0, 151.0, 151.0, 150.0, 153.0, 150.0], "value": 151.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 94.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 60.0, 61.0, 56.0, 55.0, 56.0, 57.0, 55.0, 57.0, 57.0], "value": 56.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 56.0, 55.0, 57.0, 56.0, 56.0, 56.0, 56.0, 56.0, 56.0], "value": 56.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 84.0, 84.0, 92.0, 90.0, 84.0, 82.0, 84.0, 83.0], "value": 84.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 133.0, 133.0, 141.0, 146.0, 132.0, 142.0, 134.0, 177.0, 130.0], "value": 140.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [198.0, 199.0, 200.0, 196.0, 196.0, 187.0, 203.0, 197.0, 187.0, 192.0], "value": 195.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 74.0, 75.0, 75.0, 76.0, 74.0, 75.0, 72.0, 77.0, 76.0], "value": 75.1, "unit": "score"}]}]} 09:29:49 INFO - Return code: 0 09:29:49 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:29:49 INFO - # TBPL SUCCESS # 09:29:49 INFO - Running post-action listener: _resource_record_post_action 09:29:49 INFO - [mozharness: 2017-05-19 16:29:49.858406Z] Finished run-tests step (success) 09:29:49 INFO - Running post-run listener: _resource_record_post_run 09:29:49 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 12288; Write bytes: 417673216; Read time: 216; Write time: 298128 09:29:49 INFO - TinderboxPrint: CPU usage
13.3% 09:29:49 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 216 09:29:49 INFO - TinderboxPrint: I/O write bytes / time
417,673,216 / 298,128 09:29:49 INFO - TinderboxPrint: CPU idle
8,276.2 (86.7%) 09:29:49 INFO - TinderboxPrint: CPU user
1,213.7 (12.7%) 09:29:49 INFO - TinderboxPrint: Swap in / out
0 / 0 09:29:49 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 97259520; Read time: 0; Write time: 124416 09:29:49 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 8192; Write bytes: 320413696; Read time: 180; Write time: 173712 09:29:50 INFO - Running post-run listener: _upload_blobber_files 09:29:50 INFO - Blob upload gear active. 09:29:50 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:29:50 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 09:29:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:29:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:29:50 INFO - (blobuploader) - INFO - Open directory for files ... 09:29:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:29:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:29:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:29:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:29:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:29:51 INFO - (blobuploader) - INFO - Done attempting. 09:29:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:29:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:29:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:29:55 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:29:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:29:55 INFO - (blobuploader) - INFO - Done attempting. 09:29:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:29:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:29:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:29:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:29:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:29:56 INFO - (blobuploader) - INFO - Done attempting. 09:29:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 09:29:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:29:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:29:57 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 09:29:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:29:57 INFO - (blobuploader) - INFO - Done attempting. 09:29:57 INFO - (blobuploader) - INFO - Iteration through files over. 09:29:57 INFO - Return code: 0 09:29:57 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:29:57 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:29:57 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a89dec76fe595dcb96093a3bb6656baa26de21ab534cad90a931127381c49adef95aa9ae1bdc254236641917416d36836b55bfbf7f154a213cb7216b573c2ade", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9d014e55b72f3370c13c74ffa8c6699e1b1bd0bf4025b10b946dec1dcc2401303a089267077202685b17a543a76c8c7efdf2f6b4f7d4a9bd6f4d19a4b4ec7b81", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a0b8b22cd0030fdb0293ffa8afa09b3e9143c9b23db53154540c3ffb0cd8aca03d2a61a4089d72d301ae7685b183bb9f9c0758872b9a8a810f29deff003578c3", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6f444cd8bb92f7a8ee29f024e74a96b58131c5bf1b9717fcb8886b84d70a7f16adfe94b8f3c1f3c716d5a80f9444b2aec18ef34fc3fad50f8b018e9b3ce31581"} 09:29:57 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:29:57 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:29:57 INFO - Contents: 09:29:57 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a89dec76fe595dcb96093a3bb6656baa26de21ab534cad90a931127381c49adef95aa9ae1bdc254236641917416d36836b55bfbf7f154a213cb7216b573c2ade", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9d014e55b72f3370c13c74ffa8c6699e1b1bd0bf4025b10b946dec1dcc2401303a089267077202685b17a543a76c8c7efdf2f6b4f7d4a9bd6f4d19a4b4ec7b81", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a0b8b22cd0030fdb0293ffa8afa09b3e9143c9b23db53154540c3ffb0cd8aca03d2a61a4089d72d301ae7685b183bb9f9c0758872b9a8a810f29deff003578c3", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6f444cd8bb92f7a8ee29f024e74a96b58131c5bf1b9717fcb8886b84d70a7f16adfe94b8f3c1f3c716d5a80f9444b2aec18ef34fc3fad50f8b018e9b3ce31581"} 09:29:57 INFO - Running post-run listener: copy_logs_to_upload_dir 09:29:57 INFO - Copying logs to upload dir... 09:29:57 INFO - mkdir: /builds/slave/test/build/upload/logs 09:29:57 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1253.919508 ========= master_lag: 0.35 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2017-05-19 09:29:55.877592) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-19 09:29:55.885238) ========= 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=3a3620fb28aea1604ab609ef000001d2-1495209908.476903-1416049578 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-Non-PGO/sha512/a89dec76fe595dcb96093a3bb6656baa26de21ab534cad90a931127381c49adef95aa9ae1bdc254236641917416d36836b55bfbf7f154a213cb7216b573c2ade", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9d014e55b72f3370c13c74ffa8c6699e1b1bd0bf4025b10b946dec1dcc2401303a089267077202685b17a543a76c8c7efdf2f6b4f7d4a9bd6f4d19a4b4ec7b81", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a0b8b22cd0030fdb0293ffa8afa09b3e9143c9b23db53154540c3ffb0cd8aca03d2a61a4089d72d301ae7685b183bb9f9c0758872b9a8a810f29deff003578c3", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6f444cd8bb92f7a8ee29f024e74a96b58131c5bf1b9717fcb8886b84d70a7f16adfe94b8f3c1f3c716d5a80f9444b2aec18ef34fc3fad50f8b018e9b3ce31581"} build_url:https://queue.taskcluster.net/v1/task/EkjcKEopRE6rzIoE54jPzQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011230 build_url: 'https://queue.taskcluster.net/v1/task/EkjcKEopRE6rzIoE54jPzQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a89dec76fe595dcb96093a3bb6656baa26de21ab534cad90a931127381c49adef95aa9ae1bdc254236641917416d36836b55bfbf7f154a213cb7216b573c2ade", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9d014e55b72f3370c13c74ffa8c6699e1b1bd0bf4025b10b946dec1dcc2401303a089267077202685b17a543a76c8c7efdf2f6b4f7d4a9bd6f4d19a4b4ec7b81", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a0b8b22cd0030fdb0293ffa8afa09b3e9143c9b23db53154540c3ffb0cd8aca03d2a61a4089d72d301ae7685b183bb9f9c0758872b9a8a810f29deff003578c3", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6f444cd8bb92f7a8ee29f024e74a96b58131c5bf1b9717fcb8886b84d70a7f16adfe94b8f3c1f3c716d5a80f9444b2aec18ef34fc3fad50f8b018e9b3ce31581"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-19 09:29:55.912453) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-19 09:29:55.912783) ========= 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=3a3620fb28aea1604ab609ef000001d2-1495209908.476903-1416049578 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004426 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-19 09:29:55.992640) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-19 09:29:55.995989) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-19 09:29:55.996309) ========= ========= Total master_lag: 0.53 =========