builder: mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s slave: talos-linux64-ix-029 starttime: 1500311132.33 results: success (0) revision: e0b0865639cebc1b5afa0268a4b073fcdde0e69c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-07-17 10:05:32.330538) ========= 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:32.330958) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-17 10:05:32.331227) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-17 10:05:32.356254) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-17 10:05:32.356589) ========= 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=ba164b0a7b0ec7655860e956000001c1-1500309642.612054-97850160 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-07-17 10:05:33-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 108M=0s 2017-07-17 10:05:33 (108 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.083468 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-17 10:05:32.455907) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-17 10:05:32.456217) ========= 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=ba164b0a7b0ec7655860e956000001c1-1500309642.612054-97850160 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017840 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-17 10:05:32.506343) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-17 10:05:32.506677) ========= 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=ba164b0a7b0ec7655860e956000001c1-1500309642.612054-97850160 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-07-17 10:05:33,495 truncating revision to first 12 chars 2017-07-17 10:05:33,495 Setting DEBUG logging. 2017-07-17 10:05:33,495 attempt 1/10 2017-07-17 10:05:33,495 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,825 unpacking tar archive at: mozilla-central-e0b0865639ce/testing/mozharness/ program finished with exit code 0 elapsedTime=0.630803 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-17 10:05:33.150045) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-17 10:05:33.150349) ========= script_repo_revision: e0b0865639cebc1b5afa0268a4b073fcdde0e69c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-17 10:05:33.150738) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-17 10:05:33.151005) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-17 10:05:33.159335) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2017-07-17 10:05:33.159624) ========= /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=ba164b0a7b0ec7655860e956000001c1-1500309642.612054-97850160 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-029', 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.255124Z] 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.827619Z] Finished clobber step (success) 10:05:35 INFO - [mozharness: 2017-07-17 17:05:35.827721Z] 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_styloseq_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-sequential mozilla-central talos dromaeojs-e10s", 10:05:35 INFO - "stage_platform": "linux64-stylosequential", 10:05:35 INFO - "basedir": "/builds/slave/test", 10:05:35 INFO - "buildnumber": 126, 10:05:35 INFO - "platform": "ubuntu64_hw_styloseq", 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": "IOfjBbkxQvqRZEs7kklp-g", 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-029", 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/IOfjBbkxQvqRZEs7kklp-g'}, attempt #1 10:05:36 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IOfjBbkxQvqRZEs7kklp-g'}, 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.203018Z] Finished read-buildbot-config step (success) 10:05:37 INFO - [mozharness: 2017-07-17 17:05:37.203239Z] 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:37 INFO - Downloaded 989 bytes. 10:05:37 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 10:05:37 INFO - Using the following test package requirements: 10:05:37 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 10:05:37 INFO - u'common': [u'target.common.tests.zip'], 10:05:37 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 10:05:37 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 10:05:37 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 10:05:37 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 10:05:37 INFO - u'mozbase': [u'target.common.tests.zip'], 10:05:37 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 10:05:37 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 10:05:37 INFO - u'web-platform': [u'target.common.tests.zip', 10:05:37 INFO - u'target.web-platform.tests.tar.gz'], 10:05:37 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 10:05:37 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 10:05:37 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:37 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:37 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:51 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 10:05:51 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:51 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:51 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:05 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:05 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:05 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:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:06:06 INFO - trying https://queue.taskcluster.net/v1/task/ZhXVXYEsTmqLf6LrsIK64w/artifacts/public/build/target.tar.bz2 10:06:06 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:06 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:07 INFO - Downloaded 61851947 bytes. 10:06:07 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZhXVXYEsTmqLf6LrsIK64w/artifacts/public/build/target.tar.bz2 10:06:07 INFO - mkdir: /builds/slave/test/properties 10:06:07 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:06:07 INFO - Writing to file /builds/slave/test/properties/build_url 10:06:07 INFO - Contents: 10:06:07 INFO - build_url:https://queue.taskcluster.net/v1/task/ZhXVXYEsTmqLf6LrsIK64w/artifacts/public/build/target.tar.bz2 10:06:07 INFO - Running post-action listener: _resource_record_post_action 10:06:07 INFO - Running post-action listener: set_extra_try_arguments 10:06:07 INFO - [mozharness: 2017-07-17 17:06:07.380373Z] Finished download-and-extract step (success) 10:06:07 INFO - [mozharness: 2017-07-17 17:06:07.380470Z] Running populate-webroot step. 10:06:07 INFO - Running pre-action listener: _resource_record_pre_action 10:06:07 INFO - Running main action method: populate_webroot 10:06:07 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:06:07 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:06:07 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:06:07 INFO - '--tppagecycles', 10:06:07 INFO - '7'], 10:06:07 INFO - 'tests': ['tsvgm']}}, 10:06:07 INFO - 'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:06:07 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:06:07 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:06:07 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:06:07 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 10:06:07 INFO - 'talos_options': ['--disable-e10s'], 10:06:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:06:07 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 10:06:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:06:07 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 10:06:07 INFO - 'talos_options': ['--disable-e10s'], 10:06:07 INFO - 'tests': ['damp', 'tps']}, 10:06:07 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 10:06:07 INFO - 'tests': ['damp', 'tps']}, 10:06:07 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:06:07 INFO - 'tests': ['dromaeo_dom']}, 10:06:07 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:06:07 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:06:07 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 10:06:07 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 10:06:07 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 10:06:07 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 10:06:07 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:06:07 INFO - 'tests': ['a11yr', 10:06:07 INFO - 'ts_paint', 10:06:07 INFO - 'tpaint', 10:06:07 INFO - 'sessionrestore', 10:06:07 INFO - 'sessionrestore_no_auto_restore', 10:06:07 INFO - 'tabpaint']}, 10:06:07 INFO - 'other-e10s': {'tests': ['a11yr', 10:06:07 INFO - 'ts_paint', 10:06:07 INFO - 'tpaint', 10:06:07 INFO - 'sessionrestore', 10:06:07 INFO - 'sessionrestore_many_windows', 10:06:07 INFO - 'sessionrestore_no_auto_restore', 10:06:07 INFO - 'tabpaint']}, 10:06:07 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:06:07 INFO - 'ts_paint', 10:06:07 INFO - 'tpaint', 10:06:07 INFO - 'sessionrestore', 10:06:07 INFO - 'sessionrestore_many_windows', 10:06:07 INFO - 'sessionrestore_no_auto_restore', 10:06:07 INFO - 'tabpaint']}, 10:06:07 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:06:07 INFO - 'ts_paint', 10:06:07 INFO - 'tpaint', 10:06:07 INFO - 'sessionrestore', 10:06:07 INFO - 'sessionrestore_many_windows', 10:06:07 INFO - 'sessionrestore_no_auto_restore', 10:06:07 INFO - 'tabpaint']}, 10:06:07 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:06:07 INFO - 'tests': ['a11yr', 10:06:07 INFO - 'ts_paint', 10:06:07 INFO - 'tpaint', 10:06:07 INFO - 'sessionrestore', 10:06:07 INFO - 'sessionrestore_no_auto_restore', 10:06:07 INFO - 'tabpaint']}, 10:06:07 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:06:07 INFO - 'tests': ['a11yr', 10:06:07 INFO - 'ts_paint', 10:06:07 INFO - 'tpaint', 10:06:07 INFO - 'sessionrestore', 10:06:07 INFO - 'sessionrestore_no_auto_restore', 10:06:07 INFO - 'tabpaint']}, 10:06:07 INFO - 'perf-reftest': {'tests': ['bloom_basic']}, 10:06:07 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 10:06:07 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 10:06:07 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 10:06:07 INFO - 'talos_options': ['--mitmproxy', 10:06:07 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 10:06:07 INFO - '--firstNonBlankPaint'], 10:06:07 INFO - 'tests': ['quantum_pageload_google', 10:06:07 INFO - 'quantum_pageload_youtube', 10:06:07 INFO - 'quantum_pageload_amazon', 10:06:07 INFO - 'quantum_pageload_facebook']}, 10:06:07 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:06:07 INFO - 'tests': ['tsvgx', 10:06:07 INFO - 'tsvgr_opacity', 10:06:07 INFO - 'tart', 10:06:07 INFO - 'tscrollx', 10:06:07 INFO - 'cart', 10:06:07 INFO - 'tsvg_static']}, 10:06:07 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:06:07 INFO - 'tsvgr_opacity', 10:06:07 INFO - 'tart', 10:06:07 INFO - 'tscrollx', 10:06:07 INFO - 'cart', 10:06:07 INFO - 'tsvg_static']}, 10:06:07 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 10:06:07 INFO - 'talos_options': ['--disable-e10s'], 10:06:07 INFO - 'tests': ['tp5o']}, 10:06:07 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 10:06:07 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 10:06:07 INFO - 'talos_options': ['--disable-e10s', 10:06:07 INFO - '--xperf_path', 10:06:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:06:07 INFO - 'tests': ['tp5n']}, 10:06:07 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 10:06:07 INFO - 'talos_options': ['--xperf_path', 10:06:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:06:07 INFO - 'tests': ['tp5n']}}, 10:06:07 INFO - 'talos.zip': {'path': '', 10:06:07 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:06:07 INFO - Running post-action listener: _resource_record_post_action 10:06:07 INFO - [mozharness: 2017-07-17 17:06:07.395744Z] Finished populate-webroot step (success) 10:06:07 INFO - [mozharness: 2017-07-17 17:06:07.395835Z] Running create-virtualenv step. 10:06:07 INFO - Running pre-action listener: _resource_record_pre_action 10:06:07 INFO - Running main action method: create_virtualenv 10:06:07 INFO - Creating virtualenv /builds/slave/test/build/venv 10:06:07 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 10:06:07 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:06:07 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:10 INFO - Reading from file tmpfile_stdout 10:06:10 INFO - Output received: 10:06:10 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:10 INFO - Installing pip>=1.5 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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17061f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a77b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a74d00>, '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 0x1a75c00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a76090>, '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': 'ba164b0a7b0ec7655860e956000001c1-1500309642.612054-97850160', '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', 'pip>=1.5'] 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 pip>=1.5 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': 'ba164b0a7b0ec7655860e956000001c1-1500309642.612054-97850160', 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 - 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 0x17061f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a77b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a74d00>, '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 0x1a75c00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a76090>, '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': 'ba164b0a7b0ec7655860e956000001c1-1500309642.612054-97850160', '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': 'ba164b0a7b0ec7655860e956000001c1-1500309642.612054-97850160', 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:12 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:12 INFO - building 'psutil._psutil_posix' extension 10:06:12 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:12 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:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:06:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:06:12 INFO - Successfully installed psutil 10:06:12 INFO - Cleaning up... 10:06:12 INFO - Return code: 0 10:06:12 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:06:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:06:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:06:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:06:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:06:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17061f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a77b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a74d00>, '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 0x1a75c00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a76090>, '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': 'ba164b0a7b0ec7655860e956000001c1-1500309642.612054-97850160', '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:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 10:06:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 10:06:12 INFO - Using env: {'DISPLAY': ':0', 10:06:12 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': 'ba164b0a7b0ec7655860e956000001c1-1500309642.612054-97850160', 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 0x17061f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a77b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a74d00>, '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 0x1a75c00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a76090>, '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': 'ba164b0a7b0ec7655860e956000001c1-1500309642.612054-97850160', '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': 'ba164b0a7b0ec7655860e956000001c1-1500309642.612054-97850160', 10:06:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:06:13 INFO - '_': '/tools/buildbot/bin/python'} 10:06:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:06:14 INFO - Downloading/unpacking 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:15 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:06:15 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 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:15 INFO - Downloading functools32-3.2.3-2.tar.gz 10:06:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package 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 - 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 0x17061f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a77b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a74d00>, '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 0x1a75c00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a76090>, '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': 'ba164b0a7b0ec7655860e956000001c1-1500309642.612054-97850160', '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': 'ba164b0a7b0ec7655860e956000001c1-1500309642.612054-97850160', 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 0x17061f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a77b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a74d00>, '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 0x1a75c00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a76090>, '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': 'ba164b0a7b0ec7655860e956000001c1-1500309642.612054-97850160', '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': 'ba164b0a7b0ec7655860e956000001c1-1500309642.612054-97850160', 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:17 INFO - Downloading blobuploader-1.2.4.tar.gz 10:06:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:06:17 INFO - Downloading/unpacking requests==1.2.3. (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 - 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:18 INFO - Running setup.py install for docopt 10:06:18 INFO - Successfully installed blobuploader requests docopt 10:06:18 INFO - Cleaning up... 10:06:18 INFO - Return code: 0 10:06:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:06:18 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:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:06:18 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:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:06:18 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 0x17061f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a77b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a74d00>, '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 0x1a75c00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a76090>, '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': 'ba164b0a7b0ec7655860e956000001c1-1500309642.612054-97850160', '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:18 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:18 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:18 INFO - Using env: {'DISPLAY': ':0', 10:06:18 INFO - 'HOME': '/home/cltbld', 10:06:18 INFO - 'LANG': 'en_US.UTF-8', 10:06:18 INFO - 'LANGUAGE': 'en_US:en', 10:06:18 INFO - 'LOGNAME': 'cltbld', 10:06:18 INFO - 'MAIL': '/var/mail/cltbld', 10:06:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:06:18 INFO - 'MOZ_NO_REMOTE': '1', 10:06:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:06:18 INFO - 'NO_EM_RESTART': '1', 10:06:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:06:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:06:18 INFO - 'PWD': '/builds/slave/test', 10:06:18 INFO - 'SHELL': '/bin/bash', 10:06:18 INFO - 'SHLVL': '1', 10:06:18 INFO - 'TERM': 'linux', 10:06:18 INFO - 'TMOUT': '86400', 10:06:18 INFO - 'USER': 'cltbld', 10:06:18 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1500309642.612054-97850160', 10:06:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:06:18 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-9x9OH0-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-8H_llX-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-qbEsqq-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-2CWSOu-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-5ei_3l-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-Ae4L4q-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-T3u7mU-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-syFSZH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:06:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:06:19 INFO - Running setup.py (path:/tmp/pip-DlObD2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:06:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:06:19 INFO - Running setup.py (path:/tmp/pip-6HMFfk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:06:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:06:19 INFO - Running setup.py (path:/tmp/pip-qErHiC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:06:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:06:19 INFO - Running setup.py (path:/tmp/pip-HTzn4e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:06:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:06:19 INFO - Running setup.py (path:/tmp/pip-u2KoFo-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-yJ9EzI-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-oREykr-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-RAB3Xo-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-eynJum-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:20 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:06:20 INFO - Running setup.py install for mozfile 10:06:20 INFO - Running setup.py install for mozhttpd 10:06:20 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:06:20 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:21 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:06:21 INFO - Running setup.py install for mozscreenshot 10:06:21 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 0x17061f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a77b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a74d00>, '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 0x1a75c00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a76090>, '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': 'ba164b0a7b0ec7655860e956000001c1-1500309642.612054-97850160', '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': 'ba164b0a7b0ec7655860e956000001c1-1500309642.612054-97850160', 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-e_mWPT-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-ZkUitP-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-BBVUDv-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-L05Gub-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-s_w9Zz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:06:22 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:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:06:22 INFO - Running setup.py (path:/tmp/pip-nvcf5T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:06:22 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:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:06:22 INFO - Running setup.py (path:/tmp/pip-vexmwQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:06:22 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:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:06:22 INFO - Running setup.py (path:/tmp/pip-2JEYfr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:06:22 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:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:06:22 INFO - Running setup.py (path:/tmp/pip-6Dwr5x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:06:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 10:06:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:06:22 INFO - Running setup.py (path:/tmp/pip-qR1ZXA-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-Y9bwMN-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-VFCdgP-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-lAUbGR-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-5Cnaru-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-6fUKgD-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-IG9o9t-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-EVx_TP-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:24 INFO - Installing collected packages: blessings 10:06:24 INFO - Running setup.py install for blessings 10:06:24 INFO - Successfully installed blessings 10:06:24 INFO - Cleaning up... 10:06:24 INFO - Return code: 0 10:06:24 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:06:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:06:24 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 0x17061f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a77b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a74d00>, '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 0x1a75c00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a76090>, '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': 'ba164b0a7b0ec7655860e956000001c1-1500309642.612054-97850160', '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': 'ba164b0a7b0ec7655860e956000001c1-1500309642.612054-97850160', 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:26 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:26 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:26 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:26 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:26 INFO - Installing collected packages: marionette-driver, simplejson 10:06:26 INFO - Running setup.py install for marionette-driver 10:06:26 INFO - Running setup.py install for simplejson 10:06:26 INFO - building 'simplejson._speedups' extension 10:06:26 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:27 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:27 INFO - Successfully installed marionette-driver simplejson 10:06:27 INFO - Cleaning up... 10:06:27 INFO - Return code: 0 10:06:27 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:06:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:06:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:06:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:06:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:06:27 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 0x17061f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18d2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a77b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a74d00>, '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 0x1a75c00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a76090>, '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': 'ba164b0a7b0ec7655860e956000001c1-1500309642.612054-97850160', '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:27 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:27 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:27 INFO - Using env: {'DISPLAY': ':0', 10:06:27 INFO - 'HOME': '/home/cltbld', 10:06:27 INFO - 'LANG': 'en_US.UTF-8', 10:06:27 INFO - 'LANGUAGE': 'en_US:en', 10:06:27 INFO - 'LOGNAME': 'cltbld', 10:06:27 INFO - 'MAIL': '/var/mail/cltbld', 10:06:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:06:27 INFO - 'MOZ_NO_REMOTE': '1', 10:06:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:06:27 INFO - 'NO_EM_RESTART': '1', 10:06:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:06:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:06:27 INFO - 'PWD': '/builds/slave/test', 10:06:27 INFO - 'SHELL': '/bin/bash', 10:06:27 INFO - 'SHLVL': '1', 10:06:27 INFO - 'TERM': 'linux', 10:06:27 INFO - 'TMOUT': '86400', 10:06:27 INFO - 'USER': 'cltbld', 10:06:27 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1500309642.612054-97850160', 10:06:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:06:27 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.468048Z] Finished create-virtualenv step (success) 10:06:27 INFO - [mozharness: 2017-07-17 17:06:27.468560Z] 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.743797Z] Finished install step (success) 10:06:45 INFO - [mozharness: 2017-07-17 17:06:45.744050Z] 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.745202Z] Finished setup-mitmproxy step (success) 10:06:45 INFO - [mozharness: 2017-07-17 17:06:45.745425Z] 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 0x1a74d00>, '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 0x1a75c00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a76090>, '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-029', '--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-029 --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': 'ba164b0a7b0ec7655860e956000001c1-1500309642.612054-97850160', 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-029', '--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:46 INFO - mozversion application_buildid: 20170717162507 10:06:46 INFO - mozversion application_changeset: e0b0865639cebc1b5afa0268a4b073fcdde0e69c 10:06:46 INFO - mozversion application_display_name: Nightly 10:06:46 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:06:46 INFO - mozversion application_name: Firefox 10:06:46 INFO - mozversion application_remotingname: firefox 10:06:46 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 10:06:46 INFO - mozversion application_vendor: Mozilla 10:06:46 INFO - mozversion application_version: 56.0a1 10:06:46 INFO - mozversion platform_buildid: 20170717162507 10:06:46 INFO - mozversion platform_changeset: e0b0865639cebc1b5afa0268a4b073fcdde0e69c 10:06:46 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 10:06:46 INFO - mozversion platform_version: 56.0a1 10:06:46 INFO - using testdate: 1500311206 10:06:46 INFO - actual date: 1500311206 10:06:46 INFO - starting webserver on 'localhost:56801' 10:06:46 INFO - SUITE-START | Running 2 tests 10:06:46 INFO - TEST-START | dromaeo_css 10:06:46 INFO - Initialising browser for dromaeo_css test... 10:06:46 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:56801/getInfo.html -profile /tmp/tmp6maUGP/profile 10:06:46 INFO - TEST-INFO | started process 6494 (/builds/slave/test/build/application/firefox/firefox http://localhost:56801/getInfo.html) 10:06:53 INFO - TEST-INFO | 6494: exit 0 10:06:53 INFO - Browser initialized. 10:06:53 INFO - Running cycle 1/1 for dromaeo_css test... 10:06:53 INFO - TEST-INFO | started process 6720 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6maUGP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 10:07:05 INFO - PID 6720 | RSS: Main: 173248512 10:07:05 INFO - PID 6720 | 10:10:03 INFO - PID 6720 | Cycle 1(1): loaded http://localhost:56801/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56801/tests/dromaeo/cssquery-ext.html) 10:10:05 INFO - PID 6720 | RSS: Main: 177778688 10:10:05 INFO - PID 6720 | 10:13:06 INFO - PID 6720 | Cycle 1(1): loaded http://localhost:56801/tests/dromaeo/cssquery-ext.html (next: http://localhost:56801/tests/dromaeo/cssquery-jquery.html) 10:13:07 INFO - PID 6720 | RSS: Main: 176500736 10:13:07 INFO - PID 6720 | 10:16:09 INFO - PID 6720 | Cycle 1(1): loaded http://localhost:56801/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56801/tests/dromaeo/cssquery-mootools.html) 10:16:09 INFO - PID 6720 | RSS: Main: 179392512 10:16:09 INFO - PID 6720 | 10:19:11 INFO - PID 6720 | Cycle 1(1): loaded http://localhost:56801/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56801/tests/dromaeo/cssquery-prototype.html) 10:19:11 INFO - PID 6720 | RSS: Main: 177549312 10:19:11 INFO - PID 6720 | 10:22:15 INFO - PID 6720 | Cycle 1(1): loaded http://localhost:56801/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56801/tests/dromaeo/cssquery-yui.html) 10:22:15 INFO - PID 6720 | RSS: Main: 177213440 10:22:15 INFO - PID 6720 | 10:25:17 INFO - PID 6720 | Cycle 1(1): loaded http://localhost:56801/tests/dromaeo/cssquery-yui.html (next: http://localhost:56801/tests/dromaeo/cssquery-dojo.html) 10:25:17 INFO - PID 6720 | RSS: Main: 180011008 10:25:17 INFO - PID 6720 | 10:25:17 INFO - PID 6720 | __start_tp_report 10:25:17 INFO - PID 6720 | _x_x_mozilla_page_load 10:25:17 INFO - PID 6720 | _x_x_mozilla_page_load_details 10:25:17 INFO - PID 6720 | |i|pagename|runs| 10:25:17 INFO - PID 6720 | |0;dojo.html;3067.2025273428903;3113.7353324967376;3119.4073126106036;3125.359301343225;3132.044726358461;5930.555208359368;5999.760009599616;6036.637801731888;6042;6055.939440605598;6034.668093254869;6075.088736689499;6111.449969502743;6123.846903827406;6180.227471566054;5577.386487486394;5596.328440587135;5621.297337832771;5637.520810731093;5660.066089095294;5557.249771280865;5611.046122159243;5622;5651.2370829937845;5664.915026274589;5512.531434828044;5588.497035266825;5598;5611.523020543218;5679.7160141992945;5405.405405405402;5466.808661696861;5473.945260547383;5491.176323551459;5503.6147469677135;5438.83683489496;5494.2857428534035;5498.230247765276;5505.064139096363;5514.751836167382;5974.103884417372;5984.790532331347;5989.2812862456785;6004.309504407005;6014.609050411709;6438.066480360369;6454.903176452357;6456.709448074848;6464.676766161673;6476.838079048014;6528.477721782246;6530.608163510205;6533.1180290661105;6535.019747037934;6560.704768285439;6062.787802426938;6063.090536419529;6065.848353791146;6067.878642427127;6081.3614570470345;6615.437687796495;6728.495362847708;6739.427148692416;6803.965980170067;6815.148106486689;6199.56603037783;6344.048392741033;6356.110144579762;6437.871242575216;6465.935340646533;6297.149884765498;6426.903596446057;6428.742850285937;6431.5497915146425;6474.320196379406;6369.235691717024;6410.743570257137;6413.486921046305;6434.871302574016;6436.67816609177;6424.646644434601;6462.903056454157;6466.062420948936;6493.837654058591;6532;5285.154375299933;5288.180332048539;5329.200619906967;5363.624546281801;5371.75827087782;4533.0253995390485;4545.522720114406;4553.33976573395;4583.037562111927;4597.977010114928;5450;5517.144842549411;5538.778448862081;5542.612017158841;5582.972085139549;6343.555951083472;6434.131392262078;6467.579607325509;6467.935320646828;6483.740650373932;5486.259354987025;5514.696691681996;5544.889102218014;5607.635503692247;5703.600747947604;5719;5750.597458177971;5800.158976948319;5829.854253643608;5855.355910849803;6304.464120549713;6336.429721325103;6394.23269207698;6417.2299324081405;6418.037294405876;6366.981282994699;6488.318726533646;6501.122348482894;6536.967315163393;6629.237637671729;6215.223097112861;6268.623882567061;6299.212598425197;6310.2743184534365;6312;6292.182016337847;6335.524835637438;6350.174477317919;6356.11014457967;6360.713767880549;5525.392206857162;6462.967685161544;6475.7733479328;6481.675916204265;6637.502187335873;6313.684315784284;6325.430711236011;6385.233771947396;6393.904091438539;6434.420902118832;6265.216847894013;6330.683465826783;6389.393007664265;6407.647579382992;6412.1023056771155;6049.243844519435;6136;6140.662263575367;6147.754089836357;6259.561830671809;6283.622982621057;6305.337939516285;6306.873862522815;6321.146645202839;6346.048092786119;5346.518813306821;6154.753809847556;6176.845578860564;6211.875762484816;6261.5616906816085 10:25:17 INFO - PID 6720 | |1;ext.html;772.4747171923094;845.7082306604219;873.66800615766;896.0143841774053;896.2650626486281;40996.180076398494;42302;42347.57652423475;42519.36220956688;42559;37741.24517509648;37749.811250943705;38019.61980380195;38298.42552361717;38356.808215958954;6881.9655901720425;7008.89486657698;7012.544184627983;7015.438764898796;7044.471664625148;6954.30456954303;7057.964710176442;7059.082319298484;7112.679929403189;7125.358717715405;7046.541974771649;7053.964730176342;7060.152781666207;7077.823054423629;7095.89356159658;7006.789796306119;7042.4718146138985;7049.541779784297;7061.611611361373;7063.929360706378;6345.460635845959;6415.8396040098905;6461.547691661585;6467.482601391877;6475.902861457082;33387.83306083454;33565.6643433565;33571.32857342839;33669;33853.830730846435;3333.7999720016633;3358.2947581008016;3358.983205083983;3437.673421024999;3518.5601799775027;32605.836970814995;32844.343113137606;32936.67063329384;32956.83521582401;32982;4900.338454308659;4927.433345165316;4948.257761335828;4973.104841128596;5006.649534532584;182267;183794;185716;196005;196034;48265.75867120712;49611;49641.50358496441;49692;49833.25250121251;51055;51202.74398627983;51458.48541514537;51576.22635660468;51584.74207629013;16473.176341182894;16723.581910452336;16745.246463909152;16751.078690671886;16793.916030420016;13881.375338109809;13928.025038247428;14066;14084.85915140856;14104.153750774987;14183.574492765234;14386.28068596566;14427.639309017359;14471.927640361731;14512.927435362966;5879.176915231871;5890.3815099414805;5917.881642367129;6018.398160183947;6107.84730381744;974.4250891973769;1003.1122456625939;1013.6806905824642;1037.0459177556515;1037.7768779712246;23015;23116.65325020126;23316.417089572897;23505;24036.51926961486;1074.5970261152067;1106.3417266726285;1115.4590023838432;1117.251441534174;1122.4780477078034;12241.32672702992;12340.50637974489;12560.057995650362;12565.120441569003;12647.494100236072;230172;230281;230531;230897;232046;54034.729826350616;54075.459245407044;54197.72901135548;54393.456065439634;54758;1447.232966527721;1485.3167542930157;1506.7363211437955;1516.5677781832126;1532.4483186053012;22197.556048879254;22679.20622778195;22902.770972290065;23048.769512305335;23153.768462315835;37687.24625507529;37963;38010.42984355292;38049.619503804606;38071.2385752289;178432;178531;179141;179217;179536;34501.30997380088;36992.44511332386;37912.24175516419;39545.406818897165;39579.2084158321;45934;47823;48273;48762.51237487722;48998;32296.515552266264;33588.1602959928;34795;35170.29659406849;35286.29427411386;33621.49567756535;34440;34495.310093798485;34590.82704586562;34759.13102172466;38326.80836595799;38388.80805595954;38552;38695.80652096721;38746;31877.36245275128;31953.840230798698;33084.503732444515;33144.50283245705;33716;24208.775668731818;24551.87724061368;24584;24640.260792176265;24708.629370559098 10:25:17 INFO - PID 6720 | |2;jquery.html;572.9341125770535;580.9593328467009;592.4223881715326;598.2014011294921;606.930203026652;21933.232336868212;21960.780392196073;23110.53778924425;23195.536089278205;23195.884020579895;22470.55058898821;24314.27057188283;24358.63462048071;24587.385315367126;24594.385140371498;6447.54867159299;6629.204495460527;6645.867082658344;6663.366980136903;6663.666816659172;6500.479961603084;6586.934130658704;6590.472762179038;6599.175103112111;6606.405423511883;6158.8768224635705;6245.718942647569;6408;6460.806175814733;6461.224653041618;6406.615603063808;6457.192850893638;6471.514636402265;6473.8705225895455;6478.514111441661;6020.819375418744;6023.6385816851125;6035.185249991239;6035.215421995113;6046.576739628228;26990.46019079627;28302.292442688893;28680.709368078486;29066.41867162666;29127.417451650846;1935.138863205874;1971.0243429502489;1971.9309824156085;1973.7927517610588;1975.2888959974398;18694.252229910788;19277.61444771111;19290.42128736126;19313.806861931484;19334.613307733907;2222.866628002325;2296.7014288142436;2303.2629558541275;2328.6623439601162;2381.2856143156982;137536;138306;141373;141373.2931335347;141927;14253.572392828231;14810.703785924221;14884.776728349083;15211.923940380228;15273.847261527464;23616.64575031376;23644;23656.7634323658;23676.289711308687;23720.288391348287;10061.496925153713;10321.380717156995;10411.791764164675;10604.681859544226;10677.412742299093;9601.423914565148;9657.22742180624;9708.174805141502;9821.80356392868;9853.75365615851;9051.27589792815;9280.814383712288;9286.953565232267;9287.72136835896;9435.6697515588;2643.3920198354485;2645.2064380685715;2662.467506498669;2820.3795165063652;2849.244950088228;914.6981496106268;934.8317302885409;955.7132860141929;979.2313034268066;988.1995583577325;18939.526511837314;22616.434589135075;24033.27900162998;24143.51712965731;24250.757492425204;1037.3723897042332;1054.7626783973699;1055.1822337688352;1056.1392465140887;1067.6370034188258;10633.946830265799;11132.777344453065;11138.888611113947;11147.832782508269;11263.43682815856;535371;535695;536767;545379;561618;116431;120906.39546802209;122294;122905.38547307206;123445.38277308736;1243.2664727810636;1260.1619922751267;1290.451558087809;1301.5119330251157;1312.1012106706937;19151.329703460313;20393.49016274605;20760.896195518926;20845.166193352703;20899.8955005224;51490.48509514857;54084.72957635186;54703.72648136734;55645.16532251939;56200.437995621156;65534.672326638065;66547;67454.3254567448;67962.66018669875;68196;14620.561383158098;14793.11241325524;14853.405863765329;14913.179775112472;14979.325930332943;22458.326250212518;22699.751513666248;22794.43013924665;22837.885810570842;23058.192963246205;18252.26990920348;18328.63342733111;18355.908220458812;18452;18519.53701157482;15450.30473628667;15948.441804536786;16544.50366489007;16865.831341686426;16980.915095424443;18645.90677046606;18728;18989.620207596046;19000.904995474935;19013.714794278374;14598.708025839636;14610.488632897797;14648.414063437343;14660.120392776467;14672.046316989788;17722.202500887233;17840.3755868544;18227.635447291246;18359;18454.538636533656 10:25:17 INFO - PID 6720 | |3;mootools.html;1305.7257975825078;1359.2116572388015;1366.3100134432111;1367.84269808972;1371.5679560938302;13201.801972970401;13689.794653080211;13718.657033574165;13790.793138102912;13800.930995345021;10866.782664346709;11138.888611113887;11206.943965280163;11220.66338009861;11221.32672039676;2407.711074671033;2546.3634091477084;2592.896284148632;2593.1183397644795;2598.9220323390327;2418.9637155442683;2478.2193609013193;2485.614729716897;2487.0300582772734;2489.4523204894895;2568.268043607572;2570.4987527432063;2587.45663410684;2678.1429942418436;2739.2193224930897;2651.1516314779183;2680.316519287569;2690.3543149644142;2690.367763575558;2690.9596356054576;2416.9607068960518;2435.476372579904;2435.6711843901026;2447.510497900409;2455.6439316299216;13182.472701091945;13396.062275640708;13426.731465370736;13466.124701894345;13516.797248041286;7348.265173482662;7634.160242373335;7669.424793140481;7705.113911900147;7720.498167619143;4867.537583929521;5001.224810154432;5152.639315247934;5152.845414637567;5159.535641792219;1831.1942745192073;1899.3921944977612;1913.1964574878584;1931.3433432632971;1958.7355706979517;21240.575188496143;21329.146834126615;21392.14431422741;21424.14303427861;21436.14255429781;6015.248093988252;6289.811305660837;6443.903341449882;6454.806355809334;6465.903011454832;14841.777373339408;14965.775513367309;14970.40118395252;14983.400663973536;14994.625134371729;7292.489525733254;7388.963055184689;7426.405887528985;7433.182349941502;7465.402767778564;6782.864342713118;6924.757633482804;6980.476464265201;7002.684879180449;7035.859282814315;4866.635002374836;4989.950100498949;4998.2002879539095;5045.672031317952;5121.07820592297;1472.1535117307592;1505.6386467248;1516.689078738878;1527.6791873706425;1534.8081489813774;859.9570021498901;870.9477431354139;871.2246100970142;881.5415983688446;903.8824952756099;6971.302869713089;7015.649217539102;7113.502054856214;7761.9611901940125;7850.960745196237;716.8888822232562;739.2644318902619;964.1611797736015;1001.7796084861319;1018.6434747838198;4607.239805432133;4868.2210846264425;4979.3526841510375;5014.323066385991;5045.596352291881;18239.452816415527;18710.438686839418;18799.718004229948;18868.716969245197;18881.15034823436;18101.637967240582;18494.907525462288;18941.526461838563;18946.43160705181;19155.425337239903;10669.73325666849;10701.411422371688;10708.250422470352;10735.355878647306;10770.892291077145;7337.156227033959;7979.561124137996;8068.59657017135;8117.878231826409;8143.7964050896835;16147.515574532783;16580.83419165793;16622.833771662128;16692.41576544815;17156.284371562742;15848.683026339639;16557.089360085312;16721.832781672027;17000.65998680044;17262.309507620055;10580.89419105799;10690.518926648165;10854.837177442187;10899.400532970445;10965.177611679315;12763.617091487271;12936.15914965562;12938.288394138413;12940.09419340637;12953.481860725842;9795.9020409795;10019.398836069859;10132.44271565071;10145.03622155894;10272.435016074187;9772.26707996889;10036.247281454067;10383.065524102867;10399.740006499898;10570.312929659854;8921.955390223007;8948.373613847229;9031.322650801085;9033.141851524095;9068.274538037072;6537.640429776408;6640.103586016019;6736.090627765385;6744.62904540255;6890.276520965427;6627.304133065959;6720.731170753115;6754.290799465985;6770.695318710571;6845.5550389224545 10:25:17 INFO - PID 6720 | |4;prototype.html;487.31146577110303;503.1220520192264;529.1824131716497;529.8632097979959;539.3150698612762;6167.105769663407;6182.412670796279;6217.409346112117;6238.376162383759;6261.5303852211155;5914.349421563625;5915;6005.759769609211;6076.908846367308;6094.360092190323;4833.782479788418;4839.4918533554;4871.293662418947;4896.167651499236;4911.754412279381;4899.902001959977;4934.309196712463;4935.6308971693425;4969.155073803049;4982.87542811429;4707.835225767099;4816.590589799871;4861.708297502143;4881.536254055859;4910.140725373063;4864.781084851173;4902.142125128106;4925.2858335541505;4965.379327584052;4968.552830245259;4405.3612226227015;4412.470503539564;4447.733136011817;4454.933176002362;4477.865664030084;5919.881602367972;5931.228940237785;5942.554308426886;5948.494377977877;6002.609830361012;5601.579881508862;5621.100623900156;5630.915536266959;5633.971770162738;5641.294838145232;6478.46091591687;6487.458778854821;6491.285958544557;6497.252815926135;6513.15723723001;4875.268709693539;4882.218844984785;4885.145099607555;4890.0953323634885;4892.339534162914;6776.983452482118;6791.762288319885;6863.794086177422;6873.656317184121;6884.724611015554;4958.157113290749;4963.205887058126;4984.825531106467;5017;5026.648134630614;4985.750712464363;5003.724050367206;5016.724080175625;5038.093143234253;5039.168537191323;5535.612507124462;5556.138798486241;5570.554355651539;5630.834236511014;5640.802571909963;6431.614103153825;6460.709268082947;6486.935130648728;6497.772577959749;6502.911117219283;1740.5996620777291;1759.217148368989;1761.3130878957218;1779.7897429747636;1780.7952085510074;1107.8615173103362;1120.8374785656035;1221.505290357389;1228.2323547782637;1232.5932442294202;5448.37343705471;5502.972485137629;5513.531349835309;5552.444755524496;5617.747201375866;6453.806385808433;6517.348265173445;6563.540552161303;6601.207855057424;6641.800745977628;5535.474129957647;5545.61180717354;5553.694546799884;5581.162825576115;5615.354234263031;3369.966300337014;3453.2215908806984;3486.790792552455;3504.3341765064556;3550.6626870447267;6310.6213627182515;6381.649009304533;6393.2328120625825;6395.328490508429;6397.136386587844;6615.272320044791;6696.129503164558;6768.69540870662;6788.389044985876;6794.218664853605;6319.778807741707;6321.683915804191;6360.936390636127;6386;6398.456131228804;6504.707288172138;6545.218282230128;6556.672166391757;6586.242582102927;6690.69891854858;6581.992492289706;6593.175853018372;6606.966965165144;6607.900881486878;6641.369069938348;6449.774257900951;6454.257760357619;6469.576693127693;6470.38531339522;6487.124238227779;4895.951040489549;4934.432540257916;4948.851534453972;4993.925091123563;5011.84964451067;6556.475481961527;6617.735290588323;6669.233038200669;6715.966420168063;6738.59568425896;6284.209000434854;6314.842128946813;6333.809985700436;6384.3934826191435;6475.870482590416;6291.905621415774;6338.591335292559;6379;6412.326705695835;6483.222013358427;6272;6286.591371560834;6304.936950630618;6320.009197102898;6382.32985536512;6452.2573910262945;6452.806415807533;6454.612723236621;6507.349265073455;6563.901541476977;6034.064719968412;6226.470749986302;6247.281562620356;6288.5598008138995;6300.495960323255 10:25:17 INFO - PID 6720 | |5;yui.html;901.2249465459704;907.6777743900915;920.8940971788238;924.653255029364;926.1710768861867;17753.37863174789;18040.90979545102;18171.99999999998;18247.635047299045;21146.154153833868;20240.79759202411;21285;21302.46743831405;21377.465563360925;21539.138434462602;1035.1460045462468;1038.138345173508;1045.2996492350105;1050.1651187306072;1056.028453822485;1062.5112448273803;1067.8077945969721;1071.3197119828926;1072.1690689715456;1074.156786922266;1117.5753213778753;1121.5681962444437;1126.5437497813398;1129.5255992483135;1132.3375825142302;1057.0856209378908;1096.17786660005;1098.1215027977587;1107.385401102388;1118.0887576625066;794.9863923497587;806.2542148512603;806.770070529902;809.5142914251461;810.0401024785648;17255.56861078483;17310.134493275287;17581.56046098845;17582.472525824247;17600.647987040316;19952.501187470283;20211;20775.16899324025;20844.47888802777;20932.058057387454;14409.78385324221;14443.133411995314;14452.060616059922;14485.855141448556;14498.782518262235;3432.9313413731834;3506.333796578642;3539.876104336336;3551.236484155919;3618.222082252328;115213.42393288064;117804.82195178024;121828.99999999911;122080;125127.37436312852;13707.657308567166;13998.51005214833;14084;14179.574612761633;14273.214973176367;27573;27609.895604175606;27619.447611047668;28714;28953.42093158125;7440.851182976418;7724.6523906424345;8337.916620833836;8435.746927592181;8436.40945133847;3550.1657110578994;3803.6006219347123;4013.458183145238;4015.6185162409524;4016.819243134066;4756.453007904066;4850.714560641432;4862.41651001882;4883.853484395403;4908;953.9379940303858;994.8209322321907;998.0468652436905;1003.0771690045176;1003.5835128421769;678.2708588267534;678.7963610916804;679.2833560593523;692.5879101934341;712.6935417770305;11516.481758320895;11567.942160289145;11718.121140914294;11798.46906889192;12069.577564785366;695.979120626382;705.78473565563;711.1288671377521;713.3651050565002;728.2208037400037;5193.636445448858;5198.610104242197;5237.895242095213;5325.2810870531985;5416.268803711528;101199.49400253099;104904.47547762212;104993.47503262588;107081.25215617416;109038;87406.56296718476;90611;92208.53895730479;93412.53293733623;93795;78791.60604196943;78818.6059069701;79735.60132199418;79755;81653.59173204214;10772.784544309226;11064.668059958214;11474.541018359172;11657.242279251821;11700.531978720755;33238.66761332356;33341.666333346395;35319.11702207466;35858;36450.99999999894;43687.34468982904;61995.38004619896;63644;64337.35662643314;67291.32708673047;16614.25235864413;17387.652246955244;17414.564635884206;17459.47621571355;17568.73646895272;17390.21744021497;18615.162317695464;18839.434816955512;18993.810061899203;19040.619187615892;15504;15642.374305028126;16003.759943601088;16677.833221668112;16729.49811505657;17301.30794768195;17867.553311167325;17987.460376188734;18019;18118.909405452887;16584;16837.91581042136;16892.746608800633;16971.0665913371;17211.827881721525;10368.585256589953;10795.352278863293;11194.944025279821;11425.085993120365;11494.770104597694;10167.389956602627;10254.436006019741;10257.794844103226;10517;10526.263161578921 10:25:17 INFO - PID 6720 | __end_tp_report 10:25:17 INFO - PID 6720 | __start_cc_report 10:25:17 INFO - PID 6720 | _x_x_mozilla_cycle_collect,366 10:25:17 INFO - PID 6720 | __end_cc_report 10:25:17 INFO - PID 6720 | __startTimestamp1500312317735__endTimestamp 10:25:17 INFO - PID 6720 | 10:25:17 INFO - PID 6720 | ------- Summary: start ------- 10:25:17 INFO - PID 6720 | Number of tests: 6 10:25:17 INFO - PID 6720 | 10:25:17 INFO - PID 6720 | [#0] dojo.html Cycles:165 Average:5961.81 Median:6180.23 stddev:690.40 (11.2%) stddev-sans-first:654.11 10:25:17 INFO - PID 6720 | Values: 3067.2 3113.7 3119.4 3125.4 3132.0 5930.6 5999.8 6036.6 6042.0 6055.9 6034.7 6075.1 6111.4 6123.8 6180.2 5577.4 5596.3 5621.3 5637.5 5660.1 5557.2 5611.0 5622.0 5651.2 5664.9 5512.5 5588.5 5598.0 5611.5 5679.7 5405.4 5466.8 5473.9 5491.2 5503.6 5438.8 5494.3 5498.2 5505.1 5514.8 5974.1 5984.8 5989.3 6004.3 6014.6 6438.1 6454.9 6456.7 6464.7 6476.8 6528.5 6530.6 6533.1 6535.0 6560.7 6062.8 6063.1 6065.8 6067.9 6081.4 6615.4 6728.5 6739.4 6804.0 6815.1 6199.6 6344.0 6356.1 6437.9 6465.9 6297.1 6426.9 6428.7 6431.5 6474.3 6369.2 6410.7 6413.5 6434.9 6436.7 6424.6 6462.9 6466.1 6493.8 6532.0 5285.2 5288.2 5329.2 5363.6 5371.8 4533.0 4545.5 4553.3 4583.0 4598.0 5450.0 5517.1 5538.8 5542.6 5583.0 6343.6 6434.1 6467.6 6467.9 6483.7 5486.3 5514.7 5544.9 5607.6 5703.6 5719.0 5750.6 5800.2 5829.9 5855.4 6304.5 6336.4 6394.2 6417.2 6418.0 6367.0 6488.3 6501.1 6537.0 6629.2 6215.2 6268.6 6299.2 6310.3 6312.0 6292.2 6335.5 6350.2 6356.1 6360.7 5525.4 6463.0 6475.8 6481.7 6637.5 6313.7 6325.4 6385.2 6393.9 6434.4 6265.2 6330.7 6389.4 6407.6 6412.1 6049.2 6136.0 6140.7 6147.8 6259.6 6283.6 6305.3 6306.9 6321.1 6346.0 5346.5 6154.8 6176.8 6211.9 6261.6 10:25:17 INFO - PID 6720 | 10:25:17 INFO - PID 6720 | [#1] ext.html Cycles:180 Average:37374.32 Median:34777.07 stddev:52064.05 (149.7%) stddev-sans-first:52137.56 10:25:17 INFO - PID 6720 | Values: 772.5 845.7 873.7 896.0 896.3 40996.2 42302.0 42347.6 42519.4 42559.0 37741.2 37749.8 38019.6 38298.4 38356.8 6882.0 7008.9 7012.5 7015.4 7044.5 6954.3 7058.0 7059.1 7112.7 7125.4 7046.5 7054.0 7060.2 7077.8 7095.9 7006.8 7042.5 7049.5 7061.6 7063.9 6345.5 6415.8 6461.5 6467.5 6475.9 33387.8 33565.7 33571.3 33669.0 33853.8 3333.8 3358.3 3359.0 3437.7 3518.6 32605.8 32844.3 32936.7 32956.8 32982.0 4900.3 4927.4 4948.3 4973.1 5006.6 182267.0 183794.0 185716.0 196005.0 196034.0 48265.8 49611.0 49641.5 49692.0 49833.3 51055.0 51202.7 51458.5 51576.2 51584.7 16473.2 16723.6 16745.2 16751.1 16793.9 13881.4 13928.0 14066.0 14084.9 14104.2 14183.6 14386.3 14427.6 14471.9 14512.9 5879.2 5890.4 5917.9 6018.4 6107.8 974.4 1003.1 1013.7 1037.0 1037.8 23015.0 23116.7 23316.4 23505.0 24036.5 1074.6 1106.3 1115.5 1117.3 1122.5 12241.3 12340.5 12560.1 12565.1 12647.5 230172.0 230281.0 230531.0 230897.0 232046.0 54034.7 54075.5 54197.7 54393.5 54758.0 1447.2 1485.3 1506.7 1516.6 1532.4 22197.6 22679.2 22902.8 23048.8 23153.8 37687.2 37963.0 38010.4 38049.6 38071.2 178432.0 178531.0 179141.0 179217.0 179536.0 34501.3 36992.4 37912.2 39545.4 39579.2 45934.0 47823.0 48273.0 48762.5 48998.0 32296.5 33588.2 34795.0 35170.3 35286.3 33621.5 34440.0 34495.3 34590.8 34759.1 38326.8 38388.8 38552.0 38695.8 38746.0 31877.4 31953.8 33084.5 33144.5 33716.0 24208.8 24551.9 24584.0 24640.3 24708.6 10:25:17 INFO - PID 6720 | 10:25:17 INFO - PID 6720 | [#2] jquery.html Cycles:180 Average:36369.37 Median:2299.98 stddev:90924.74 (3953.3%) stddev-sans-first:91140.09 10:25:17 INFO - PID 6720 | Values: 572.9 581.0 592.4 598.2 606.9 21933.2 21960.8 23110.5 23195.5 23195.9 22470.6 24314.3 24358.6 24587.4 24594.4 6447.5 6629.2 6645.9 6663.4 6663.7 6500.5 6586.9 6590.5 6599.2 6606.4 6158.9 6245.7 6408.0 6460.8 6461.2 6406.6 6457.2 6471.5 6473.9 6478.5 6020.8 6023.6 6035.2 6035.2 6046.6 26990.5 28302.3 28680.7 29066.4 29127.4 1935.1 1971.0 1971.9 1973.8 1975.3 18694.3 19277.6 19290.4 19313.8 19334.6 2222.9 2296.7 2303.3 2328.7 2381.3 137536.0 138306.0 141373.0 141373.3 141927.0 14253.6 14810.7 14884.8 15211.9 15273.8 23616.6 23644.0 23656.8 23676.3 23720.3 10061.5 10321.4 10411.8 10604.7 10677.4 9601.4 9657.2 9708.2 9821.8 9853.8 9051.3 9280.8 9287.0 9287.7 9435.7 2643.4 2645.2 2662.5 2820.4 2849.2 914.7 934.8 955.7 979.2 988.2 18939.5 22616.4 24033.3 24143.5 24250.8 1037.4 1054.8 1055.2 1056.1 1067.6 10633.9 11132.8 11138.9 11147.8 11263.4 535371.0 535695.0 536767.0 545379.0 561618.0 116431.0 120906.4 122294.0 122905.4 123445.4 1243.3 1260.2 1290.5 1301.5 1312.1 19151.3 20393.5 20760.9 20845.2 20899.9 51490.5 54084.7 54703.7 55645.2 56200.4 65534.7 66547.0 67454.3 67962.7 68196.0 14620.6 14793.1 14853.4 14913.2 14979.3 22458.3 22699.8 22794.4 22837.9 23058.2 18252.3 18328.6 18355.9 18452.0 18519.5 15450.3 15948.4 16544.5 16865.8 16980.9 18645.9 18728.0 18989.6 19000.9 19013.7 14598.7 14610.5 14648.4 14660.1 14672.0 17722.2 17840.4 18227.6 18359.0 18454.5 10:25:17 INFO - PID 6720 | 10:25:17 INFO - PID 6720 | [#3] mootools.html Cycles:180 Average:8340.53 Median:2451.58 stddev:5623.37 (229.4%) stddev-sans-first:5614.30 10:25:17 INFO - PID 6720 | Values: 1305.7 1359.2 1366.3 1367.8 1371.6 13201.8 13689.8 13718.7 13790.8 13800.9 10866.8 11138.9 11206.9 11220.7 11221.3 2407.7 2546.4 2592.9 2593.1 2598.9 2419.0 2478.2 2485.6 2487.0 2489.5 2568.3 2570.5 2587.5 2678.1 2739.2 2651.2 2680.3 2690.4 2690.4 2691.0 2417.0 2435.5 2435.7 2447.5 2455.6 13182.5 13396.1 13426.7 13466.1 13516.8 7348.3 7634.2 7669.4 7705.1 7720.5 4867.5 5001.2 5152.6 5152.8 5159.5 1831.2 1899.4 1913.2 1931.3 1958.7 21240.6 21329.1 21392.1 21424.1 21436.1 6015.2 6289.8 6443.9 6454.8 6465.9 14841.8 14965.8 14970.4 14983.4 14994.6 7292.5 7389.0 7426.4 7433.2 7465.4 6782.9 6924.8 6980.5 7002.7 7035.9 4866.6 4990.0 4998.2 5045.7 5121.1 1472.2 1505.6 1516.7 1527.7 1534.8 860.0 870.9 871.2 881.5 903.9 6971.3 7015.6 7113.5 7762.0 7851.0 716.9 739.3 964.2 1001.8 1018.6 4607.2 4868.2 4979.4 5014.3 5045.6 18239.5 18710.4 18799.7 18868.7 18881.2 18101.6 18494.9 18941.5 18946.4 19155.4 10669.7 10701.4 10708.3 10735.4 10770.9 7337.2 7979.6 8068.6 8117.9 8143.8 16147.5 16580.8 16622.8 16692.4 17156.3 15848.7 16557.1 16721.8 17000.7 17262.3 10580.9 10690.5 10854.8 10899.4 10965.2 12763.6 12936.2 12938.3 12940.1 12953.5 9795.9 10019.4 10132.4 10145.0 10272.4 9772.3 10036.2 10383.1 10399.7 10570.3 8922.0 8948.4 9031.3 9033.1 9068.3 6537.6 6640.1 6736.1 6744.6 6890.3 6627.3 6720.7 6754.3 6770.7 6845.6 10:25:17 INFO - PID 6720 | 10:25:17 INFO - PID 6720 | [#4] prototype.html Cycles:180 Average:5421.30 Median:5975.55 stddev:1516.52 (25.4%) stddev-sans-first:1474.86 10:25:17 INFO - PID 6720 | Values: 487.3 503.1 529.2 529.9 539.3 6167.1 6182.4 6217.4 6238.4 6261.5 5914.3 5915.0 6005.8 6076.9 6094.4 4833.8 4839.5 4871.3 4896.2 4911.8 4899.9 4934.3 4935.6 4969.2 4982.9 4707.8 4816.6 4861.7 4881.5 4910.1 4864.8 4902.1 4925.3 4965.4 4968.6 4405.4 4412.5 4447.7 4454.9 4477.9 5919.9 5931.2 5942.6 5948.5 6002.6 5601.6 5621.1 5630.9 5634.0 5641.3 6478.5 6487.5 6491.3 6497.3 6513.2 4875.3 4882.2 4885.1 4890.1 4892.3 6777.0 6791.8 6863.8 6873.7 6884.7 4958.2 4963.2 4984.8 5017.0 5026.6 4985.8 5003.7 5016.7 5038.1 5039.2 5535.6 5556.1 5570.6 5630.8 5640.8 6431.6 6460.7 6486.9 6497.8 6502.9 1740.6 1759.2 1761.3 1779.8 1780.8 1107.9 1120.8 1221.5 1228.2 1232.6 5448.4 5503.0 5513.5 5552.4 5617.7 6453.8 6517.3 6563.5 6601.2 6641.8 5535.5 5545.6 5553.7 5581.2 5615.4 3370.0 3453.2 3486.8 3504.3 3550.7 6310.6 6381.6 6393.2 6395.3 6397.1 6615.3 6696.1 6768.7 6788.4 6794.2 6319.8 6321.7 6360.9 6386.0 6398.5 6504.7 6545.2 6556.7 6586.2 6690.7 6582.0 6593.2 6607.0 6607.9 6641.4 6449.8 6454.3 6469.6 6470.4 6487.1 4896.0 4934.4 4948.9 4993.9 5011.8 6556.5 6617.7 6669.2 6716.0 6738.6 6284.2 6314.8 6333.8 6384.4 6475.9 6291.9 6338.6 6379.0 6412.3 6483.2 6272.0 6286.6 6304.9 6320.0 6382.3 6452.3 6452.8 6454.6 6507.3 6563.9 6034.1 6226.5 6247.3 6288.6 6300.5 10:25:17 INFO - PID 6720 | 10:25:17 INFO - PID 6720 | [#5] yui.html Cycles:180 Average:21994.91 Median:18209.82 stddev:30243.20 (166.1%) stddev-sans-first:30286.57 10:25:17 INFO - PID 6720 | Values: 901.2 907.7 920.9 924.7 926.2 17753.4 18040.9 18172.0 18247.6 21146.2 20240.8 21285.0 21302.5 21377.5 21539.1 1035.1 1038.1 1045.3 1050.2 1056.0 1062.5 1067.8 1071.3 1072.2 1074.2 1117.6 1121.6 1126.5 1129.5 1132.3 1057.1 1096.2 1098.1 1107.4 1118.1 795.0 806.3 806.8 809.5 810.0 17255.6 17310.1 17581.6 17582.5 17600.6 19952.5 20211.0 20775.2 20844.5 20932.1 14409.8 14443.1 14452.1 14485.9 14498.8 3432.9 3506.3 3539.9 3551.2 3618.2 115213.4 117804.8 121829.0 122080.0 125127.4 13707.7 13998.5 14084.0 14179.6 14273.2 27573.0 27609.9 27619.4 28714.0 28953.4 7440.9 7724.7 8337.9 8435.7 8436.4 3550.2 3803.6 4013.5 4015.6 4016.8 4756.5 4850.7 4862.4 4883.9 4908.0 953.9 994.8 998.0 1003.1 1003.6 678.3 678.8 679.3 692.6 712.7 11516.5 11567.9 11718.1 11798.5 12069.6 696.0 705.8 711.1 713.4 728.2 5193.6 5198.6 5237.9 5325.3 5416.3 101199.5 104904.5 104993.5 107081.3 109038.0 87406.6 90611.0 92208.5 93412.5 93795.0 78791.6 78818.6 79735.6 79755.0 81653.6 10772.8 11064.7 11474.5 11657.2 11700.5 33238.7 33341.7 35319.1 35858.0 36451.0 43687.3 61995.4 63644.0 64337.4 67291.3 16614.3 17387.7 17414.6 17459.5 17568.7 17390.2 18615.2 18839.4 18993.8 19040.6 15504.0 15642.4 16003.8 16677.8 16729.5 17301.3 17867.6 17987.5 18019.0 18118.9 16584.0 16837.9 16892.7 16971.1 17211.8 10368.6 10795.4 11194.9 11425.1 11494.8 10167.4 10254.4 10257.8 10517.0 10526.3 10:25:17 INFO - PID 6720 | -------- Summary: end -------- 10:25:17 INFO - PID 6720 | 10:25:18 INFO - TEST-INFO | 6720: exit 0 10:25:18 INFO - TEST-OK | dromaeo_css | took 1112138ms 10:25:18 INFO - TEST-START | kraken 10:25:18 INFO - Initialising browser for kraken test... 10:25:18 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:56801/getInfo.html -profile /tmp/tmphhmcfc/profile 10:25:18 INFO - TEST-INFO | started process 7133 (/builds/slave/test/build/application/firefox/firefox http://localhost:56801/getInfo.html) 10:25:24 INFO - TEST-INFO | 7133: exit 0 10:25:25 INFO - Browser initialized. 10:25:25 INFO - Running cycle 1/1 for kraken test... 10:25:25 INFO - TEST-INFO | started process 7358 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphhmcfc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 10:25:36 INFO - PID 7358 | RSS: Main: 169549824 10:25:36 INFO - PID 7358 | 10:25:38 INFO - PID 7358 | Cycle 1(1): loaded http://localhost:56801/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56801/tests/kraken/driver.html?testName=audio-beat-detection) 10:25:39 INFO - PID 7358 | RSS: Main: 176111616 10:25:39 INFO - PID 7358 | 10:25:42 INFO - PID 7358 | Cycle 1(1): loaded http://localhost:56801/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56801/tests/kraken/driver.html?testName=audio-dft) 10:25:43 INFO - PID 7358 | RSS: Main: 176164864 10:25:43 INFO - PID 7358 | 10:25:46 INFO - PID 7358 | Cycle 1(1): loaded http://localhost:56801/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56801/tests/kraken/driver.html?testName=audio-fft) 10:25:46 INFO - PID 7358 | RSS: Main: 170082304 10:25:46 INFO - PID 7358 | 10:25:48 INFO - PID 7358 | Cycle 1(1): loaded http://localhost:56801/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56801/tests/kraken/driver.html?testName=audio-oscillator) 10:25:49 INFO - PID 7358 | RSS: Main: 171233280 10:25:49 INFO - PID 7358 | 10:25:51 INFO - PID 7358 | Cycle 1(1): loaded http://localhost:56801/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56801/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:25:52 INFO - PID 7358 | RSS: Main: 171462656 10:25:52 INFO - PID 7358 | 10:25:55 INFO - PID 7358 | Cycle 1(1): loaded http://localhost:56801/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56801/tests/kraken/driver.html?testName=imaging-darkroom) 10:25:55 INFO - PID 7358 | RSS: Main: 174657536 10:25:55 INFO - PID 7358 | 10:25:59 INFO - PID 7358 | Cycle 1(1): loaded http://localhost:56801/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56801/tests/kraken/driver.html?testName=imaging-desaturate) 10:25:59 INFO - PID 7358 | RSS: Main: 175927296 10:25:59 INFO - PID 7358 | 10:26:02 INFO - PID 7358 | Cycle 1(1): loaded http://localhost:56801/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56801/tests/kraken/driver.html?testName=json-parse-financial) 10:26:03 INFO - PID 7358 | RSS: Main: 175218688 10:26:03 INFO - PID 7358 | 10:26:04 INFO - PID 7358 | Cycle 1(1): loaded http://localhost:56801/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56801/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:26:05 INFO - PID 7358 | RSS: Main: 174796800 10:26:05 INFO - PID 7358 | 10:26:07 INFO - PID 7358 | Cycle 1(1): loaded http://localhost:56801/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56801/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:26:07 INFO - PID 7358 | RSS: Main: 174903296 10:26:07 INFO - PID 7358 | 10:26:09 INFO - PID 7358 | Cycle 1(1): loaded http://localhost:56801/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56801/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:26:10 INFO - PID 7358 | RSS: Main: 175095808 10:26:10 INFO - PID 7358 | 10:26:13 INFO - PID 7358 | Cycle 1(1): loaded http://localhost:56801/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56801/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:26:14 INFO - PID 7358 | RSS: Main: 175116288 10:26:14 INFO - PID 7358 | 10:26:17 INFO - PID 7358 | Cycle 1(1): loaded http://localhost:56801/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56801/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:26:17 INFO - PID 7358 | RSS: Main: 175296512 10:26:17 INFO - PID 7358 | 10:26:19 INFO - PID 7358 | Cycle 1(1): loaded http://localhost:56801/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56801/tests/kraken/driver.html?testName=ai-astar) 10:26:19 INFO - PID 7358 | RSS: Main: 176848896 10:26:19 INFO - PID 7358 | 10:26:19 INFO - PID 7358 | __start_tp_report 10:26:19 INFO - PID 7358 | _x_x_mozilla_page_load 10:26:19 INFO - PID 7358 | _x_x_mozilla_page_load_details 10:26:19 INFO - PID 7358 | |i|pagename|runs| 10:26:19 INFO - PID 7358 | |0;ai-astar;100;109;108;108;108;111;108;109;109;109 10:26:19 INFO - PID 7358 | |1;audio-beat-detection;159;122;144;181;127;160;156;123;177;123 10:26:19 INFO - PID 7358 | |2;audio-dft;165;161;164;162;163;168;164;164;173;167 10:26:19 INFO - PID 7358 | |3;audio-fft;74;78;75;160;74;75;74;74;95;75 10:26:19 INFO - PID 7358 | |4;audio-oscillator;81;82;131;81;81;81;130;82;81;126 10:26:19 INFO - PID 7358 | |5;imaging-gaussian-blur;113;113;113;113;113;113;115;113;114;114 10:26:19 INFO - PID 7358 | |6;imaging-darkroom;148;151;150;148;149;149;150;150;150;151 10:26:19 INFO - PID 7358 | |7;imaging-desaturate;94;95;94;94;93;95;93;95;94;94 10:26:19 INFO - PID 7358 | |8;json-parse-financial;55;55;55;56;55;58;56;56;56;56 10:26:19 INFO - PID 7358 | |9;json-stringify-tinderbox;54;54;55;55;55;54;53;54;55;53 10:26:19 INFO - PID 7358 | |10;stanford-crypto-aes;78;85;78;82;79;76;76;76;85;76 10:26:19 INFO - PID 7358 | |11;stanford-crypto-ccm;130;132;128;131;138;127;138;130;139;156 10:26:19 INFO - PID 7358 | |12;stanford-crypto-pbkdf2;182;200;185;183;186;183;186;184;185;190 10:26:19 INFO - PID 7358 | |13;stanford-crypto-sha256-iterative;71;70;71;68;69;70;67;73;74;70 10:26:19 INFO - PID 7358 | __end_tp_report 10:26:19 INFO - PID 7358 | __start_cc_report 10:26:19 INFO - PID 7358 | _x_x_mozilla_cycle_collect,938 10:26:19 INFO - PID 7358 | __end_cc_report 10:26:19 INFO - PID 7358 | __startTimestamp1500312379658__endTimestamp 10:26:19 INFO - PID 7358 | 10:26:19 INFO - PID 7358 | ------- Summary: start ------- 10:26:19 INFO - PID 7358 | Number of tests: 14 10:26:19 INFO - PID 7358 | 10:26:19 INFO - PID 7358 | [#0] ai-astar Cycles:10 Average:107.90 Median:109.00 stddev:2.92 (2.7%) stddev-sans-first:0.97 10:26:19 INFO - PID 7358 | Values: 100.0 109.0 108.0 108.0 108.0 111.0 108.0 109.0 109.0 109.0 10:26:19 INFO - PID 7358 | 10:26:19 INFO - PID 7358 | [#1] audio-beat-detection Cycles:10 Average:147.20 Median:157.50 stddev:22.70 (14.4%) stddev-sans-first:23.67 10:26:19 INFO - PID 7358 | Values: 159.0 122.0 144.0 181.0 127.0 160.0 156.0 123.0 177.0 123.0 10:26:19 INFO - PID 7358 | 10:26:19 INFO - PID 7358 | [#2] audio-dft Cycles:10 Average:165.10 Median:164.50 stddev:3.48 (2.1%) stddev-sans-first:3.69 10:26:19 INFO - PID 7358 | Values: 165.0 161.0 164.0 162.0 163.0 168.0 164.0 164.0 173.0 167.0 10:26:19 INFO - PID 7358 | 10:26:19 INFO - PID 7358 | [#3] audio-fft Cycles:10 Average:85.40 Median:75.00 stddev:26.99 (36.0%) stddev-sans-first:28.31 10:26:19 INFO - PID 7358 | Values: 74.0 78.0 75.0 160.0 74.0 75.0 74.0 74.0 95.0 75.0 10:26:19 INFO - PID 7358 | 10:26:19 INFO - PID 7358 | [#4] audio-oscillator Cycles:10 Average:95.60 Median:81.00 stddev:23.09 (28.5%) stddev-sans-first:23.87 10:26:19 INFO - PID 7358 | Values: 81.0 82.0 131.0 81.0 81.0 81.0 130.0 82.0 81.0 126.0 10:26:19 INFO - PID 7358 | 10:26:19 INFO - PID 7358 | [#5] imaging-gaussian-blur Cycles:10 Average:113.40 Median:113.00 stddev:0.70 (0.6%) stddev-sans-first:0.73 10:26:19 INFO - PID 7358 | Values: 113.0 113.0 113.0 113.0 113.0 113.0 115.0 113.0 114.0 114.0 10:26:19 INFO - PID 7358 | 10:26:19 INFO - PID 7358 | [#6] imaging-darkroom Cycles:10 Average:149.60 Median:150.00 stddev:1.07 (0.7%) stddev-sans-first:0.97 10:26:19 INFO - PID 7358 | Values: 148.0 151.0 150.0 148.0 149.0 149.0 150.0 150.0 150.0 151.0 10:26:19 INFO - PID 7358 | 10:26:19 INFO - PID 7358 | [#7] imaging-desaturate Cycles:10 Average:94.10 Median:94.00 stddev:0.74 (0.8%) stddev-sans-first:0.78 10:26:19 INFO - PID 7358 | Values: 94.0 95.0 94.0 94.0 93.0 95.0 93.0 95.0 94.0 94.0 10:26:19 INFO - PID 7358 | 10:26:19 INFO - PID 7358 | [#8] json-parse-financial Cycles:10 Average:55.80 Median:56.00 stddev:0.92 (1.6%) stddev-sans-first:0.93 10:26:19 INFO - PID 7358 | Values: 55.0 55.0 55.0 56.0 55.0 58.0 56.0 56.0 56.0 56.0 10:26:19 INFO - PID 7358 | 10:26:19 INFO - PID 7358 | [#9] json-stringify-tinderbox Cycles:10 Average:54.20 Median:54.50 stddev:0.79 (1.4%) stddev-sans-first:0.83 10:26:19 INFO - PID 7358 | Values: 54.0 54.0 55.0 55.0 55.0 54.0 53.0 54.0 55.0 53.0 10:26:19 INFO - PID 7358 | 10:26:19 INFO - PID 7358 | [#10] stanford-crypto-aes Cycles:10 Average:79.10 Median:78.50 stddev:3.63 (4.6%) stddev-sans-first:3.83 10:26:19 INFO - PID 7358 | Values: 78.0 85.0 78.0 82.0 79.0 76.0 76.0 76.0 85.0 76.0 10:26:19 INFO - PID 7358 | 10:26:19 INFO - PID 7358 | [#11] stanford-crypto-ccm Cycles:10 Average:134.90 Median:135.00 stddev:8.58 (6.4%) stddev-sans-first:8.92 10:26:19 INFO - PID 7358 | Values: 130.0 132.0 128.0 131.0 138.0 127.0 138.0 130.0 139.0 156.0 10:26:19 INFO - PID 7358 | 10:26:19 INFO - PID 7358 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:186.40 Median:185.50 stddev:5.27 (2.8%) stddev-sans-first:5.35 10:26:19 INFO - PID 7358 | Values: 182.0 200.0 185.0 183.0 186.0 183.0 186.0 184.0 185.0 190.0 10:26:19 INFO - PID 7358 | 10:26:19 INFO - PID 7358 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.30 Median:70.50 stddev:2.11 (3.0%) stddev-sans-first:2.22 10:26:19 INFO - PID 7358 | Values: 71.0 70.0 71.0 68.0 69.0 70.0 67.0 73.0 74.0 70.0 10:26:19 INFO - PID 7358 | -------- Summary: end -------- 10:26:19 INFO - PID 7358 | 10:26:20 INFO - PID 7358 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 10:26:20 INFO - TEST-INFO | 7358: exit 0 10:26:20 INFO - TEST-OK | kraken | took 62189ms 10:26:20 INFO - SUITE-END | took 1174s 10:26:20 INFO - Completed test suite (00:19:34) 10:26:20 INFO - javascript benchmark 10:26:20 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8280.500441344042, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3067.2025273428903, 3113.7353324967376, 3119.4073126106036, 3125.359301343225, 3132.044726358461, 5930.555208359368, 5999.760009599616, 6036.637801731888, 6042.0, 6055.939440605598, 6034.668093254869, 6075.088736689499, 6111.449969502743, 6123.846903827406, 6180.227471566054, 5577.386487486394, 5596.328440587135, 5621.297337832771, 5637.520810731093, 5660.066089095294, 5557.249771280865, 5611.046122159243, 5622.0, 5651.2370829937845, 5664.915026274589, 5512.531434828044, 5588.497035266825, 5598.0, 5611.523020543218, 5679.7160141992945, 5405.405405405402, 5466.808661696861, 5473.945260547383, 5491.176323551459, 5503.6147469677135, 5438.83683489496, 5494.2857428534035, 5498.230247765276, 5505.064139096363, 5514.751836167382, 5974.103884417372, 5984.790532331347, 5989.2812862456785, 6004.309504407005, 6014.609050411709, 6438.066480360369, 6454.903176452357, 6456.709448074848, 6464.676766161673, 6476.838079048014, 6528.477721782246, 6530.608163510205, 6533.1180290661105, 6535.019747037934, 6560.704768285439, 6062.787802426938, 6063.090536419529, 6065.848353791146, 6067.878642427127, 6081.3614570470345, 6615.437687796495, 6728.495362847708, 6739.427148692416, 6803.965980170067, 6815.148106486689, 6199.56603037783, 6344.048392741033, 6356.110144579762, 6437.871242575216, 6465.935340646533, 6297.149884765498, 6426.903596446057, 6428.742850285937, 6431.5497915146425, 6474.320196379406, 6369.235691717024, 6410.743570257137, 6413.486921046305, 6434.871302574016, 6436.67816609177, 6424.646644434601, 6462.903056454157, 6466.062420948936, 6493.837654058591, 6532.0, 5285.154375299933, 5288.180332048539, 5329.200619906967, 5363.624546281801, 5371.75827087782, 4533.0253995390485, 4545.522720114406, 4553.33976573395, 4583.037562111927, 4597.977010114928, 5450.0, 5517.144842549411, 5538.778448862081, 5542.612017158841, 5582.972085139549, 6343.555951083472, 6434.131392262078, 6467.579607325509, 6467.935320646828, 6483.740650373932, 5486.259354987025, 5514.696691681996, 5544.889102218014, 5607.635503692247, 5703.600747947604, 5719.0, 5750.597458177971, 5800.158976948319, 5829.854253643608, 5855.355910849803, 6304.464120549713, 6336.429721325103, 6394.23269207698, 6417.2299324081405, 6418.037294405876, 6366.981282994699, 6488.318726533646, 6501.122348482894, 6536.967315163393, 6629.237637671729, 6215.223097112861, 6268.623882567061, 6299.212598425197, 6310.2743184534365, 6312.0, 6292.182016337847, 6335.524835637438, 6350.174477317919, 6356.11014457967, 6360.713767880549, 5525.392206857162, 6462.967685161544, 6475.7733479328, 6481.675916204265, 6637.502187335873, 6313.684315784284, 6325.430711236011, 6385.233771947396, 6393.904091438539, 6434.420902118832, 6265.216847894013, 6330.683465826783, 6389.393007664265, 6407.647579382992, 6412.1023056771155, 6049.243844519435, 6136.0, 6140.662263575367, 6147.754089836357, 6259.561830671809, 6283.622982621057, 6305.337939516285, 6306.873862522815, 6321.146645202839, 6346.048092786119, 5346.518813306821, 6154.753809847556, 6176.845578860564, 6211.875762484816, 6261.5616906816085], "value": 5912.030347603075, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [772.4747171923094, 845.7082306604219, 873.66800615766, 896.0143841774053, 896.2650626486281, 40996.180076398494, 42302.0, 42347.57652423475, 42519.36220956688, 42559.0, 37741.24517509648, 37749.811250943705, 38019.61980380195, 38298.42552361717, 38356.808215958954, 6881.9655901720425, 7008.89486657698, 7012.544184627983, 7015.438764898796, 7044.471664625148, 6954.30456954303, 7057.964710176442, 7059.082319298484, 7112.679929403189, 7125.358717715405, 7046.541974771649, 7053.964730176342, 7060.152781666207, 7077.823054423629, 7095.89356159658, 7006.789796306119, 7042.4718146138985, 7049.541779784297, 7061.611611361373, 7063.929360706378, 6345.460635845959, 6415.8396040098905, 6461.547691661585, 6467.482601391877, 6475.902861457082, 33387.83306083454, 33565.6643433565, 33571.32857342839, 33669.0, 33853.830730846435, 3333.7999720016633, 3358.2947581008016, 3358.983205083983, 3437.673421024999, 3518.5601799775027, 32605.836970814995, 32844.343113137606, 32936.67063329384, 32956.83521582401, 32982.0, 4900.338454308659, 4927.433345165316, 4948.257761335828, 4973.104841128596, 5006.649534532584, 182267.0, 183794.0, 185716.0, 196005.0, 196034.0, 48265.75867120712, 49611.0, 49641.50358496441, 49692.0, 49833.25250121251, 51055.0, 51202.74398627983, 51458.48541514537, 51576.22635660468, 51584.74207629013, 16473.176341182894, 16723.581910452336, 16745.246463909152, 16751.078690671886, 16793.916030420016, 13881.375338109809, 13928.025038247428, 14066.0, 14084.85915140856, 14104.153750774987, 14183.574492765234, 14386.28068596566, 14427.639309017359, 14471.927640361731, 14512.927435362966, 5879.176915231871, 5890.3815099414805, 5917.881642367129, 6018.398160183947, 6107.84730381744, 974.4250891973769, 1003.1122456625939, 1013.6806905824642, 1037.0459177556515, 1037.7768779712246, 23015.0, 23116.65325020126, 23316.417089572897, 23505.0, 24036.51926961486, 1074.5970261152067, 1106.3417266726285, 1115.4590023838432, 1117.251441534174, 1122.4780477078034, 12241.32672702992, 12340.50637974489, 12560.057995650362, 12565.120441569003, 12647.494100236072, 230172.0, 230281.0, 230531.0, 230897.0, 232046.0, 54034.729826350616, 54075.459245407044, 54197.72901135548, 54393.456065439634, 54758.0, 1447.232966527721, 1485.3167542930157, 1506.7363211437955, 1516.5677781832126, 1532.4483186053012, 22197.556048879254, 22679.20622778195, 22902.770972290065, 23048.769512305335, 23153.768462315835, 37687.24625507529, 37963.0, 38010.42984355292, 38049.619503804606, 38071.2385752289, 178432.0, 178531.0, 179141.0, 179217.0, 179536.0, 34501.30997380088, 36992.44511332386, 37912.24175516419, 39545.406818897165, 39579.2084158321, 45934.0, 47823.0, 48273.0, 48762.51237487722, 48998.0, 32296.515552266264, 33588.1602959928, 34795.0, 35170.29659406849, 35286.29427411386, 33621.49567756535, 34440.0, 34495.310093798485, 34590.82704586562, 34759.13102172466, 38326.80836595799, 38388.80805595954, 38552.0, 38695.80652096721, 38746.0, 31877.36245275128, 31953.840230798698, 33084.503732444515, 33144.50283245705, 33716.0, 24208.775668731818, 24551.87724061368, 24584.0, 24640.260792176265, 24708.629370559098], "value": 17101.024086013356, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [572.9341125770535, 580.9593328467009, 592.4223881715326, 598.2014011294921, 606.930203026652, 21933.232336868212, 21960.780392196073, 23110.53778924425, 23195.536089278205, 23195.884020579895, 22470.55058898821, 24314.27057188283, 24358.63462048071, 24587.385315367126, 24594.385140371498, 6447.54867159299, 6629.204495460527, 6645.867082658344, 6663.366980136903, 6663.666816659172, 6500.479961603084, 6586.934130658704, 6590.472762179038, 6599.175103112111, 6606.405423511883, 6158.8768224635705, 6245.718942647569, 6408.0, 6460.806175814733, 6461.224653041618, 6406.615603063808, 6457.192850893638, 6471.514636402265, 6473.8705225895455, 6478.514111441661, 6020.819375418744, 6023.6385816851125, 6035.185249991239, 6035.215421995113, 6046.576739628228, 26990.46019079627, 28302.292442688893, 28680.709368078486, 29066.41867162666, 29127.417451650846, 1935.138863205874, 1971.0243429502489, 1971.9309824156085, 1973.7927517610588, 1975.2888959974398, 18694.252229910788, 19277.61444771111, 19290.42128736126, 19313.806861931484, 19334.613307733907, 2222.866628002325, 2296.7014288142436, 2303.2629558541275, 2328.6623439601162, 2381.2856143156982, 137536.0, 138306.0, 141373.0, 141373.2931335347, 141927.0, 14253.572392828231, 14810.703785924221, 14884.776728349083, 15211.923940380228, 15273.847261527464, 23616.64575031376, 23644.0, 23656.7634323658, 23676.289711308687, 23720.288391348287, 10061.496925153713, 10321.380717156995, 10411.791764164675, 10604.681859544226, 10677.412742299093, 9601.423914565148, 9657.22742180624, 9708.174805141502, 9821.80356392868, 9853.75365615851, 9051.27589792815, 9280.814383712288, 9286.953565232267, 9287.72136835896, 9435.6697515588, 2643.3920198354485, 2645.2064380685715, 2662.467506498669, 2820.3795165063652, 2849.244950088228, 914.6981496106268, 934.8317302885409, 955.7132860141929, 979.2313034268066, 988.1995583577325, 18939.526511837314, 22616.434589135075, 24033.27900162998, 24143.51712965731, 24250.757492425204, 1037.3723897042332, 1054.7626783973699, 1055.1822337688352, 1056.1392465140887, 1067.6370034188258, 10633.946830265799, 11132.777344453065, 11138.888611113947, 11147.832782508269, 11263.43682815856, 535371.0, 535695.0, 536767.0, 545379.0, 561618.0, 116431.0, 120906.39546802209, 122294.0, 122905.38547307206, 123445.38277308736, 1243.2664727810636, 1260.1619922751267, 1290.451558087809, 1301.5119330251157, 1312.1012106706937, 19151.329703460313, 20393.49016274605, 20760.896195518926, 20845.166193352703, 20899.8955005224, 51490.48509514857, 54084.72957635186, 54703.72648136734, 55645.16532251939, 56200.437995621156, 65534.672326638065, 66547.0, 67454.3254567448, 67962.66018669875, 68196.0, 14620.561383158098, 14793.11241325524, 14853.405863765329, 14913.179775112472, 14979.325930332943, 22458.326250212518, 22699.751513666248, 22794.43013924665, 22837.885810570842, 23058.192963246205, 18252.26990920348, 18328.63342733111, 18355.908220458812, 18452.0, 18519.53701157482, 15450.30473628667, 15948.441804536786, 16544.50366489007, 16865.831341686426, 16980.915095424443, 18645.90677046606, 18728.0, 18989.620207596046, 19000.904995474935, 19013.714794278374, 14598.708025839636, 14610.488632897797, 14648.414063437343, 14660.120392776467, 14672.046316989788, 17722.202500887233, 17840.3755868544, 18227.635447291246, 18359.0, 18454.538636533656], "value": 12072.900113193313, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1305.7257975825078, 1359.2116572388015, 1366.3100134432111, 1367.84269808972, 1371.5679560938302, 13201.801972970401, 13689.794653080211, 13718.657033574165, 13790.793138102912, 13800.930995345021, 10866.782664346709, 11138.888611113887, 11206.943965280163, 11220.66338009861, 11221.32672039676, 2407.711074671033, 2546.3634091477084, 2592.896284148632, 2593.1183397644795, 2598.9220323390327, 2418.9637155442683, 2478.2193609013193, 2485.614729716897, 2487.0300582772734, 2489.4523204894895, 2568.268043607572, 2570.4987527432063, 2587.45663410684, 2678.1429942418436, 2739.2193224930897, 2651.1516314779183, 2680.316519287569, 2690.3543149644142, 2690.367763575558, 2690.9596356054576, 2416.9607068960518, 2435.476372579904, 2435.6711843901026, 2447.510497900409, 2455.6439316299216, 13182.472701091945, 13396.062275640708, 13426.731465370736, 13466.124701894345, 13516.797248041286, 7348.265173482662, 7634.160242373335, 7669.424793140481, 7705.113911900147, 7720.498167619143, 4867.537583929521, 5001.224810154432, 5152.639315247934, 5152.845414637567, 5159.535641792219, 1831.1942745192073, 1899.3921944977612, 1913.1964574878584, 1931.3433432632971, 1958.7355706979517, 21240.575188496143, 21329.146834126615, 21392.14431422741, 21424.14303427861, 21436.14255429781, 6015.248093988252, 6289.811305660837, 6443.903341449882, 6454.806355809334, 6465.903011454832, 14841.777373339408, 14965.775513367309, 14970.40118395252, 14983.400663973536, 14994.625134371729, 7292.489525733254, 7388.963055184689, 7426.405887528985, 7433.182349941502, 7465.402767778564, 6782.864342713118, 6924.757633482804, 6980.476464265201, 7002.684879180449, 7035.859282814315, 4866.635002374836, 4989.950100498949, 4998.2002879539095, 5045.672031317952, 5121.07820592297, 1472.1535117307592, 1505.6386467248, 1516.689078738878, 1527.6791873706425, 1534.8081489813774, 859.9570021498901, 870.9477431354139, 871.2246100970142, 881.5415983688446, 903.8824952756099, 6971.302869713089, 7015.649217539102, 7113.502054856214, 7761.9611901940125, 7850.960745196237, 716.8888822232562, 739.2644318902619, 964.1611797736015, 1001.7796084861319, 1018.6434747838198, 4607.239805432133, 4868.2210846264425, 4979.3526841510375, 5014.323066385991, 5045.596352291881, 18239.452816415527, 18710.438686839418, 18799.718004229948, 18868.716969245197, 18881.15034823436, 18101.637967240582, 18494.907525462288, 18941.526461838563, 18946.43160705181, 19155.425337239903, 10669.73325666849, 10701.411422371688, 10708.250422470352, 10735.355878647306, 10770.892291077145, 7337.156227033959, 7979.561124137996, 8068.59657017135, 8117.878231826409, 8143.7964050896835, 16147.515574532783, 16580.83419165793, 16622.833771662128, 16692.41576544815, 17156.284371562742, 15848.683026339639, 16557.089360085312, 16721.832781672027, 17000.65998680044, 17262.309507620055, 10580.89419105799, 10690.518926648165, 10854.837177442187, 10899.400532970445, 10965.177611679315, 12763.617091487271, 12936.15914965562, 12938.288394138413, 12940.09419340637, 12953.481860725842, 9795.9020409795, 10019.398836069859, 10132.44271565071, 10145.03622155894, 10272.435016074187, 9772.26707996889, 10036.247281454067, 10383.065524102867, 10399.740006499898, 10570.312929659854, 8921.955390223007, 8948.373613847229, 9031.322650801085, 9033.141851524095, 9068.274538037072, 6537.640429776408, 6640.103586016019, 6736.090627765385, 6744.62904540255, 6890.276520965427, 6627.304133065959, 6720.731170753115, 6754.290799465985, 6770.695318710571, 6845.5550389224545], "value": 6138.531461537212, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [487.31146577110303, 503.1220520192264, 529.1824131716497, 529.8632097979959, 539.3150698612762, 6167.105769663407, 6182.412670796279, 6217.409346112117, 6238.376162383759, 6261.5303852211155, 5914.349421563625, 5915.0, 6005.759769609211, 6076.908846367308, 6094.360092190323, 4833.782479788418, 4839.4918533554, 4871.293662418947, 4896.167651499236, 4911.754412279381, 4899.902001959977, 4934.309196712463, 4935.6308971693425, 4969.155073803049, 4982.87542811429, 4707.835225767099, 4816.590589799871, 4861.708297502143, 4881.536254055859, 4910.140725373063, 4864.781084851173, 4902.142125128106, 4925.2858335541505, 4965.379327584052, 4968.552830245259, 4405.3612226227015, 4412.470503539564, 4447.733136011817, 4454.933176002362, 4477.865664030084, 5919.881602367972, 5931.228940237785, 5942.554308426886, 5948.494377977877, 6002.609830361012, 5601.579881508862, 5621.100623900156, 5630.915536266959, 5633.971770162738, 5641.294838145232, 6478.46091591687, 6487.458778854821, 6491.285958544557, 6497.252815926135, 6513.15723723001, 4875.268709693539, 4882.218844984785, 4885.145099607555, 4890.0953323634885, 4892.339534162914, 6776.983452482118, 6791.762288319885, 6863.794086177422, 6873.656317184121, 6884.724611015554, 4958.157113290749, 4963.205887058126, 4984.825531106467, 5017.0, 5026.648134630614, 4985.750712464363, 5003.724050367206, 5016.724080175625, 5038.093143234253, 5039.168537191323, 5535.612507124462, 5556.138798486241, 5570.554355651539, 5630.834236511014, 5640.802571909963, 6431.614103153825, 6460.709268082947, 6486.935130648728, 6497.772577959749, 6502.911117219283, 1740.5996620777291, 1759.217148368989, 1761.3130878957218, 1779.7897429747636, 1780.7952085510074, 1107.8615173103362, 1120.8374785656035, 1221.505290357389, 1228.2323547782637, 1232.5932442294202, 5448.37343705471, 5502.972485137629, 5513.531349835309, 5552.444755524496, 5617.747201375866, 6453.806385808433, 6517.348265173445, 6563.540552161303, 6601.207855057424, 6641.800745977628, 5535.474129957647, 5545.61180717354, 5553.694546799884, 5581.162825576115, 5615.354234263031, 3369.966300337014, 3453.2215908806984, 3486.790792552455, 3504.3341765064556, 3550.6626870447267, 6310.6213627182515, 6381.649009304533, 6393.2328120625825, 6395.328490508429, 6397.136386587844, 6615.272320044791, 6696.129503164558, 6768.69540870662, 6788.389044985876, 6794.218664853605, 6319.778807741707, 6321.683915804191, 6360.936390636127, 6386.0, 6398.456131228804, 6504.707288172138, 6545.218282230128, 6556.672166391757, 6586.242582102927, 6690.69891854858, 6581.992492289706, 6593.175853018372, 6606.966965165144, 6607.900881486878, 6641.369069938348, 6449.774257900951, 6454.257760357619, 6469.576693127693, 6470.38531339522, 6487.124238227779, 4895.951040489549, 4934.432540257916, 4948.851534453972, 4993.925091123563, 5011.84964451067, 6556.475481961527, 6617.735290588323, 6669.233038200669, 6715.966420168063, 6738.59568425896, 6284.209000434854, 6314.842128946813, 6333.809985700436, 6384.3934826191435, 6475.870482590416, 6291.905621415774, 6338.591335292559, 6379.0, 6412.326705695835, 6483.222013358427, 6272.0, 6286.591371560834, 6304.936950630618, 6320.009197102898, 6382.32985536512, 6452.2573910262945, 6452.806415807533, 6454.612723236621, 6507.349265073455, 6563.901541476977, 6034.064719968412, 6226.470749986302, 6247.281562620356, 6288.5598008138995, 6300.495960323255], "value": 4977.522446543672, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [901.2249465459704, 907.6777743900915, 920.8940971788238, 924.653255029364, 926.1710768861867, 17753.37863174789, 18040.90979545102, 18171.99999999998, 18247.635047299045, 21146.154153833868, 20240.79759202411, 21285.0, 21302.46743831405, 21377.465563360925, 21539.138434462602, 1035.1460045462468, 1038.138345173508, 1045.2996492350105, 1050.1651187306072, 1056.028453822485, 1062.5112448273803, 1067.8077945969721, 1071.3197119828926, 1072.1690689715456, 1074.156786922266, 1117.5753213778753, 1121.5681962444437, 1126.5437497813398, 1129.5255992483135, 1132.3375825142302, 1057.0856209378908, 1096.17786660005, 1098.1215027977587, 1107.385401102388, 1118.0887576625066, 794.9863923497587, 806.2542148512603, 806.770070529902, 809.5142914251461, 810.0401024785648, 17255.56861078483, 17310.134493275287, 17581.56046098845, 17582.472525824247, 17600.647987040316, 19952.501187470283, 20211.0, 20775.16899324025, 20844.47888802777, 20932.058057387454, 14409.78385324221, 14443.133411995314, 14452.060616059922, 14485.855141448556, 14498.782518262235, 3432.9313413731834, 3506.333796578642, 3539.876104336336, 3551.236484155919, 3618.222082252328, 115213.42393288064, 117804.82195178024, 121828.99999999911, 122080.0, 125127.37436312852, 13707.657308567166, 13998.51005214833, 14084.0, 14179.574612761633, 14273.214973176367, 27573.0, 27609.895604175606, 27619.447611047668, 28714.0, 28953.42093158125, 7440.851182976418, 7724.6523906424345, 8337.916620833836, 8435.746927592181, 8436.40945133847, 3550.1657110578994, 3803.6006219347123, 4013.458183145238, 4015.6185162409524, 4016.819243134066, 4756.453007904066, 4850.714560641432, 4862.41651001882, 4883.853484395403, 4908.0, 953.9379940303858, 994.8209322321907, 998.0468652436905, 1003.0771690045176, 1003.5835128421769, 678.2708588267534, 678.7963610916804, 679.2833560593523, 692.5879101934341, 712.6935417770305, 11516.481758320895, 11567.942160289145, 11718.121140914294, 11798.46906889192, 12069.577564785366, 695.979120626382, 705.78473565563, 711.1288671377521, 713.3651050565002, 728.2208037400037, 5193.636445448858, 5198.610104242197, 5237.895242095213, 5325.2810870531985, 5416.268803711528, 101199.49400253099, 104904.47547762212, 104993.47503262588, 107081.25215617416, 109038.0, 87406.56296718476, 90611.0, 92208.53895730479, 93412.53293733623, 93795.0, 78791.60604196943, 78818.6059069701, 79735.60132199418, 79755.0, 81653.59173204214, 10772.784544309226, 11064.668059958214, 11474.541018359172, 11657.242279251821, 11700.531978720755, 33238.66761332356, 33341.666333346395, 35319.11702207466, 35858.0, 36450.99999999894, 43687.34468982904, 61995.38004619896, 63644.0, 64337.35662643314, 67291.32708673047, 16614.25235864413, 17387.652246955244, 17414.564635884206, 17459.47621571355, 17568.73646895272, 17390.21744021497, 18615.162317695464, 18839.434816955512, 18993.810061899203, 19040.619187615892, 15504.0, 15642.374305028126, 16003.759943601088, 16677.833221668112, 16729.49811505657, 17301.30794768195, 17867.553311167325, 17987.460376188734, 18019.0, 18118.909405452887, 16584.0, 16837.91581042136, 16892.746608800633, 16971.0665913371, 17211.827881721525, 10368.585256589953, 10795.352278863293, 11194.944025279821, 11425.085993120365, 11494.770104597694, 10167.389956602627, 10254.436006019741, 10257.794844103226, 10517.0, 10526.263161578921], "value": 8642.970517510388, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1539.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 109.0, 108.0, 108.0, 108.0, 111.0, 108.0, 109.0, 109.0, 109.0], "value": 107.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 122.0, 144.0, 181.0, 127.0, 160.0, 156.0, 123.0, 177.0, 123.0], "value": 147.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 161.0, 164.0, 162.0, 163.0, 168.0, 164.0, 164.0, 173.0, 167.0], "value": 165.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 78.0, 75.0, 160.0, 74.0, 75.0, 74.0, 74.0, 95.0, 75.0], "value": 85.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 82.0, 131.0, 81.0, 81.0, 81.0, 130.0, 82.0, 81.0, 126.0], "value": 95.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 113.0, 113.0, 113.0, 113.0, 115.0, 113.0, 114.0, 114.0], "value": 113.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 151.0, 150.0, 148.0, 149.0, 149.0, 150.0, 150.0, 150.0, 151.0], "value": 149.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 94.0, 94.0, 93.0, 95.0, 93.0, 95.0, 94.0, 94.0], "value": 94.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 55.0, 56.0, 55.0, 58.0, 56.0, 56.0, 56.0, 56.0], "value": 55.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 55.0, 55.0, 55.0, 54.0, 53.0, 54.0, 55.0, 53.0], "value": 54.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 85.0, 78.0, 82.0, 79.0, 76.0, 76.0, 76.0, 85.0, 76.0], "value": 79.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 132.0, 128.0, 131.0, 138.0, 127.0, 138.0, 130.0, 139.0, 156.0], "value": 134.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 200.0, 185.0, 183.0, 186.0, 183.0, 186.0, 184.0, 185.0, 190.0], "value": 186.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 70.0, 71.0, 68.0, 69.0, 70.0, 67.0, 73.0, 74.0, 70.0], "value": 70.3, "unit": "score"}]}]} 10:26:20 INFO - Return code: 0 10:26:20 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:26:20 INFO - # TBPL SUCCESS # 10:26:20 INFO - Running post-action listener: _package_coverage_data 10:26:20 INFO - Running post-action listener: _resource_record_post_action 10:26:20 INFO - [mozharness: 2017-07-17 17:26:20.974293Z] Finished run-tests step (success) 10:26:20 INFO - Running post-run listener: _resource_record_post_run 10:26:21 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 4096; Write bytes: 431005696; Read time: 12; Write time: 573192 10:26:21 INFO - TinderboxPrint: CPU usage
13.1% 10:26:21 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 10:26:21 INFO - TinderboxPrint: I/O write bytes / time
431,005,696 / 573,192 10:26:21 INFO - TinderboxPrint: CPU idle
8,262.2 (86.8%) 10:26:21 INFO - TinderboxPrint: CPU user
1,198.6 (12.6%) 10:26:21 INFO - TinderboxPrint: Swap in / out
0 / 0 10:26:21 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 107233280; Read time: 0; Write time: 188832 10:26:21 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:21 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 0; Write bytes: 323772416; Read time: 0; Write time: 384360 10:26:21 INFO - Running post-run listener: _upload_blobber_files 10:26:21 INFO - Blob upload gear active. 10:26:21 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:26:21 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:21 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:21 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:22 INFO - Traceback (most recent call last): 10:26:22 INFO - File "/builds/slave/test/build/venv/bin/blobberc.py", line 253, in 10:26:22 INFO - main() 10:26:22 INFO - File "/builds/slave/test/build/venv/bin/blobberc.py", line 235, in main 10:26:22 INFO - filetype_whitelist = get_server_whitelist(args['--url']) 10:26:22 INFO - File "/builds/slave/test/build/venv/bin/blobberc.py", line 69, in get_server_whitelist 10:26:22 INFO - return set(response.json().get('whitelist', [])) 10:26:22 INFO - File "/builds/slave/test/build/venv/local/lib/python2.7/site-packages/requests/models.py", line 651, in json 10:26:22 INFO - return json.loads(self.text or self.content, **kwargs) 10:26:22 INFO - File "/builds/slave/test/build/venv/local/lib/python2.7/site-packages/simplejson/__init__.py", line 488, in loads 10:26:22 INFO - return _default_decoder.decode(s) 10:26:22 INFO - File "/builds/slave/test/build/venv/local/lib/python2.7/site-packages/simplejson/decoder.py", line 370, in decode 10:26:22 INFO - obj, end = self.raw_decode(s) 10:26:22 INFO - File "/builds/slave/test/build/venv/local/lib/python2.7/site-packages/simplejson/decoder.py", line 389, in raw_decode 10:26:22 INFO - return self.scan_once(s, idx=_w(s, idx).end()) 10:26:22 INFO - simplejson.scanner.JSONDecodeError: Expecting value: line 1 column 1 (char 0) 10:26:22 ERROR - Return code: 1 10:26:22 INFO - Setting buildbot property blobber_files to {} 10:26:22 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:26:22 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:26:22 INFO - Contents: 10:26:22 INFO - blobber_files:{} 10:26:22 INFO - Running post-run listener: copy_logs_to_upload_dir 10:26:22 INFO - Copying logs to upload dir... 10:26:22 INFO - mkdir: /builds/slave/test/build/upload/logs 10:26:22 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.967907 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2017-07-17 10:26:21.140052) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-17 10:26:21.144200) ========= 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=ba164b0a7b0ec7655860e956000001c1-1500309642.612054-97850160 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.011260 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:21.195840) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-17 10:26:21.196216) ========= 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=ba164b0a7b0ec7655860e956000001c1-1500309642.612054-97850160 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004534 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-17 10:26:21.248794) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-17 10:26:21.249221) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-17 10:26:21.249655) ========= ========= Total master_lag: 0.16 =========