builder: mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s slave: talos-linux64-ix-065 starttime: 1500311131.44 results: success (0) revision: e0b0865639cebc1b5afa0268a4b073fcdde0e69c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-07-17 10:05:31.437936) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-07-17 10:05:31.438455) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-17 10:05:31.438759) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-17 10:05:31.455309) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-17 10:05:31.455600) ========= 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=523ca41ca1e0623de333ad52000001bf-1500309659.981018-920335768 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-07-17 10:05:32-- 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% 223M=0s 2017-07-17 10:05:32 (223 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.151522 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-17 10:05:31.621102) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-17 10:05:31.621488) ========= 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=523ca41ca1e0623de333ad52000001bf-1500309659.981018-920335768 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014769 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-17 10:05:31.679748) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-07-17 10:05:31.680105) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev e0b0865639cebc1b5afa0268a4b073fcdde0e69c --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 e0b0865639cebc1b5afa0268a4b073fcdde0e69c --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=523ca41ca1e0623de333ad52000001bf-1500309659.981018-920335768 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-07-17 10:05:32,331 truncating revision to first 12 chars 2017-07-17 10:05:32,331 Setting DEBUG logging. 2017-07-17 10:05:32,331 attempt 1/10 2017-07-17 10:05:32,331 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/e0b0865639ce?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-07-17 10:05:33,841 unpacking tar archive at: mozilla-central-e0b0865639ce/testing/mozharness/ program finished with exit code 0 elapsedTime=1.825363 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-07-17 10:05:33.518152) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-17 10:05:33.518456) ========= script_repo_revision: e0b0865639cebc1b5afa0268a4b073fcdde0e69c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-17 10:05:33.518844) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-17 10:05:33.519110) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-17 10:05:33.527102) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2017-07-17 10:05:33.527446) ========= /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=523ca41ca1e0623de333ad52000001bf-1500309659.981018-920335768 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:05:34 INFO - MultiFileLogger online at 20170717 10:05:34 in /builds/slave/test 10:05:34 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 10:05:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:05:34 INFO - {'append_to_log': False, 10:05:34 INFO - 'base_work_dir': '/builds/slave/test', 10:05:34 INFO - 'blob_upload_branch': 'Firefox', 10:05:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:05:34 INFO - 'branch': 'Firefox', 10:05:34 INFO - 'buildbot_json_path': 'buildprops.json', 10:05:34 INFO - 'code_coverage': False, 10:05:34 INFO - 'config_files': ('talos/linux_config.py',), 10:05:34 INFO - 'default_actions': ('clobber', 10:05:34 INFO - 'read-buildbot-config', 10:05:34 INFO - 'download-and-extract', 10:05:34 INFO - 'populate-webroot', 10:05:34 INFO - 'create-virtualenv', 10:05:34 INFO - 'install', 10:05:34 INFO - 'setup-mitmproxy', 10:05:34 INFO - 'run-tests'), 10:05:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:05:34 INFO - 'disable_ccov_upload': False, 10:05:34 INFO - 'download_minidump_stackwalk': True, 10:05:34 INFO - 'download_symbols': 'ondemand', 10:05:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:05:34 INFO - 'tooltool.py': '/tools/tooltool.py', 10:05:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:05:34 INFO - '/tools/misc-python/virtualenv.py')}, 10:05:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:05:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:05:34 INFO - 'gecko_profile': False, 10:05:34 INFO - 'gecko_profile_interval': 0, 10:05:34 INFO - 'installer_path': 'installer.exe', 10:05:34 INFO - 'log_level': 'info', 10:05:34 INFO - 'log_name': 'talos', 10:05:34 INFO - 'log_to_console': True, 10:05:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:05:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:05:34 INFO - 'opt_config_files': (), 10:05:34 INFO - 'pip_index': False, 10:05:34 INFO - 'suite': 'dromaeojs-e10s', 10:05:34 INFO - 'system_bits': '32', 10:05:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:05:34 INFO - 'title': 'talos-linux64-ix-065', 10:05:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:05:34 INFO - 'use_talos_json': True, 10:05:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:05:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:05:34 INFO - 'work_dir': 'build'} 10:05:34 INFO - [mozharness: 2017-07-17 17:05:34.284810Z] Running clobber step. 10:05:34 INFO - Running pre-action listener: _resource_record_pre_action 10:05:34 INFO - Running main action method: clobber 10:05:34 INFO - rmtree: /builds/slave/test/build 10:05:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:05:35 INFO - Running post-action listener: _resource_record_post_action 10:05:35 INFO - [mozharness: 2017-07-17 17:05:35.837764Z] Finished clobber step (success) 10:05:35 INFO - [mozharness: 2017-07-17 17:05:35.837866Z] Running read-buildbot-config step. 10:05:35 INFO - Running pre-action listener: _resource_record_pre_action 10:05:35 INFO - Running main action method: read_buildbot_config 10:05:35 INFO - Using buildbot properties: 10:05:35 INFO - { 10:05:35 INFO - "project": "", 10:05:35 INFO - "product": "firefox", 10:05:35 INFO - "who": "ffxbld@noreply.mozilla.org", 10:05:35 INFO - "installer_path": "public/build/target.tar.bz2", 10:05:35 INFO - "builddir": "mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s", 10:05:35 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 10:05:35 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo mozilla-central talos dromaeojs-e10s", 10:05:35 INFO - "stage_platform": "linux64-stylo", 10:05:35 INFO - "basedir": "/builds/slave/test", 10:05:35 INFO - "buildnumber": 215, 10:05:35 INFO - "platform": "ubuntu64_hw_stylo", 10:05:35 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 10:05:35 INFO - "slavebuilddir": "test", 10:05:35 INFO - "taskId": "d5Y6Q8fXS4mvtW_zfFPSPw", 10:05:35 INFO - "branch": "mozilla-central", 10:05:35 INFO - "script_repo_revision": "production", 10:05:35 INFO - "revision": "e0b0865639cebc1b5afa0268a4b073fcdde0e69c", 10:05:35 INFO - "slavename": "talos-linux64-ix-065", 10:05:35 INFO - "repo_path": "mozilla-central" 10:05:35 INFO - } 10:05:35 INFO - Finding installer, test and symbols from parent task. 10:05:35 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/d5Y6Q8fXS4mvtW_zfFPSPw'}, attempt #1 10:05:36 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/d5Y6Q8fXS4mvtW_zfFPSPw'}, attempt #1 10:05:36 INFO - Task dependencies: ZhXVXYEsTmqLf6LrsIK64w 10:05:36 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZhXVXYEsTmqLf6LrsIK64w'}, attempt #1 10:05:37 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/ZhXVXYEsTmqLf6LrsIK64w/artifacts/public/build/target.tar.bz2 10:05:37 INFO - Set test_url: https://queue.taskcluster.net/v1/task/ZhXVXYEsTmqLf6LrsIK64w/artifacts/public/build/test_packages.json 10:05:37 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/ZhXVXYEsTmqLf6LrsIK64w/artifacts/public/build/target.crashreporter-symbols.zip 10:05:37 INFO - Running post-action listener: _resource_record_post_action 10:05:37 INFO - [mozharness: 2017-07-17 17:05:37.291372Z] Finished read-buildbot-config step (success) 10:05:37 INFO - [mozharness: 2017-07-17 17:05:37.291683Z] Running download-and-extract step. 10:05:37 INFO - Running pre-action listener: _resource_record_pre_action 10:05:37 INFO - Running main action method: download_and_extract 10:05:37 INFO - mkdir: /builds/slave/test/build/tests 10:05:37 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')]} 10:05:37 INFO - trying https://queue.taskcluster.net/v1/task/ZhXVXYEsTmqLf6LrsIK64w/artifacts/public/build/target.test_packages.json 10:05:37 INFO - Downloading https://queue.taskcluster.net/v1/task/ZhXVXYEsTmqLf6LrsIK64w/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 10:05:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZhXVXYEsTmqLf6LrsIK64w/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 10:05:38 INFO - Downloaded 989 bytes. 10:05:38 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 10:05:38 INFO - Using the following test package requirements: 10:05:38 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 10:05:38 INFO - u'common': [u'target.common.tests.zip'], 10:05:38 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 10:05:38 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 10:05:38 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 10:05:38 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 10:05:38 INFO - u'mozbase': [u'target.common.tests.zip'], 10:05:38 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 10:05:38 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 10:05:38 INFO - u'web-platform': [u'target.common.tests.zip', 10:05:38 INFO - u'target.web-platform.tests.tar.gz'], 10:05:38 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 10:05:38 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 10:05:38 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZhXVXYEsTmqLf6LrsIK64w/artifacts/public/build/target.common.tests.zip 10:05:38 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZhXVXYEsTmqLf6LrsIK64w/artifacts/public/build/target.common.tests.zip'}, attempt #1 10:05:38 INFO - Fetch https://queue.taskcluster.net/v1/task/ZhXVXYEsTmqLf6LrsIK64w/artifacts/public/build/target.common.tests.zip into memory 10:05:39 INFO - Content-Length response header: 72769112 10:05:39 INFO - Bytes received: 72769112 10:05:50 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 10:05:50 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZhXVXYEsTmqLf6LrsIK64w/artifacts/public/build/target.common.tests.zip 10:05:50 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZhXVXYEsTmqLf6LrsIK64w/artifacts/public/build/target.common.tests.zip'}, attempt #1 10:05:50 INFO - Fetch https://queue.taskcluster.net/v1/task/ZhXVXYEsTmqLf6LrsIK64w/artifacts/public/build/target.common.tests.zip into memory 10:05:52 INFO - Content-Length response header: 72769112 10:05:52 INFO - Bytes received: 72769112 10:06:04 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZhXVXYEsTmqLf6LrsIK64w/artifacts/public/build/target.talos.tests.zip 10:06:04 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZhXVXYEsTmqLf6LrsIK64w/artifacts/public/build/target.talos.tests.zip'}, attempt #1 10:06:04 INFO - Fetch https://queue.taskcluster.net/v1/task/ZhXVXYEsTmqLf6LrsIK64w/artifacts/public/build/target.talos.tests.zip into memory 10:06:05 INFO - Content-Length response header: 14495033 10:06:05 INFO - Bytes received: 14495033 10:06: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')]} 10:06:05 INFO - trying https://queue.taskcluster.net/v1/task/ZhXVXYEsTmqLf6LrsIK64w/artifacts/public/build/target.tar.bz2 10:06:05 INFO - Downloading https://queue.taskcluster.net/v1/task/ZhXVXYEsTmqLf6LrsIK64w/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 10:06:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZhXVXYEsTmqLf6LrsIK64w/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 10:06:06 INFO - Downloaded 61851947 bytes. 10:06:06 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZhXVXYEsTmqLf6LrsIK64w/artifacts/public/build/target.tar.bz2 10:06:06 INFO - mkdir: /builds/slave/test/properties 10:06:06 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:06:06 INFO - Writing to file /builds/slave/test/properties/build_url 10:06:06 INFO - Contents: 10:06:06 INFO - build_url:https://queue.taskcluster.net/v1/task/ZhXVXYEsTmqLf6LrsIK64w/artifacts/public/build/target.tar.bz2 10:06:06 INFO - Running post-action listener: _resource_record_post_action 10:06:06 INFO - Running post-action listener: set_extra_try_arguments 10:06:06 INFO - [mozharness: 2017-07-17 17:06:06.966058Z] Finished download-and-extract step (success) 10:06:06 INFO - [mozharness: 2017-07-17 17:06:06.966154Z] Running populate-webroot step. 10:06:06 INFO - Running pre-action listener: _resource_record_pre_action 10:06:06 INFO - Running main action method: populate_webroot 10:06:06 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:06:06 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:06:06 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:06:06 INFO - '--tppagecycles', 10:06:06 INFO - '7'], 10:06:06 INFO - 'tests': ['tsvgm']}}, 10:06:06 INFO - 'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:06:06 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:06:06 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:06:06 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:06:06 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 10:06:06 INFO - 'talos_options': ['--disable-e10s'], 10:06:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:06:06 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 10:06:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:06:06 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 10:06:06 INFO - 'talos_options': ['--disable-e10s'], 10:06:06 INFO - 'tests': ['damp', 'tps']}, 10:06:06 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 10:06:06 INFO - 'tests': ['damp', 'tps']}, 10:06:06 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:06:06 INFO - 'tests': ['dromaeo_dom']}, 10:06:06 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:06:06 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:06:06 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 10:06:06 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 10:06:06 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 10:06:06 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 10:06:06 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:06:06 INFO - 'tests': ['a11yr', 10:06:06 INFO - 'ts_paint', 10:06:06 INFO - 'tpaint', 10:06:06 INFO - 'sessionrestore', 10:06:06 INFO - 'sessionrestore_no_auto_restore', 10:06:06 INFO - 'tabpaint']}, 10:06:06 INFO - 'other-e10s': {'tests': ['a11yr', 10:06:06 INFO - 'ts_paint', 10:06:06 INFO - 'tpaint', 10:06:06 INFO - 'sessionrestore', 10:06:06 INFO - 'sessionrestore_many_windows', 10:06:06 INFO - 'sessionrestore_no_auto_restore', 10:06:06 INFO - 'tabpaint']}, 10:06:06 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:06:06 INFO - 'ts_paint', 10:06:06 INFO - 'tpaint', 10:06:06 INFO - 'sessionrestore', 10:06:06 INFO - 'sessionrestore_many_windows', 10:06:06 INFO - 'sessionrestore_no_auto_restore', 10:06:06 INFO - 'tabpaint']}, 10:06:06 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:06:06 INFO - 'ts_paint', 10:06:06 INFO - 'tpaint', 10:06:06 INFO - 'sessionrestore', 10:06:06 INFO - 'sessionrestore_many_windows', 10:06:06 INFO - 'sessionrestore_no_auto_restore', 10:06:06 INFO - 'tabpaint']}, 10:06:06 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:06:06 INFO - 'tests': ['a11yr', 10:06:06 INFO - 'ts_paint', 10:06:06 INFO - 'tpaint', 10:06:06 INFO - 'sessionrestore', 10:06:06 INFO - 'sessionrestore_no_auto_restore', 10:06:06 INFO - 'tabpaint']}, 10:06:06 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:06:06 INFO - 'tests': ['a11yr', 10:06:06 INFO - 'ts_paint', 10:06:06 INFO - 'tpaint', 10:06:06 INFO - 'sessionrestore', 10:06:06 INFO - 'sessionrestore_no_auto_restore', 10:06:06 INFO - 'tabpaint']}, 10:06:06 INFO - 'perf-reftest': {'tests': ['bloom_basic']}, 10:06:06 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 10:06:06 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 10:06:06 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 10:06:06 INFO - 'talos_options': ['--mitmproxy', 10:06:06 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 10:06:06 INFO - '--firstNonBlankPaint'], 10:06:06 INFO - 'tests': ['quantum_pageload_google', 10:06:06 INFO - 'quantum_pageload_youtube', 10:06:06 INFO - 'quantum_pageload_amazon', 10:06:06 INFO - 'quantum_pageload_facebook']}, 10:06:06 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:06:06 INFO - 'tests': ['tsvgx', 10:06:06 INFO - 'tsvgr_opacity', 10:06:06 INFO - 'tart', 10:06:06 INFO - 'tscrollx', 10:06:06 INFO - 'cart', 10:06:06 INFO - 'tsvg_static']}, 10:06:06 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:06:06 INFO - 'tsvgr_opacity', 10:06:06 INFO - 'tart', 10:06:06 INFO - 'tscrollx', 10:06:06 INFO - 'cart', 10:06:06 INFO - 'tsvg_static']}, 10:06:06 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 10:06:06 INFO - 'talos_options': ['--disable-e10s'], 10:06:06 INFO - 'tests': ['tp5o']}, 10:06:06 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 10:06:06 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 10:06:06 INFO - 'talos_options': ['--disable-e10s', 10:06:06 INFO - '--xperf_path', 10:06:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:06:06 INFO - 'tests': ['tp5n']}, 10:06:06 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 10:06:06 INFO - 'talos_options': ['--xperf_path', 10:06:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:06:06 INFO - 'tests': ['tp5n']}}, 10:06:06 INFO - 'talos.zip': {'path': '', 10:06:06 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:06:06 INFO - Running post-action listener: _resource_record_post_action 10:06:06 INFO - [mozharness: 2017-07-17 17:06:06.981563Z] Finished populate-webroot step (success) 10:06:06 INFO - [mozharness: 2017-07-17 17:06:06.981654Z] Running create-virtualenv step. 10:06:06 INFO - Running pre-action listener: _resource_record_pre_action 10:06:06 INFO - Running main action method: create_virtualenv 10:06:06 INFO - Creating virtualenv /builds/slave/test/build/venv 10:06:06 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 10:06:06 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:06:06 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 10:06:07 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:06:07 INFO - Using real prefix '/usr' 10:06:07 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:06:07 INFO - Installing distribute.............................................................................................................................................................................................done. 10:06:09 INFO - Installing pip.................done. 10:06:09 INFO - Return code: 0 10:06:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 10:06:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 10:06:09 INFO - Reading from file tmpfile_stdout 10:06:09 INFO - Output received: 10:06:09 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 10:06:09 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:06: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')]} 10:06:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:06: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')]} 10:06:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:06:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19981f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b64a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d09b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d06d00>, '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 0x1d07c00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d08090>, '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': '523ca41ca1e0623de333ad52000001bf-1500309659.981018-920335768', '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 10:06:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 10:06:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 10:06:09 INFO - Using env: {'DISPLAY': ':0', 10:06:09 INFO - 'HOME': '/home/cltbld', 10:06:09 INFO - 'LANG': 'en_US.UTF-8', 10:06:09 INFO - 'LANGUAGE': 'en_US:en', 10:06:09 INFO - 'LOGNAME': 'cltbld', 10:06:09 INFO - 'MAIL': '/var/mail/cltbld', 10:06:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:06:09 INFO - 'MOZ_NO_REMOTE': '1', 10:06:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:06:09 INFO - 'NO_EM_RESTART': '1', 10:06:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:06:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:06:09 INFO - 'PWD': '/builds/slave/test', 10:06:09 INFO - 'SHELL': '/bin/bash', 10:06:09 INFO - 'SHLVL': '1', 10:06:09 INFO - 'TERM': 'linux', 10:06:09 INFO - 'TMOUT': '86400', 10:06:09 INFO - 'USER': 'cltbld', 10:06:09 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1500309659.981018-920335768', 10:06:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:06:09 INFO - '_': '/tools/buildbot/bin/python'} 10:06:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:06:10 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 10:06:10 INFO - Cleaning up... 10:06:10 INFO - Return code: 0 10:06:10 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:06:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:06:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:06:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:06:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:06:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19981f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b64a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d09b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d06d00>, '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 0x1d07c00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d08090>, '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': '523ca41ca1e0623de333ad52000001bf-1500309659.981018-920335768', '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 10:06:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 10:06:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 10:06:10 INFO - Using env: {'DISPLAY': ':0', 10:06:10 INFO - 'HOME': '/home/cltbld', 10:06:10 INFO - 'LANG': 'en_US.UTF-8', 10:06:10 INFO - 'LANGUAGE': 'en_US:en', 10:06:10 INFO - 'LOGNAME': 'cltbld', 10:06:10 INFO - 'MAIL': '/var/mail/cltbld', 10:06:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:06:10 INFO - 'MOZ_NO_REMOTE': '1', 10:06:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:06:10 INFO - 'NO_EM_RESTART': '1', 10:06:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:06:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:06:10 INFO - 'PWD': '/builds/slave/test', 10:06:10 INFO - 'SHELL': '/bin/bash', 10:06:10 INFO - 'SHLVL': '1', 10:06:10 INFO - 'TERM': 'linux', 10:06:10 INFO - 'TMOUT': '86400', 10:06:10 INFO - 'USER': 'cltbld', 10:06:10 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1500309659.981018-920335768', 10:06:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:06:10 INFO - '_': '/tools/buildbot/bin/python'} 10:06:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:06:10 INFO - Downloading/unpacking psutil>=3.1.1 10:06: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 10:06: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 10:06: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 10:06: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 10:06:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:06:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:06:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:06:11 INFO - Installing collected packages: psutil 10:06:11 INFO - Running setup.py install for psutil 10:06:11 INFO - building 'psutil._psutil_linux' extension 10:06:11 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 10:06:11 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 10:06:11 INFO - building 'psutil._psutil_posix' extension 10:06:11 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 10:06:11 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 10:06:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:06:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:06:11 INFO - Successfully installed psutil 10:06:11 INFO - Cleaning up... 10:06:11 INFO - Return code: 0 10:06:11 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:06: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')]} 10:06:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:06: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')]} 10:06:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:06: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19981f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b64a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d09b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d06d00>, '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 0x1d07c00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d08090>, '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': '523ca41ca1e0623de333ad52000001bf-1500309659.981018-920335768', '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 10:06: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 10:06: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 mozsystemmonitor==0.3 10:06:11 INFO - Using env: {'DISPLAY': ':0', 10:06:11 INFO - 'HOME': '/home/cltbld', 10:06:12 INFO - 'LANG': 'en_US.UTF-8', 10:06:12 INFO - 'LANGUAGE': 'en_US:en', 10:06:12 INFO - 'LOGNAME': 'cltbld', 10:06:12 INFO - 'MAIL': '/var/mail/cltbld', 10:06:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:06:12 INFO - 'MOZ_NO_REMOTE': '1', 10:06:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:06:12 INFO - 'NO_EM_RESTART': '1', 10:06:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:06:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:06:12 INFO - 'PWD': '/builds/slave/test', 10:06:12 INFO - 'SHELL': '/bin/bash', 10:06:12 INFO - 'SHLVL': '1', 10:06:12 INFO - 'TERM': 'linux', 10:06:12 INFO - 'TMOUT': '86400', 10:06:12 INFO - 'USER': 'cltbld', 10:06:12 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1500309659.981018-920335768', 10:06:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:06:12 INFO - '_': '/tools/buildbot/bin/python'} 10:06:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:06:12 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:06: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 10:06: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 10:06: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 10:06: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 10:06:13 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:06:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:06:13 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:06:13 INFO - Installing collected packages: mozsystemmonitor 10:06:13 INFO - Running setup.py install for mozsystemmonitor 10:06:13 INFO - Successfully installed mozsystemmonitor 10:06:13 INFO - Cleaning up... 10:06:13 INFO - Return code: 0 10:06:13 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:06: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')]} 10:06:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:06: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')]} 10:06:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:06:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19981f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b64a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d09b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d06d00>, '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 0x1d07c00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d08090>, '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': '523ca41ca1e0623de333ad52000001bf-1500309659.981018-920335768', '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 10:06:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 10:06:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 10:06:13 INFO - Using env: {'DISPLAY': ':0', 10:06:13 INFO - 'HOME': '/home/cltbld', 10:06:13 INFO - 'LANG': 'en_US.UTF-8', 10:06:13 INFO - 'LANGUAGE': 'en_US:en', 10:06:13 INFO - 'LOGNAME': 'cltbld', 10:06:13 INFO - 'MAIL': '/var/mail/cltbld', 10:06:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:06:13 INFO - 'MOZ_NO_REMOTE': '1', 10:06:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:06:13 INFO - 'NO_EM_RESTART': '1', 10:06:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:06:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:06:13 INFO - 'PWD': '/builds/slave/test', 10:06:13 INFO - 'SHELL': '/bin/bash', 10:06:13 INFO - 'SHLVL': '1', 10:06:13 INFO - 'TERM': 'linux', 10:06:13 INFO - 'TMOUT': '86400', 10:06:13 INFO - 'USER': 'cltbld', 10:06:13 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1500309659.981018-920335768', 10:06:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:06:13 INFO - '_': '/tools/buildbot/bin/python'} 10:06:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:06:13 INFO - Downloading/unpacking jsonschema==2.5.1 10:06: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 10:06: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 10:06: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 10:06: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 10:06:14 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:06:14 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:06:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:06:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:06:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:06:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:06:14 INFO - Downloading functools32-3.2.3-2.tar.gz 10:06:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:06:14 INFO - warning: no files found matching '*.txt' 10:06:14 INFO - no previously-included directories found matching 'build' 10:06:14 INFO - no previously-included directories found matching 'dist' 10:06:14 INFO - no previously-included directories found matching '.git*' 10:06:14 INFO - Installing collected packages: jsonschema, functools32 10:06:15 INFO - Running setup.py install for functools32 10:06:15 INFO - warning: no files found matching '*.txt' 10:06:15 INFO - no previously-included directories found matching 'build' 10:06:15 INFO - no previously-included directories found matching 'dist' 10:06:15 INFO - no previously-included directories found matching '.git*' 10:06:15 INFO - Successfully installed jsonschema functools32 10:06:15 INFO - Cleaning up... 10:06:15 INFO - Return code: 0 10:06:15 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:06:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:06:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:06:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:06:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:06:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19981f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b64a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d09b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d06d00>, '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 0x1d07c00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d08090>, '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': '523ca41ca1e0623de333ad52000001bf-1500309659.981018-920335768', '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 10:06:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 10:06:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 10:06:15 INFO - Using env: {'DISPLAY': ':0', 10:06:15 INFO - 'HOME': '/home/cltbld', 10:06:15 INFO - 'LANG': 'en_US.UTF-8', 10:06:15 INFO - 'LANGUAGE': 'en_US:en', 10:06:15 INFO - 'LOGNAME': 'cltbld', 10:06:15 INFO - 'MAIL': '/var/mail/cltbld', 10:06:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:06:15 INFO - 'MOZ_NO_REMOTE': '1', 10:06:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:06:15 INFO - 'NO_EM_RESTART': '1', 10:06:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:06:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:06:15 INFO - 'PWD': '/builds/slave/test', 10:06:15 INFO - 'SHELL': '/bin/bash', 10:06:15 INFO - 'SHLVL': '1', 10:06:15 INFO - 'TERM': 'linux', 10:06:15 INFO - 'TMOUT': '86400', 10:06:15 INFO - 'USER': 'cltbld', 10:06:15 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1500309659.981018-920335768', 10:06:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:06:15 INFO - '_': '/tools/buildbot/bin/python'} 10:06:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:06:15 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:06:15 INFO - Cleaning up... 10:06:15 INFO - Return code: 0 10:06:15 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:06:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:06:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:06:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:06:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:06:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19981f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b64a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d09b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d06d00>, '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 0x1d07c00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d08090>, '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': '523ca41ca1e0623de333ad52000001bf-1500309659.981018-920335768', '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 10:06:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 10:06:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 10:06:15 INFO - Using env: {'DISPLAY': ':0', 10:06:15 INFO - 'HOME': '/home/cltbld', 10:06:15 INFO - 'LANG': 'en_US.UTF-8', 10:06:15 INFO - 'LANGUAGE': 'en_US:en', 10:06:15 INFO - 'LOGNAME': 'cltbld', 10:06:15 INFO - 'MAIL': '/var/mail/cltbld', 10:06:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:06:15 INFO - 'MOZ_NO_REMOTE': '1', 10:06:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:06:15 INFO - 'NO_EM_RESTART': '1', 10:06:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:06:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:06:15 INFO - 'PWD': '/builds/slave/test', 10:06:15 INFO - 'SHELL': '/bin/bash', 10:06:15 INFO - 'SHLVL': '1', 10:06:15 INFO - 'TERM': 'linux', 10:06:15 INFO - 'TMOUT': '86400', 10:06:15 INFO - 'USER': 'cltbld', 10:06:15 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1500309659.981018-920335768', 10:06:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:06:15 INFO - '_': '/tools/buildbot/bin/python'} 10:06:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:06:15 INFO - Downloading/unpacking blobuploader==1.2.4 10:06:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:06:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:06:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:06:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:06:16 INFO - Downloading blobuploader-1.2.4.tar.gz 10:06:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:06:16 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:06:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:06:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:06:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:06:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:06:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:06:17 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:06:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:06:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:06:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:06:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:06:17 INFO - Downloading docopt-0.6.1.tar.gz 10:06:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:06:17 INFO - Installing collected packages: blobuploader, requests, docopt 10:06:17 INFO - Running setup.py install for blobuploader 10:06:17 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:06:17 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:06:17 INFO - Running setup.py install for requests 10:06:17 INFO - Running setup.py install for docopt 10:06:17 INFO - Successfully installed blobuploader requests docopt 10:06:17 INFO - Cleaning up... 10:06:17 INFO - Return code: 0 10:06:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:06: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')]} 10:06:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:06: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')]} 10:06:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:06:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19981f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b64a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d09b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d06d00>, '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 0x1d07c00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d08090>, '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': '523ca41ca1e0623de333ad52000001bf-1500309659.981018-920335768', '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 10:06:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 10:06:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:06:17 INFO - Using env: {'DISPLAY': ':0', 10:06:17 INFO - 'HOME': '/home/cltbld', 10:06:17 INFO - 'LANG': 'en_US.UTF-8', 10:06:17 INFO - 'LANGUAGE': 'en_US:en', 10:06:17 INFO - 'LOGNAME': 'cltbld', 10:06:17 INFO - 'MAIL': '/var/mail/cltbld', 10:06:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:06:17 INFO - 'MOZ_NO_REMOTE': '1', 10:06:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:06:17 INFO - 'NO_EM_RESTART': '1', 10:06:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:06:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:06:17 INFO - 'PWD': '/builds/slave/test', 10:06:17 INFO - 'SHELL': '/bin/bash', 10:06:17 INFO - 'SHLVL': '1', 10:06:17 INFO - 'TERM': 'linux', 10:06:17 INFO - 'TMOUT': '86400', 10:06:17 INFO - 'USER': 'cltbld', 10:06:17 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1500309659.981018-920335768', 10:06:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:06:17 INFO - '_': '/tools/buildbot/bin/python'} 10:06:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:06:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:06:18 INFO - Running setup.py (path:/tmp/pip-lYjFgk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:06:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:06:18 INFO - Running setup.py (path:/tmp/pip-fVpu0F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:06:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:06:18 INFO - Running setup.py (path:/tmp/pip-NX7Lcy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:06:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:06:18 INFO - Running setup.py (path:/tmp/pip-UwikQg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:06:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:06:18 INFO - Running setup.py (path:/tmp/pip-l7KOXE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:06:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:06:18 INFO - Running setup.py (path:/tmp/pip-uQ1_S0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:06:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:06:18 INFO - Running setup.py (path:/tmp/pip-LvJQhi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:06:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:06:18 INFO - Running setup.py (path:/tmp/pip-C9Q9_Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:06:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:06:18 INFO - Running setup.py (path:/tmp/pip-qozSXM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:06:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:06:18 INFO - Running setup.py (path:/tmp/pip-WOUUPj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:06:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:06:18 INFO - Running setup.py (path:/tmp/pip-53WYPY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:06:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:06:18 INFO - Running setup.py (path:/tmp/pip-Y1iM8h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:06:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:06:18 INFO - Running setup.py (path:/tmp/pip-BMMyUL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:06:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:06:19 INFO - Running setup.py (path:/tmp/pip-Io1Oai-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:06:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:06:19 INFO - Running setup.py (path:/tmp/pip-FgxNtt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:06:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:06:19 INFO - Running setup.py (path:/tmp/pip-NjB2OZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:06:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:06:19 INFO - Running setup.py (path:/tmp/pip-1ev_JR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:06:19 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:06:19 INFO - Running setup.py install for manifestparser 10:06:19 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:06:19 INFO - Running setup.py install for mozcrash 10:06:19 INFO - Running setup.py install for mozdebug 10:06:19 INFO - Running setup.py install for mozdevice 10:06:19 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:06:19 INFO - Running setup.py install for mozfile 10:06:19 INFO - Running setup.py install for mozhttpd 10:06:19 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:06:19 INFO - Running setup.py install for mozinfo 10:06:20 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:06:20 INFO - Running setup.py install for mozInstall 10:06:20 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:06:20 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:06:20 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:06:20 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:06:20 INFO - Running setup.py install for mozleak 10:06:20 INFO - Running setup.py install for mozlog 10:06:20 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:06:20 INFO - Running setup.py install for moznetwork 10:06:20 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:06:20 INFO - Running setup.py install for mozprocess 10:06:20 INFO - Running setup.py install for mozprofile 10:06:20 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:06:20 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:06:20 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:06:20 INFO - Running setup.py install for mozrunner 10:06:20 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:06:20 INFO - Running setup.py install for mozscreenshot 10:06:20 INFO - Running setup.py install for moztest 10:06:21 INFO - Running setup.py install for mozversion 10:06:21 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:06:21 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:06:21 INFO - Cleaning up... 10:06:21 INFO - Return code: 0 10:06:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:06:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:06:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:06:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:06:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:06:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19981f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b64a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d09b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d06d00>, '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 0x1d07c00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d08090>, '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': '523ca41ca1e0623de333ad52000001bf-1500309659.981018-920335768', '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 10:06:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 10:06:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:06:21 INFO - Using env: {'DISPLAY': ':0', 10:06:21 INFO - 'HOME': '/home/cltbld', 10:06:21 INFO - 'LANG': 'en_US.UTF-8', 10:06:21 INFO - 'LANGUAGE': 'en_US:en', 10:06:21 INFO - 'LOGNAME': 'cltbld', 10:06:21 INFO - 'MAIL': '/var/mail/cltbld', 10:06:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:06:21 INFO - 'MOZ_NO_REMOTE': '1', 10:06:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:06:21 INFO - 'NO_EM_RESTART': '1', 10:06:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:06:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:06:21 INFO - 'PWD': '/builds/slave/test', 10:06:21 INFO - 'SHELL': '/bin/bash', 10:06:21 INFO - 'SHLVL': '1', 10:06:21 INFO - 'TERM': 'linux', 10:06:21 INFO - 'TMOUT': '86400', 10:06:21 INFO - 'USER': 'cltbld', 10:06:21 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1500309659.981018-920335768', 10:06:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:06:21 INFO - '_': '/tools/buildbot/bin/python'} 10:06:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:06:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:06:21 INFO - Running setup.py (path:/tmp/pip-38vImc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:06:21 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 10:06:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:06:21 INFO - Running setup.py (path:/tmp/pip-EtDUzQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:06:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:06:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:06:21 INFO - Running setup.py (path:/tmp/pip-K2qQN_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:06:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 10:06:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:06:21 INFO - Running setup.py (path:/tmp/pip-DZwams-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:06:21 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)) 10:06:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:06:21 INFO - Running setup.py (path:/tmp/pip-DhY1OF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:06:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 10:06:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:06:21 INFO - Running setup.py (path:/tmp/pip-8fNQVk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:06:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 10:06:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:06:21 INFO - Running setup.py (path:/tmp/pip-vCyXGX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:06:21 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)) 10:06:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:06:21 INFO - Running setup.py (path:/tmp/pip-_7t3iR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:06:21 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)) 10:06:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:06:21 INFO - Running setup.py (path:/tmp/pip-RyJHWl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:06:21 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)) 10:06:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:06:22 INFO - Running setup.py (path:/tmp/pip-GC_3GW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:06:22 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)) 10:06:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:06:22 INFO - Running setup.py (path:/tmp/pip-fkSnhN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:06:22 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 10:06:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:06:22 INFO - Running setup.py (path:/tmp/pip-t7QUcN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:06:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 10:06:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:06:22 INFO - Running setup.py (path:/tmp/pip-JM2AcD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:06:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 10:06:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:06:22 INFO - Running setup.py (path:/tmp/pip-pxG6dz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:06:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 10:06:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:06:22 INFO - Running setup.py (path:/tmp/pip-62p3Fi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:06:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 10:06:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:06:22 INFO - Running setup.py (path:/tmp/pip-uxwqtj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:06:22 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 10:06:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:06:22 INFO - Running setup.py (path:/tmp/pip-K2CAcT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:06:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 10:06:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:06:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:06:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 10:06:22 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:06:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:06:22 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)) 10:06:22 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:06:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:06:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:06:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:06:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:06:23 INFO - Downloading blessings-1.6.tar.gz 10:06:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:06:23 INFO - Installing collected packages: blessings 10:06:23 INFO - Running setup.py install for blessings 10:06:23 INFO - Successfully installed blessings 10:06:23 INFO - Cleaning up... 10:06:23 INFO - Return code: 0 10:06:23 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:06:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:06:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:06:24 INFO - Reading from file tmpfile_stdout 10:06:24 INFO - Current package versions: 10:06:24 INFO - argparse == 1.2.1 10:06:24 INFO - blessings == 1.6 10:06:24 INFO - blobuploader == 1.2.4 10:06:24 INFO - docopt == 0.6.1 10:06:24 INFO - functools32 == 3.2.3-2 10:06:24 INFO - jsonschema == 2.5.1 10:06:24 INFO - manifestparser == 1.1 10:06:24 INFO - mozInstall == 1.13 10:06:24 INFO - mozcrash == 1.0 10:06:24 INFO - mozdebug == 0.1 10:06:24 INFO - mozdevice == 0.51 10:06:24 INFO - mozfile == 1.2 10:06:24 INFO - mozhttpd == 0.7 10:06:24 INFO - mozinfo == 0.10 10:06:24 INFO - mozleak == 0.1 10:06:24 INFO - mozlog == 3.5 10:06:24 INFO - moznetwork == 0.27 10:06:24 INFO - mozprocess == 0.25 10:06:24 INFO - mozprofile == 0.28 10:06:24 INFO - mozrunner == 6.13 10:06:24 INFO - mozscreenshot == 0.1 10:06:24 INFO - mozsystemmonitor == 0.3 10:06:24 INFO - moztest == 0.8 10:06:24 INFO - mozversion == 1.4 10:06:24 INFO - psutil == 3.1.1 10:06:24 INFO - requests == 1.2.3 10:06:24 INFO - wsgiref == 0.1.2 10:06:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:06:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:06:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:06:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:06:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:06:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19981f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b64a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d09b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d06d00>, '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 0x1d07c00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d08090>, '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': '523ca41ca1e0623de333ad52000001bf-1500309659.981018-920335768', '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 10:06:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 10:06:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:06:24 INFO - Using env: {'DISPLAY': ':0', 10:06:24 INFO - 'HOME': '/home/cltbld', 10:06:24 INFO - 'LANG': 'en_US.UTF-8', 10:06:24 INFO - 'LANGUAGE': 'en_US:en', 10:06:24 INFO - 'LOGNAME': 'cltbld', 10:06:24 INFO - 'MAIL': '/var/mail/cltbld', 10:06:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:06:24 INFO - 'MOZ_NO_REMOTE': '1', 10:06:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:06:24 INFO - 'NO_EM_RESTART': '1', 10:06:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:06:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:06:24 INFO - 'PWD': '/builds/slave/test', 10:06:24 INFO - 'SHELL': '/bin/bash', 10:06:24 INFO - 'SHLVL': '1', 10:06:24 INFO - 'TERM': 'linux', 10:06:24 INFO - 'TMOUT': '86400', 10:06:24 INFO - 'USER': 'cltbld', 10:06:24 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1500309659.981018-920335768', 10:06:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:06:24 INFO - '_': '/tools/buildbot/bin/python'} 10:06:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:06:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 10:06:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 10:06:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 10:06:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 10:06:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 10:06:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 10:06:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 10:06:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 10:06:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 10:06:24 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 10:06:24 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 10:06:24 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 10:06:24 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 10:06:24 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 10:06:25 INFO - Downloading marionette_driver-1.4.0.tar.gz 10:06:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 10:06:25 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 11)) 10:06:25 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 10:06:25 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 10:06:25 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 10:06:25 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 10:06:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 10:06:25 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)) 10:06:25 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)) 10:06:25 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)) 10:06:25 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)) 10:06:25 INFO - Installing collected packages: marionette-driver, simplejson 10:06:25 INFO - Running setup.py install for marionette-driver 10:06:25 INFO - Running setup.py install for simplejson 10:06:25 INFO - building 'simplejson._speedups' extension 10:06:25 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 10:06:26 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 10:06:26 INFO - Successfully installed marionette-driver simplejson 10:06:26 INFO - Cleaning up... 10:06:26 INFO - Return code: 0 10:06:26 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:06:26 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')]} 10:06:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:06:26 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')]} 10:06:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:06:26 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 0x19981f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b64a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d09b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d06d00>, '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 0x1d07c00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d08090>, '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': '523ca41ca1e0623de333ad52000001bf-1500309659.981018-920335768', '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 10:06:26 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 10:06:26 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 10:06:26 INFO - Using env: {'DISPLAY': ':0', 10:06:26 INFO - 'HOME': '/home/cltbld', 10:06:26 INFO - 'LANG': 'en_US.UTF-8', 10:06:26 INFO - 'LANGUAGE': 'en_US:en', 10:06:26 INFO - 'LOGNAME': 'cltbld', 10:06:26 INFO - 'MAIL': '/var/mail/cltbld', 10:06:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:06:26 INFO - 'MOZ_NO_REMOTE': '1', 10:06:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:06:26 INFO - 'NO_EM_RESTART': '1', 10:06:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:06:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:06:26 INFO - 'PWD': '/builds/slave/test', 10:06:26 INFO - 'SHELL': '/bin/bash', 10:06:26 INFO - 'SHLVL': '1', 10:06:26 INFO - 'TERM': 'linux', 10:06:26 INFO - 'TMOUT': '86400', 10:06:26 INFO - 'USER': 'cltbld', 10:06:26 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1500309659.981018-920335768', 10:06:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:06:26 INFO - '_': '/tools/buildbot/bin/python'} 10:06:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:06:27 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:06:27 INFO - Cleaning up... 10:06:27 INFO - Return code: 0 10:06:27 INFO - Running post-action listener: _resource_record_post_action 10:06:27 INFO - Running post-action listener: _start_resource_monitoring 10:06:27 INFO - Starting resource monitoring. 10:06:27 INFO - [mozharness: 2017-07-17 17:06:27.216493Z] Finished create-virtualenv step (success) 10:06:27 INFO - [mozharness: 2017-07-17 17:06:27.217012Z] Running install step. 10:06:27 INFO - Running pre-action listener: _resource_record_pre_action 10:06:27 INFO - Running main action method: install 10:06:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:06:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:06:27 INFO - Reading from file tmpfile_stdout 10:06:27 INFO - Detecting whether we're running mozinstall >=1.0... 10:06:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:06:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:06:27 INFO - Reading from file tmpfile_stdout 10:06:27 INFO - Output received: 10:06:27 INFO - Usage: mozinstall [options] installer 10:06:27 INFO - Options: 10:06:27 INFO - -h, --help show this help message and exit 10:06:27 INFO - -d DEST, --destination=DEST 10:06:27 INFO - Directory to install application into. [default: 10:06:27 INFO - "/builds/slave/test"] 10:06:27 INFO - --app=APP Application being installed. [default: firefox] 10:06:27 INFO - mkdir: /builds/slave/test/build/application 10:06:27 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'] 10:06:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 10:06:45 INFO - Reading from file tmpfile_stdout 10:06:45 INFO - Output received: 10:06:45 INFO - /builds/slave/test/build/application/firefox/firefox 10:06:45 INFO - Running post-action listener: _resource_record_post_action 10:06:45 INFO - [mozharness: 2017-07-17 17:06:45.467623Z] Finished install step (success) 10:06:45 INFO - [mozharness: 2017-07-17 17:06:45.467879Z] Running setup-mitmproxy step. 10:06:45 INFO - Running pre-action listener: _resource_record_pre_action 10:06:45 INFO - Running main action method: setup_mitmproxy 10:06:45 INFO - Skipping: mitmproxy is not required 10:06:45 INFO - Running post-action listener: _resource_record_post_action 10:06:45 INFO - [mozharness: 2017-07-17 17:06:45.469024Z] Finished setup-mitmproxy step (success) 10:06:45 INFO - [mozharness: 2017-07-17 17:06:45.469304Z] Running run-tests step. 10:06:45 INFO - Running pre-action listener: _resource_record_pre_action 10:06:45 INFO - Running pre-action listener: _set_gcov_prefix 10:06:45 INFO - Running main action method: run_tests 10:06:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:06:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:06:45 INFO - Python 2.7.3 10:06:45 INFO - Return code: 0 10:06:45 INFO - grabbing minidump binary from tooltool 10:06:45 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')]} 10:06:45 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 0x1d06d00>, '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 0x1d07c00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d08090>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:06:45 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 10:06:45 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 10:06:45 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 10:06:45 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:06:45 INFO - Return code: 0 10:06:45 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:06:45 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:06:45 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:06:45 INFO - ENV: RUST_BACKTRACE is now 1 10:06:45 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:06:45 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:06:45 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/ZhXVXYEsTmqLf6LrsIK64w/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-065', '--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 10:06:45 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/ZhXVXYEsTmqLf6LrsIK64w/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-065 --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 10:06:45 INFO - Using env: {'DISPLAY': ':0', 10:06:45 INFO - 'HOME': '/home/cltbld', 10:06:45 INFO - 'LANG': 'en_US.UTF-8', 10:06:45 INFO - 'LANGUAGE': 'en_US:en', 10:06:45 INFO - 'LOGNAME': 'cltbld', 10:06:45 INFO - 'MAIL': '/var/mail/cltbld', 10:06:45 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:06:45 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:06:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:06:45 INFO - 'MOZ_NO_REMOTE': '1', 10:06:45 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:06:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:06:45 INFO - 'NO_EM_RESTART': '1', 10:06:45 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:06:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:06:45 INFO - 'PWD': '/builds/slave/test', 10:06:45 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:06:45 INFO - 'RUST_BACKTRACE': '1', 10:06:45 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 10:06:45 INFO - 'SHELL': '/bin/bash', 10:06:45 INFO - 'SHLVL': '1', 10:06:45 INFO - 'TERM': 'linux', 10:06:45 INFO - 'TMOUT': '86400', 10:06:45 INFO - 'USER': 'cltbld', 10:06:45 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1500309659.981018-920335768', 10:06:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:06:45 INFO - '_': '/tools/buildbot/bin/python'} 10:06:45 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/ZhXVXYEsTmqLf6LrsIK64w/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-065', '--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 10:06:45 INFO - mozversion application_buildid: 20170717162507 10:06:45 INFO - mozversion application_changeset: e0b0865639cebc1b5afa0268a4b073fcdde0e69c 10:06:45 INFO - mozversion application_display_name: Nightly 10:06:45 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:06:45 INFO - mozversion application_name: Firefox 10:06:45 INFO - mozversion application_remotingname: firefox 10:06:45 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 10:06:45 INFO - mozversion application_vendor: Mozilla 10:06:45 INFO - mozversion application_version: 56.0a1 10:06:45 INFO - mozversion platform_buildid: 20170717162507 10:06:45 INFO - mozversion platform_changeset: e0b0865639cebc1b5afa0268a4b073fcdde0e69c 10:06:45 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 10:06:45 INFO - mozversion platform_version: 56.0a1 10:06:45 INFO - using testdate: 1500311205 10:06:45 INFO - actual date: 1500311205 10:06:45 INFO - starting webserver on 'localhost:38719' 10:06:45 INFO - SUITE-START | Running 2 tests 10:06:45 INFO - TEST-START | dromaeo_css 10:06:45 INFO - Initialising browser for dromaeo_css test... 10:06:45 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:38719/getInfo.html -profile /tmp/tmpm5O3a3/profile 10:06:45 INFO - TEST-INFO | started process 1939 (/builds/slave/test/build/application/firefox/firefox http://localhost:38719/getInfo.html) 10:06:52 INFO - TEST-INFO | 1939: exit 0 10:06:52 INFO - Browser initialized. 10:06:52 INFO - Running cycle 1/1 for dromaeo_css test... 10:06:52 INFO - TEST-INFO | started process 2165 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpm5O3a3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 10:07:03 INFO - PID 2165 | RSS: Main: 169885696 10:07:03 INFO - PID 2165 | 10:10:01 INFO - PID 2165 | Cycle 1(1): loaded http://localhost:38719/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38719/tests/dromaeo/cssquery-ext.html) 10:10:03 INFO - PID 2165 | RSS: Main: 178155520 10:10:03 INFO - PID 2165 | 10:13:04 INFO - PID 2165 | Cycle 1(1): loaded http://localhost:38719/tests/dromaeo/cssquery-ext.html (next: http://localhost:38719/tests/dromaeo/cssquery-jquery.html) 10:13:05 INFO - PID 2165 | RSS: Main: 176910336 10:13:05 INFO - PID 2165 | 10:16:07 INFO - PID 2165 | Cycle 1(1): loaded http://localhost:38719/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38719/tests/dromaeo/cssquery-mootools.html) 10:16:07 INFO - PID 2165 | RSS: Main: 178724864 10:16:07 INFO - PID 2165 | 10:19:09 INFO - PID 2165 | Cycle 1(1): loaded http://localhost:38719/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38719/tests/dromaeo/cssquery-prototype.html) 10:19:10 INFO - PID 2165 | RSS: Main: 175243264 10:19:10 INFO - PID 2165 | 10:22:13 INFO - PID 2165 | Cycle 1(1): loaded http://localhost:38719/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38719/tests/dromaeo/cssquery-yui.html) 10:22:13 INFO - PID 2165 | RSS: Main: 176218112 10:22:13 INFO - PID 2165 | 10:25:15 INFO - PID 2165 | Cycle 1(1): loaded http://localhost:38719/tests/dromaeo/cssquery-yui.html (next: http://localhost:38719/tests/dromaeo/cssquery-dojo.html) 10:25:15 INFO - PID 2165 | RSS: Main: 179228672 10:25:15 INFO - PID 2165 | 10:25:15 INFO - PID 2165 | __start_tp_report 10:25:15 INFO - PID 2165 | _x_x_mozilla_page_load 10:25:15 INFO - PID 2165 | _x_x_mozilla_page_load_details 10:25:15 INFO - PID 2165 | |i|pagename|runs| 10:25:15 INFO - PID 2165 | |0;dojo.html;3042.7870049096573;3120.625524937008;3126.390353880994;3147.9370412591747;3156.1951702315905;5914.112883067537;5932.940670593303;5981.252343457068;5988.3712210217955;6009;6002.639841609506;6021.397860213977;6027.517798576115;6037.698115094238;6041.818745437633;5501.944980550204;5511.889762204753;5522.861928451801;5528.530074943625;5541.5289700375515;5532.28080349556;5542.584306177033;5564.666120032791;5569.526590239834;5570.136628822539;5562.471565201299;5569.693666848321;5569.693666848342;5570.969370666419;5578.804741834037;5539.224508568804;5566.081596536566;5574.247476590649;5579.191017302468;5601.7759289628775;5459.508644222039;5477.178423236546;5502.2296878437055;5544.584156188302;5559.332880054379;5976.64140151588;6017.7592896284095;6068.393160683941;6079.392060793885;6097.512199024068;6282.528810339243;6298.496120310364;6350.587211831216;6379.776707815204;6386.425221730066;6412.871742565169;6474.384933431316;6538.901916471256;6551.508636852208;6552.541322107454;6020.909686354708;6034.24571928509;6034.969825150846;6035.124906888521;6055.27336719592;5785.537157027427;6597.63712995785;6600.1089852869245;6631.806274870473;6725.361090696376;6221.564490485713;6223.813285601439;6320.5259605528845;6339.302676705559;6341.080543321193;6264.655443950535;6343.143675603735;6346.4605508532295;6444.871102577922;6497.837554061186;6274.6548939808745;6356.682165891687;6396.744130234832;6419.99219363735;6516.609003459713;6390;6393.648349340738;6419.972804351281;6428.614283143026;6461.8061458156335;5223.947760522422;5225.9738701307015;5296.576273898079;5307.0182016326335;5326.9467305327225;4412.69111162222;4493.258612328995;4497.572730590588;4511.729296242236;4513.074819661962;5519.199716041152;5527.917081243784;5540.390557038722;5543.972280138654;5548.250986116904;6484.740610375532;6486;6489.156409666713;6491.67541622917;6506.512011599149;5508.118701007899;5520.585956053312;5540.2243685884005;5542.86142846424;5578.693171875505;5643.266375371176;5713.200151978726;5725.656460612293;5730.942690573041;5761.366249712528;5343.893122137613;6285.402886725754;6304.495640348761;6308.148399965946;6308.463780578611;6454;6464.127342808661;6532.085508028785;6553.115329430657;6559.6064236145985;6187.876242475035;6263.843403914939;6318.936810631835;6359.618422894641;6362.268339141058;6289.654069026247;6334.746610135543;6365;6453.41919227253;6453.774117906039;6459.935400646122;6479.5788273762055;6489.5781774184525;6490.902636460552;6515.28331883502;5331.413544510023;6206.131141640264;6249.281332646804;6327.303996560283;6335.461485773761;6249.625022498664;6268.623882567061;6284.622922624657;6338.809835704752;6346.365363463617;6133.815985520441;6135.9079613806725;6149.323574406722;6232.127502149612;6236.251649802053;6235.688215589294;6243.313235544178;6250.718717657625;6292.779752708633;6298.960671489153;5962.493188078888;6054.061620448838;6097.054956481752;6101.389861013863;6114.57197996136 10:25:15 INFO - PID 2165 | |1;ext.html;806.7741032510899;841.1336323586708;861.4486728493763;886.9467831930085;890.9955450222752;38897.4165387519;40028.79985600068;40211.59788402119;40468;40476.39285410714;36112.81943590285;36403.81798091013;36455;36519;36545.63454365455;6779.186497620292;6853.862922741542;6891.276415976326;6904.447644188453;6917.55035922666;6874.725010999554;6972.651367431608;6975.755848545302;6977.162740471151;6997.545159564637;6894.758683446081;6895.344942230505;6955.547889387199;6965.303469653019;6987.650617469106;6846.931530684679;6871.312868713114;6872.450203983669;6898.448124150106;6898.793036208922;6261.96677548204;6307.580794321287;6334.841628959267;6339.96830015847;6358.395952384516;32649.836750816332;32860.67139328624;32920;32934;33147.17132071718;3296.241864371208;3325.085601459594;3342.565466489341;3422.9315413691834;3544.769589976643;30271.697283027108;30429.847850760827;30434.54348184779;30443.2389190272;30500;4861.805527778884;4896.975515122437;4919.08996835583;4948.158813001798;4978.900421991576;194163;194362;195219;195883.99999999857;197049;48607.27089093666;49117;49323.50676493261;49337;49389.25916111189;51541;51812.22281665778;52006.21990670143;52181.478185218424;52192.73903630458;15904.443344482888;15934.36262549485;15948.2823272953;15954.521364359089;15965.361385544447;13139.080264381593;13219;13236.13965092266;13274.93362533181;13366.131201471873;14344.856551434561;14410.13539187631;14416.279186040865;14458;14595.562133136023;5649.124385720138;5820.621659592113;5862.941370586324;5934.495567876693;5948.583599148018;989.4459102902398;995.6863587969766;1003.9196864250843;1040.4433628008978;1042.1037907399782;22057.33827985163;22059;22349.32952011442;22426;29015.274618134714;1086.750047489082;1091.3997301484153;1101.3336931156534;1102.9062529685066;1106.5850306135198;12358.82591153839;12432.875671243171;12434.56479023248;12476.937615311865;12578.68553286157;224045;226901;227319;227375;228100;52635.47364526306;52760.47239527556;53023.73488132535;53042.7347863266;53148;1410.4949201234922;1470.919099449519;1473.82314122306;1482.6071091160852;1495.6709523904724;21021.89489052545;22065.33803985883;22290.442738931655;22293.777062229172;22338.10647574144;37573.62426375701;37749.62250377461;37850.810745946095;38055;38109.42835857409;197019;197285;197385;198029;198323;29762.255943600718;34089.318213636085;34242.48636270408;34276;34503.137421564665;42241.78879105585;42976;43404.78297608492;44011.11977760491;44438;28648.85675571609;31186.844065779525;31496.685033149377;31996.5200521997;32237.87167449128;30920;31761.523577145897;32101.839490802395;32204.516932245566;32281;35886.28227435384;35965.82017090003;36212;36219;36493;30413.543796842623;31494;31615;31697.20756981094;31922;22274;23146.884265578563;23369.76630233676;23619.763802361755;23710 10:25:15 INFO - PID 2165 | |2;jquery.html;567.8977783998879;574.2104606166521;574.4112284907969;584.713490389709;597.5816928150294;21070.6839397409;21906;22110.778892211074;22113.226037088683;22561.435964100907;24858.875705621445;26774.196774096807;26789.33026674334;26951.595726064075;26966.325841853963;6433.388828061338;6549.672516374186;6567.211934567858;6568.244651865049;6580.407763301302;5873.970630146843;6363.204599425072;6429.8392540186405;6470.708818103173;6481.967590162042;6204.379562043782;6482.7406903723795;6483.805485835433;6498.902516462257;6540.967295163541;6492.513061520382;6502.122213501164;6502.6748662566915;6508.54440189187;6515.120458738057;3621.3300539400293;3800.3539398302355;3817.7327587068917;3822.8661996830256;6044.8186554403;28413;29999.700002999907;30483;30524.69475305241;30546.54180187299;1853.5180852978187;1876.3807943378788;1877.1458986161401;1877.774667039964;1881.040669258688;18192.63614727698;18709.158087886077;19067.80932190688;19088.809111908842;19155.23379064836;2335.474518233384;2363.869987150706;2386.2602593195993;2390.796782273509;2393.329867637047;132696;135608.999999999;135643.32178339144;135938.3203083988;136036;14772.63068423298;15219.315130819139;15345.769813452807;15518.224088795741;15649.765253521206;24187.637185442232;24237.272881813573;24277.514449710907;24348.539087654797;24356.391090222885;10378.636747713794;10453.634122805664;10651.615290012249;10682.198835087243;10687.625933092304;9858.112769850748;9880.35777674449;9920.107190352903;9955.104040636377;10078.949605251926;9127.452352858849;9604.327697061139;9618.951905240428;9625.807483850283;9743.489759087353;2620.502104600158;2626.540355437829;2669.7997650175926;2741.1481677430834;2784.610154578361;926.7961048569304;960.9327347085776;961.5576834655997;985.8767654043245;986.2208855004609;19572.608547828964;19647.901760491106;20128.49678758043;23226.3032109037;24722.752772472406;1023.247912784103;1055.5672174408455;1056.4136904018344;1058.9470526473644;1061.930974486656;11257.043151332065;11281.32312061279;11403.942980285046;11430;11605.88394116048;484169;484972;509581;511346;514303;106563;107253.46373268084;115581;117387;117744;1198.1553005131361;1232.2483285196201;1272.8090786381931;1281.2056524954587;1282.6665067082627;20577.691334629693;20619.381418557467;20715.689264661345;21371.67942480895;21784.45538861541;54135.45864541304;55132;55741.72129139328;56004;58405.70797145987;65750.67124664345;68787.3121268781;69131;69317.3068269331;70903;14111;14774.335154917839;14922.328495217524;15019.624509387353;15138.243087845343;17682.292708291523;18444;18712.719309210646;22181.445463863532;23914.760852391253;16900.746488802924;18263.360782372554;18471.815281847008;18486.630267394306;18671.159797809403;16790.66418671644;17484.388046418313;17908.46274611764;18150.364737234133;18273.451796446127;18421.723674145167;20052.59894802125;20125;20261.89869050704;20263.59472810565;14812;14904.329305181076;14919.552413427615;14947.177905215318;14968.925155374154;18750.156242968827;18809.247630094644;18887.244510219985;18933.33733319327;18949.715754263972 10:25:15 INFO - PID 2165 | |3;mootools.html;1322.656109411553;1387.1954266525415;1395.2814300635175;1395.9581212563626;1400.7548678981182;12941.805872911902;13499.122557033787;13544.322783860804;13566.45734170632;13601.047926645115;13080.280584567845;13464.192148471098;13502.257375844325;13531.255780932044;13532;2551.1963731424635;2582.496413199427;2587.9482410351875;2590.44305474323;2594.779443747284;2483.7640424159677;2520.193538067819;2532.8480291182495;2538.9111381101666;2546.987265063672;2046.3656266557414;2491.040949234549;2492.389364605674;2536.581464058437;2539.987300063506;2160.470684682255;2177.5536015116863;2455.5088982203542;2546.567083595793;2559.053150334388;2529.20330096021;2536.7716905478596;2537.2641933839163;2544.0459827564664;2554.9105781297753;13249.536266230733;13341.599752007456;13343.466261349631;13384.330783460788;13386.129901556367;7062.258462861377;7371;7436.1820199777985;7444.622744792231;7461.589612571306;4733.83431579893;4870.561649451531;5033.496650334974;5085.262636917626;5085.389753229636;1792.4891405949243;1795.5780391607962;1803.9368622098164;1859.1912518054555;1873.7095750158746;23180.65229021566;23373;23402.882985585133;23424.765752342428;23445.17941872026;6032.607880487842;6098.573099883054;6226.813195604139;6269.46709529686;6411.294757576663;14682.853171468363;14765.852341476448;14833.480828170963;14853.9602227843;14877;6856.897146542806;6993.930060699327;6997.93002069983;6997.965010174917;7003.439724822002;6453;6507.219133703891;6525.119108920235;6650.767223147167;6797.218319893177;4861.29511220871;5004.249362595567;5019.949800502021;5054.292399064134;5154.149565321755;1376.6283103561982;1404.1504889541884;1413.61832305277;1423.2030063164455;1424.3448013913508;875.8117004843989;879.8152387998464;891.4829398948594;911.9740292171307;925.9259259259243;7166.856662866713;7226.602536860523;7252.456065795086;7271.127464704269;7305.086864141982;722.8229083874485;725.5175308419947;948.3877408405738;1001.9048190421898;1005.3465247589126;4940;5214.765335559909;5307.674245489913;5341.118715411913;5490.6431081980345;18007.099645017697;18266.086695665163;18316.17577209002;18356.724649130272;18376.264949401873;17600.20799064045;18241.27034918615;18284.54288642768;18450.446486605422;18507.814921850608;9856.68164022654;10097.646582369582;10231.43727095002;10293.94853025745;10309.432981186106;7560.4329675273475;7771.92228077712;8019.599020048858;8074.192580741878;8122.675092996214;15420.691586168437;16136.435224767078;16198.190090495193;16972.49082527526;17109.230084645973;16023.839761602701;16636.25136868868;16872.79679751447;17249.655006899542;17475.82524174742;9585.664501742405;9906.30655854112;9918.05778451046;9946.104850563484;9964.601415943282;12649.367531623198;12770.297633629867;13202.867971320164;13217.933910330386;13236.536721214712;10150.289479736348;10436.112930401001;10462.21533384984;10465.529051192563;10662.573497060032;10021.09810117093;10278.691639250834;10466.529006194587;10476.371417714656;10576;9228.984811670845;9386.624535018796;9389.061093890556;9403.85894211601;9410.341276110881;7173.390261827803;7258.745943891939;7288.562686238843;7298.927010729824;7314.451416143704;7206.6396680164735;7306.378957788647;7365.7790266292095;7432.516886402366;7490.438217133627 10:25:15 INFO - PID 2165 | |4;prototype.html;490.3374675511969;494.90101979604066;530.358266497538;531.1395539226453;532.2117684579811;5958.404159584039;6019.969900150504;6069.15031895535;6074.331823499417;6161.753529858805;5922;5924.99275123229;5963.970180149104;5980.252468441445;6044.304904935933;4917.655764096515;4958.801647934097;4961.900761984758;4970;5009.749512524378;4971.279164521142;4981;4987.351644286237;4998.6750861193905;5023.572996295319;4641.767911604423;4892.8042878285005;4931.876703082416;4964.453910069889;4981.651284410093;4815.855524334275;4818.566329030386;4846.75766211688;4858.271259311132;4895.265710143472;4325.6106950374615;4342.261815491374;4370.2133615949115;4377.255866502702;4379.146066517031;5862.736176872008;5887.35239123696;5901;5915.408459154093;5952.375000624958;5521.116621340566;5528.778848846082;5538.667679939176;5542.251796007527;5549.639273447213;6290.748370065192;6298.307186209513;6311.842203944892;6387.201599800025;6391.561898572831;4793.424789025305;4798.328234047236;4804.615630749532;4815.831445899412;4832.951670483285;6417.229932408094;6504.739810407626;6586.440152587036;6611.669416529202;6645.3686899744935;4881.975590122027;4886.877828054327;4936.90126197474;4950.925736113961;4961.206207006861;4905.87735306613;4924.679895806761;4940.555350018516;4980.427250866124;5012.774425150877;5535.363433205152;5589.35722391922;5601.159826026047;5601.991641504568;5608.831735047955;6394.584352017104;6420.839479013062;6434.420902118738;6439.839004024937;6444.8388790280615;1724.5688577855535;1734.9045802480732;1736.6266252755718;1744.6074633207681;1754.9558012982254;1165.650304908524;1221.7984032634693;1230.4865016030333;1236.394166858251;1244.7074937389707;5519.337679478488;5521;5521.66869987794;5525.668459892339;5552.056150454432;6480.189976252968;6486.221653401528;6497.967510162419;6500.902486462707;6533.281339052701;5481.7109734159985;5524.364698059694;5526.889462210734;5560.165975103686;5597.888042239132;3429.3484237994703;3452.879149229765;3479.2867462170193;3481.3211423772123;3490.9650903491147;6349.206349206349;6350.714217860207;6394.584352017104;6409.4231519163495;6429.582077165063;6713.69788359525;6726.0158253315385;6732;6732.831679208059;6846.117317737562;6271.9024170769935;6364.936350636434;6370.872582548416;6390.360963903572;6480.416762491398;6424.787606196902;6429.54993150475;6492.513061520499;6496.935030649633;6582.923357390729;5981.616545109437;6435.774747883989;6455.354464553695;6475.417212450902;6560.901586476302;6252.468540174136;6309.684515774285;6399.256434985586;6401;6423.743050277936;4930.975345123252;4937.926071050239;4947.282644016669;4976.253561965589;4987.476314986874;6338.239411270492;6574.107392747176;6602.933970660232;6627.304133065959;6646.867062658816;6177.505799536116;6322.589031712924;6337.936620633919;6349.555311282029;6355.936440635719;6223.3465486125115;6223.875522489616;6228.847663182326;6303.243610766737;6350.110984462087;6199.349068347939;6236.781712640036;6264.498840092872;6302.621842689453;6354.17395738551;6285.811425657238;6310.6529140895855;6361.777337793155;6412.679366031586;6413.77551785704;6128.724207410766;6159.476444502267;6196.907046394217;6224.657643829632;6235.347632877382 10:25:15 INFO - PID 2165 | |5;yui.html;903.602414937427;921.5392303848078;925.3337596930207;928.4104593583077;946.1957336264177;14993.700125997473;18148.455546333615;19101.140448679824;19131.234750609976;19170;15566.066036037846;15825.60435989098;16077.919610401961;16123.596910077255;16126.113063781488;1025.0467065628961;1053.968380948569;1059.7986382587321;1060.4220699718633;1060.8779990301136;1037.2531777120462;1037.584966013593;1045.362328979322;1046.481991414251;1046.7278507588005;1079.3739631013993;1086.625114335553;1087.597588892107;1090.0843291635024;1102.6030628973563;994.666786626481;1074.9247552671316;1075.569772091166;1076.48328802175;1089.2919602258555;746.115852714535;779.4894344204555;786.4219798448136;789.7038610521055;790.0992868130336;19211.51971200717;19565.510862228417;19570.412887613395;19606;19659.901700491548;18592.163352649164;19716.112774925165;19892.502687432785;19907.701384479245;20010.79989200104;15390.384384624602;16067.955582887074;16158.434454794144;16172.514824555283;16282.348706051744;3508.7894726316504;3531.8940431787087;3548.4854696069183;3571.1250743567734;3572.1962558424148;91394.54302728444;112770;116258.41870790676;116610;119802.40098799451;12698.746025079447;12872.678183045311;13036.80444793329;13129.868701313055;15293.770593441108;27515.17454476369;28342.85828570844;28643.57034644482;28781.85609071983;29160.854195728887;8460.492370457792;8537;8542.74371768848;8587.914120858837;8601.354898382646;4043.939340909889;4120.938185927213;4133.318002529609;4173.248815213291;4215.662746980234;4887.853364399074;4995.525425084611;5003.3495645565845;5011.448740638527;5013.749312534359;944.9433034017981;955.3264948211634;957.5212393803098;985.8176237395961;1030.5568605499557;639.718523849514;664.5713514783034;698.9405900498413;703.0719450325623;717.160921721587;11277.436128193558;11499.655010349703;11758.176927614984;12311.13822032467;12337.938310308571;681.4207923265284;684.3532861445985;686.3630241873069;689.862027594473;712.5226098514008;4864.124457597595;5043.268726034705;5055.393352797688;5093.312402825645;5455.7897208166105;97014.51492742491;97029;97805.5109724461;100189.49905250572;101713.4742978856;82334;86318;86418.56790716006;87646;88495;72646.63676681583;72874.27125728781;74904.62547687227;79162.6041869787;79522;11736.237144585575;11851.348175850066;12004.639860804189;12357.505699771908;12374.62876113718;34194.316113678084;35952;35976.460353095244;37548;38100.809495952344;44338.57268378455;45869.54130458653;46197.53802461932;67801;68328.65835670989;17043.233054512824;17521.649567008844;17696.73454898152;17839.46481605554;18118.184681689618;20084;20227.696584550948;20321.695174572687;20512.794872051087;20647;15897.617786674697;16136.757948630546;16541.66916661636;16793.41223057236;17092.48722538276;15358.616034599225;15385.384584616937;15526.22368881574;15757.29092190877;15766.290516926536;16260;16493.505194844172;16559;16609.916950415653;16755.497335079966;12903.612891612891;13504.93247533756;13753.587392378246;14029.92985035109;14140.575782726535;12900.612981610566;13147.276899770604;13326.200427974352;13398.196108233537;13702 10:25:15 INFO - PID 2165 | __end_tp_report 10:25:15 INFO - PID 2165 | __start_cc_report 10:25:15 INFO - PID 2165 | _x_x_mozilla_cycle_collect,372 10:25:15 INFO - PID 2165 | __end_cc_report 10:25:15 INFO - PID 2165 | __startTimestamp1500312315872__endTimestamp 10:25:15 INFO - PID 2165 | 10:25:15 INFO - PID 2165 | ------- Summary: start ------- 10:25:15 INFO - PID 2165 | Number of tests: 6 10:25:15 INFO - PID 2165 | 10:25:15 INFO - PID 2165 | [#0] dojo.html Cycles:165 Average:5922.47 Median:6114.57 stddev:682.38 (11.2%) stddev-sans-first:645.99 10:25:15 INFO - PID 2165 | Values: 3042.8 3120.6 3126.4 3147.9 3156.2 5914.1 5932.9 5981.3 5988.4 6009.0 6002.6 6021.4 6027.5 6037.7 6041.8 5501.9 5511.9 5522.9 5528.5 5541.5 5532.3 5542.6 5564.7 5569.5 5570.1 5562.5 5569.7 5569.7 5571.0 5578.8 5539.2 5566.1 5574.2 5579.2 5601.8 5459.5 5477.2 5502.2 5544.6 5559.3 5976.6 6017.8 6068.4 6079.4 6097.5 6282.5 6298.5 6350.6 6379.8 6386.4 6412.9 6474.4 6538.9 6551.5 6552.5 6020.9 6034.2 6035.0 6035.1 6055.3 5785.5 6597.6 6600.1 6631.8 6725.4 6221.6 6223.8 6320.5 6339.3 6341.1 6264.7 6343.1 6346.5 6444.9 6497.8 6274.7 6356.7 6396.7 6420.0 6516.6 6390.0 6393.6 6420.0 6428.6 6461.8 5223.9 5226.0 5296.6 5307.0 5326.9 4412.7 4493.3 4497.6 4511.7 4513.1 5519.2 5527.9 5540.4 5544.0 5548.3 6484.7 6486.0 6489.2 6491.7 6506.5 5508.1 5520.6 5540.2 5542.9 5578.7 5643.3 5713.2 5725.7 5730.9 5761.4 5343.9 6285.4 6304.5 6308.1 6308.5 6454.0 6464.1 6532.1 6553.1 6559.6 6187.9 6263.8 6318.9 6359.6 6362.3 6289.7 6334.7 6365.0 6453.4 6453.8 6459.9 6479.6 6489.6 6490.9 6515.3 5331.4 6206.1 6249.3 6327.3 6335.5 6249.6 6268.6 6284.6 6338.8 6346.4 6133.8 6135.9 6149.3 6232.1 6236.3 6235.7 6243.3 6250.7 6292.8 6299.0 5962.5 6054.1 6097.1 6101.4 6114.6 10:25:15 INFO - PID 2165 | 10:25:15 INFO - PID 2165 | [#1] ext.html Cycles:180 Average:37114.31 Median:3333.83 stddev:53713.42 (1611.2%) stddev-sans-first:53794.92 10:25:15 INFO - PID 2165 | Values: 806.8 841.1 861.4 886.9 891.0 38897.4 40028.8 40211.6 40468.0 40476.4 36112.8 36403.8 36455.0 36519.0 36545.6 6779.2 6853.9 6891.3 6904.4 6917.6 6874.7 6972.7 6975.8 6977.2 6997.5 6894.8 6895.3 6955.5 6965.3 6987.7 6846.9 6871.3 6872.5 6898.4 6898.8 6262.0 6307.6 6334.8 6340.0 6358.4 32649.8 32860.7 32920.0 32934.0 33147.2 3296.2 3325.1 3342.6 3422.9 3544.8 30271.7 30429.8 30434.5 30443.2 30500.0 4861.8 4897.0 4919.1 4948.2 4978.9 194163.0 194362.0 195219.0 195884.0 197049.0 48607.3 49117.0 49323.5 49337.0 49389.3 51541.0 51812.2 52006.2 52181.5 52192.7 15904.4 15934.4 15948.3 15954.5 15965.4 13139.1 13219.0 13236.1 13274.9 13366.1 14344.9 14410.1 14416.3 14458.0 14595.6 5649.1 5820.6 5862.9 5934.5 5948.6 989.4 995.7 1003.9 1040.4 1042.1 22057.3 22059.0 22349.3 22426.0 29015.3 1086.8 1091.4 1101.3 1102.9 1106.6 12358.8 12432.9 12434.6 12476.9 12578.7 224045.0 226901.0 227319.0 227375.0 228100.0 52635.5 52760.5 53023.7 53042.7 53148.0 1410.5 1470.9 1473.8 1482.6 1495.7 21021.9 22065.3 22290.4 22293.8 22338.1 37573.6 37749.6 37850.8 38055.0 38109.4 197019.0 197285.0 197385.0 198029.0 198323.0 29762.3 34089.3 34242.5 34276.0 34503.1 42241.8 42976.0 43404.8 44011.1 44438.0 28648.9 31186.8 31496.7 31996.5 32237.9 30920.0 31761.5 32101.8 32204.5 32281.0 35886.3 35965.8 36212.0 36219.0 36493.0 30413.5 31494.0 31615.0 31697.2 31922.0 22274.0 23146.9 23369.8 23619.8 23710.0 10:25:15 INFO - PID 2165 | 10:25:15 INFO - PID 2165 | [#2] jquery.html Cycles:180 Average:34990.70 Median:22147.34 stddev:84055.73 (379.5%) stddev-sans-first:84251.79 10:25:15 INFO - PID 2165 | Values: 567.9 574.2 574.4 584.7 597.6 21070.7 21906.0 22110.8 22113.2 22561.4 24858.9 26774.2 26789.3 26951.6 26966.3 6433.4 6549.7 6567.2 6568.2 6580.4 5874.0 6363.2 6429.8 6470.7 6482.0 6204.4 6482.7 6483.8 6498.9 6541.0 6492.5 6502.1 6502.7 6508.5 6515.1 3621.3 3800.4 3817.7 3822.9 6044.8 28413.0 29999.7 30483.0 30524.7 30546.5 1853.5 1876.4 1877.1 1877.8 1881.0 18192.6 18709.2 19067.8 19088.8 19155.2 2335.5 2363.9 2386.3 2390.8 2393.3 132696.0 135609.0 135643.3 135938.3 136036.0 14772.6 15219.3 15345.8 15518.2 15649.8 24187.6 24237.3 24277.5 24348.5 24356.4 10378.6 10453.6 10651.6 10682.2 10687.6 9858.1 9880.4 9920.1 9955.1 10078.9 9127.5 9604.3 9619.0 9625.8 9743.5 2620.5 2626.5 2669.8 2741.1 2784.6 926.8 960.9 961.6 985.9 986.2 19572.6 19647.9 20128.5 23226.3 24722.8 1023.2 1055.6 1056.4 1058.9 1061.9 11257.0 11281.3 11403.9 11430.0 11605.9 484169.0 484972.0 509581.0 511346.0 514303.0 106563.0 107253.5 115581.0 117387.0 117744.0 1198.2 1232.2 1272.8 1281.2 1282.7 20577.7 20619.4 20715.7 21371.7 21784.5 54135.5 55132.0 55741.7 56004.0 58405.7 65750.7 68787.3 69131.0 69317.3 70903.0 14111.0 14774.3 14922.3 15019.6 15138.2 17682.3 18444.0 18712.7 22181.4 23914.8 16900.7 18263.4 18471.8 18486.6 18671.2 16790.7 17484.4 17908.5 18150.4 18273.5 18421.7 20052.6 20125.0 20261.9 20263.6 14812.0 14904.3 14919.6 14947.2 14968.9 18750.2 18809.2 18887.2 18933.3 18949.7 10:25:15 INFO - PID 2165 | 10:25:15 INFO - PID 2165 | [#3] mootools.html Cycles:180 Average:8395.59 Median:2534.71 stddev:5747.17 (226.7%) stddev-sans-first:5738.72 10:25:15 INFO - PID 2165 | Values: 1322.7 1387.2 1395.3 1396.0 1400.8 12941.8 13499.1 13544.3 13566.5 13601.0 13080.3 13464.2 13502.3 13531.3 13532.0 2551.2 2582.5 2587.9 2590.4 2594.8 2483.8 2520.2 2532.8 2538.9 2547.0 2046.4 2491.0 2492.4 2536.6 2540.0 2160.5 2177.6 2455.5 2546.6 2559.1 2529.2 2536.8 2537.3 2544.0 2554.9 13249.5 13341.6 13343.5 13384.3 13386.1 7062.3 7371.0 7436.2 7444.6 7461.6 4733.8 4870.6 5033.5 5085.3 5085.4 1792.5 1795.6 1803.9 1859.2 1873.7 23180.7 23373.0 23402.9 23424.8 23445.2 6032.6 6098.6 6226.8 6269.5 6411.3 14682.9 14765.9 14833.5 14854.0 14877.0 6856.9 6993.9 6997.9 6998.0 7003.4 6453.0 6507.2 6525.1 6650.8 6797.2 4861.3 5004.2 5019.9 5054.3 5154.1 1376.6 1404.2 1413.6 1423.2 1424.3 875.8 879.8 891.5 912.0 925.9 7166.9 7226.6 7252.5 7271.1 7305.1 722.8 725.5 948.4 1001.9 1005.3 4940.0 5214.8 5307.7 5341.1 5490.6 18007.1 18266.1 18316.2 18356.7 18376.3 17600.2 18241.3 18284.5 18450.4 18507.8 9856.7 10097.6 10231.4 10293.9 10309.4 7560.4 7771.9 8019.6 8074.2 8122.7 15420.7 16136.4 16198.2 16972.5 17109.2 16023.8 16636.3 16872.8 17249.7 17475.8 9585.7 9906.3 9918.1 9946.1 9964.6 12649.4 12770.3 13202.9 13217.9 13236.5 10150.3 10436.1 10462.2 10465.5 10662.6 10021.1 10278.7 10466.5 10476.4 10576.0 9229.0 9386.6 9389.1 9403.9 9410.3 7173.4 7258.7 7288.6 7298.9 7314.5 7206.6 7306.4 7365.8 7432.5 7490.4 10:25:15 INFO - PID 2165 | 10:25:15 INFO - PID 2165 | [#4] prototype.html Cycles:180 Average:5367.97 Median:5938.68 stddev:1486.73 (25.0%) stddev-sans-first:1445.13 10:25:15 INFO - PID 2165 | Values: 490.3 494.9 530.4 531.1 532.2 5958.4 6020.0 6069.2 6074.3 6161.8 5922.0 5925.0 5964.0 5980.3 6044.3 4917.7 4958.8 4961.9 4970.0 5009.7 4971.3 4981.0 4987.4 4998.7 5023.6 4641.8 4892.8 4931.9 4964.5 4981.7 4815.9 4818.6 4846.8 4858.3 4895.3 4325.6 4342.3 4370.2 4377.3 4379.1 5862.7 5887.4 5901.0 5915.4 5952.4 5521.1 5528.8 5538.7 5542.3 5549.6 6290.7 6298.3 6311.8 6387.2 6391.6 4793.4 4798.3 4804.6 4815.8 4833.0 6417.2 6504.7 6586.4 6611.7 6645.4 4882.0 4886.9 4936.9 4950.9 4961.2 4905.9 4924.7 4940.6 4980.4 5012.8 5535.4 5589.4 5601.2 5602.0 5608.8 6394.6 6420.8 6434.4 6439.8 6444.8 1724.6 1734.9 1736.6 1744.6 1755.0 1165.7 1221.8 1230.5 1236.4 1244.7 5519.3 5521.0 5521.7 5525.7 5552.1 6480.2 6486.2 6498.0 6500.9 6533.3 5481.7 5524.4 5526.9 5560.2 5597.9 3429.3 3452.9 3479.3 3481.3 3491.0 6349.2 6350.7 6394.6 6409.4 6429.6 6713.7 6726.0 6732.0 6732.8 6846.1 6271.9 6364.9 6370.9 6390.4 6480.4 6424.8 6429.5 6492.5 6496.9 6582.9 5981.6 6435.8 6455.4 6475.4 6560.9 6252.5 6309.7 6399.3 6401.0 6423.7 4931.0 4937.9 4947.3 4976.3 4987.5 6338.2 6574.1 6602.9 6627.3 6646.9 6177.5 6322.6 6337.9 6349.6 6355.9 6223.3 6223.9 6228.8 6303.2 6350.1 6199.3 6236.8 6264.5 6302.6 6354.2 6285.8 6310.7 6361.8 6412.7 6413.8 6128.7 6159.5 6196.9 6224.7 6235.3 10:25:15 INFO - PID 2165 | 10:25:15 INFO - PID 2165 | [#5] yui.html Cycles:180 Average:21283.86 Median:19632.95 stddev:28213.73 (143.7%) stddev-sans-first:28251.37 10:25:15 INFO - PID 2165 | Values: 903.6 921.5 925.3 928.4 946.2 14993.7 18148.5 19101.1 19131.2 19170.0 15566.1 15825.6 16077.9 16123.6 16126.1 1025.0 1054.0 1059.8 1060.4 1060.9 1037.3 1037.6 1045.4 1046.5 1046.7 1079.4 1086.6 1087.6 1090.1 1102.6 994.7 1074.9 1075.6 1076.5 1089.3 746.1 779.5 786.4 789.7 790.1 19211.5 19565.5 19570.4 19606.0 19659.9 18592.2 19716.1 19892.5 19907.7 20010.8 15390.4 16068.0 16158.4 16172.5 16282.3 3508.8 3531.9 3548.5 3571.1 3572.2 91394.5 112770.0 116258.4 116610.0 119802.4 12698.7 12872.7 13036.8 13129.9 15293.8 27515.2 28342.9 28643.6 28781.9 29160.9 8460.5 8537.0 8542.7 8587.9 8601.4 4043.9 4120.9 4133.3 4173.2 4215.7 4887.9 4995.5 5003.3 5011.4 5013.7 944.9 955.3 957.5 985.8 1030.6 639.7 664.6 698.9 703.1 717.2 11277.4 11499.7 11758.2 12311.1 12337.9 681.4 684.4 686.4 689.9 712.5 4864.1 5043.3 5055.4 5093.3 5455.8 97014.5 97029.0 97805.5 100189.5 101713.5 82334.0 86318.0 86418.6 87646.0 88495.0 72646.6 72874.3 74904.6 79162.6 79522.0 11736.2 11851.3 12004.6 12357.5 12374.6 34194.3 35952.0 35976.5 37548.0 38100.8 44338.6 45869.5 46197.5 67801.0 68328.7 17043.2 17521.6 17696.7 17839.5 18118.2 20084.0 20227.7 20321.7 20512.8 20647.0 15897.6 16136.8 16541.7 16793.4 17092.5 15358.6 15385.4 15526.2 15757.3 15766.3 16260.0 16493.5 16559.0 16609.9 16755.5 12903.6 13504.9 13753.6 14029.9 14140.6 12900.6 13147.3 13326.2 13398.2 13702.0 10:25:15 INFO - PID 2165 | -------- Summary: end -------- 10:25:15 INFO - PID 2165 | 10:25:16 INFO - TEST-INFO | 2165: exit 0 10:25:16 INFO - TEST-OK | dromaeo_css | took 1110565ms 10:25:16 INFO - TEST-START | kraken 10:25:16 INFO - Initialising browser for kraken test... 10:25:16 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:38719/getInfo.html -profile /tmp/tmpTc3t6b/profile 10:25:16 INFO - TEST-INFO | started process 2674 (/builds/slave/test/build/application/firefox/firefox http://localhost:38719/getInfo.html) 10:25:22 INFO - TEST-INFO | 2674: exit 0 10:25:22 INFO - Browser initialized. 10:25:22 INFO - Running cycle 1/1 for kraken test... 10:25:22 INFO - TEST-INFO | started process 3012 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTc3t6b/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 10:25:33 INFO - PID 3012 | RSS: Main: 169701376 10:25:33 INFO - PID 3012 | 10:25:36 INFO - PID 3012 | Cycle 1(1): loaded http://localhost:38719/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38719/tests/kraken/driver.html?testName=audio-beat-detection) 10:25:37 INFO - PID 3012 | RSS: Main: 176439296 10:25:37 INFO - PID 3012 | 10:25:40 INFO - PID 3012 | Cycle 1(1): loaded http://localhost:38719/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38719/tests/kraken/driver.html?testName=audio-dft) 10:25:40 INFO - PID 3012 | RSS: Main: 176644096 10:25:40 INFO - PID 3012 | 10:25:43 INFO - PID 3012 | Cycle 1(1): loaded http://localhost:38719/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38719/tests/kraken/driver.html?testName=audio-fft) 10:25:44 INFO - PID 3012 | RSS: Main: 170041344 10:25:44 INFO - PID 3012 | 10:25:46 INFO - PID 3012 | Cycle 1(1): loaded http://localhost:38719/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38719/tests/kraken/driver.html?testName=audio-oscillator) 10:25:46 INFO - PID 3012 | RSS: Main: 171347968 10:25:46 INFO - PID 3012 | 10:25:48 INFO - PID 3012 | Cycle 1(1): loaded http://localhost:38719/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38719/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:25:49 INFO - PID 3012 | RSS: Main: 172339200 10:25:49 INFO - PID 3012 | 10:25:52 INFO - PID 3012 | Cycle 1(1): loaded http://localhost:38719/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38719/tests/kraken/driver.html?testName=imaging-darkroom) 10:25:53 INFO - PID 3012 | RSS: Main: 175235072 10:25:53 INFO - PID 3012 | 10:25:56 INFO - PID 3012 | Cycle 1(1): loaded http://localhost:38719/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38719/tests/kraken/driver.html?testName=imaging-desaturate) 10:25:57 INFO - PID 3012 | RSS: Main: 176336896 10:25:57 INFO - PID 3012 | 10:26:00 INFO - PID 3012 | Cycle 1(1): loaded http://localhost:38719/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38719/tests/kraken/driver.html?testName=json-parse-financial) 10:26:00 INFO - PID 3012 | RSS: Main: 175185920 10:26:00 INFO - PID 3012 | 10:26:02 INFO - PID 3012 | Cycle 1(1): loaded http://localhost:38719/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38719/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:26:02 INFO - PID 3012 | RSS: Main: 174993408 10:26:02 INFO - PID 3012 | 10:26:04 INFO - PID 3012 | Cycle 1(1): loaded http://localhost:38719/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38719/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:26:05 INFO - PID 3012 | RSS: Main: 175063040 10:26:05 INFO - PID 3012 | 10:26:07 INFO - PID 3012 | Cycle 1(1): loaded http://localhost:38719/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38719/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:26:07 INFO - PID 3012 | RSS: Main: 175439872 10:26:07 INFO - PID 3012 | 10:26:10 INFO - PID 3012 | Cycle 1(1): loaded http://localhost:38719/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38719/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:26:11 INFO - PID 3012 | RSS: Main: 175415296 10:26:11 INFO - PID 3012 | 10:26:14 INFO - PID 3012 | Cycle 1(1): loaded http://localhost:38719/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38719/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:26:14 INFO - PID 3012 | RSS: Main: 175407104 10:26:14 INFO - PID 3012 | 10:26:16 INFO - PID 3012 | Cycle 1(1): loaded http://localhost:38719/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38719/tests/kraken/driver.html?testName=ai-astar) 10:26:16 INFO - PID 3012 | RSS: Main: 176742400 10:26:16 INFO - PID 3012 | 10:26:16 INFO - PID 3012 | __start_tp_report 10:26:16 INFO - PID 3012 | _x_x_mozilla_page_load 10:26:16 INFO - PID 3012 | _x_x_mozilla_page_load_details 10:26:16 INFO - PID 3012 | |i|pagename|runs| 10:26:16 INFO - PID 3012 | |0;ai-astar;101;109;109;110;110;108;110;110;108;110 10:26:16 INFO - PID 3012 | |1;audio-beat-detection;144;125;148;185;122;152;146;123;162;121 10:26:16 INFO - PID 3012 | |2;audio-dft;164;164;164;164;162;172;164;166;166;165 10:26:16 INFO - PID 3012 | |3;audio-fft;75;76;75;168;76;74;74;74;94;76 10:26:16 INFO - PID 3012 | |4;audio-oscillator;81;81;128;81;82;81;135;81;81;132 10:26:16 INFO - PID 3012 | |5;imaging-gaussian-blur;114;114;114;114;113;113;114;115;115;114 10:26:16 INFO - PID 3012 | |6;imaging-darkroom;151;151;149;149;150;150;149;149;150;150 10:26:16 INFO - PID 3012 | |7;imaging-desaturate;95;94;94;94;94;94;94;94;94;95 10:26:16 INFO - PID 3012 | |8;json-parse-financial;54;55;57;61;59;57;55;56;56;55 10:26:16 INFO - PID 3012 | |9;json-stringify-tinderbox;53;55;54;55;54;54;54;55;55;55 10:26:16 INFO - PID 3012 | |10;stanford-crypto-aes;77;76;85;77;77;78;76;78;77;79 10:26:16 INFO - PID 3012 | |11;stanford-crypto-ccm;127;138;137;133;126;126;134;127;135;155 10:26:16 INFO - PID 3012 | |12;stanford-crypto-pbkdf2;178;200;182;183;183;183;188;185;182;186 10:26:16 INFO - PID 3012 | |13;stanford-crypto-sha256-iterative;69;70;71;69;70;68;69;69;68;69 10:26:16 INFO - PID 3012 | __end_tp_report 10:26:16 INFO - PID 3012 | __start_cc_report 10:26:16 INFO - PID 3012 | _x_x_mozilla_cycle_collect,934 10:26:16 INFO - PID 3012 | __end_cc_report 10:26:16 INFO - PID 3012 | __startTimestamp1500312376962__endTimestamp 10:26:16 INFO - PID 3012 | 10:26:16 INFO - PID 3012 | ------- Summary: start ------- 10:26:16 INFO - PID 3012 | Number of tests: 14 10:26:16 INFO - PID 3012 | 10:26:16 INFO - PID 3012 | [#0] ai-astar Cycles:10 Average:108.50 Median:110.00 stddev:2.76 (2.5%) stddev-sans-first:0.87 10:26:16 INFO - PID 3012 | Values: 101.0 109.0 109.0 110.0 110.0 108.0 110.0 110.0 108.0 110.0 10:26:16 INFO - PID 3012 | 10:26:16 INFO - PID 3012 | [#1] audio-beat-detection Cycles:10 Average:142.80 Median:147.00 stddev:20.79 (14.1%) stddev-sans-first:22.05 10:26:16 INFO - PID 3012 | Values: 144.0 125.0 148.0 185.0 122.0 152.0 146.0 123.0 162.0 121.0 10:26:16 INFO - PID 3012 | 10:26:16 INFO - PID 3012 | [#2] audio-dft Cycles:10 Average:165.10 Median:164.50 stddev:2.69 (1.6%) stddev-sans-first:2.82 10:26:16 INFO - PID 3012 | Values: 164.0 164.0 164.0 164.0 162.0 172.0 164.0 166.0 166.0 165.0 10:26:16 INFO - PID 3012 | 10:26:16 INFO - PID 3012 | [#3] audio-fft Cycles:10 Average:86.20 Median:75.50 stddev:29.37 (38.9%) stddev-sans-first:30.87 10:26:16 INFO - PID 3012 | Values: 75.0 76.0 75.0 168.0 76.0 74.0 74.0 74.0 94.0 76.0 10:26:16 INFO - PID 3012 | 10:26:16 INFO - PID 3012 | [#4] audio-oscillator Cycles:10 Average:96.30 Median:81.00 stddev:24.46 (30.2%) stddev-sans-first:25.31 10:26:16 INFO - PID 3012 | Values: 81.0 81.0 128.0 81.0 82.0 81.0 135.0 81.0 81.0 132.0 10:26:16 INFO - PID 3012 | 10:26:16 INFO - PID 3012 | [#5] imaging-gaussian-blur Cycles:10 Average:114.00 Median:114.00 stddev:0.67 (0.6%) stddev-sans-first:0.71 10:26:16 INFO - PID 3012 | Values: 114.0 114.0 114.0 114.0 113.0 113.0 114.0 115.0 115.0 114.0 10:26:16 INFO - PID 3012 | 10:26:16 INFO - PID 3012 | [#6] imaging-darkroom Cycles:10 Average:149.80 Median:150.00 stddev:0.79 (0.5%) stddev-sans-first:0.71 10:26:16 INFO - PID 3012 | Values: 151.0 151.0 149.0 149.0 150.0 150.0 149.0 149.0 150.0 150.0 10:26:16 INFO - PID 3012 | 10:26:16 INFO - PID 3012 | [#7] imaging-desaturate Cycles:10 Average:94.20 Median:94.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 10:26:16 INFO - PID 3012 | Values: 95.0 94.0 94.0 94.0 94.0 94.0 94.0 94.0 94.0 95.0 10:26:16 INFO - PID 3012 | 10:26:16 INFO - PID 3012 | [#8] json-parse-financial Cycles:10 Average:56.50 Median:56.50 stddev:2.12 (3.8%) stddev-sans-first:2.05 10:26:16 INFO - PID 3012 | Values: 54.0 55.0 57.0 61.0 59.0 57.0 55.0 56.0 56.0 55.0 10:26:16 INFO - PID 3012 | 10:26:16 INFO - PID 3012 | [#9] json-stringify-tinderbox Cycles:10 Average:54.40 Median:55.00 stddev:0.70 (1.3%) stddev-sans-first:0.53 10:26:16 INFO - PID 3012 | Values: 53.0 55.0 54.0 55.0 54.0 54.0 54.0 55.0 55.0 55.0 10:26:16 INFO - PID 3012 | 10:26:16 INFO - PID 3012 | [#10] stanford-crypto-aes Cycles:10 Average:78.00 Median:77.50 stddev:2.62 (3.4%) stddev-sans-first:2.76 10:26:16 INFO - PID 3012 | Values: 77.0 76.0 85.0 77.0 77.0 78.0 76.0 78.0 77.0 79.0 10:26:16 INFO - PID 3012 | 10:26:16 INFO - PID 3012 | [#11] stanford-crypto-ccm Cycles:10 Average:133.80 Median:134.50 stddev:8.78 (6.5%) stddev-sans-first:8.96 10:26:16 INFO - PID 3012 | Values: 127.0 138.0 137.0 133.0 126.0 126.0 134.0 127.0 135.0 155.0 10:26:16 INFO - PID 3012 | 10:26:16 INFO - PID 3012 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:185.00 Median:184.00 stddev:5.91 (3.2%) stddev-sans-first:5.70 10:26:16 INFO - PID 3012 | Values: 178.0 200.0 182.0 183.0 183.0 183.0 188.0 185.0 182.0 186.0 10:26:16 INFO - PID 3012 | 10:26:16 INFO - PID 3012 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.20 Median:69.00 stddev:0.92 (1.3%) stddev-sans-first:0.97 10:26:16 INFO - PID 3012 | Values: 69.0 70.0 71.0 69.0 70.0 68.0 69.0 69.0 68.0 69.0 10:26:16 INFO - PID 3012 | -------- Summary: end -------- 10:26:16 INFO - PID 3012 | 10:26:17 INFO - PID 3012 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 10:26:17 INFO - TEST-INFO | 3012: exit 0 10:26:17 INFO - TEST-OK | kraken | took 61271ms 10:26:17 INFO - SUITE-END | took 1171s 10:26:18 INFO - Completed test suite (00:19:32) 10:26:18 INFO - javascript benchmark 10:26:18 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8210.556326583992, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3042.7870049096573, 3120.625524937008, 3126.390353880994, 3147.9370412591747, 3156.1951702315905, 5914.112883067537, 5932.940670593303, 5981.252343457068, 5988.3712210217955, 6009.0, 6002.639841609506, 6021.397860213977, 6027.517798576115, 6037.698115094238, 6041.818745437633, 5501.944980550204, 5511.889762204753, 5522.861928451801, 5528.530074943625, 5541.5289700375515, 5532.28080349556, 5542.584306177033, 5564.666120032791, 5569.526590239834, 5570.136628822539, 5562.471565201299, 5569.693666848321, 5569.693666848342, 5570.969370666419, 5578.804741834037, 5539.224508568804, 5566.081596536566, 5574.247476590649, 5579.191017302468, 5601.7759289628775, 5459.508644222039, 5477.178423236546, 5502.2296878437055, 5544.584156188302, 5559.332880054379, 5976.64140151588, 6017.7592896284095, 6068.393160683941, 6079.392060793885, 6097.512199024068, 6282.528810339243, 6298.496120310364, 6350.587211831216, 6379.776707815204, 6386.425221730066, 6412.871742565169, 6474.384933431316, 6538.901916471256, 6551.508636852208, 6552.541322107454, 6020.909686354708, 6034.24571928509, 6034.969825150846, 6035.124906888521, 6055.27336719592, 5785.537157027427, 6597.63712995785, 6600.1089852869245, 6631.806274870473, 6725.361090696376, 6221.564490485713, 6223.813285601439, 6320.5259605528845, 6339.302676705559, 6341.080543321193, 6264.655443950535, 6343.143675603735, 6346.4605508532295, 6444.871102577922, 6497.837554061186, 6274.6548939808745, 6356.682165891687, 6396.744130234832, 6419.99219363735, 6516.609003459713, 6390.0, 6393.648349340738, 6419.972804351281, 6428.614283143026, 6461.8061458156335, 5223.947760522422, 5225.9738701307015, 5296.576273898079, 5307.0182016326335, 5326.9467305327225, 4412.69111162222, 4493.258612328995, 4497.572730590588, 4511.729296242236, 4513.074819661962, 5519.199716041152, 5527.917081243784, 5540.390557038722, 5543.972280138654, 5548.250986116904, 6484.740610375532, 6486.0, 6489.156409666713, 6491.67541622917, 6506.512011599149, 5508.118701007899, 5520.585956053312, 5540.2243685884005, 5542.86142846424, 5578.693171875505, 5643.266375371176, 5713.200151978726, 5725.656460612293, 5730.942690573041, 5761.366249712528, 5343.893122137613, 6285.402886725754, 6304.495640348761, 6308.148399965946, 6308.463780578611, 6454.0, 6464.127342808661, 6532.085508028785, 6553.115329430657, 6559.6064236145985, 6187.876242475035, 6263.843403914939, 6318.936810631835, 6359.618422894641, 6362.268339141058, 6289.654069026247, 6334.746610135543, 6365.0, 6453.41919227253, 6453.774117906039, 6459.935400646122, 6479.5788273762055, 6489.5781774184525, 6490.902636460552, 6515.28331883502, 5331.413544510023, 6206.131141640264, 6249.281332646804, 6327.303996560283, 6335.461485773761, 6249.625022498664, 6268.623882567061, 6284.622922624657, 6338.809835704752, 6346.365363463617, 6133.815985520441, 6135.9079613806725, 6149.323574406722, 6232.127502149612, 6236.251649802053, 6235.688215589294, 6243.313235544178, 6250.718717657625, 6292.779752708633, 6298.960671489153, 5962.493188078888, 6054.061620448838, 6097.054956481752, 6101.389861013863, 6114.57197996136], "value": 5873.967349668359, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [806.7741032510899, 841.1336323586708, 861.4486728493763, 886.9467831930085, 890.9955450222752, 38897.4165387519, 40028.79985600068, 40211.59788402119, 40468.0, 40476.39285410714, 36112.81943590285, 36403.81798091013, 36455.0, 36519.0, 36545.63454365455, 6779.186497620292, 6853.862922741542, 6891.276415976326, 6904.447644188453, 6917.55035922666, 6874.725010999554, 6972.651367431608, 6975.755848545302, 6977.162740471151, 6997.545159564637, 6894.758683446081, 6895.344942230505, 6955.547889387199, 6965.303469653019, 6987.650617469106, 6846.931530684679, 6871.312868713114, 6872.450203983669, 6898.448124150106, 6898.793036208922, 6261.96677548204, 6307.580794321287, 6334.841628959267, 6339.96830015847, 6358.395952384516, 32649.836750816332, 32860.67139328624, 32920.0, 32934.0, 33147.17132071718, 3296.241864371208, 3325.085601459594, 3342.565466489341, 3422.9315413691834, 3544.769589976643, 30271.697283027108, 30429.847850760827, 30434.54348184779, 30443.2389190272, 30500.0, 4861.805527778884, 4896.975515122437, 4919.08996835583, 4948.158813001798, 4978.900421991576, 194163.0, 194362.0, 195219.0, 195883.99999999857, 197049.0, 48607.27089093666, 49117.0, 49323.50676493261, 49337.0, 49389.25916111189, 51541.0, 51812.22281665778, 52006.21990670143, 52181.478185218424, 52192.73903630458, 15904.443344482888, 15934.36262549485, 15948.2823272953, 15954.521364359089, 15965.361385544447, 13139.080264381593, 13219.0, 13236.13965092266, 13274.93362533181, 13366.131201471873, 14344.856551434561, 14410.13539187631, 14416.279186040865, 14458.0, 14595.562133136023, 5649.124385720138, 5820.621659592113, 5862.941370586324, 5934.495567876693, 5948.583599148018, 989.4459102902398, 995.6863587969766, 1003.9196864250843, 1040.4433628008978, 1042.1037907399782, 22057.33827985163, 22059.0, 22349.32952011442, 22426.0, 29015.274618134714, 1086.750047489082, 1091.3997301484153, 1101.3336931156534, 1102.9062529685066, 1106.5850306135198, 12358.82591153839, 12432.875671243171, 12434.56479023248, 12476.937615311865, 12578.68553286157, 224045.0, 226901.0, 227319.0, 227375.0, 228100.0, 52635.47364526306, 52760.47239527556, 53023.73488132535, 53042.7347863266, 53148.0, 1410.4949201234922, 1470.919099449519, 1473.82314122306, 1482.6071091160852, 1495.6709523904724, 21021.89489052545, 22065.33803985883, 22290.442738931655, 22293.777062229172, 22338.10647574144, 37573.62426375701, 37749.62250377461, 37850.810745946095, 38055.0, 38109.42835857409, 197019.0, 197285.0, 197385.0, 198029.0, 198323.0, 29762.255943600718, 34089.318213636085, 34242.48636270408, 34276.0, 34503.137421564665, 42241.78879105585, 42976.0, 43404.78297608492, 44011.11977760491, 44438.0, 28648.85675571609, 31186.844065779525, 31496.685033149377, 31996.5200521997, 32237.87167449128, 30920.0, 31761.523577145897, 32101.839490802395, 32204.516932245566, 32281.0, 35886.28227435384, 35965.82017090003, 36212.0, 36219.0, 36493.0, 30413.543796842623, 31494.0, 31615.0, 31697.20756981094, 31922.0, 22274.0, 23146.884265578563, 23369.76630233676, 23619.763802361755, 23710.0], "value": 16663.55964302646, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [567.8977783998879, 574.2104606166521, 574.4112284907969, 584.713490389709, 597.5816928150294, 21070.6839397409, 21906.0, 22110.778892211074, 22113.226037088683, 22561.435964100907, 24858.875705621445, 26774.196774096807, 26789.33026674334, 26951.595726064075, 26966.325841853963, 6433.388828061338, 6549.672516374186, 6567.211934567858, 6568.244651865049, 6580.407763301302, 5873.970630146843, 6363.204599425072, 6429.8392540186405, 6470.708818103173, 6481.967590162042, 6204.379562043782, 6482.7406903723795, 6483.805485835433, 6498.902516462257, 6540.967295163541, 6492.513061520382, 6502.122213501164, 6502.6748662566915, 6508.54440189187, 6515.120458738057, 3621.3300539400293, 3800.3539398302355, 3817.7327587068917, 3822.8661996830256, 6044.8186554403, 28413.0, 29999.700002999907, 30483.0, 30524.69475305241, 30546.54180187299, 1853.5180852978187, 1876.3807943378788, 1877.1458986161401, 1877.774667039964, 1881.040669258688, 18192.63614727698, 18709.158087886077, 19067.80932190688, 19088.809111908842, 19155.23379064836, 2335.474518233384, 2363.869987150706, 2386.2602593195993, 2390.796782273509, 2393.329867637047, 132696.0, 135608.999999999, 135643.32178339144, 135938.3203083988, 136036.0, 14772.63068423298, 15219.315130819139, 15345.769813452807, 15518.224088795741, 15649.765253521206, 24187.637185442232, 24237.272881813573, 24277.514449710907, 24348.539087654797, 24356.391090222885, 10378.636747713794, 10453.634122805664, 10651.615290012249, 10682.198835087243, 10687.625933092304, 9858.112769850748, 9880.35777674449, 9920.107190352903, 9955.104040636377, 10078.949605251926, 9127.452352858849, 9604.327697061139, 9618.951905240428, 9625.807483850283, 9743.489759087353, 2620.502104600158, 2626.540355437829, 2669.7997650175926, 2741.1481677430834, 2784.610154578361, 926.7961048569304, 960.9327347085776, 961.5576834655997, 985.8767654043245, 986.2208855004609, 19572.608547828964, 19647.901760491106, 20128.49678758043, 23226.3032109037, 24722.752772472406, 1023.247912784103, 1055.5672174408455, 1056.4136904018344, 1058.9470526473644, 1061.930974486656, 11257.043151332065, 11281.32312061279, 11403.942980285046, 11430.0, 11605.88394116048, 484169.0, 484972.0, 509581.0, 511346.0, 514303.0, 106563.0, 107253.46373268084, 115581.0, 117387.0, 117744.0, 1198.1553005131361, 1232.2483285196201, 1272.8090786381931, 1281.2056524954587, 1282.6665067082627, 20577.691334629693, 20619.381418557467, 20715.689264661345, 21371.67942480895, 21784.45538861541, 54135.45864541304, 55132.0, 55741.72129139328, 56004.0, 58405.70797145987, 65750.67124664345, 68787.3121268781, 69131.0, 69317.3068269331, 70903.0, 14111.0, 14774.335154917839, 14922.328495217524, 15019.624509387353, 15138.243087845343, 17682.292708291523, 18444.0, 18712.719309210646, 22181.445463863532, 23914.760852391253, 16900.746488802924, 18263.360782372554, 18471.815281847008, 18486.630267394306, 18671.159797809403, 16790.66418671644, 17484.388046418313, 17908.46274611764, 18150.364737234133, 18273.451796446127, 18421.723674145167, 20052.59894802125, 20125.0, 20261.89869050704, 20263.59472810565, 14812.0, 14904.329305181076, 14919.552413427615, 14947.177905215318, 14968.925155374154, 18750.156242968827, 18809.247630094644, 18887.244510219985, 18933.33733319327, 18949.715754263972], "value": 11966.457719656193, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1322.656109411553, 1387.1954266525415, 1395.2814300635175, 1395.9581212563626, 1400.7548678981182, 12941.805872911902, 13499.122557033787, 13544.322783860804, 13566.45734170632, 13601.047926645115, 13080.280584567845, 13464.192148471098, 13502.257375844325, 13531.255780932044, 13532.0, 2551.1963731424635, 2582.496413199427, 2587.9482410351875, 2590.44305474323, 2594.779443747284, 2483.7640424159677, 2520.193538067819, 2532.8480291182495, 2538.9111381101666, 2546.987265063672, 2046.3656266557414, 2491.040949234549, 2492.389364605674, 2536.581464058437, 2539.987300063506, 2160.470684682255, 2177.5536015116863, 2455.5088982203542, 2546.567083595793, 2559.053150334388, 2529.20330096021, 2536.7716905478596, 2537.2641933839163, 2544.0459827564664, 2554.9105781297753, 13249.536266230733, 13341.599752007456, 13343.466261349631, 13384.330783460788, 13386.129901556367, 7062.258462861377, 7371.0, 7436.1820199777985, 7444.622744792231, 7461.589612571306, 4733.83431579893, 4870.561649451531, 5033.496650334974, 5085.262636917626, 5085.389753229636, 1792.4891405949243, 1795.5780391607962, 1803.9368622098164, 1859.1912518054555, 1873.7095750158746, 23180.65229021566, 23373.0, 23402.882985585133, 23424.765752342428, 23445.17941872026, 6032.607880487842, 6098.573099883054, 6226.813195604139, 6269.46709529686, 6411.294757576663, 14682.853171468363, 14765.852341476448, 14833.480828170963, 14853.9602227843, 14877.0, 6856.897146542806, 6993.930060699327, 6997.93002069983, 6997.965010174917, 7003.439724822002, 6453.0, 6507.219133703891, 6525.119108920235, 6650.767223147167, 6797.218319893177, 4861.29511220871, 5004.249362595567, 5019.949800502021, 5054.292399064134, 5154.149565321755, 1376.6283103561982, 1404.1504889541884, 1413.61832305277, 1423.2030063164455, 1424.3448013913508, 875.8117004843989, 879.8152387998464, 891.4829398948594, 911.9740292171307, 925.9259259259243, 7166.856662866713, 7226.602536860523, 7252.456065795086, 7271.127464704269, 7305.086864141982, 722.8229083874485, 725.5175308419947, 948.3877408405738, 1001.9048190421898, 1005.3465247589126, 4940.0, 5214.765335559909, 5307.674245489913, 5341.118715411913, 5490.6431081980345, 18007.099645017697, 18266.086695665163, 18316.17577209002, 18356.724649130272, 18376.264949401873, 17600.20799064045, 18241.27034918615, 18284.54288642768, 18450.446486605422, 18507.814921850608, 9856.68164022654, 10097.646582369582, 10231.43727095002, 10293.94853025745, 10309.432981186106, 7560.4329675273475, 7771.92228077712, 8019.599020048858, 8074.192580741878, 8122.675092996214, 15420.691586168437, 16136.435224767078, 16198.190090495193, 16972.49082527526, 17109.230084645973, 16023.839761602701, 16636.25136868868, 16872.79679751447, 17249.655006899542, 17475.82524174742, 9585.664501742405, 9906.30655854112, 9918.05778451046, 9946.104850563484, 9964.601415943282, 12649.367531623198, 12770.297633629867, 13202.867971320164, 13217.933910330386, 13236.536721214712, 10150.289479736348, 10436.112930401001, 10462.21533384984, 10465.529051192563, 10662.573497060032, 10021.09810117093, 10278.691639250834, 10466.529006194587, 10476.371417714656, 10576.0, 9228.984811670845, 9386.624535018796, 9389.061093890556, 9403.85894211601, 9410.341276110881, 7173.390261827803, 7258.745943891939, 7288.562686238843, 7298.927010729824, 7314.451416143704, 7206.6396680164735, 7306.378957788647, 7365.7790266292095, 7432.516886402366, 7490.438217133627], "value": 6133.319544409141, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [490.3374675511969, 494.90101979604066, 530.358266497538, 531.1395539226453, 532.2117684579811, 5958.404159584039, 6019.969900150504, 6069.15031895535, 6074.331823499417, 6161.753529858805, 5922.0, 5924.99275123229, 5963.970180149104, 5980.252468441445, 6044.304904935933, 4917.655764096515, 4958.801647934097, 4961.900761984758, 4970.0, 5009.749512524378, 4971.279164521142, 4981.0, 4987.351644286237, 4998.6750861193905, 5023.572996295319, 4641.767911604423, 4892.8042878285005, 4931.876703082416, 4964.453910069889, 4981.651284410093, 4815.855524334275, 4818.566329030386, 4846.75766211688, 4858.271259311132, 4895.265710143472, 4325.6106950374615, 4342.261815491374, 4370.2133615949115, 4377.255866502702, 4379.146066517031, 5862.736176872008, 5887.35239123696, 5901.0, 5915.408459154093, 5952.375000624958, 5521.116621340566, 5528.778848846082, 5538.667679939176, 5542.251796007527, 5549.639273447213, 6290.748370065192, 6298.307186209513, 6311.842203944892, 6387.201599800025, 6391.561898572831, 4793.424789025305, 4798.328234047236, 4804.615630749532, 4815.831445899412, 4832.951670483285, 6417.229932408094, 6504.739810407626, 6586.440152587036, 6611.669416529202, 6645.3686899744935, 4881.975590122027, 4886.877828054327, 4936.90126197474, 4950.925736113961, 4961.206207006861, 4905.87735306613, 4924.679895806761, 4940.555350018516, 4980.427250866124, 5012.774425150877, 5535.363433205152, 5589.35722391922, 5601.159826026047, 5601.991641504568, 5608.831735047955, 6394.584352017104, 6420.839479013062, 6434.420902118738, 6439.839004024937, 6444.8388790280615, 1724.5688577855535, 1734.9045802480732, 1736.6266252755718, 1744.6074633207681, 1754.9558012982254, 1165.650304908524, 1221.7984032634693, 1230.4865016030333, 1236.394166858251, 1244.7074937389707, 5519.337679478488, 5521.0, 5521.66869987794, 5525.668459892339, 5552.056150454432, 6480.189976252968, 6486.221653401528, 6497.967510162419, 6500.902486462707, 6533.281339052701, 5481.7109734159985, 5524.364698059694, 5526.889462210734, 5560.165975103686, 5597.888042239132, 3429.3484237994703, 3452.879149229765, 3479.2867462170193, 3481.3211423772123, 3490.9650903491147, 6349.206349206349, 6350.714217860207, 6394.584352017104, 6409.4231519163495, 6429.582077165063, 6713.69788359525, 6726.0158253315385, 6732.0, 6732.831679208059, 6846.117317737562, 6271.9024170769935, 6364.936350636434, 6370.872582548416, 6390.360963903572, 6480.416762491398, 6424.787606196902, 6429.54993150475, 6492.513061520499, 6496.935030649633, 6582.923357390729, 5981.616545109437, 6435.774747883989, 6455.354464553695, 6475.417212450902, 6560.901586476302, 6252.468540174136, 6309.684515774285, 6399.256434985586, 6401.0, 6423.743050277936, 4930.975345123252, 4937.926071050239, 4947.282644016669, 4976.253561965589, 4987.476314986874, 6338.239411270492, 6574.107392747176, 6602.933970660232, 6627.304133065959, 6646.867062658816, 6177.505799536116, 6322.589031712924, 6337.936620633919, 6349.555311282029, 6355.936440635719, 6223.3465486125115, 6223.875522489616, 6228.847663182326, 6303.243610766737, 6350.110984462087, 6199.349068347939, 6236.781712640036, 6264.498840092872, 6302.621842689453, 6354.17395738551, 6285.811425657238, 6310.6529140895855, 6361.777337793155, 6412.679366031586, 6413.77551785704, 6128.724207410766, 6159.476444502267, 6196.907046394217, 6224.657643829632, 6235.347632877382], "value": 4936.023393045722, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [903.602414937427, 921.5392303848078, 925.3337596930207, 928.4104593583077, 946.1957336264177, 14993.700125997473, 18148.455546333615, 19101.140448679824, 19131.234750609976, 19170.0, 15566.066036037846, 15825.60435989098, 16077.919610401961, 16123.596910077255, 16126.113063781488, 1025.0467065628961, 1053.968380948569, 1059.7986382587321, 1060.4220699718633, 1060.8779990301136, 1037.2531777120462, 1037.584966013593, 1045.362328979322, 1046.481991414251, 1046.7278507588005, 1079.3739631013993, 1086.625114335553, 1087.597588892107, 1090.0843291635024, 1102.6030628973563, 994.666786626481, 1074.9247552671316, 1075.569772091166, 1076.48328802175, 1089.2919602258555, 746.115852714535, 779.4894344204555, 786.4219798448136, 789.7038610521055, 790.0992868130336, 19211.51971200717, 19565.510862228417, 19570.412887613395, 19606.0, 19659.901700491548, 18592.163352649164, 19716.112774925165, 19892.502687432785, 19907.701384479245, 20010.79989200104, 15390.384384624602, 16067.955582887074, 16158.434454794144, 16172.514824555283, 16282.348706051744, 3508.7894726316504, 3531.8940431787087, 3548.4854696069183, 3571.1250743567734, 3572.1962558424148, 91394.54302728444, 112770.0, 116258.41870790676, 116610.0, 119802.40098799451, 12698.746025079447, 12872.678183045311, 13036.80444793329, 13129.868701313055, 15293.770593441108, 27515.17454476369, 28342.85828570844, 28643.57034644482, 28781.85609071983, 29160.854195728887, 8460.492370457792, 8537.0, 8542.74371768848, 8587.914120858837, 8601.354898382646, 4043.939340909889, 4120.938185927213, 4133.318002529609, 4173.248815213291, 4215.662746980234, 4887.853364399074, 4995.525425084611, 5003.3495645565845, 5011.448740638527, 5013.749312534359, 944.9433034017981, 955.3264948211634, 957.5212393803098, 985.8176237395961, 1030.5568605499557, 639.718523849514, 664.5713514783034, 698.9405900498413, 703.0719450325623, 717.160921721587, 11277.436128193558, 11499.655010349703, 11758.176927614984, 12311.13822032467, 12337.938310308571, 681.4207923265284, 684.3532861445985, 686.3630241873069, 689.862027594473, 712.5226098514008, 4864.124457597595, 5043.268726034705, 5055.393352797688, 5093.312402825645, 5455.7897208166105, 97014.51492742491, 97029.0, 97805.5109724461, 100189.49905250572, 101713.4742978856, 82334.0, 86318.0, 86418.56790716006, 87646.0, 88495.0, 72646.63676681583, 72874.27125728781, 74904.62547687227, 79162.6041869787, 79522.0, 11736.237144585575, 11851.348175850066, 12004.639860804189, 12357.505699771908, 12374.62876113718, 34194.316113678084, 35952.0, 35976.460353095244, 37548.0, 38100.809495952344, 44338.57268378455, 45869.54130458653, 46197.53802461932, 67801.0, 68328.65835670989, 17043.233054512824, 17521.649567008844, 17696.73454898152, 17839.46481605554, 18118.184681689618, 20084.0, 20227.696584550948, 20321.695174572687, 20512.794872051087, 20647.0, 15897.617786674697, 16136.757948630546, 16541.66916661636, 16793.41223057236, 17092.48722538276, 15358.616034599225, 15385.384584616937, 15526.22368881574, 15757.29092190877, 15766.290516926536, 16260.0, 16493.505194844172, 16559.0, 16609.916950415653, 16755.497335079966, 12903.612891612891, 13504.93247533756, 13753.587392378246, 14029.92985035109, 14140.575782726535, 12900.612981610566, 13147.276899770604, 13326.200427974352, 13398.196108233537, 13702.0], "value": 8639.126003033198, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1533.8000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 109.0, 109.0, 110.0, 110.0, 108.0, 110.0, 110.0, 108.0, 110.0], "value": 108.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 125.0, 148.0, 185.0, 122.0, 152.0, 146.0, 123.0, 162.0, 121.0], "value": 142.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 164.0, 164.0, 164.0, 162.0, 172.0, 164.0, 166.0, 166.0, 165.0], "value": 165.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 75.0, 168.0, 76.0, 74.0, 74.0, 74.0, 94.0, 76.0], "value": 86.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 81.0, 128.0, 81.0, 82.0, 81.0, 135.0, 81.0, 81.0, 132.0], "value": 96.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 114.0, 114.0, 113.0, 113.0, 114.0, 115.0, 115.0, 114.0], "value": 114.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 151.0, 149.0, 149.0, 150.0, 150.0, 149.0, 149.0, 150.0, 150.0], "value": 149.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 95.0], "value": 94.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 55.0, 57.0, 61.0, 59.0, 57.0, 55.0, 56.0, 56.0, 55.0], "value": 56.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 55.0, 54.0, 55.0, 54.0, 54.0, 54.0, 55.0, 55.0, 55.0], "value": 54.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 85.0, 77.0, 77.0, 78.0, 76.0, 78.0, 77.0, 79.0], "value": 78.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 138.0, 137.0, 133.0, 126.0, 126.0, 134.0, 127.0, 135.0, 155.0], "value": 133.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [178.0, 200.0, 182.0, 183.0, 183.0, 183.0, 188.0, 185.0, 182.0, 186.0], "value": 185.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 70.0, 71.0, 69.0, 70.0, 68.0, 69.0, 69.0, 68.0, 69.0], "value": 69.2, "unit": "score"}]}]} 10:26:18 INFO - Return code: 0 10:26:18 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:26:18 INFO - # TBPL SUCCESS # 10:26:18 INFO - Running post-action listener: _package_coverage_data 10:26:18 INFO - Running post-action listener: _resource_record_post_action 10:26:18 INFO - [mozharness: 2017-07-17 17:26:18.263575Z] Finished run-tests step (success) 10:26:18 INFO - Running post-run listener: _resource_record_post_run 10:26:18 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 4096; Write bytes: 436977664; Read time: 12; Write time: 286160 10:26:18 INFO - TinderboxPrint: CPU usage
13.1% 10:26:18 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 10:26:18 INFO - TinderboxPrint: I/O write bytes / time
436,977,664 / 286,160 10:26:18 INFO - TinderboxPrint: CPU idle
8,252.8 (86.9%) 10:26:18 INFO - TinderboxPrint: CPU user
1,198.1 (12.6%) 10:26:18 INFO - TinderboxPrint: Swap in / out
0 / 0 10:26:18 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 107274240; Read time: 0; Write time: 75588 10:26:18 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 10:26:18 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 0; Write bytes: 329703424; Read time: 0; Write time: 210572 10:26:18 INFO - Running post-run listener: _upload_blobber_files 10:26:18 INFO - Blob upload gear active. 10:26:18 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:26: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 10:26: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'] 10:26: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 10:26:19 INFO - Traceback (most recent call last): 10:26:19 INFO - File "/builds/slave/test/build/venv/bin/blobberc.py", line 253, in 10:26:19 INFO - main() 10:26:19 INFO - File "/builds/slave/test/build/venv/bin/blobberc.py", line 235, in main 10:26:19 INFO - filetype_whitelist = get_server_whitelist(args['--url']) 10:26:19 INFO - File "/builds/slave/test/build/venv/bin/blobberc.py", line 69, in get_server_whitelist 10:26:19 INFO - return set(response.json().get('whitelist', [])) 10:26:19 INFO - File "/builds/slave/test/build/venv/local/lib/python2.7/site-packages/requests/models.py", line 651, in json 10:26:19 INFO - return json.loads(self.text or self.content, **kwargs) 10:26:19 INFO - File "/builds/slave/test/build/venv/local/lib/python2.7/site-packages/simplejson/__init__.py", line 488, in loads 10:26:19 INFO - return _default_decoder.decode(s) 10:26:19 INFO - File "/builds/slave/test/build/venv/local/lib/python2.7/site-packages/simplejson/decoder.py", line 370, in decode 10:26:19 INFO - obj, end = self.raw_decode(s) 10:26:19 INFO - File "/builds/slave/test/build/venv/local/lib/python2.7/site-packages/simplejson/decoder.py", line 389, in raw_decode 10:26:19 INFO - return self.scan_once(s, idx=_w(s, idx).end()) 10:26:19 INFO - simplejson.scanner.JSONDecodeError: Expecting value: line 1 column 1 (char 0) 10:26:19 ERROR - Return code: 1 10:26:19 INFO - Setting buildbot property blobber_files to {} 10:26:19 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:26:19 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:26:19 INFO - Contents: 10:26:19 INFO - blobber_files:{} 10:26:19 INFO - Running post-run listener: copy_logs_to_upload_dir 10:26:19 INFO - Copying logs to upload dir... 10:26:19 INFO - mkdir: /builds/slave/test/build/upload/logs 10:26:19 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1245.254342 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2017-07-17 10:26:18.785665) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-17 10:26:18.789260) ========= 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=523ca41ca1e0623de333ad52000001bf-1500309659.981018-920335768 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{} build_url:https://queue.taskcluster.net/v1/task/ZhXVXYEsTmqLf6LrsIK64w/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011408 build_url: 'https://queue.taskcluster.net/v1/task/ZhXVXYEsTmqLf6LrsIK64w/artifacts/public/build/target.tar.bz2' blobber_files: '{}' ========= master_lag: 0.04 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-17 10:26:18.841047) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-17 10:26:18.841421) ========= 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=523ca41ca1e0623de333ad52000001bf-1500309659.981018-920335768 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004465 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-17 10:26:18.891938) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-17 10:26:18.892370) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-17 10:26:18.892817) ========= ========= Total master_lag: 0.16 =========