builder: mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s slave: talos-linux64-ix-012 starttime: 1500806670.05 results: success (0) revision: 23d9d005d92afdb5afabeae2ad672323c7d903ad ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-07-23 03:44:30.048586) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-07-23 03:44:30.048982) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-23 03:44:30.049265) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-23 03:44:30.085393) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-23 03:44:30.085649) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1500806115.35968-1985897236 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-07-23 03:44:30-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 56.4K=0.2s 2017-07-23 03:44:30 (56.4 KB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.345169 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-23 03:44:30.444469) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-23 03:44:30.444823) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1500806115.35968-1985897236 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017587 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-23 03:44:30.494224) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-23 03:44:30.494561) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 23d9d005d92afdb5afabeae2ad672323c7d903ad --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 23d9d005d92afdb5afabeae2ad672323c7d903ad --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=2c5dd2b0a310ecf02fd87158000001b4-1500806115.35968-1985897236 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-07-23 03:44:30,806 truncating revision to first 12 chars 2017-07-23 03:44:30,806 Setting DEBUG logging. 2017-07-23 03:44:30,806 attempt 1/10 2017-07-23 03:44:30,806 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/23d9d005d92a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-07-23 03:44:31,285 unpacking tar archive at: mozilla-central-23d9d005d92a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.785366 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-23 03:44:31.292226) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-23 03:44:31.292520) ========= script_repo_revision: 23d9d005d92afdb5afabeae2ad672323c7d903ad ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-23 03:44:31.292897) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-23 03:44:31.293187) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-23 03:44:31.300110) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2017-07-23 03:44:31.300421) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=2c5dd2b0a310ecf02fd87158000001b4-1500806115.35968-1985897236 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:44:31 INFO - MultiFileLogger online at 20170723 03:44:31 in /builds/slave/test 03:44:31 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 03:44:31 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:44:31 INFO - {'append_to_log': False, 03:44:31 INFO - 'base_work_dir': '/builds/slave/test', 03:44:31 INFO - 'blob_upload_branch': 'Firefox', 03:44:31 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:44:31 INFO - 'branch': 'Firefox', 03:44:31 INFO - 'buildbot_json_path': 'buildprops.json', 03:44:31 INFO - 'code_coverage': False, 03:44:31 INFO - 'config_files': ('talos/linux_config.py',), 03:44:31 INFO - 'default_actions': ('clobber', 03:44:31 INFO - 'read-buildbot-config', 03:44:31 INFO - 'download-and-extract', 03:44:31 INFO - 'populate-webroot', 03:44:31 INFO - 'create-virtualenv', 03:44:31 INFO - 'install', 03:44:31 INFO - 'setup-mitmproxy', 03:44:31 INFO - 'run-tests'), 03:44:31 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:44:31 INFO - 'disable_ccov_upload': False, 03:44:31 INFO - 'download_minidump_stackwalk': True, 03:44:31 INFO - 'download_symbols': 'ondemand', 03:44:31 INFO - 'enable_stylo': False, 03:44:31 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:44:31 INFO - 'tooltool.py': '/tools/tooltool.py', 03:44:31 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:44:31 INFO - '/tools/misc-python/virtualenv.py')}, 03:44:31 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:44:31 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:44:31 INFO - 'gecko_profile': False, 03:44:31 INFO - 'gecko_profile_interval': 0, 03:44:31 INFO - 'installer_path': 'installer.exe', 03:44:31 INFO - 'log_level': 'info', 03:44:31 INFO - 'log_name': 'talos', 03:44:31 INFO - 'log_to_console': True, 03:44:31 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:44:31 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:44:31 INFO - 'opt_config_files': (), 03:44:31 INFO - 'pip_index': False, 03:44:31 INFO - 'suite': 'dromaeojs-e10s', 03:44:31 INFO - 'system_bits': '32', 03:44:31 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:44:31 INFO - 'title': 'talos-linux64-ix-012', 03:44:31 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:44:31 INFO - 'use_talos_json': True, 03:44:31 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:44:31 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:44:31 INFO - 'work_dir': 'build'} 03:44:31 INFO - [mozharness: 2017-07-23 10:44:31.719385Z] Running clobber step. 03:44:31 INFO - Running pre-action listener: _resource_record_pre_action 03:44:31 INFO - Running main action method: clobber 03:44:31 INFO - rmtree: /builds/slave/test/build 03:44:31 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:44:32 INFO - Running post-action listener: _resource_record_post_action 03:44:32 INFO - [mozharness: 2017-07-23 10:44:32.750593Z] Finished clobber step (success) 03:44:32 INFO - [mozharness: 2017-07-23 10:44:32.750696Z] Running read-buildbot-config step. 03:44:32 INFO - Running pre-action listener: _resource_record_pre_action 03:44:32 INFO - Running main action method: read_buildbot_config 03:44:32 INFO - Using buildbot properties: 03:44:32 INFO - { 03:44:32 INFO - "project": "", 03:44:32 INFO - "product": "firefox", 03:44:32 INFO - "who": "ffxbld@noreply.mozilla.org", 03:44:32 INFO - "installer_path": "public/build/target.tar.bz2", 03:44:32 INFO - "builddir": "mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s", 03:44:32 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 03:44:32 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo mozilla-central talos dromaeojs-e10s", 03:44:32 INFO - "stage_platform": "linux64-stylo", 03:44:32 INFO - "basedir": "/builds/slave/test", 03:44:32 INFO - "buildnumber": 232, 03:44:32 INFO - "platform": "ubuntu64_hw_stylo", 03:44:32 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 03:44:32 INFO - "slavebuilddir": "test", 03:44:32 INFO - "taskId": "Rw-zuyQiQBGnmAIuIZ66Kg", 03:44:32 INFO - "branch": "mozilla-central", 03:44:32 INFO - "script_repo_revision": "production", 03:44:32 INFO - "revision": "23d9d005d92afdb5afabeae2ad672323c7d903ad", 03:44:32 INFO - "slavename": "talos-linux64-ix-012", 03:44:32 INFO - "repo_path": "mozilla-central" 03:44:32 INFO - } 03:44:32 INFO - Finding installer, test and symbols from parent task. 03:44:32 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Rw-zuyQiQBGnmAIuIZ66Kg'}, attempt #1 03:44:33 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Rw-zuyQiQBGnmAIuIZ66Kg'}, attempt #1 03:44:33 INFO - Task dependencies: aOjLU-_YTmm47TDQ28JXgw 03:44:33 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aOjLU-_YTmm47TDQ28JXgw'}, attempt #1 03:44:34 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/aOjLU-_YTmm47TDQ28JXgw/artifacts/public/build/target.tar.bz2 03:44:34 INFO - Set test_url: https://queue.taskcluster.net/v1/task/aOjLU-_YTmm47TDQ28JXgw/artifacts/public/build/test_packages.json 03:44:34 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/aOjLU-_YTmm47TDQ28JXgw/artifacts/public/build/target.crashreporter-symbols.zip 03:44:34 INFO - Running post-action listener: _resource_record_post_action 03:44:34 INFO - [mozharness: 2017-07-23 10:44:34.078472Z] Finished read-buildbot-config step (success) 03:44:34 INFO - [mozharness: 2017-07-23 10:44:34.078694Z] Running download-and-extract step. 03:44:34 INFO - Running pre-action listener: _resource_record_pre_action 03:44:34 INFO - Running main action method: download_and_extract 03:44:34 INFO - mkdir: /builds/slave/test/build/tests 03:44:34 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')]} 03:44:34 INFO - trying https://queue.taskcluster.net/v1/task/aOjLU-_YTmm47TDQ28JXgw/artifacts/public/build/target.test_packages.json 03:44:34 INFO - Downloading https://queue.taskcluster.net/v1/task/aOjLU-_YTmm47TDQ28JXgw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 03:44:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aOjLU-_YTmm47TDQ28JXgw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 03:44:34 INFO - Downloaded 989 bytes. 03:44:34 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 03:44:34 INFO - Using the following test package requirements: 03:44:34 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 03:44:34 INFO - u'common': [u'target.common.tests.zip'], 03:44:34 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 03:44:34 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 03:44:34 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 03:44:34 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 03:44:34 INFO - u'mozbase': [u'target.common.tests.zip'], 03:44:34 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 03:44:34 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 03:44:34 INFO - u'web-platform': [u'target.common.tests.zip', 03:44:34 INFO - u'target.web-platform.tests.tar.gz'], 03:44:34 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 03:44:34 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 03:44:34 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/aOjLU-_YTmm47TDQ28JXgw/artifacts/public/build/target.common.tests.zip 03:44:34 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/aOjLU-_YTmm47TDQ28JXgw/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:44:34 INFO - Fetch https://queue.taskcluster.net/v1/task/aOjLU-_YTmm47TDQ28JXgw/artifacts/public/build/target.common.tests.zip into memory 03:44:36 INFO - Content-Length response header: 72760949 03:44:36 INFO - Bytes received: 72760949 03:44:47 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 03:44:47 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/aOjLU-_YTmm47TDQ28JXgw/artifacts/public/build/target.common.tests.zip 03:44:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/aOjLU-_YTmm47TDQ28JXgw/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:44:47 INFO - Fetch https://queue.taskcluster.net/v1/task/aOjLU-_YTmm47TDQ28JXgw/artifacts/public/build/target.common.tests.zip into memory 03:44:48 INFO - Content-Length response header: 72760949 03:44:48 INFO - Bytes received: 72760949 03:45:00 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/aOjLU-_YTmm47TDQ28JXgw/artifacts/public/build/target.talos.tests.zip 03:45:00 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/aOjLU-_YTmm47TDQ28JXgw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 03:45:00 INFO - Fetch https://queue.taskcluster.net/v1/task/aOjLU-_YTmm47TDQ28JXgw/artifacts/public/build/target.talos.tests.zip into memory 03:45:01 INFO - Content-Length response header: 14498880 03:45:01 INFO - Bytes received: 14498880 03:45:01 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')]} 03:45:01 INFO - trying https://queue.taskcluster.net/v1/task/aOjLU-_YTmm47TDQ28JXgw/artifacts/public/build/target.tar.bz2 03:45:01 INFO - Downloading https://queue.taskcluster.net/v1/task/aOjLU-_YTmm47TDQ28JXgw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 03:45:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aOjLU-_YTmm47TDQ28JXgw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 03:45:03 INFO - Downloaded 62071862 bytes. 03:45:03 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/aOjLU-_YTmm47TDQ28JXgw/artifacts/public/build/target.tar.bz2 03:45:03 INFO - mkdir: /builds/slave/test/properties 03:45:03 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:45:03 INFO - Writing to file /builds/slave/test/properties/build_url 03:45:03 INFO - Contents: 03:45:03 INFO - build_url:https://queue.taskcluster.net/v1/task/aOjLU-_YTmm47TDQ28JXgw/artifacts/public/build/target.tar.bz2 03:45:03 INFO - Running post-action listener: _resource_record_post_action 03:45:03 INFO - Running post-action listener: set_extra_try_arguments 03:45:03 INFO - [mozharness: 2017-07-23 10:45:03.134834Z] Finished download-and-extract step (success) 03:45:03 INFO - [mozharness: 2017-07-23 10:45:03.134932Z] Running populate-webroot step. 03:45:03 INFO - Running pre-action listener: _resource_record_pre_action 03:45:03 INFO - Running main action method: populate_webroot 03:45:03 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:45:03 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:45:03 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 03:45:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:45:03 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 03:45:03 INFO - 'tests': ['damp', 'tps']}, 03:45:03 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:45:03 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 03:45:03 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 03:45:03 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 03:45:03 INFO - 'other-e10s': {'tests': ['a11yr', 03:45:03 INFO - 'ts_paint', 03:45:03 INFO - 'tpaint', 03:45:03 INFO - 'sessionrestore', 03:45:03 INFO - 'sessionrestore_many_windows', 03:45:03 INFO - 'sessionrestore_no_auto_restore', 03:45:03 INFO - 'tabpaint']}, 03:45:03 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 03:45:03 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 03:45:03 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:45:03 INFO - 'talos_options': ['--mitmproxy', 03:45:03 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:45:03 INFO - '--firstNonBlankPaint'], 03:45:03 INFO - 'tests': ['quantum_pageload_google', 03:45:03 INFO - 'quantum_pageload_youtube', 03:45:03 INFO - 'quantum_pageload_amazon', 03:45:03 INFO - 'quantum_pageload_facebook']}, 03:45:03 INFO - 'quantum-pageload-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 03:45:03 INFO - 'talos_options': ['--stylo', 03:45:03 INFO - '--mitmproxy', 03:45:03 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 03:45:03 INFO - '--firstNonBlankPaint'], 03:45:03 INFO - 'tests': ['quantum_pageload_google', 03:45:03 INFO - 'quantum_pageload_youtube', 03:45:03 INFO - 'quantum_pageload_amazon', 03:45:03 INFO - 'quantum_pageload_facebook']}, 03:45:03 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:45:03 INFO - 'tsvgr_opacity', 03:45:03 INFO - 'tart', 03:45:03 INFO - 'tscrollx', 03:45:03 INFO - 'cart', 03:45:03 INFO - 'tsvg_static']}, 03:45:03 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 03:45:03 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 03:45:03 INFO - 'talos_options': ['--xperf_path', 03:45:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:45:03 INFO - 'tests': ['tp5n']}}} 03:45:03 INFO - Running post-action listener: _resource_record_post_action 03:45:03 INFO - [mozharness: 2017-07-23 10:45:03.142234Z] Finished populate-webroot step (success) 03:45:03 INFO - [mozharness: 2017-07-23 10:45:03.142324Z] Running create-virtualenv step. 03:45:03 INFO - Running pre-action listener: _resource_record_pre_action 03:45:03 INFO - Running main action method: create_virtualenv 03:45:03 INFO - Creating virtualenv /builds/slave/test/build/venv 03:45:03 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 03:45:03 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:45:03 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 03:45:03 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:45:03 INFO - Using real prefix '/usr' 03:45:03 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:45:03 INFO - Installing distribute.............................................................................................................................................................................................done. 03:45:05 INFO - Installing pip.................done. 03:45:05 INFO - Return code: 0 03:45:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:45:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:45:05 INFO - Reading from file tmpfile_stdout 03:45:05 INFO - Output received: 03:45:05 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) 03:45:05 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:45:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:45:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:45:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:45:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:45:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x113c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1308a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14abd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14a8eb0>, '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 0x14a9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14aa240>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1500806115.35968-1985897236', '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 03:45:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:45:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:45:05 INFO - Using env: {'DISPLAY': ':0', 03:45:05 INFO - 'HOME': '/home/cltbld', 03:45:05 INFO - 'LANG': 'en_US.UTF-8', 03:45:05 INFO - 'LANGUAGE': 'en_US:en', 03:45:05 INFO - 'LOGNAME': 'cltbld', 03:45:05 INFO - 'MAIL': '/var/mail/cltbld', 03:45:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:45:05 INFO - 'MOZ_NO_REMOTE': '1', 03:45:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:45:05 INFO - 'NO_EM_RESTART': '1', 03:45:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:45:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:45:05 INFO - 'PWD': '/builds/slave/test', 03:45:05 INFO - 'SHELL': '/bin/bash', 03:45:05 INFO - 'SHLVL': '1', 03:45:05 INFO - 'TERM': 'linux', 03:45:05 INFO - 'TMOUT': '86400', 03:45:05 INFO - 'USER': 'cltbld', 03:45:05 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1500806115.35968-1985897236', 03:45:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:45:05 INFO - '_': '/tools/buildbot/bin/python'} 03:45:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:45:06 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 03:45:06 INFO - Cleaning up... 03:45:06 INFO - Return code: 0 03:45:06 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:45: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')]} 03:45:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:45: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')]} 03:45:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:45:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x113c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1308a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14abd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14a8eb0>, '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 0x14a9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14aa240>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1500806115.35968-1985897236', '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 03:45:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 03:45:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 03:45:06 INFO - Using env: {'DISPLAY': ':0', 03:45:06 INFO - 'HOME': '/home/cltbld', 03:45:06 INFO - 'LANG': 'en_US.UTF-8', 03:45:06 INFO - 'LANGUAGE': 'en_US:en', 03:45:06 INFO - 'LOGNAME': 'cltbld', 03:45:06 INFO - 'MAIL': '/var/mail/cltbld', 03:45:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:45:06 INFO - 'MOZ_NO_REMOTE': '1', 03:45:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:45:06 INFO - 'NO_EM_RESTART': '1', 03:45:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:45:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:45:06 INFO - 'PWD': '/builds/slave/test', 03:45:06 INFO - 'SHELL': '/bin/bash', 03:45:06 INFO - 'SHLVL': '1', 03:45:06 INFO - 'TERM': 'linux', 03:45:06 INFO - 'TMOUT': '86400', 03:45:06 INFO - 'USER': 'cltbld', 03:45:06 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1500806115.35968-1985897236', 03:45:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:45:06 INFO - '_': '/tools/buildbot/bin/python'} 03:45:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:45:06 INFO - Downloading/unpacking psutil>=3.1.1 03:45:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:45:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:45:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:45:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:45:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:45:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:45:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:45:07 INFO - Installing collected packages: psutil 03:45:07 INFO - Running setup.py install for psutil 03:45:07 INFO - building 'psutil._psutil_linux' extension 03:45:07 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 03:45:07 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 03:45:07 INFO - building 'psutil._psutil_posix' extension 03:45:07 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 03:45:07 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 03:45:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:45:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:45:08 INFO - Successfully installed psutil 03:45:08 INFO - Cleaning up... 03:45:08 INFO - Return code: 0 03:45:08 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:45:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:45:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:45:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:45:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:45:08 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 0x113c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1308a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14abd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14a8eb0>, '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 0x14a9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14aa240>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1500806115.35968-1985897236', '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 03:45:08 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 03:45:08 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 03:45:08 INFO - Using env: {'DISPLAY': ':0', 03:45:08 INFO - 'HOME': '/home/cltbld', 03:45:08 INFO - 'LANG': 'en_US.UTF-8', 03:45:08 INFO - 'LANGUAGE': 'en_US:en', 03:45:08 INFO - 'LOGNAME': 'cltbld', 03:45:08 INFO - 'MAIL': '/var/mail/cltbld', 03:45:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:45:08 INFO - 'MOZ_NO_REMOTE': '1', 03:45:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:45:08 INFO - 'NO_EM_RESTART': '1', 03:45:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:45:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:45:08 INFO - 'PWD': '/builds/slave/test', 03:45:08 INFO - 'SHELL': '/bin/bash', 03:45:08 INFO - 'SHLVL': '1', 03:45:08 INFO - 'TERM': 'linux', 03:45:08 INFO - 'TMOUT': '86400', 03:45:08 INFO - 'USER': 'cltbld', 03:45:08 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1500806115.35968-1985897236', 03:45:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:45:08 INFO - '_': '/tools/buildbot/bin/python'} 03:45:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:45:08 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:45:08 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 03:45:08 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 03:45:08 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 03:45:08 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 03:45:09 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:45:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:45:09 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:45:09 INFO - Installing collected packages: mozsystemmonitor 03:45:09 INFO - Running setup.py install for mozsystemmonitor 03:45:09 INFO - Successfully installed mozsystemmonitor 03:45:09 INFO - Cleaning up... 03:45:09 INFO - Return code: 0 03:45:09 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:45:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:45:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:45:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:45:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:45:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x113c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1308a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14abd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14a8eb0>, '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 0x14a9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14aa240>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1500806115.35968-1985897236', '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 03:45:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:45:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 03:45:09 INFO - Using env: {'DISPLAY': ':0', 03:45:09 INFO - 'HOME': '/home/cltbld', 03:45:09 INFO - 'LANG': 'en_US.UTF-8', 03:45:09 INFO - 'LANGUAGE': 'en_US:en', 03:45:09 INFO - 'LOGNAME': 'cltbld', 03:45:09 INFO - 'MAIL': '/var/mail/cltbld', 03:45:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:45:09 INFO - 'MOZ_NO_REMOTE': '1', 03:45:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:45:09 INFO - 'NO_EM_RESTART': '1', 03:45:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:45:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:45:09 INFO - 'PWD': '/builds/slave/test', 03:45:09 INFO - 'SHELL': '/bin/bash', 03:45:09 INFO - 'SHLVL': '1', 03:45:09 INFO - 'TERM': 'linux', 03:45:09 INFO - 'TMOUT': '86400', 03:45:09 INFO - 'USER': 'cltbld', 03:45:09 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1500806115.35968-1985897236', 03:45:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:45:09 INFO - '_': '/tools/buildbot/bin/python'} 03:45:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:45:09 INFO - Downloading/unpacking jsonschema==2.5.1 03:45:09 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 03:45:09 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 03:45:09 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 03:45:09 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 03:45:10 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:45:10 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:45:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:45:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:45:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:45:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:45:10 INFO - Downloading functools32-3.2.3-2.tar.gz 03:45:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:45:11 INFO - warning: no files found matching '*.txt' 03:45:11 INFO - no previously-included directories found matching 'build' 03:45:11 INFO - no previously-included directories found matching 'dist' 03:45:11 INFO - no previously-included directories found matching '.git*' 03:45:11 INFO - Installing collected packages: jsonschema, functools32 03:45:11 INFO - Running setup.py install for functools32 03:45:11 INFO - warning: no files found matching '*.txt' 03:45:11 INFO - no previously-included directories found matching 'build' 03:45:11 INFO - no previously-included directories found matching 'dist' 03:45:11 INFO - no previously-included directories found matching '.git*' 03:45:11 INFO - Successfully installed jsonschema functools32 03:45:11 INFO - Cleaning up... 03:45:11 INFO - Return code: 0 03:45:11 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:45:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:45:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:45:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:45:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:45:11 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 0x113c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1308a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14abd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14a8eb0>, '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 0x14a9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14aa240>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1500806115.35968-1985897236', '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 03:45:11 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 03:45:11 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 03:45:11 INFO - Using env: {'DISPLAY': ':0', 03:45:11 INFO - 'HOME': '/home/cltbld', 03:45:11 INFO - 'LANG': 'en_US.UTF-8', 03:45:11 INFO - 'LANGUAGE': 'en_US:en', 03:45:11 INFO - 'LOGNAME': 'cltbld', 03:45:11 INFO - 'MAIL': '/var/mail/cltbld', 03:45:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:45:11 INFO - 'MOZ_NO_REMOTE': '1', 03:45:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:45:11 INFO - 'NO_EM_RESTART': '1', 03:45:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:45:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:45:11 INFO - 'PWD': '/builds/slave/test', 03:45:11 INFO - 'SHELL': '/bin/bash', 03:45:11 INFO - 'SHLVL': '1', 03:45:11 INFO - 'TERM': 'linux', 03:45:11 INFO - 'TMOUT': '86400', 03:45:11 INFO - 'USER': 'cltbld', 03:45:11 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1500806115.35968-1985897236', 03:45:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:45:11 INFO - '_': '/tools/buildbot/bin/python'} 03:45:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:45:11 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:45:11 INFO - Cleaning up... 03:45:11 INFO - Return code: 0 03:45:11 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:45:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:45:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:45:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:45:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:45:11 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 0x113c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1308a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14abd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14a8eb0>, '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 0x14a9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14aa240>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1500806115.35968-1985897236', '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 03:45:11 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 03:45:11 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 03:45:11 INFO - Using env: {'DISPLAY': ':0', 03:45:11 INFO - 'HOME': '/home/cltbld', 03:45:11 INFO - 'LANG': 'en_US.UTF-8', 03:45:11 INFO - 'LANGUAGE': 'en_US:en', 03:45:11 INFO - 'LOGNAME': 'cltbld', 03:45:11 INFO - 'MAIL': '/var/mail/cltbld', 03:45:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:45:11 INFO - 'MOZ_NO_REMOTE': '1', 03:45:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:45:11 INFO - 'NO_EM_RESTART': '1', 03:45:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:45:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:45:11 INFO - 'PWD': '/builds/slave/test', 03:45:11 INFO - 'SHELL': '/bin/bash', 03:45:11 INFO - 'SHLVL': '1', 03:45:11 INFO - 'TERM': 'linux', 03:45:11 INFO - 'TMOUT': '86400', 03:45:11 INFO - 'USER': 'cltbld', 03:45:11 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1500806115.35968-1985897236', 03:45:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:45:11 INFO - '_': '/tools/buildbot/bin/python'} 03:45:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:45:11 INFO - Downloading/unpacking blobuploader==1.2.4 03:45:11 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 03:45:11 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 03:45:11 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 03:45:11 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 03:45:12 INFO - Downloading blobuploader-1.2.4.tar.gz 03:45:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:45:12 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:45:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:45:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:45:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:45:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:45:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:45:13 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:45:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:45:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:45:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:45:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:45:13 INFO - Downloading docopt-0.6.1.tar.gz 03:45:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:45:13 INFO - Installing collected packages: blobuploader, requests, docopt 03:45:13 INFO - Running setup.py install for blobuploader 03:45:13 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:45:13 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:45:13 INFO - Running setup.py install for requests 03:45:13 INFO - Running setup.py install for docopt 03:45:13 INFO - Successfully installed blobuploader requests docopt 03:45:13 INFO - Cleaning up... 03:45:13 INFO - Return code: 0 03:45:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:45:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:45:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:45:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:45:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:45:13 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 0x113c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1308a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14abd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14a8eb0>, '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 0x14a9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14aa240>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1500806115.35968-1985897236', '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 03:45:13 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 03:45:13 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 03:45:13 INFO - Using env: {'DISPLAY': ':0', 03:45:13 INFO - 'HOME': '/home/cltbld', 03:45:13 INFO - 'LANG': 'en_US.UTF-8', 03:45:13 INFO - 'LANGUAGE': 'en_US:en', 03:45:13 INFO - 'LOGNAME': 'cltbld', 03:45:13 INFO - 'MAIL': '/var/mail/cltbld', 03:45:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:45:13 INFO - 'MOZ_NO_REMOTE': '1', 03:45:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:45:13 INFO - 'NO_EM_RESTART': '1', 03:45:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:45:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:45:13 INFO - 'PWD': '/builds/slave/test', 03:45:13 INFO - 'SHELL': '/bin/bash', 03:45:13 INFO - 'SHLVL': '1', 03:45:13 INFO - 'TERM': 'linux', 03:45:13 INFO - 'TMOUT': '86400', 03:45:13 INFO - 'USER': 'cltbld', 03:45:13 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1500806115.35968-1985897236', 03:45:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:45:13 INFO - '_': '/tools/buildbot/bin/python'} 03:45:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:45:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:45:14 INFO - Running setup.py (path:/tmp/pip-3A4peG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:45:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:45:14 INFO - Running setup.py (path:/tmp/pip-AzmdSH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:45:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:45:14 INFO - Running setup.py (path:/tmp/pip-zoWiYa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:45:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:45:14 INFO - Running setup.py (path:/tmp/pip-7eeEAB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:45:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:45:14 INFO - Running setup.py (path:/tmp/pip-uxM3El-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:45:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:45:14 INFO - Running setup.py (path:/tmp/pip-l0wJr3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:45:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:45:14 INFO - Running setup.py (path:/tmp/pip-yvVy0Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:45:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:45:14 INFO - Running setup.py (path:/tmp/pip-CUgSsA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:45:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:45:14 INFO - Running setup.py (path:/tmp/pip-Y2s6uS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:45:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:45:14 INFO - Running setup.py (path:/tmp/pip-3BVF6m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:45:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:45:14 INFO - Running setup.py (path:/tmp/pip-CxMNlo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:45:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:45:14 INFO - Running setup.py (path:/tmp/pip-lDKGOR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:45:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:45:15 INFO - Running setup.py (path:/tmp/pip-mekue7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:45:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:45:15 INFO - Running setup.py (path:/tmp/pip-Dqg3An-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:45:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:45:15 INFO - Running setup.py (path:/tmp/pip-njI7f2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:45:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:45:15 INFO - Running setup.py (path:/tmp/pip-4_yffb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:45:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:45:15 INFO - Running setup.py (path:/tmp/pip-0Ibxj8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:45:15 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:45:15 INFO - Running setup.py install for manifestparser 03:45:15 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:45:15 INFO - Running setup.py install for mozcrash 03:45:15 INFO - Running setup.py install for mozdebug 03:45:15 INFO - Running setup.py install for mozdevice 03:45:15 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:45:15 INFO - Running setup.py install for mozfile 03:45:15 INFO - Running setup.py install for mozhttpd 03:45:16 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:45:16 INFO - Running setup.py install for mozinfo 03:45:16 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:45:16 INFO - Running setup.py install for mozInstall 03:45:16 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:45:16 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:45:16 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:45:16 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:45:16 INFO - Running setup.py install for mozleak 03:45:16 INFO - Running setup.py install for mozlog 03:45:16 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:45:16 INFO - Running setup.py install for moznetwork 03:45:16 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:45:16 INFO - Running setup.py install for mozprocess 03:45:16 INFO - Running setup.py install for mozprofile 03:45:16 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:45:16 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:45:16 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:45:16 INFO - Running setup.py install for mozrunner 03:45:16 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:45:16 INFO - Running setup.py install for mozscreenshot 03:45:16 INFO - Running setup.py install for moztest 03:45:17 INFO - Running setup.py install for mozversion 03:45:17 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:45:17 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:45:17 INFO - Cleaning up... 03:45:17 INFO - Return code: 0 03:45:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:45:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:45:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:45:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:45:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:45:17 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 0x113c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1308a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14abd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14a8eb0>, '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 0x14a9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14aa240>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1500806115.35968-1985897236', '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 03:45:17 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 03:45:17 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 03:45:17 INFO - Using env: {'DISPLAY': ':0', 03:45:17 INFO - 'HOME': '/home/cltbld', 03:45:17 INFO - 'LANG': 'en_US.UTF-8', 03:45:17 INFO - 'LANGUAGE': 'en_US:en', 03:45:17 INFO - 'LOGNAME': 'cltbld', 03:45:17 INFO - 'MAIL': '/var/mail/cltbld', 03:45:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:45:17 INFO - 'MOZ_NO_REMOTE': '1', 03:45:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:45:17 INFO - 'NO_EM_RESTART': '1', 03:45:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:45:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:45:17 INFO - 'PWD': '/builds/slave/test', 03:45:17 INFO - 'SHELL': '/bin/bash', 03:45:17 INFO - 'SHLVL': '1', 03:45:17 INFO - 'TERM': 'linux', 03:45:17 INFO - 'TMOUT': '86400', 03:45:17 INFO - 'USER': 'cltbld', 03:45:17 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1500806115.35968-1985897236', 03:45:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:45:17 INFO - '_': '/tools/buildbot/bin/python'} 03:45:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:45:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:45:17 INFO - Running setup.py (path:/tmp/pip-gHHWsk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:45:17 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)) 03:45:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:45:17 INFO - Running setup.py (path:/tmp/pip-S12hDA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:45:17 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)) 03:45:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:45:17 INFO - Running setup.py (path:/tmp/pip-4gYUPu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:45:17 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)) 03:45:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:45:17 INFO - Running setup.py (path:/tmp/pip-9AFJiO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:45:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 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)) 03:45:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:45:17 INFO - Running setup.py (path:/tmp/pip-NwRaYP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:45:17 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)) 03:45:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:45:17 INFO - Running setup.py (path:/tmp/pip-AO0S0B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:45:17 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)) 03:45:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:45:17 INFO - Running setup.py (path:/tmp/pip-wynCLW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:45:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 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)) 03:45:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:45:17 INFO - Running setup.py (path:/tmp/pip-XV3pBY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:45:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 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)) 03:45:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:45:17 INFO - Running setup.py (path:/tmp/pip-cE9qcO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:45:18 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)) 03:45:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:45:18 INFO - Running setup.py (path:/tmp/pip-7m635R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:45:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 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)) 03:45:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:45:18 INFO - Running setup.py (path:/tmp/pip-udlPY7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:45:18 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)) 03:45:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:45:18 INFO - Running setup.py (path:/tmp/pip-ZTUq4D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:45:18 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)) 03:45:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:45:18 INFO - Running setup.py (path:/tmp/pip-BLpAvR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:45:18 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)) 03:45:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:45:18 INFO - Running setup.py (path:/tmp/pip-6TLPM9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:45:18 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)) 03:45:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:45:18 INFO - Running setup.py (path:/tmp/pip-RXE0Rg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:45:18 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)) 03:45:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:45:18 INFO - Running setup.py (path:/tmp/pip-cD1qQD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:45:18 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)) 03:45:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:45:18 INFO - Running setup.py (path:/tmp/pip-796HKO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:45:18 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)) 03:45:18 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)) 03:45:18 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)) 03:45:18 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)) 03:45:18 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.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:45:18 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.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:45:18 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 03:45:18 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:45:18 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 03:45:18 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 03:45:18 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 03:45:18 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 03:45:19 INFO - Downloading blessings-1.6.tar.gz 03:45:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:45:19 INFO - Installing collected packages: blessings 03:45:19 INFO - Running setup.py install for blessings 03:45:19 INFO - Successfully installed blessings 03:45:19 INFO - Cleaning up... 03:45:19 INFO - Return code: 0 03:45:19 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:45:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:45:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:45:20 INFO - Reading from file tmpfile_stdout 03:45:20 INFO - Current package versions: 03:45:20 INFO - argparse == 1.2.1 03:45:20 INFO - blessings == 1.6 03:45:20 INFO - blobuploader == 1.2.4 03:45:20 INFO - docopt == 0.6.1 03:45:20 INFO - functools32 == 3.2.3-2 03:45:20 INFO - jsonschema == 2.5.1 03:45:20 INFO - manifestparser == 1.1 03:45:20 INFO - mozInstall == 1.13 03:45:20 INFO - mozcrash == 1.0 03:45:20 INFO - mozdebug == 0.1 03:45:20 INFO - mozdevice == 0.51 03:45:20 INFO - mozfile == 1.2 03:45:20 INFO - mozhttpd == 0.7 03:45:20 INFO - mozinfo == 0.10 03:45:20 INFO - mozleak == 0.1 03:45:20 INFO - mozlog == 3.5 03:45:20 INFO - moznetwork == 0.27 03:45:20 INFO - mozprocess == 0.25 03:45:20 INFO - mozprofile == 0.28 03:45:20 INFO - mozrunner == 6.13 03:45:20 INFO - mozscreenshot == 0.1 03:45:20 INFO - mozsystemmonitor == 0.3 03:45:20 INFO - moztest == 0.8 03:45:20 INFO - mozversion == 1.4 03:45:20 INFO - psutil == 3.1.1 03:45:20 INFO - requests == 1.2.3 03:45:20 INFO - wsgiref == 0.1.2 03:45:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:45:20 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')]} 03:45:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:45:20 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')]} 03:45:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:45:20 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 0x113c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1308a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14abd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14a8eb0>, '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 0x14a9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14aa240>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1500806115.35968-1985897236', '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 03:45:20 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 03:45:20 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 03:45:20 INFO - Using env: {'DISPLAY': ':0', 03:45:20 INFO - 'HOME': '/home/cltbld', 03:45:20 INFO - 'LANG': 'en_US.UTF-8', 03:45:20 INFO - 'LANGUAGE': 'en_US:en', 03:45:20 INFO - 'LOGNAME': 'cltbld', 03:45:20 INFO - 'MAIL': '/var/mail/cltbld', 03:45:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:45:20 INFO - 'MOZ_NO_REMOTE': '1', 03:45:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:45:20 INFO - 'NO_EM_RESTART': '1', 03:45:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:45:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:45:20 INFO - 'PWD': '/builds/slave/test', 03:45:20 INFO - 'SHELL': '/bin/bash', 03:45:20 INFO - 'SHLVL': '1', 03:45:20 INFO - 'TERM': 'linux', 03:45:20 INFO - 'TMOUT': '86400', 03:45:20 INFO - 'USER': 'cltbld', 03:45:20 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1500806115.35968-1985897236', 03:45:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:45:20 INFO - '_': '/tools/buildbot/bin/python'} 03:45:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:45:20 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)) 03:45:20 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)) 03:45:20 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)) 03:45:20 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)) 03:45:20 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)) 03:45:20 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)) 03:45:20 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)) 03:45:20 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)) 03:45:20 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)) 03:45:20 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 03:45:20 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 03:45:20 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 03:45:20 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 03:45:20 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 03:45:21 INFO - Downloading marionette_driver-1.4.0.tar.gz 03:45:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 03:45:21 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 11)) 03:45:21 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 03:45:21 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 03:45:21 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 03:45:21 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 03:45:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 03:45:21 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)) 03:45:21 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)) 03:45:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner>=6.9 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 03:45:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice>=0.37 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozrunner>=6.9->marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 03:45:21 INFO - Installing collected packages: marionette-driver, simplejson 03:45:21 INFO - Running setup.py install for marionette-driver 03:45:21 INFO - Running setup.py install for simplejson 03:45:22 INFO - building 'simplejson._speedups' extension 03:45:22 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 03:45:22 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 03:45:22 INFO - Successfully installed marionette-driver simplejson 03:45:22 INFO - Cleaning up... 03:45:22 INFO - Return code: 0 03:45:22 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:45:22 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')]} 03:45:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:45:22 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')]} 03:45:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:45:22 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 0x113c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1308a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14abd10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14a8eb0>, '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 0x14a9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14aa240>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1500806115.35968-1985897236', '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 03:45:22 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 03:45:22 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 03:45:22 INFO - Using env: {'DISPLAY': ':0', 03:45:22 INFO - 'HOME': '/home/cltbld', 03:45:22 INFO - 'LANG': 'en_US.UTF-8', 03:45:22 INFO - 'LANGUAGE': 'en_US:en', 03:45:22 INFO - 'LOGNAME': 'cltbld', 03:45:22 INFO - 'MAIL': '/var/mail/cltbld', 03:45:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:45:22 INFO - 'MOZ_NO_REMOTE': '1', 03:45:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:45:22 INFO - 'NO_EM_RESTART': '1', 03:45:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:45:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:45:22 INFO - 'PWD': '/builds/slave/test', 03:45:22 INFO - 'SHELL': '/bin/bash', 03:45:22 INFO - 'SHLVL': '1', 03:45:22 INFO - 'TERM': 'linux', 03:45:22 INFO - 'TMOUT': '86400', 03:45:22 INFO - 'USER': 'cltbld', 03:45:22 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1500806115.35968-1985897236', 03:45:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:45:22 INFO - '_': '/tools/buildbot/bin/python'} 03:45:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:45:23 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:45:23 INFO - Cleaning up... 03:45:23 INFO - Return code: 0 03:45:23 INFO - Running post-action listener: _resource_record_post_action 03:45:23 INFO - Running post-action listener: _start_resource_monitoring 03:45:23 INFO - Starting resource monitoring. 03:45:23 INFO - [mozharness: 2017-07-23 10:45:23.249763Z] Finished create-virtualenv step (success) 03:45:23 INFO - [mozharness: 2017-07-23 10:45:23.250278Z] Running install step. 03:45:23 INFO - Running pre-action listener: _resource_record_pre_action 03:45:23 INFO - Running main action method: install 03:45:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:45:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:45:23 INFO - Reading from file tmpfile_stdout 03:45:23 INFO - Detecting whether we're running mozinstall >=1.0... 03:45:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:45:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:45:23 INFO - Reading from file tmpfile_stdout 03:45:23 INFO - Output received: 03:45:23 INFO - Usage: mozinstall [options] installer 03:45:23 INFO - Options: 03:45:23 INFO - -h, --help show this help message and exit 03:45:23 INFO - -d DEST, --destination=DEST 03:45:23 INFO - Directory to install application into. [default: 03:45:23 INFO - "/builds/slave/test"] 03:45:23 INFO - --app=APP Application being installed. [default: firefox] 03:45:23 INFO - mkdir: /builds/slave/test/build/application 03:45:23 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'] 03:45:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 03:45:41 INFO - Reading from file tmpfile_stdout 03:45:41 INFO - Output received: 03:45:41 INFO - /builds/slave/test/build/application/firefox/firefox 03:45:41 INFO - Running post-action listener: _resource_record_post_action 03:45:41 INFO - [mozharness: 2017-07-23 10:45:41.596039Z] Finished install step (success) 03:45:41 INFO - [mozharness: 2017-07-23 10:45:41.596165Z] Running setup-mitmproxy step. 03:45:41 INFO - Running pre-action listener: _resource_record_pre_action 03:45:41 INFO - Running main action method: setup_mitmproxy 03:45:41 INFO - Skipping: mitmproxy is not required 03:45:41 INFO - Running post-action listener: _resource_record_post_action 03:45:41 INFO - [mozharness: 2017-07-23 10:45:41.596694Z] Finished setup-mitmproxy step (success) 03:45:41 INFO - [mozharness: 2017-07-23 10:45:41.596798Z] Running run-tests step. 03:45:41 INFO - Running pre-action listener: _resource_record_pre_action 03:45:41 INFO - Running pre-action listener: _set_gcov_prefix 03:45:41 INFO - Running main action method: run_tests 03:45:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:45:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:45:41 INFO - Python 2.7.3 03:45:41 INFO - Return code: 0 03:45:41 INFO - grabbing minidump binary from tooltool 03:45: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')]} 03:45:41 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 0x14a8eb0>, '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 0x14a9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14aa240>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:45:41 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 03:45:41 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 03:45:41 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 03:45:41 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:45:41 INFO - Return code: 0 03:45:41 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:45:41 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:45:41 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:45:41 INFO - ENV: RUST_BACKTRACE is now 1 03:45:41 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:45:41 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:45:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/aOjLU-_YTmm47TDQ28JXgw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--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 03:45:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/aOjLU-_YTmm47TDQ28JXgw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-012 --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 03:45:41 INFO - Using env: {'DISPLAY': ':0', 03:45:41 INFO - 'HOME': '/home/cltbld', 03:45:41 INFO - 'LANG': 'en_US.UTF-8', 03:45:41 INFO - 'LANGUAGE': 'en_US:en', 03:45:41 INFO - 'LOGNAME': 'cltbld', 03:45:41 INFO - 'MAIL': '/var/mail/cltbld', 03:45:41 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:45:41 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:45:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:45:41 INFO - 'MOZ_NO_REMOTE': '1', 03:45:41 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:45:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:45:41 INFO - 'NO_EM_RESTART': '1', 03:45:41 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:45:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:45:41 INFO - 'PWD': '/builds/slave/test', 03:45:41 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:45:41 INFO - 'RUST_BACKTRACE': '1', 03:45:41 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:45:41 INFO - 'SHELL': '/bin/bash', 03:45:41 INFO - 'SHLVL': '1', 03:45:41 INFO - 'STYLO_FORCE_ENABLED': '1', 03:45:41 INFO - 'TERM': 'linux', 03:45:41 INFO - 'TMOUT': '86400', 03:45:41 INFO - 'USER': 'cltbld', 03:45:41 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1500806115.35968-1985897236', 03:45:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:45:41 INFO - '_': '/tools/buildbot/bin/python'} 03:45:41 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/aOjLU-_YTmm47TDQ28JXgw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--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 03:45:41 INFO - mozversion application_buildid: 20170723100047 03:45:41 INFO - mozversion application_changeset: 23d9d005d92afdb5afabeae2ad672323c7d903ad 03:45:41 INFO - mozversion application_display_name: Nightly 03:45:41 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:45:41 INFO - mozversion application_name: Firefox 03:45:41 INFO - mozversion application_remotingname: firefox 03:45:41 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:45:41 INFO - mozversion application_vendor: Mozilla 03:45:41 INFO - mozversion application_version: 56.0a1 03:45:41 INFO - mozversion platform_buildid: 20170723100047 03:45:41 INFO - mozversion platform_changeset: 23d9d005d92afdb5afabeae2ad672323c7d903ad 03:45:41 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:45:41 INFO - mozversion platform_version: 56.0a1 03:45:41 INFO - using testdate: 1500806741 03:45:41 INFO - actual date: 1500806741 03:45:41 INFO - starting webserver on 'localhost:34721' 03:45:41 INFO - SUITE-START | Running 2 tests 03:45:41 INFO - TEST-START | dromaeo_css 03:45:41 INFO - Initialising browser for dromaeo_css test... 03:45:41 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:34721/getInfo.html -profile /tmp/tmpMhVCGo/profile 03:45:41 INFO - TEST-INFO | started process 27011 (/builds/slave/test/build/application/firefox/firefox http://localhost:34721/getInfo.html) 03:45:47 INFO - TEST-INFO | 27011: exit 0 03:45:48 INFO - Browser initialized. 03:45:48 INFO - Running cycle 1/1 for dromaeo_css test... 03:45:48 INFO - TEST-INFO | started process 27238 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMhVCGo/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 03:45:59 INFO - PID 27238 | RSS: Main: 173985792 03:45:59 INFO - PID 27238 | 03:48:58 INFO - PID 27238 | Cycle 1(1): loaded http://localhost:34721/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34721/tests/dromaeo/cssquery-ext.html) 03:49:00 INFO - PID 27238 | RSS: Main: 181604352 03:49:00 INFO - PID 27238 | 03:52:01 INFO - PID 27238 | Cycle 1(1): loaded http://localhost:34721/tests/dromaeo/cssquery-ext.html (next: http://localhost:34721/tests/dromaeo/cssquery-jquery.html) 03:52:02 INFO - PID 27238 | RSS: Main: 179384320 03:52:02 INFO - PID 27238 | 03:55:04 INFO - PID 27238 | Cycle 1(1): loaded http://localhost:34721/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34721/tests/dromaeo/cssquery-mootools.html) 03:55:05 INFO - PID 27238 | RSS: Main: 180891648 03:55:05 INFO - PID 27238 | 03:58:07 INFO - PID 27238 | Cycle 1(1): loaded http://localhost:34721/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34721/tests/dromaeo/cssquery-prototype.html) 03:58:07 INFO - PID 27238 | RSS: Main: 177479680 03:58:07 INFO - PID 27238 | 04:01:11 INFO - PID 27238 | Cycle 1(1): loaded http://localhost:34721/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34721/tests/dromaeo/cssquery-yui.html) 04:01:12 INFO - PID 27238 | RSS: Main: 180916224 04:01:12 INFO - PID 27238 | 04:04:14 INFO - PID 27238 | Cycle 1(1): loaded http://localhost:34721/tests/dromaeo/cssquery-yui.html (next: http://localhost:34721/tests/dromaeo/cssquery-dojo.html) 04:04:14 INFO - PID 27238 | RSS: Main: 183635968 04:04:14 INFO - PID 27238 | 04:04:14 INFO - PID 27238 | __start_tp_report 04:04:14 INFO - PID 27238 | _x_x_mozilla_page_load 04:04:14 INFO - PID 27238 | _x_x_mozilla_page_load_details 04:04:14 INFO - PID 27238 | |i|pagename|runs| 04:04:14 INFO - PID 27238 | |0;dojo.html;3052.221683470716;3106.5961425014775;3169.445347064264;3179.697928696774;3215.3247817958227;6035.336113027563;6196.628202307865;6216.1918950536365;6227.750889964396;6229.657368844717;5822.068469044953;5987.700614969245;6005.429484198994;6012;6015.248093988252;5454.53636440903;5462.562994960394;5467.753951072192;5477.452254774511;5509.173623956399;5553.111502159655;5602.075657516505;5607.635503692268;5616.213730077792;5628.521575666074;5576.86057848553;5598.384177740486;5672.290963629546;5678.205051292823;5694.402087780765;5408.702521361323;5469.425710300441;5507.0637991541535;5512.035393806068;5591.9720401397735;5534.52956498694;5557.944420555824;5619;5627.409122042168;5634.7182640867795;6032.728527216286;6041.969790151021;6142.04798256271;6144.2319710036245;6163.630182189038;6306.936930630681;6419.422251997343;6481.125048118491;6615.206175258952;6619.801405957829;6546.18172728409;6608.702608382634;6652.334766523358;6659.63372014539;6674.666266686646;6105.114758360013;6124.081387791867;6155.322914479404;6168.506519478521;6181.567290289727;6548.8035358939305;6635.170603674541;6749.662516874137;6766.458683305324;6843.760468383683;6317.526185536103;6392.4246817786625;6401.743930242738;6405.103285540028;6405.711742971577;6411.455026322815;6415.262244841903;6478.028295755675;6519.119918810899;6530;6221.564490485713;6325.620462772248;6346.936530634727;6392.808215753535;6401.967990160112;6496.382843629847;6538.019297105472;6597.30728273534;6602.96698516514;6631.535792494576;5303.257543943851;5374.978754036799;5381.865453363619;5382.703951282717;5396.703181325065;4463.754493502824;4548.249538826123;4549.27211646135;4564.726116433025;4614.97692511542;5689.715514224355;5708.942910570924;5791.449812267828;5806.332271788714;5850.853728656818;6538;6541.116949211891;6597.9670101650145;6643;6650.833729156713;5709.7716091356715;5722.484976352148;5790.623609465371;5813.534917206698;5821.446962538552;5598.468145526169;5705.315362156568;5723;5782.826515204551;5858.443447872445;6339.207599050119;6426.1003459515705;6429.357064293533;6430.80707578764;6444.355564443518;6555.115059466911;6572.901406478811;6573.112629795108;6664.5334826561675;6671.766488172891;6145.508359331332;6237.282712488122;6337.017762246859;6396.392342727433;6424.13274207976;6462.870742585216;6480.708368123352;6523.543351965317;6527.51043671717;6541.215054193527;6544.116544266463;6560.573562718408;6655.966720166368;6675.632840193836;6699.162604674416;6221.782237621662;6258.280297765815;6380.7447702091395;6419.293877673359;6425.421712045938;6277.811665650038;6324.051392291193;6416.294207637063;6420.6468644225015;6429.38920802523;6217.067439884054;6317.147185129948;6356.77751278703;6386.840328991627;6396.616203027833;6273.435390814849;6408.58344207625;6491.383318584727;6533.150690410406;6539.11721917535;6145.877082458415;6205.565610407228;6207.503399727921;6208.534359922934;6300.369963003663 04:04:14 INFO - PID 27238 | |1;ext.html;823.1480417767608;853.0616322045748;882.4925667741051;891.5631340643083;1157.4733496259203;29433.2641683958;30466.238344041383;39862.402063969064;40704.38943415851;40881.18237635245;40869.38695919556;41597.376039359355;41681.166376672445;41747.37378939311;41814;7111;7558.697652093923;7694.192109828471;7719.305262526372;7768.145503994584;7605;7707.499012564193;7715.344195743369;7716.074071111474;7718.189590093044;7690.2694244046725;7730.420218483609;7730.574818384986;7734.381249500055;7735.7679269622;7671.386289096887;7704.768856934301;7711.537307761524;7717.614119294069;7719.72980945667;7620.047494063242;7632.961835190844;7638.1979892111085;7678.961605191938;7689.154193038761;37963;38162;38271.42592861109;38281;38424.61575384239;3492.6681965213265;3521.9471707924404;3522.330757156132;3527.894163175109;3529.2588556403184;30850.845745771352;30915.690843091506;31014.379712405625;31035.22411939697;31069;4838.685485443435;4884.804607815683;4920.532549407801;4939.481354457766;4956.281339205831;182591;182947;183068;184601;185599;48191.03617927622;48239.51760482421;48288.5171148284;48370.758146209744;48396.7580162104;50781.492185078416;50900.74549627302;50929.74535127375;50957.490425095275;50986.49013509892;13908.095973761672;14155.29223538819;14197.077189982618;14220;14224.359903804354;10729.088027517748;11141.331520108819;11199.72000699989;11465.942670286595;11934.761304773856;14274.787407951577;14275.14349139055;14278.500252491112;14288.714225715428;14441.277936103153;5787.2476578045425;5865.530757539472;5925.644461332334;5937.287525496881;5952.642841429528;964;976.7606936300651;982.4252812104999;1008.4201584089178;1014.7310962594918;22072.2274720384;22089.668654970188;22230.444238894157;22256.109755609596;22597.322080337617;1073.6456969200144;1084.810158222308;1097.9670609881716;1099.290957332516;1100.0869278498988;11867.287962722092;11938.522459101712;11963.940180299043;11975.221610595458;11999.400029998465;219320;221051;221519;221779;221946;52659.47340526546;52886;53168;53411.19883201755;53438.73280633572;1413.8798202152727;1465.6482444213311;1469.713405885842;1473.6757913258853;1485.5023567104924;21152.682709759058;21381.786182138603;21671.783282167606;21869.562608748056;22361.77638223597;36177.45733814048;36437.817810910776;36442;36494.8175259122;36510.8174459126;190624;191742;192421;192748;193062.03468982564;31805;33096.1725956853;33100.66899330976;33412.33175336528;33514.83242583772;41320.586794131676;41513.37729934114;41628.1674366517;42075.7896210517;42142;29881.70118298789;30845.691543084282;30948.845255773576;31190.376192476477;31303.68696313099;29842.403151937273;30000.399992000475;30158.095257141442;30182.84908575443;30975.84512077425;34457.655423445445;34602.307953841286;34656.306873862886;34753.82623086868;34878;28257.71742282551;29034;29831;30471.08586742401;30566.84716576403;21968.340949770893;23052.654210186523;23262.883685581462;23426.18008369699;23725.762742372357 04:04:14 INFO - PID 27238 | |2;jquery.html;574.7729646789518;576.8125359258242;583.1078449971545;583.8832233553288;607.4714997951781;21781.128754849808;22512.54974900501;22783.430414239654;22803.201887933905;22822;25168.496630067435;25883.74116258837;25896.482070358583;25925.740742592567;25993.350166245855;6514.967425162879;6674.1323627928305;6674.399304062634;6675.966620166892;6676.532642715012;5724.141378793172;6026.728797204137;6246.875062498747;6282.371762823704;6300.905486417708;6258.4680302174365;6272.466840318579;6279.623222606659;6291.748330066792;6294.181756371689;6265.71804268809;6289.119523266746;6291.150694656231;6298.02380631003;6301.590396624228;5836.445537673914;5848.561357898175;5857.589968702193;5858.794942177004;5871.442212989759;28143.155705328874;29343.853280733674;29982;30425.087247382613;30702;1916.290972340229;1919.424172748184;1940.505171181354;1953.687410014391;1954.3257576136211;18685.439436816916;20716.274930377363;21718.23986160477;21739.456513587127;21853.67219491709;2477.826552141351;2492.763187497185;2547.38862672959;2549.872506374674;2568.114000669766;137369.3131534346;140244;141101;145510.27244863813;152254.23872880565;21574.78425215759;22449;22463.775362246495;22728.863556822093;23604.409889752893;44506.777466112464;44810.77594612071;44934;45015.54984450113;45098.32352514715;10465.581376744996;10501.684949451528;10508.264421490576;10722.624708135178;10761.730956726144;8273.46222495536;8381.497110173286;8424.4945303282;8578.356623253156;8596.828063438696;10458.633947811943;11507.712307192387;11623.76752464946;11700.414979251003;11714.824277635842;3846.288436639231;4018.819153138057;4079.73481723687;4088.7546747195265;4558.566936141127;963.6579014449769;966.7824739433571;974.7222041718218;975.6877799104218;994.0854413939194;19882.70175947362;20012.799872001386;20039.59920801576;20573.89713051455;23265.883670581537;993.5876611206269;1014.832552628808;1035.570238351091;1042.4735508568124;1044.4307852220559;11028.28316159447;11393.86061393854;11490.712732181595;11759.88240117605;13077.607671769862;509500;511877;516978;546715;551581;116971;120439.39780301042;121772.39113804375;122152;122628;1233.9136260461682;1246.5512415530402;1282.8396450443695;1298.1107941060404;1305.1646945954597;20242.696359554913;20317.49206269796;20926.058327375;21701;22186.55626887421;57885.421145788;58875;59738.70130649319;60146.69926650514;61878.0718289235;69231.65384173047;69956.65021674859;70560.64719676369;70663.29336706568;70669.64665176641;12490.375481225721;12880;14973.775393369326;15123;15539.766903496682;23726.406839829142;23904;24009.159679411136;24011.75988240095;24149.51700966006;19008.14463349125;19176;19400.932948687958;19505.12226949819;19515.707264390763;12585.87414125847;13048.934755326163;13240.602781916557;14393.424263029361;15878.364865405254;15032.173230472428;15051.849481505045;15098.39606415731;15187.164705940837;15538.61153471127;13829.239391833546;14452.927735361256;14527.636809079857;14530.418783248551;15026.398944042554;19118.713219302;19206.327778527684;19239;19240.23039078421;19320 04:04:14 INFO - PID 27238 | |3;mootools.html;1391.6173052410586;1433.8064361311226;1461.605366551031;1471.3231913319878;1476.9187694676802;13545.390457429414;13641.181529108248;14175.78736318956;14228.07517511361;14235.359408826602;14409.711805763905;14742.41030358787;14746.778798318033;14756.704865902675;14758;2641.960370594443;2682.141714651312;2698.0421950207688;2704.4591081783624;2705.4318593095472;2600.804939629526;2652.3103992961774;2687.9596806047825;2690.6905705843783;2697.406570554475;2594.8443093414458;2622.7901767858525;2653.0183831982195;2707.1743118348895;2709.105995021638;2563.3591602099477;2596.883140258693;2616.1105224223666;2622.3313055171;2631.855247961371;2523.5079159563893;2550.910718124857;2552.055739376424;2557.654716613252;2559.398541342783;13774.862251377459;13871.930640346834;13983.930080349635;13998.440062397594;14003.64990875226;7416.517926334771;7749.263819937097;7782.571958542278;7792.025996750406;7803.492772969739;4940.135476291671;5023.547880690719;5039.596832253447;5180.171172612401;5200.8959820803375;1870.5978214683773;1879.20133943075;1883.5479484923658;1916.8466522678152;1942.6114777044506;22146.88926555373;22268.55045944945;22480.55038899229;22928.885355573282;24109.758902410926;6292.528060395489;6434.324395938453;6541.803745887631;6619.966900165468;6666.533342665967;15763.448279310398;15976.76034859478;15984.920075399548;16030.75953860693;16329.34682612706;7393.704251829974;7591.164971853092;7615.619219039026;7624.161342252348;7629.923700763033;6881.965590172017;7035.261297563785;7068.187158476738;7282.417406607458;7312.1956584775635;4782.545658162469;4908.607311415079;4934.358533390637;4938.753062346868;4962.131626965267;1394.471985875736;1402.0536138106738;1409.4573589168244;1439.0574173916102;1442.4662874736414;760.9619519024027;779.8089468080357;786.6735304848423;807.7132617920671;817.5258350156895;6592.604443733391;6822.897656535156;6888.931110688929;6891.3797758202;6909.827254318581;682.6450245872119;731.8984927683802;972.0765272990687;996.9750756231152;1000.8048430555972;4889.095517329305;4962.181240095344;4978.5768209701855;5186.5850731941355;5208.635395522353;18046.187921543562;19277.80722192788;19476.4157075288;19541.218351266074;19670.40988770339;18142.183601737954;18361.265549377877;18516.444506664822;18522.722159167624;18544.629107417775;10768;10778.4071876046;10956.068734157687;10996.615118470816;11013.229073964745;7366.300201480851;7995.760127196193;8138.511689298661;8207.097219305751;8211.05572859129;16190.514284571482;16470.341186352412;16634.50096497107;16937.661246774747;17150.056746879043;17107.828921711123;17229.483115506555;17432;17444.47666570005;17781.644367112844;11236;11583;11627.6511704649;11642.94178529102;11651.184417090722;13045.217286962812;13181.604551863076;13192.142510736772;13230.735385292048;13247.337633118113;10190.490475476345;10743.24797264184;10790.568377265135;11076.612318568812;11325.773484530428;9322.347435679709;9660.468674222704;9825.16486098661;9864.802703946025;10008.64969726056;9441.197498212729;9487.241020718464;9565.091316324939;9566.330356874952;9870.309078364733;6788.864222715617;6807.081044059187;6956.5478243913985;7066.929330706627;7204.171520275026;6815.386615204656;6969.58182509051;7008.7546935857;7116.146062472537;7228.385587224934 04:04:14 INFO - PID 27238 | |4;prototype.html;489.91841318109084;490.0522331122718;526.815614534913;528.2577977940991;531.2138035707153;6108.20593322868;6112.358202388752;6117.327094019665;6143.477804386622;6221.129041934121;5800.883982320362;5950.880982380349;6019.759209631609;6041.275046994367;6060.21217241759;4884.2172606998365;4913.385826771653;4942.3327850740225;4949.2328689053165;4977.427595826472;4830.9033819323595;4866.7566621668775;4913.06651736169;4939.185034469308;4964.4787297333805;4691.390119284488;4778.235482322829;4841.329741239267;4861.246506791453;4870.464248932614;4846.151923413388;4848.369711937461;4858.878528036792;4874.049560335736;4877.439094504142;4349.238883195429;4397.186520493687;4400.603945644907;4415.955840441587;4421.65139632412;5926.436988486087;5976.820695379146;5984.281886173643;6054.788082417138;6071.332153463116;5559.471850174227;5592.720363981825;5593.272874526327;5616.550675945915;5660.886782264372;6345.555811093225;6347.936520634781;6370.375554233641;6402.647854368008;6404.48764098871;4774.307725379836;4774.856754297377;4775.188218002913;4803.447603525605;4825.4933232010835;6660.600363978177;6714.597124172566;6782.626955517445;6787.423069039138;6833.180018397824;4839.935214252859;4930.827421040246;4950.8762280943265;4950.975245123751;4970.72661003641;5020;5021.623378246646;5038.571721403721;5049;5052;5482.945170548323;5571.777128914798;5576.498115169654;5584.190292407659;5625.38120806711;6300.527460440485;6323.30443651198;6373.852706512779;6406.583572067801;6410.903836442457;1646.2838665180445;1685.5196269063258;1702.4381953955165;1706.5648259693698;1731.437282883068;1203.6389083274983;1212.7453234820787;1218.6831423829867;1225.4607972492074;1225.6139316115396;5638.718064096861;5656.377798442168;5683.232763576947;5698.800541981093;5730.049024752256;6393.968030159913;6466.288708242089;6492.747250550897;6553.737850486023;6572.441342485942;5617.662940223599;5635.154726791015;5688.857778555569;5688.9715551422805;5713.571482138773;3423.3153369325737;3491.3715531204625;3522.1370764162943;3527.7883327000463;3534.6111927687934;6300.842478938063;6415.903761443582;6429.164208652845;6451.516136289703;6458.257300410419;6698.39714425704;6731.2932142125355;6736.8989465158065;6780.762348425008;6807.761728339583;6287.30839607652;6303;6362.618242905441;6436.163298771224;6445.355464453611;6395.616263024233;6452.193475815523;6471.644059576768;6523;6641.867162656817;6500.749625187406;6518.967405162944;6551.344865513411;6560.639164845979;6577.901331479936;6298.71655775482;6314.052892066226;6315.326658272937;6316.905246421215;6348.936510634834;4902.7202350907;4951.5791157750555;4969.850904472872;4971.428285747185;4983.975080124576;6552.901706474502;6560.245571759308;6588.472922166311;6612.8346791330605;6655.700493477708;6366.840828979312;6367;6409.71156297977;6431.678416079271;6481.944083614788;6017.209158230286;6346.397092276226;6404.327545607644;6416.903746443713;6463.967680161569;6085.661154545993;6239.563230573998;6251.6874156292915;6268.937310626835;6367.490600751836;6344.777932772331;6450.355354304713;6469.967650161719;6477.384648458389;6520.119783829123;6084.665343405978;6201.379862013762;6217;6219;6230.844228894314 04:04:14 INFO - PID 27238 | |5;yui.html;904.3443503459993;904.4754042655261;923.2383283790874;926.3885835348672;932.463833295855;18360.35738749144;19356.12897419616;19390.90304548477;19448;20927.9536023199;20385;21512.8924355378;21529.354119376403;21601.45996350092;21749.782502174974;1036.7045392063244;1066.9093127084207;1073.6349641122056;1074.8387741838708;1076.1122074288703;1057.6562617149418;1069.1126365116934;1069.1446842525986;1072.2494254022176;1072.8390741388775;1057.2282233969206;1104.2932523185168;1110.3282514078987;1110.9222354435192;1117.1286396610656;1097.4457898761075;1099.8680158380967;1101.5869049106584;1105.0054950544493;1107.4905543449981;801.863683173856;804.6298702596813;805.005817814998;805.138501803071;805.4160733468248;17207.225674844663;17686.469405917844;18055.638887222183;18087.366942157092;18151.818481815277;20440.08019639105;20583.8970805145;20779.64932279397;21054;21091.15635374583;15699.37202511898;15846.76229856553;15985.120818354986;16045.117518536475;16092.75860862088;3574.0528759878653;3587.5336206293014;3596.7122630189524;3597.0467826026124;3601.657842504958;112831;118078;119428;120585.39707301494;122961;15570.377184912477;16427.425040123537;16471.094089825176;16474.258658360402;16486;29725;30155.547666785016;30194;30194.54708179379;30242.697573024427;7236.312550307713;7365.447591430664;8280.58597070144;8371.162883711702;8708.390412671051;3899.3760998240145;4028.274910516135;4036.4348991141264;4042.4542686737504;4054.351303791379;5145.331106956147;5236.816711415082;5272.6836389816735;5285.180796976475;5328.200769884548;986.4574484033752;1002;1010.1060561403211;1013.6756238003916;1014.6651604970342;680.0547239337325;680.4590350671228;680.9931900681029;705.4603228530178;706.2407911495163;11708;12164.635060948185;13050.412731427108;13532.526361577495;14175.078619889675;672.5191488086042;688.3976520544524;704.9436045116379;708.5536112249353;720.1394333771093;5481.616286859881;5530.972345138249;5608.635438696471;5690.4025077367105;5810.854728631733;95408.52295738478;96815;100486;103332.48333758283;104686;89751.55124224468;90862.54568727114;93539;96105.51947240219;96679;71562;76134;76174.23825761782;77019.22980770233;77742.2225777735;10406.479676016017;10733.141348692243;10775.353478791298;10863.619773307897;10929.781404372026;33334.66665333413;34534.30931381308;35558.28883422369;36291.27417451689;36897;43392;46209.60646296576;47158;47684.7615761919;48584.271235932196;16273.349066037226;16339.918300408423;16383.098929558988;16409.425670101966;16696;17509.299628014738;17510.212040457955;17523.649527009642;17587.912060439616;17651.205695743978;16108.838911611203;16115.516534503984;16168.67662646764;16313.59216019609;16336.754948676016;16008.439704610282;16040.598985025468;16079.839201607834;16099.436519722221;16122.838771612604;15343.846561534241;15347.846521534642;15439.459618913284;15550.144742039296;15608.375664973728;11662;11758.470868810753;12376.62870113898;12455.128141030042;12844.639603309764;12246.938765306117;12551;12615.873841261837;12724.618261452171;12725.681857953625 04:04:14 INFO - PID 27238 | __end_tp_report 04:04:14 INFO - PID 27238 | __start_cc_report 04:04:14 INFO - PID 27238 | _x_x_mozilla_cycle_collect,389 04:04:14 INFO - PID 27238 | __end_cc_report 04:04:14 INFO - PID 27238 | __startTimestamp1500807854348__endTimestamp 04:04:14 INFO - PID 27238 | 04:04:14 INFO - PID 27238 | ------- Summary: start ------- 04:04:14 INFO - PID 27238 | Number of tests: 6 04:04:14 INFO - PID 27238 | 04:04:14 INFO - PID 27238 | [#0] dojo.html Cycles:165 Average:6027.62 Median:6229.66 stddev:702.53 (11.3%) stddev-sans-first:664.78 04:04:14 INFO - PID 27238 | Values: 3052.2 3106.6 3169.4 3179.7 3215.3 6035.3 6196.6 6216.2 6227.8 6229.7 5822.1 5987.7 6005.4 6012.0 6015.2 5454.5 5462.6 5467.8 5477.5 5509.2 5553.1 5602.1 5607.6 5616.2 5628.5 5576.9 5598.4 5672.3 5678.2 5694.4 5408.7 5469.4 5507.1 5512.0 5592.0 5534.5 5557.9 5619.0 5627.4 5634.7 6032.7 6042.0 6142.0 6144.2 6163.6 6306.9 6419.4 6481.1 6615.2 6619.8 6546.2 6608.7 6652.3 6659.6 6674.7 6105.1 6124.1 6155.3 6168.5 6181.6 6548.8 6635.2 6749.7 6766.5 6843.8 6317.5 6392.4 6401.7 6405.1 6405.7 6411.5 6415.3 6478.0 6519.1 6530.0 6221.6 6325.6 6346.9 6392.8 6402.0 6496.4 6538.0 6597.3 6603.0 6631.5 5303.3 5375.0 5381.9 5382.7 5396.7 4463.8 4548.2 4549.3 4564.7 4615.0 5689.7 5708.9 5791.4 5806.3 5850.9 6538.0 6541.1 6598.0 6643.0 6650.8 5709.8 5722.5 5790.6 5813.5 5821.4 5598.5 5705.3 5723.0 5782.8 5858.4 6339.2 6426.1 6429.4 6430.8 6444.4 6555.1 6572.9 6573.1 6664.5 6671.8 6145.5 6237.3 6337.0 6396.4 6424.1 6462.9 6480.7 6523.5 6527.5 6541.2 6544.1 6560.6 6656.0 6675.6 6699.2 6221.8 6258.3 6380.7 6419.3 6425.4 6277.8 6324.1 6416.3 6420.6 6429.4 6217.1 6317.1 6356.8 6386.8 6396.6 6273.4 6408.6 6491.4 6533.2 6539.1 6145.9 6205.6 6207.5 6208.5 6300.4 04:04:14 INFO - PID 27238 | 04:04:14 INFO - PID 27238 | [#1] ext.html Cycles:180 Average:36352.31 Median:34529.98 stddev:51752.53 (149.9%) stddev-sans-first:51828.95 04:04:14 INFO - PID 27238 | Values: 823.1 853.1 882.5 891.6 1157.5 29433.3 30466.2 39862.4 40704.4 40881.2 40869.4 41597.4 41681.2 41747.4 41814.0 7111.0 7558.7 7694.2 7719.3 7768.1 7605.0 7707.5 7715.3 7716.1 7718.2 7690.3 7730.4 7730.6 7734.4 7735.8 7671.4 7704.8 7711.5 7717.6 7719.7 7620.0 7633.0 7638.2 7679.0 7689.2 37963.0 38162.0 38271.4 38281.0 38424.6 3492.7 3521.9 3522.3 3527.9 3529.3 30850.8 30915.7 31014.4 31035.2 31069.0 4838.7 4884.8 4920.5 4939.5 4956.3 182591.0 182947.0 183068.0 184601.0 185599.0 48191.0 48239.5 48288.5 48370.8 48396.8 50781.5 50900.7 50929.7 50957.5 50986.5 13908.1 14155.3 14197.1 14220.0 14224.4 10729.1 11141.3 11199.7 11465.9 11934.8 14274.8 14275.1 14278.5 14288.7 14441.3 5787.2 5865.5 5925.6 5937.3 5952.6 964.0 976.8 982.4 1008.4 1014.7 22072.2 22089.7 22230.4 22256.1 22597.3 1073.6 1084.8 1098.0 1099.3 1100.1 11867.3 11938.5 11963.9 11975.2 11999.4 219320.0 221051.0 221519.0 221779.0 221946.0 52659.5 52886.0 53168.0 53411.2 53438.7 1413.9 1465.6 1469.7 1473.7 1485.5 21152.7 21381.8 21671.8 21869.6 22361.8 36177.5 36437.8 36442.0 36494.8 36510.8 190624.0 191742.0 192421.0 192748.0 193062.0 31805.0 33096.2 33100.7 33412.3 33514.8 41320.6 41513.4 41628.2 42075.8 42142.0 29881.7 30845.7 30948.8 31190.4 31303.7 29842.4 30000.4 30158.1 30182.8 30975.8 34457.7 34602.3 34656.3 34753.8 34878.0 28257.7 29034.0 29831.0 30471.1 30566.8 21968.3 23052.7 23262.9 23426.2 23725.8 04:04:14 INFO - PID 27238 | 04:04:14 INFO - PID 27238 | [#2] jquery.html Cycles:180 Average:37099.81 Median:22812.60 stddev:88632.32 (388.5%) stddev-sans-first:88838.53 04:04:14 INFO - PID 27238 | Values: 574.8 576.8 583.1 583.9 607.5 21781.1 22512.5 22783.4 22803.2 22822.0 25168.5 25883.7 25896.5 25925.7 25993.4 6515.0 6674.1 6674.4 6676.0 6676.5 5724.1 6026.7 6246.9 6282.4 6300.9 6258.5 6272.5 6279.6 6291.7 6294.2 6265.7 6289.1 6291.2 6298.0 6301.6 5836.4 5848.6 5857.6 5858.8 5871.4 28143.2 29343.9 29982.0 30425.1 30702.0 1916.3 1919.4 1940.5 1953.7 1954.3 18685.4 20716.3 21718.2 21739.5 21853.7 2477.8 2492.8 2547.4 2549.9 2568.1 137369.3 140244.0 141101.0 145510.3 152254.2 21574.8 22449.0 22463.8 22728.9 23604.4 44506.8 44810.8 44934.0 45015.5 45098.3 10465.6 10501.7 10508.3 10722.6 10761.7 8273.5 8381.5 8424.5 8578.4 8596.8 10458.6 11507.7 11623.8 11700.4 11714.8 3846.3 4018.8 4079.7 4088.8 4558.6 963.7 966.8 974.7 975.7 994.1 19882.7 20012.8 20039.6 20573.9 23265.9 993.6 1014.8 1035.6 1042.5 1044.4 11028.3 11393.9 11490.7 11759.9 13077.6 509500.0 511877.0 516978.0 546715.0 551581.0 116971.0 120439.4 121772.4 122152.0 122628.0 1233.9 1246.6 1282.8 1298.1 1305.2 20242.7 20317.5 20926.1 21701.0 22186.6 57885.4 58875.0 59738.7 60146.7 61878.1 69231.7 69956.7 70560.6 70663.3 70669.6 12490.4 12880.0 14973.8 15123.0 15539.8 23726.4 23904.0 24009.2 24011.8 24149.5 19008.1 19176.0 19400.9 19505.1 19515.7 12585.9 13048.9 13240.6 14393.4 15878.4 15032.2 15051.8 15098.4 15187.2 15538.6 13829.2 14452.9 14527.6 14530.4 15026.4 19118.7 19206.3 19239.0 19240.2 19320.0 04:04:14 INFO - PID 27238 | 04:04:14 INFO - PID 27238 | [#3] mootools.html Cycles:180 Average:8643.83 Median:2608.46 stddev:5904.04 (226.3%) stddev-sans-first:5895.46 04:04:14 INFO - PID 27238 | Values: 1391.6 1433.8 1461.6 1471.3 1476.9 13545.4 13641.2 14175.8 14228.1 14235.4 14409.7 14742.4 14746.8 14756.7 14758.0 2642.0 2682.1 2698.0 2704.5 2705.4 2600.8 2652.3 2688.0 2690.7 2697.4 2594.8 2622.8 2653.0 2707.2 2709.1 2563.4 2596.9 2616.1 2622.3 2631.9 2523.5 2550.9 2552.1 2557.7 2559.4 13774.9 13871.9 13983.9 13998.4 14003.6 7416.5 7749.3 7782.6 7792.0 7803.5 4940.1 5023.5 5039.6 5180.2 5200.9 1870.6 1879.2 1883.5 1916.8 1942.6 22146.9 22268.6 22480.6 22928.9 24109.8 6292.5 6434.3 6541.8 6620.0 6666.5 15763.4 15976.8 15984.9 16030.8 16329.3 7393.7 7591.2 7615.6 7624.2 7629.9 6882.0 7035.3 7068.2 7282.4 7312.2 4782.5 4908.6 4934.4 4938.8 4962.1 1394.5 1402.1 1409.5 1439.1 1442.5 761.0 779.8 786.7 807.7 817.5 6592.6 6822.9 6888.9 6891.4 6909.8 682.6 731.9 972.1 997.0 1000.8 4889.1 4962.2 4978.6 5186.6 5208.6 18046.2 19277.8 19476.4 19541.2 19670.4 18142.2 18361.3 18516.4 18522.7 18544.6 10768.0 10778.4 10956.1 10996.6 11013.2 7366.3 7995.8 8138.5 8207.1 8211.1 16190.5 16470.3 16634.5 16937.7 17150.1 17107.8 17229.5 17432.0 17444.5 17781.6 11236.0 11583.0 11627.7 11642.9 11651.2 13045.2 13181.6 13192.1 13230.7 13247.3 10190.5 10743.2 10790.6 11076.6 11325.8 9322.3 9660.5 9825.2 9864.8 10008.6 9441.2 9487.2 9565.1 9566.3 9870.3 6788.9 6807.1 6956.5 7066.9 7204.2 6815.4 6969.6 7008.8 7116.1 7228.4 04:04:14 INFO - PID 27238 | 04:04:14 INFO - PID 27238 | [#4] prototype.html Cycles:180 Average:5396.56 Median:6018.48 stddev:1505.35 (25.0%) stddev-sans-first:1463.83 04:04:14 INFO - PID 27238 | Values: 489.9 490.1 526.8 528.3 531.2 6108.2 6112.4 6117.3 6143.5 6221.1 5800.9 5950.9 6019.8 6041.3 6060.2 4884.2 4913.4 4942.3 4949.2 4977.4 4830.9 4866.8 4913.1 4939.2 4964.5 4691.4 4778.2 4841.3 4861.2 4870.5 4846.2 4848.4 4858.9 4874.0 4877.4 4349.2 4397.2 4400.6 4416.0 4421.7 5926.4 5976.8 5984.3 6054.8 6071.3 5559.5 5592.7 5593.3 5616.6 5660.9 6345.6 6347.9 6370.4 6402.6 6404.5 4774.3 4774.9 4775.2 4803.4 4825.5 6660.6 6714.6 6782.6 6787.4 6833.2 4839.9 4930.8 4950.9 4951.0 4970.7 5020.0 5021.6 5038.6 5049.0 5052.0 5482.9 5571.8 5576.5 5584.2 5625.4 6300.5 6323.3 6373.9 6406.6 6410.9 1646.3 1685.5 1702.4 1706.6 1731.4 1203.6 1212.7 1218.7 1225.5 1225.6 5638.7 5656.4 5683.2 5698.8 5730.0 6394.0 6466.3 6492.7 6553.7 6572.4 5617.7 5635.2 5688.9 5689.0 5713.6 3423.3 3491.4 3522.1 3527.8 3534.6 6300.8 6415.9 6429.2 6451.5 6458.3 6698.4 6731.3 6736.9 6780.8 6807.8 6287.3 6303.0 6362.6 6436.2 6445.4 6395.6 6452.2 6471.6 6523.0 6641.9 6500.7 6519.0 6551.3 6560.6 6577.9 6298.7 6314.1 6315.3 6316.9 6348.9 4902.7 4951.6 4969.9 4971.4 4984.0 6552.9 6560.2 6588.5 6612.8 6655.7 6366.8 6367.0 6409.7 6431.7 6481.9 6017.2 6346.4 6404.3 6416.9 6464.0 6085.7 6239.6 6251.7 6268.9 6367.5 6344.8 6450.4 6470.0 6477.4 6520.1 6084.7 6201.4 6217.0 6219.0 6230.8 04:04:14 INFO - PID 27238 | 04:04:14 INFO - PID 27238 | [#5] yui.html Cycles:180 Average:21579.67 Median:18119.59 stddev:29136.49 (160.8%) stddev-sans-first:29176.86 04:04:14 INFO - PID 27238 | Values: 904.3 904.5 923.2 926.4 932.5 18360.4 19356.1 19390.9 19448.0 20928.0 20385.0 21512.9 21529.4 21601.5 21749.8 1036.7 1066.9 1073.6 1074.8 1076.1 1057.7 1069.1 1069.1 1072.2 1072.8 1057.2 1104.3 1110.3 1110.9 1117.1 1097.4 1099.9 1101.6 1105.0 1107.5 801.9 804.6 805.0 805.1 805.4 17207.2 17686.5 18055.6 18087.4 18151.8 20440.1 20583.9 20779.6 21054.0 21091.2 15699.4 15846.8 15985.1 16045.1 16092.8 3574.1 3587.5 3596.7 3597.0 3601.7 112831.0 118078.0 119428.0 120585.4 122961.0 15570.4 16427.4 16471.1 16474.3 16486.0 29725.0 30155.5 30194.0 30194.5 30242.7 7236.3 7365.4 8280.6 8371.2 8708.4 3899.4 4028.3 4036.4 4042.5 4054.4 5145.3 5236.8 5272.7 5285.2 5328.2 986.5 1002.0 1010.1 1013.7 1014.7 680.1 680.5 681.0 705.5 706.2 11708.0 12164.6 13050.4 13532.5 14175.1 672.5 688.4 704.9 708.6 720.1 5481.6 5531.0 5608.6 5690.4 5810.9 95408.5 96815.0 100486.0 103332.5 104686.0 89751.6 90862.5 93539.0 96105.5 96679.0 71562.0 76134.0 76174.2 77019.2 77742.2 10406.5 10733.1 10775.4 10863.6 10929.8 33334.7 34534.3 35558.3 36291.3 36897.0 43392.0 46209.6 47158.0 47684.8 48584.3 16273.3 16339.9 16383.1 16409.4 16696.0 17509.3 17510.2 17523.6 17587.9 17651.2 16108.8 16115.5 16168.7 16313.6 16336.8 16008.4 16040.6 16079.8 16099.4 16122.8 15343.8 15347.8 15439.5 15550.1 15608.4 11662.0 11758.5 12376.6 12455.1 12844.6 12246.9 12551.0 12615.9 12724.6 12725.7 04:04:14 INFO - PID 27238 | -------- Summary: end -------- 04:04:14 INFO - PID 27238 | 04:04:15 INFO - TEST-INFO | 27238: exit 0 04:04:15 INFO - TEST-OK | dromaeo_css | took 1113078ms 04:04:15 INFO - TEST-START | kraken 04:04:15 INFO - Initialising browser for kraken test... 04:04:15 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:34721/getInfo.html -profile /tmp/tmp8h9VwY/profile 04:04:15 INFO - TEST-INFO | started process 27617 (/builds/slave/test/build/application/firefox/firefox http://localhost:34721/getInfo.html) 04:04:20 INFO - TEST-INFO | 27617: exit 0 04:04:20 INFO - Browser initialized. 04:04:20 INFO - Running cycle 1/1 for kraken test... 04:04:20 INFO - TEST-INFO | started process 27844 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8h9VwY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 04:04:32 INFO - PID 27844 | RSS: Main: 176013312 04:04:32 INFO - PID 27844 | 04:04:34 INFO - PID 27844 | Cycle 1(1): loaded http://localhost:34721/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34721/tests/kraken/driver.html?testName=audio-beat-detection) 04:04:35 INFO - PID 27844 | RSS: Main: 179417088 04:04:35 INFO - PID 27844 | 04:04:38 INFO - PID 27844 | Cycle 1(1): loaded http://localhost:34721/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34721/tests/kraken/driver.html?testName=audio-dft) 04:04:39 INFO - PID 27844 | RSS: Main: 180371456 04:04:39 INFO - PID 27844 | 04:04:42 INFO - PID 27844 | Cycle 1(1): loaded http://localhost:34721/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34721/tests/kraken/driver.html?testName=audio-fft) 04:04:42 INFO - PID 27844 | RSS: Main: 174424064 04:04:42 INFO - PID 27844 | 04:04:44 INFO - PID 27844 | Cycle 1(1): loaded http://localhost:34721/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34721/tests/kraken/driver.html?testName=audio-oscillator) 04:04:45 INFO - PID 27844 | RSS: Main: 175865856 04:04:45 INFO - PID 27844 | 04:04:47 INFO - PID 27844 | Cycle 1(1): loaded http://localhost:34721/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34721/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:04:48 INFO - PID 27844 | RSS: Main: 175337472 04:04:48 INFO - PID 27844 | 04:04:51 INFO - PID 27844 | Cycle 1(1): loaded http://localhost:34721/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34721/tests/kraken/driver.html?testName=imaging-darkroom) 04:04:52 INFO - PID 27844 | RSS: Main: 177803264 04:04:52 INFO - PID 27844 | 04:04:55 INFO - PID 27844 | Cycle 1(1): loaded http://localhost:34721/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34721/tests/kraken/driver.html?testName=imaging-desaturate) 04:04:56 INFO - PID 27844 | RSS: Main: 177577984 04:04:56 INFO - PID 27844 | 04:04:59 INFO - PID 27844 | Cycle 1(1): loaded http://localhost:34721/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34721/tests/kraken/driver.html?testName=json-parse-financial) 04:04:59 INFO - PID 27844 | RSS: Main: 178114560 04:04:59 INFO - PID 27844 | 04:05:01 INFO - PID 27844 | Cycle 1(1): loaded http://localhost:34721/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34721/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:05:02 INFO - PID 27844 | RSS: Main: 178511872 04:05:02 INFO - PID 27844 | 04:05:03 INFO - PID 27844 | Cycle 1(1): loaded http://localhost:34721/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34721/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:05:04 INFO - PID 27844 | RSS: Main: 178581504 04:05:04 INFO - PID 27844 | 04:05:06 INFO - PID 27844 | Cycle 1(1): loaded http://localhost:34721/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34721/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:05:07 INFO - PID 27844 | RSS: Main: 179081216 04:05:07 INFO - PID 27844 | 04:05:09 INFO - PID 27844 | Cycle 1(1): loaded http://localhost:34721/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34721/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:05:10 INFO - PID 27844 | RSS: Main: 179367936 04:05:10 INFO - PID 27844 | 04:05:13 INFO - PID 27844 | Cycle 1(1): loaded http://localhost:34721/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34721/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:05:14 INFO - PID 27844 | RSS: Main: 179298304 04:05:14 INFO - PID 27844 | 04:05:16 INFO - PID 27844 | Cycle 1(1): loaded http://localhost:34721/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34721/tests/kraken/driver.html?testName=ai-astar) 04:05:16 INFO - PID 27844 | RSS: Main: 181784576 04:05:16 INFO - PID 27844 | 04:05:16 INFO - PID 27844 | __start_tp_report 04:05:16 INFO - PID 27844 | _x_x_mozilla_page_load 04:05:16 INFO - PID 27844 | _x_x_mozilla_page_load_details 04:05:16 INFO - PID 27844 | |i|pagename|runs| 04:05:16 INFO - PID 27844 | |0;ai-astar;100;109;105;109;109;112;113;102;114;112 04:05:16 INFO - PID 27844 | |1;audio-beat-detection;145;117;152;191;119;141;151;119;174;119 04:05:16 INFO - PID 27844 | |2;audio-dft;165;163;163;165;162;161;170;173;162;167 04:05:16 INFO - PID 27844 | |3;audio-fft;75;75;75;171;76;76;76;76;149;77 04:05:16 INFO - PID 27844 | |4;audio-oscillator;81;82;137;85;80;80;134;81;80;139 04:05:16 INFO - PID 27844 | |5;imaging-gaussian-blur;115;115;114;116;114;115;114;115;114;116 04:05:16 INFO - PID 27844 | |6;imaging-darkroom;153;152;150;150;152;151;150;152;150;150 04:05:16 INFO - PID 27844 | |7;imaging-desaturate;97;98;94;94;93;94;94;94;95;100 04:05:16 INFO - PID 27844 | |8;json-parse-financial;54;53;57;55;54;54;53;53;53;53 04:05:16 INFO - PID 27844 | |9;json-stringify-tinderbox;54;54;54;55;54;55;54;55;54;54 04:05:16 INFO - PID 27844 | |10;stanford-crypto-aes;77;79;79;78;80;78;78;80;78;82 04:05:16 INFO - PID 27844 | |11;stanford-crypto-ccm;126;146;126;129;126;127;141;130;128;160 04:05:16 INFO - PID 27844 | |12;stanford-crypto-pbkdf2;175;180;176;179;179;181;182;177;178;178 04:05:16 INFO - PID 27844 | |13;stanford-crypto-sha256-iterative;70;70;71;69;70;69;69;70;90;67 04:05:16 INFO - PID 27844 | __end_tp_report 04:05:16 INFO - PID 27844 | __start_cc_report 04:05:16 INFO - PID 27844 | _x_x_mozilla_cycle_collect,973 04:05:16 INFO - PID 27844 | __end_cc_report 04:05:16 INFO - PID 27844 | __startTimestamp1500807916438__endTimestamp 04:05:16 INFO - PID 27844 | 04:05:16 INFO - PID 27844 | ------- Summary: start ------- 04:05:16 INFO - PID 27844 | Number of tests: 14 04:05:16 INFO - PID 27844 | 04:05:16 INFO - PID 27844 | [#0] ai-astar Cycles:10 Average:108.50 Median:110.50 stddev:4.74 (4.3%) stddev-sans-first:3.91 04:05:16 INFO - PID 27844 | Values: 100.0 109.0 105.0 109.0 109.0 112.0 113.0 102.0 114.0 112.0 04:05:16 INFO - PID 27844 | 04:05:16 INFO - PID 27844 | [#1] audio-beat-detection Cycles:10 Average:142.80 Median:148.00 stddev:25.43 (17.2%) stddev-sans-first:26.96 04:05:16 INFO - PID 27844 | Values: 145.0 117.0 152.0 191.0 119.0 141.0 151.0 119.0 174.0 119.0 04:05:16 INFO - PID 27844 | 04:05:16 INFO - PID 27844 | [#2] audio-dft Cycles:10 Average:165.10 Median:165.00 stddev:3.87 (2.3%) stddev-sans-first:4.11 04:05:16 INFO - PID 27844 | Values: 165.0 163.0 163.0 165.0 162.0 161.0 170.0 173.0 162.0 167.0 04:05:16 INFO - PID 27844 | 04:05:16 INFO - PID 27844 | [#3] audio-fft Cycles:10 Average:92.60 Median:76.00 stddev:35.90 (47.2%) stddev-sans-first:37.51 04:05:16 INFO - PID 27844 | Values: 75.0 75.0 75.0 171.0 76.0 76.0 76.0 76.0 149.0 77.0 04:05:16 INFO - PID 27844 | 04:05:16 INFO - PID 27844 | [#4] audio-oscillator Cycles:10 Average:97.90 Median:80.50 stddev:26.82 (33.3%) stddev-sans-first:27.74 04:05:16 INFO - PID 27844 | Values: 81.0 82.0 137.0 85.0 80.0 80.0 134.0 81.0 80.0 139.0 04:05:16 INFO - PID 27844 | 04:05:16 INFO - PID 27844 | [#5] imaging-gaussian-blur Cycles:10 Average:114.80 Median:115.00 stddev:0.79 (0.7%) stddev-sans-first:0.83 04:05:16 INFO - PID 27844 | Values: 115.0 115.0 114.0 116.0 114.0 115.0 114.0 115.0 114.0 116.0 04:05:16 INFO - PID 27844 | 04:05:16 INFO - PID 27844 | [#6] imaging-darkroom Cycles:10 Average:151.00 Median:151.50 stddev:1.15 (0.8%) stddev-sans-first:0.97 04:05:16 INFO - PID 27844 | Values: 153.0 152.0 150.0 150.0 152.0 151.0 150.0 152.0 150.0 150.0 04:05:16 INFO - PID 27844 | 04:05:16 INFO - PID 27844 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:94.00 stddev:2.26 (2.4%) stddev-sans-first:2.32 04:05:16 INFO - PID 27844 | Values: 97.0 98.0 94.0 94.0 93.0 94.0 94.0 94.0 95.0 100.0 04:05:16 INFO - PID 27844 | 04:05:16 INFO - PID 27844 | [#8] json-parse-financial Cycles:10 Average:53.90 Median:54.00 stddev:1.29 (2.4%) stddev-sans-first:1.36 04:05:16 INFO - PID 27844 | Values: 54.0 53.0 57.0 55.0 54.0 54.0 53.0 53.0 53.0 53.0 04:05:16 INFO - PID 27844 | 04:05:16 INFO - PID 27844 | [#9] json-stringify-tinderbox Cycles:10 Average:54.30 Median:54.00 stddev:0.48 (0.9%) stddev-sans-first:0.50 04:05:16 INFO - PID 27844 | Values: 54.0 54.0 54.0 55.0 54.0 55.0 54.0 55.0 54.0 54.0 04:05:16 INFO - PID 27844 | 04:05:16 INFO - PID 27844 | [#10] stanford-crypto-aes Cycles:10 Average:78.90 Median:79.00 stddev:1.45 (1.8%) stddev-sans-first:1.36 04:05:16 INFO - PID 27844 | Values: 77.0 79.0 79.0 78.0 80.0 78.0 78.0 80.0 78.0 82.0 04:05:16 INFO - PID 27844 | 04:05:16 INFO - PID 27844 | [#11] stanford-crypto-ccm Cycles:10 Average:133.90 Median:129.50 stddev:11.48 (8.9%) stddev-sans-first:11.82 04:05:16 INFO - PID 27844 | Values: 126.0 146.0 126.0 129.0 126.0 127.0 141.0 130.0 128.0 160.0 04:05:16 INFO - PID 27844 | 04:05:16 INFO - PID 27844 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:178.50 Median:179.00 stddev:2.17 (1.2%) stddev-sans-first:1.90 04:05:16 INFO - PID 27844 | Values: 175.0 180.0 176.0 179.0 179.0 181.0 182.0 177.0 178.0 178.0 04:05:16 INFO - PID 27844 | 04:05:16 INFO - PID 27844 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.50 Median:70.00 stddev:6.59 (9.4%) stddev-sans-first:6.96 04:05:16 INFO - PID 27844 | Values: 70.0 70.0 71.0 69.0 70.0 69.0 69.0 70.0 90.0 67.0 04:05:16 INFO - PID 27844 | -------- Summary: end -------- 04:05:16 INFO - PID 27844 | 04:05:16 INFO - PID 27844 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 04:05:17 INFO - TEST-INFO | 27844: exit 0 04:05:17 INFO - TEST-OK | kraken | took 62146ms 04:05:17 INFO - SUITE-END | took 1175s 04:05:17 INFO - Completed test suite (00:19:35) 04:05:17 INFO - javascript benchmark 04:05:17 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8359.393553824648, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3052.221683470716, 3106.5961425014775, 3169.445347064264, 3179.697928696774, 3215.3247817958227, 6035.336113027563, 6196.628202307865, 6216.1918950536365, 6227.750889964396, 6229.657368844717, 5822.068469044953, 5987.700614969245, 6005.429484198994, 6012.0, 6015.248093988252, 5454.53636440903, 5462.562994960394, 5467.753951072192, 5477.452254774511, 5509.173623956399, 5553.111502159655, 5602.075657516505, 5607.635503692268, 5616.213730077792, 5628.521575666074, 5576.86057848553, 5598.384177740486, 5672.290963629546, 5678.205051292823, 5694.402087780765, 5408.702521361323, 5469.425710300441, 5507.0637991541535, 5512.035393806068, 5591.9720401397735, 5534.52956498694, 5557.944420555824, 5619.0, 5627.409122042168, 5634.7182640867795, 6032.728527216286, 6041.969790151021, 6142.04798256271, 6144.2319710036245, 6163.630182189038, 6306.936930630681, 6419.422251997343, 6481.125048118491, 6615.206175258952, 6619.801405957829, 6546.18172728409, 6608.702608382634, 6652.334766523358, 6659.63372014539, 6674.666266686646, 6105.114758360013, 6124.081387791867, 6155.322914479404, 6168.506519478521, 6181.567290289727, 6548.8035358939305, 6635.170603674541, 6749.662516874137, 6766.458683305324, 6843.760468383683, 6317.526185536103, 6392.4246817786625, 6401.743930242738, 6405.103285540028, 6405.711742971577, 6411.455026322815, 6415.262244841903, 6478.028295755675, 6519.119918810899, 6530.0, 6221.564490485713, 6325.620462772248, 6346.936530634727, 6392.808215753535, 6401.967990160112, 6496.382843629847, 6538.019297105472, 6597.30728273534, 6602.96698516514, 6631.535792494576, 5303.257543943851, 5374.978754036799, 5381.865453363619, 5382.703951282717, 5396.703181325065, 4463.754493502824, 4548.249538826123, 4549.27211646135, 4564.726116433025, 4614.97692511542, 5689.715514224355, 5708.942910570924, 5791.449812267828, 5806.332271788714, 5850.853728656818, 6538.0, 6541.116949211891, 6597.9670101650145, 6643.0, 6650.833729156713, 5709.7716091356715, 5722.484976352148, 5790.623609465371, 5813.534917206698, 5821.446962538552, 5598.468145526169, 5705.315362156568, 5723.0, 5782.826515204551, 5858.443447872445, 6339.207599050119, 6426.1003459515705, 6429.357064293533, 6430.80707578764, 6444.355564443518, 6555.115059466911, 6572.901406478811, 6573.112629795108, 6664.5334826561675, 6671.766488172891, 6145.508359331332, 6237.282712488122, 6337.017762246859, 6396.392342727433, 6424.13274207976, 6462.870742585216, 6480.708368123352, 6523.543351965317, 6527.51043671717, 6541.215054193527, 6544.116544266463, 6560.573562718408, 6655.966720166368, 6675.632840193836, 6699.162604674416, 6221.782237621662, 6258.280297765815, 6380.7447702091395, 6419.293877673359, 6425.421712045938, 6277.811665650038, 6324.051392291193, 6416.294207637063, 6420.6468644225015, 6429.38920802523, 6217.067439884054, 6317.147185129948, 6356.77751278703, 6386.840328991627, 6396.616203027833, 6273.435390814849, 6408.58344207625, 6491.383318584727, 6533.150690410406, 6539.11721917535, 6145.877082458415, 6205.565610407228, 6207.503399727921, 6208.534359922934, 6300.369963003663], "value": 5976.030519883665, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [823.1480417767608, 853.0616322045748, 882.4925667741051, 891.5631340643083, 1157.4733496259203, 29433.2641683958, 30466.238344041383, 39862.402063969064, 40704.38943415851, 40881.18237635245, 40869.38695919556, 41597.376039359355, 41681.166376672445, 41747.37378939311, 41814.0, 7111.0, 7558.697652093923, 7694.192109828471, 7719.305262526372, 7768.145503994584, 7605.0, 7707.499012564193, 7715.344195743369, 7716.074071111474, 7718.189590093044, 7690.2694244046725, 7730.420218483609, 7730.574818384986, 7734.381249500055, 7735.7679269622, 7671.386289096887, 7704.768856934301, 7711.537307761524, 7717.614119294069, 7719.72980945667, 7620.047494063242, 7632.961835190844, 7638.1979892111085, 7678.961605191938, 7689.154193038761, 37963.0, 38162.0, 38271.42592861109, 38281.0, 38424.61575384239, 3492.6681965213265, 3521.9471707924404, 3522.330757156132, 3527.894163175109, 3529.2588556403184, 30850.845745771352, 30915.690843091506, 31014.379712405625, 31035.22411939697, 31069.0, 4838.685485443435, 4884.804607815683, 4920.532549407801, 4939.481354457766, 4956.281339205831, 182591.0, 182947.0, 183068.0, 184601.0, 185599.0, 48191.03617927622, 48239.51760482421, 48288.5171148284, 48370.758146209744, 48396.7580162104, 50781.492185078416, 50900.74549627302, 50929.74535127375, 50957.490425095275, 50986.49013509892, 13908.095973761672, 14155.29223538819, 14197.077189982618, 14220.0, 14224.359903804354, 10729.088027517748, 11141.331520108819, 11199.72000699989, 11465.942670286595, 11934.761304773856, 14274.787407951577, 14275.14349139055, 14278.500252491112, 14288.714225715428, 14441.277936103153, 5787.2476578045425, 5865.530757539472, 5925.644461332334, 5937.287525496881, 5952.642841429528, 964.0, 976.7606936300651, 982.4252812104999, 1008.4201584089178, 1014.7310962594918, 22072.2274720384, 22089.668654970188, 22230.444238894157, 22256.109755609596, 22597.322080337617, 1073.6456969200144, 1084.810158222308, 1097.9670609881716, 1099.290957332516, 1100.0869278498988, 11867.287962722092, 11938.522459101712, 11963.940180299043, 11975.221610595458, 11999.400029998465, 219320.0, 221051.0, 221519.0, 221779.0, 221946.0, 52659.47340526546, 52886.0, 53168.0, 53411.19883201755, 53438.73280633572, 1413.8798202152727, 1465.6482444213311, 1469.713405885842, 1473.6757913258853, 1485.5023567104924, 21152.682709759058, 21381.786182138603, 21671.783282167606, 21869.562608748056, 22361.77638223597, 36177.45733814048, 36437.817810910776, 36442.0, 36494.8175259122, 36510.8174459126, 190624.0, 191742.0, 192421.0, 192748.0, 193062.03468982564, 31805.0, 33096.1725956853, 33100.66899330976, 33412.33175336528, 33514.83242583772, 41320.586794131676, 41513.37729934114, 41628.1674366517, 42075.7896210517, 42142.0, 29881.70118298789, 30845.691543084282, 30948.845255773576, 31190.376192476477, 31303.68696313099, 29842.403151937273, 30000.399992000475, 30158.095257141442, 30182.84908575443, 30975.84512077425, 34457.655423445445, 34602.307953841286, 34656.306873862886, 34753.82623086868, 34878.0, 28257.71742282551, 29034.0, 29831.0, 30471.08586742401, 30566.84716576403, 21968.340949770893, 23052.654210186523, 23262.883685581462, 23426.18008369699, 23725.762742372357], "value": 16702.070572560257, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [574.7729646789518, 576.8125359258242, 583.1078449971545, 583.8832233553288, 607.4714997951781, 21781.128754849808, 22512.54974900501, 22783.430414239654, 22803.201887933905, 22822.0, 25168.496630067435, 25883.74116258837, 25896.482070358583, 25925.740742592567, 25993.350166245855, 6514.967425162879, 6674.1323627928305, 6674.399304062634, 6675.966620166892, 6676.532642715012, 5724.141378793172, 6026.728797204137, 6246.875062498747, 6282.371762823704, 6300.905486417708, 6258.4680302174365, 6272.466840318579, 6279.623222606659, 6291.748330066792, 6294.181756371689, 6265.71804268809, 6289.119523266746, 6291.150694656231, 6298.02380631003, 6301.590396624228, 5836.445537673914, 5848.561357898175, 5857.589968702193, 5858.794942177004, 5871.442212989759, 28143.155705328874, 29343.853280733674, 29982.0, 30425.087247382613, 30702.0, 1916.290972340229, 1919.424172748184, 1940.505171181354, 1953.687410014391, 1954.3257576136211, 18685.439436816916, 20716.274930377363, 21718.23986160477, 21739.456513587127, 21853.67219491709, 2477.826552141351, 2492.763187497185, 2547.38862672959, 2549.872506374674, 2568.114000669766, 137369.3131534346, 140244.0, 141101.0, 145510.27244863813, 152254.23872880565, 21574.78425215759, 22449.0, 22463.775362246495, 22728.863556822093, 23604.409889752893, 44506.777466112464, 44810.77594612071, 44934.0, 45015.54984450113, 45098.32352514715, 10465.581376744996, 10501.684949451528, 10508.264421490576, 10722.624708135178, 10761.730956726144, 8273.46222495536, 8381.497110173286, 8424.4945303282, 8578.356623253156, 8596.828063438696, 10458.633947811943, 11507.712307192387, 11623.76752464946, 11700.414979251003, 11714.824277635842, 3846.288436639231, 4018.819153138057, 4079.73481723687, 4088.7546747195265, 4558.566936141127, 963.6579014449769, 966.7824739433571, 974.7222041718218, 975.6877799104218, 994.0854413939194, 19882.70175947362, 20012.799872001386, 20039.59920801576, 20573.89713051455, 23265.883670581537, 993.5876611206269, 1014.832552628808, 1035.570238351091, 1042.4735508568124, 1044.4307852220559, 11028.28316159447, 11393.86061393854, 11490.712732181595, 11759.88240117605, 13077.607671769862, 509500.0, 511877.0, 516978.0, 546715.0, 551581.0, 116971.0, 120439.39780301042, 121772.39113804375, 122152.0, 122628.0, 1233.9136260461682, 1246.5512415530402, 1282.8396450443695, 1298.1107941060404, 1305.1646945954597, 20242.696359554913, 20317.49206269796, 20926.058327375, 21701.0, 22186.55626887421, 57885.421145788, 58875.0, 59738.70130649319, 60146.69926650514, 61878.0718289235, 69231.65384173047, 69956.65021674859, 70560.64719676369, 70663.29336706568, 70669.64665176641, 12490.375481225721, 12880.0, 14973.775393369326, 15123.0, 15539.766903496682, 23726.406839829142, 23904.0, 24009.159679411136, 24011.75988240095, 24149.51700966006, 19008.14463349125, 19176.0, 19400.932948687958, 19505.12226949819, 19515.707264390763, 12585.87414125847, 13048.934755326163, 13240.602781916557, 14393.424263029361, 15878.364865405254, 15032.173230472428, 15051.849481505045, 15098.39606415731, 15187.164705940837, 15538.61153471127, 13829.239391833546, 14452.927735361256, 14527.636809079857, 14530.418783248551, 15026.398944042554, 19118.713219302, 19206.327778527684, 19239.0, 19240.23039078421, 19320.0], "value": 12591.218421760806, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1391.6173052410586, 1433.8064361311226, 1461.605366551031, 1471.3231913319878, 1476.9187694676802, 13545.390457429414, 13641.181529108248, 14175.78736318956, 14228.07517511361, 14235.359408826602, 14409.711805763905, 14742.41030358787, 14746.778798318033, 14756.704865902675, 14758.0, 2641.960370594443, 2682.141714651312, 2698.0421950207688, 2704.4591081783624, 2705.4318593095472, 2600.804939629526, 2652.3103992961774, 2687.9596806047825, 2690.6905705843783, 2697.406570554475, 2594.8443093414458, 2622.7901767858525, 2653.0183831982195, 2707.1743118348895, 2709.105995021638, 2563.3591602099477, 2596.883140258693, 2616.1105224223666, 2622.3313055171, 2631.855247961371, 2523.5079159563893, 2550.910718124857, 2552.055739376424, 2557.654716613252, 2559.398541342783, 13774.862251377459, 13871.930640346834, 13983.930080349635, 13998.440062397594, 14003.64990875226, 7416.517926334771, 7749.263819937097, 7782.571958542278, 7792.025996750406, 7803.492772969739, 4940.135476291671, 5023.547880690719, 5039.596832253447, 5180.171172612401, 5200.8959820803375, 1870.5978214683773, 1879.20133943075, 1883.5479484923658, 1916.8466522678152, 1942.6114777044506, 22146.88926555373, 22268.55045944945, 22480.55038899229, 22928.885355573282, 24109.758902410926, 6292.528060395489, 6434.324395938453, 6541.803745887631, 6619.966900165468, 6666.533342665967, 15763.448279310398, 15976.76034859478, 15984.920075399548, 16030.75953860693, 16329.34682612706, 7393.704251829974, 7591.164971853092, 7615.619219039026, 7624.161342252348, 7629.923700763033, 6881.965590172017, 7035.261297563785, 7068.187158476738, 7282.417406607458, 7312.1956584775635, 4782.545658162469, 4908.607311415079, 4934.358533390637, 4938.753062346868, 4962.131626965267, 1394.471985875736, 1402.0536138106738, 1409.4573589168244, 1439.0574173916102, 1442.4662874736414, 760.9619519024027, 779.8089468080357, 786.6735304848423, 807.7132617920671, 817.5258350156895, 6592.604443733391, 6822.897656535156, 6888.931110688929, 6891.3797758202, 6909.827254318581, 682.6450245872119, 731.8984927683802, 972.0765272990687, 996.9750756231152, 1000.8048430555972, 4889.095517329305, 4962.181240095344, 4978.5768209701855, 5186.5850731941355, 5208.635395522353, 18046.187921543562, 19277.80722192788, 19476.4157075288, 19541.218351266074, 19670.40988770339, 18142.183601737954, 18361.265549377877, 18516.444506664822, 18522.722159167624, 18544.629107417775, 10768.0, 10778.4071876046, 10956.068734157687, 10996.615118470816, 11013.229073964745, 7366.300201480851, 7995.760127196193, 8138.511689298661, 8207.097219305751, 8211.05572859129, 16190.514284571482, 16470.341186352412, 16634.50096497107, 16937.661246774747, 17150.056746879043, 17107.828921711123, 17229.483115506555, 17432.0, 17444.47666570005, 17781.644367112844, 11236.0, 11583.0, 11627.6511704649, 11642.94178529102, 11651.184417090722, 13045.217286962812, 13181.604551863076, 13192.142510736772, 13230.735385292048, 13247.337633118113, 10190.490475476345, 10743.24797264184, 10790.568377265135, 11076.612318568812, 11325.773484530428, 9322.347435679709, 9660.468674222704, 9825.16486098661, 9864.802703946025, 10008.64969726056, 9441.197498212729, 9487.241020718464, 9565.091316324939, 9566.330356874952, 9870.309078364733, 6788.864222715617, 6807.081044059187, 6956.5478243913985, 7066.929330706627, 7204.171520275026, 6815.386615204656, 6969.58182509051, 7008.7546935857, 7116.146062472537, 7228.385587224934], "value": 6287.421717016922, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [489.91841318109084, 490.0522331122718, 526.815614534913, 528.2577977940991, 531.2138035707153, 6108.20593322868, 6112.358202388752, 6117.327094019665, 6143.477804386622, 6221.129041934121, 5800.883982320362, 5950.880982380349, 6019.759209631609, 6041.275046994367, 6060.21217241759, 4884.2172606998365, 4913.385826771653, 4942.3327850740225, 4949.2328689053165, 4977.427595826472, 4830.9033819323595, 4866.7566621668775, 4913.06651736169, 4939.185034469308, 4964.4787297333805, 4691.390119284488, 4778.235482322829, 4841.329741239267, 4861.246506791453, 4870.464248932614, 4846.151923413388, 4848.369711937461, 4858.878528036792, 4874.049560335736, 4877.439094504142, 4349.238883195429, 4397.186520493687, 4400.603945644907, 4415.955840441587, 4421.65139632412, 5926.436988486087, 5976.820695379146, 5984.281886173643, 6054.788082417138, 6071.332153463116, 5559.471850174227, 5592.720363981825, 5593.272874526327, 5616.550675945915, 5660.886782264372, 6345.555811093225, 6347.936520634781, 6370.375554233641, 6402.647854368008, 6404.48764098871, 4774.307725379836, 4774.856754297377, 4775.188218002913, 4803.447603525605, 4825.4933232010835, 6660.600363978177, 6714.597124172566, 6782.626955517445, 6787.423069039138, 6833.180018397824, 4839.935214252859, 4930.827421040246, 4950.8762280943265, 4950.975245123751, 4970.72661003641, 5020.0, 5021.623378246646, 5038.571721403721, 5049.0, 5052.0, 5482.945170548323, 5571.777128914798, 5576.498115169654, 5584.190292407659, 5625.38120806711, 6300.527460440485, 6323.30443651198, 6373.852706512779, 6406.583572067801, 6410.903836442457, 1646.2838665180445, 1685.5196269063258, 1702.4381953955165, 1706.5648259693698, 1731.437282883068, 1203.6389083274983, 1212.7453234820787, 1218.6831423829867, 1225.4607972492074, 1225.6139316115396, 5638.718064096861, 5656.377798442168, 5683.232763576947, 5698.800541981093, 5730.049024752256, 6393.968030159913, 6466.288708242089, 6492.747250550897, 6553.737850486023, 6572.441342485942, 5617.662940223599, 5635.154726791015, 5688.857778555569, 5688.9715551422805, 5713.571482138773, 3423.3153369325737, 3491.3715531204625, 3522.1370764162943, 3527.7883327000463, 3534.6111927687934, 6300.842478938063, 6415.903761443582, 6429.164208652845, 6451.516136289703, 6458.257300410419, 6698.39714425704, 6731.2932142125355, 6736.8989465158065, 6780.762348425008, 6807.761728339583, 6287.30839607652, 6303.0, 6362.618242905441, 6436.163298771224, 6445.355464453611, 6395.616263024233, 6452.193475815523, 6471.644059576768, 6523.0, 6641.867162656817, 6500.749625187406, 6518.967405162944, 6551.344865513411, 6560.639164845979, 6577.901331479936, 6298.71655775482, 6314.052892066226, 6315.326658272937, 6316.905246421215, 6348.936510634834, 4902.7202350907, 4951.5791157750555, 4969.850904472872, 4971.428285747185, 4983.975080124576, 6552.901706474502, 6560.245571759308, 6588.472922166311, 6612.8346791330605, 6655.700493477708, 6366.840828979312, 6367.0, 6409.71156297977, 6431.678416079271, 6481.944083614788, 6017.209158230286, 6346.397092276226, 6404.327545607644, 6416.903746443713, 6463.967680161569, 6085.661154545993, 6239.563230573998, 6251.6874156292915, 6268.937310626835, 6367.490600751836, 6344.777932772331, 6450.355354304713, 6469.967650161719, 6477.384648458389, 6520.119783829123, 6084.665343405978, 6201.379862013762, 6217.0, 6219.0, 6230.844228894314], "value": 4955.931707709054, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [904.3443503459993, 904.4754042655261, 923.2383283790874, 926.3885835348672, 932.463833295855, 18360.35738749144, 19356.12897419616, 19390.90304548477, 19448.0, 20927.9536023199, 20385.0, 21512.8924355378, 21529.354119376403, 21601.45996350092, 21749.782502174974, 1036.7045392063244, 1066.9093127084207, 1073.6349641122056, 1074.8387741838708, 1076.1122074288703, 1057.6562617149418, 1069.1126365116934, 1069.1446842525986, 1072.2494254022176, 1072.8390741388775, 1057.2282233969206, 1104.2932523185168, 1110.3282514078987, 1110.9222354435192, 1117.1286396610656, 1097.4457898761075, 1099.8680158380967, 1101.5869049106584, 1105.0054950544493, 1107.4905543449981, 801.863683173856, 804.6298702596813, 805.005817814998, 805.138501803071, 805.4160733468248, 17207.225674844663, 17686.469405917844, 18055.638887222183, 18087.366942157092, 18151.818481815277, 20440.08019639105, 20583.8970805145, 20779.64932279397, 21054.0, 21091.15635374583, 15699.37202511898, 15846.76229856553, 15985.120818354986, 16045.117518536475, 16092.75860862088, 3574.0528759878653, 3587.5336206293014, 3596.7122630189524, 3597.0467826026124, 3601.657842504958, 112831.0, 118078.0, 119428.0, 120585.39707301494, 122961.0, 15570.377184912477, 16427.425040123537, 16471.094089825176, 16474.258658360402, 16486.0, 29725.0, 30155.547666785016, 30194.0, 30194.54708179379, 30242.697573024427, 7236.312550307713, 7365.447591430664, 8280.58597070144, 8371.162883711702, 8708.390412671051, 3899.3760998240145, 4028.274910516135, 4036.4348991141264, 4042.4542686737504, 4054.351303791379, 5145.331106956147, 5236.816711415082, 5272.6836389816735, 5285.180796976475, 5328.200769884548, 986.4574484033752, 1002.0, 1010.1060561403211, 1013.6756238003916, 1014.6651604970342, 680.0547239337325, 680.4590350671228, 680.9931900681029, 705.4603228530178, 706.2407911495163, 11708.0, 12164.635060948185, 13050.412731427108, 13532.526361577495, 14175.078619889675, 672.5191488086042, 688.3976520544524, 704.9436045116379, 708.5536112249353, 720.1394333771093, 5481.616286859881, 5530.972345138249, 5608.635438696471, 5690.4025077367105, 5810.854728631733, 95408.52295738478, 96815.0, 100486.0, 103332.48333758283, 104686.0, 89751.55124224468, 90862.54568727114, 93539.0, 96105.51947240219, 96679.0, 71562.0, 76134.0, 76174.23825761782, 77019.22980770233, 77742.2225777735, 10406.479676016017, 10733.141348692243, 10775.353478791298, 10863.619773307897, 10929.781404372026, 33334.66665333413, 34534.30931381308, 35558.28883422369, 36291.27417451689, 36897.0, 43392.0, 46209.60646296576, 47158.0, 47684.7615761919, 48584.271235932196, 16273.349066037226, 16339.918300408423, 16383.098929558988, 16409.425670101966, 16696.0, 17509.299628014738, 17510.212040457955, 17523.649527009642, 17587.912060439616, 17651.205695743978, 16108.838911611203, 16115.516534503984, 16168.67662646764, 16313.59216019609, 16336.754948676016, 16008.439704610282, 16040.598985025468, 16079.839201607834, 16099.436519722221, 16122.838771612604, 15343.846561534241, 15347.846521534642, 15439.459618913284, 15550.144742039296, 15608.375664973728, 11662.0, 11758.470868810753, 12376.62870113898, 12455.128141030042, 12844.639603309764, 12246.938765306117, 12551.0, 12615.873841261837, 12724.618261452171, 12725.681857953625], "value": 8713.083118944161, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1539.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 109.0, 105.0, 109.0, 109.0, 112.0, 113.0, 102.0, 114.0, 112.0], "value": 108.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 117.0, 152.0, 191.0, 119.0, 141.0, 151.0, 119.0, 174.0, 119.0], "value": 142.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 163.0, 163.0, 165.0, 162.0, 161.0, 170.0, 173.0, 162.0, 167.0], "value": 165.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 171.0, 76.0, 76.0, 76.0, 76.0, 149.0, 77.0], "value": 92.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 82.0, 137.0, 85.0, 80.0, 80.0, 134.0, 81.0, 80.0, 139.0], "value": 97.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 115.0, 114.0, 116.0, 114.0, 115.0, 114.0, 115.0, 114.0, 116.0], "value": 114.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 152.0, 150.0, 150.0, 152.0, 151.0, 150.0, 152.0, 150.0, 150.0], "value": 151.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 98.0, 94.0, 94.0, 93.0, 94.0, 94.0, 94.0, 95.0, 100.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 57.0, 55.0, 54.0, 54.0, 53.0, 53.0, 53.0, 53.0], "value": 53.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 54.0, 55.0, 54.0, 55.0, 54.0, 55.0, 54.0, 54.0], "value": 54.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 79.0, 79.0, 78.0, 80.0, 78.0, 78.0, 80.0, 78.0, 82.0], "value": 78.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 146.0, 126.0, 129.0, 126.0, 127.0, 141.0, 130.0, 128.0, 160.0], "value": 133.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 180.0, 176.0, 179.0, 179.0, 181.0, 182.0, 177.0, 178.0, 178.0], "value": 178.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 70.0, 71.0, 69.0, 70.0, 69.0, 69.0, 70.0, 90.0, 67.0], "value": 71.5, "unit": "score"}]}]} 04:05:17 INFO - Return code: 0 04:05:17 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:05:17 INFO - # TBPL SUCCESS # 04:05:17 INFO - Running post-action listener: _package_coverage_data 04:05:17 INFO - Running post-action listener: _resource_record_post_action 04:05:17 INFO - [mozharness: 2017-07-23 11:05:17.726170Z] Finished run-tests step (success) 04:05:17 INFO - Running post-run listener: _resource_record_post_run 04:05:17 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 8192; Write bytes: 440528896; Read time: 176; Write time: 271372 04:05:17 INFO - TinderboxPrint: CPU usage
13.1% 04:05:17 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 176 04:05:17 INFO - TinderboxPrint: I/O write bytes / time
440,528,896 / 271,372 04:05:17 INFO - TinderboxPrint: CPU idle
8,266.4 (86.8%) 04:05:17 INFO - TinderboxPrint: CPU user
1,203.9 (12.6%) 04:05:17 INFO - TinderboxPrint: Swap in / out
0 / 0 04:05:17 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 107565056; Read time: 0; Write time: 87280 04:05:17 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 04:05:17 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 4096; Write bytes: 332963840; Read time: 168; Write time: 184092 04:05:18 INFO - Running post-run listener: _upload_blobber_files 04:05:18 INFO - Blob upload gear active. 04:05:18 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:05:18 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 04:05:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:05:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:05:18 INFO - (blobuploader) - INFO - Open directory for files ... 04:05:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:05:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:05:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:05:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:05:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:05:19 INFO - (blobuploader) - INFO - Done attempting. 04:05:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:05:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:05:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:05:22 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:05:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:05:22 INFO - (blobuploader) - INFO - Done attempting. 04:05:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:05:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:05:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:05:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:05:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:05:23 INFO - (blobuploader) - INFO - Done attempting. 04:05:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 04:05:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:05:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:05:24 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 04:05:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:05:24 INFO - (blobuploader) - INFO - Done attempting. 04:05:24 INFO - (blobuploader) - INFO - Iteration through files over. 04:05:24 INFO - Return code: 0 04:05:24 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:05:24 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:05:24 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/679f0d0a7ccecfb29295e9823bcb242d158b2d2986d51c3ab9a2d03aeb587dff2a27b2a167834549ff8750be119d3b7be93ae55deb18f3aecca8aed4d0fe473a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/95834c2099363790b0b9123ce2494ca1d64f3005de77c7b13e888043c60b57953e15690300d0756a00c350996b96e1051ab77691a9a53026ba4c168acd169e34", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f83fee4e4dd73d4764ff795f89903edf0879b541b4bafc8331d950d6a9674900ecc291549d088208f143d6809da73a91293e5d200a865ac235829f831f06bdf1", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/33efc639ad536d9c4d74dbe93e7de3dc7701c2e6f700a89192ad02b01e36b621e7c28b4ddda4be752b772d7f37c063d1d4f4b65caceb2c6751ce70d432b8c8eb"} 04:05:24 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:05:24 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:05:24 INFO - Contents: 04:05:24 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/679f0d0a7ccecfb29295e9823bcb242d158b2d2986d51c3ab9a2d03aeb587dff2a27b2a167834549ff8750be119d3b7be93ae55deb18f3aecca8aed4d0fe473a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/95834c2099363790b0b9123ce2494ca1d64f3005de77c7b13e888043c60b57953e15690300d0756a00c350996b96e1051ab77691a9a53026ba4c168acd169e34", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f83fee4e4dd73d4764ff795f89903edf0879b541b4bafc8331d950d6a9674900ecc291549d088208f143d6809da73a91293e5d200a865ac235829f831f06bdf1", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/33efc639ad536d9c4d74dbe93e7de3dc7701c2e6f700a89192ad02b01e36b621e7c28b4ddda4be752b772d7f37c063d1d4f4b65caceb2c6751ce70d432b8c8eb"} 04:05:24 INFO - Running post-run listener: copy_logs_to_upload_dir 04:05:24 INFO - Copying logs to upload dir... 04:05:24 INFO - mkdir: /builds/slave/test/build/upload/logs 04:05:24 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1252.827496 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2017-07-23 04:05:24.143241) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-23 04:05:24.146545) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1500806115.35968-1985897236 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/679f0d0a7ccecfb29295e9823bcb242d158b2d2986d51c3ab9a2d03aeb587dff2a27b2a167834549ff8750be119d3b7be93ae55deb18f3aecca8aed4d0fe473a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/95834c2099363790b0b9123ce2494ca1d64f3005de77c7b13e888043c60b57953e15690300d0756a00c350996b96e1051ab77691a9a53026ba4c168acd169e34", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f83fee4e4dd73d4764ff795f89903edf0879b541b4bafc8331d950d6a9674900ecc291549d088208f143d6809da73a91293e5d200a865ac235829f831f06bdf1", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/33efc639ad536d9c4d74dbe93e7de3dc7701c2e6f700a89192ad02b01e36b621e7c28b4ddda4be752b772d7f37c063d1d4f4b65caceb2c6751ce70d432b8c8eb"} build_url:https://queue.taskcluster.net/v1/task/aOjLU-_YTmm47TDQ28JXgw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011179 build_url: 'https://queue.taskcluster.net/v1/task/aOjLU-_YTmm47TDQ28JXgw/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/679f0d0a7ccecfb29295e9823bcb242d158b2d2986d51c3ab9a2d03aeb587dff2a27b2a167834549ff8750be119d3b7be93ae55deb18f3aecca8aed4d0fe473a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/95834c2099363790b0b9123ce2494ca1d64f3005de77c7b13e888043c60b57953e15690300d0756a00c350996b96e1051ab77691a9a53026ba4c168acd169e34", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f83fee4e4dd73d4764ff795f89903edf0879b541b4bafc8331d950d6a9674900ecc291549d088208f143d6809da73a91293e5d200a865ac235829f831f06bdf1", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/33efc639ad536d9c4d74dbe93e7de3dc7701c2e6f700a89192ad02b01e36b621e7c28b4ddda4be752b772d7f37c063d1d4f4b65caceb2c6751ce70d432b8c8eb"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-23 04:05:24.171222) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-23 04:05:24.171541) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1500806115.35968-1985897236 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004474 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-23 04:05:24.255110) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-23 04:05:24.255435) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-23 04:05:24.255735) ========= ========= Total master_lag: 0.17 =========