builder: mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s slave: talos-linux64-ix-061 starttime: 1501871468.76 results: success (0) revision: bc829569880635c52d6e3d54f51cd7d3df180186 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-08-04 11:31:08.760299) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-08-04 11:31:08.760779) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-04 11:31:08.761093) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-08-04 11:31:08.777146) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-04 11:31:08.777437) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1501871467.645597-2068506153 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-08-04 11:31:08-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.6M=0s 2017-08-04 11:31:08 (46.6 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.147653 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-04 11:31:08.938085) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-04 11:31:08.938407) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1501871467.645597-2068506153 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015182 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-08-04 11:31:08.988130) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-04 11:31:08.988477) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev bc829569880635c52d6e3d54f51cd7d3df180186 --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 bc829569880635c52d6e3d54f51cd7d3df180186 --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=516f8d7ca085b4d087ab0a71000001a4-1501871467.645597-2068506153 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-08-04 11:31:08,830 truncating revision to first 12 chars 2017-08-04 11:31:08,830 Setting DEBUG logging. 2017-08-04 11:31:08,830 attempt 1/10 2017-08-04 11:31:08,830 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/bc8295698806?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-08-04 11:31:09,138 unpacking tar archive at: mozilla-central-bc8295698806/testing/mozharness/ program finished with exit code 0 elapsedTime=0.647059 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-08-04 11:31:09.647854) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-04 11:31:09.648218) ========= script_repo_revision: bc829569880635c52d6e3d54f51cd7d3df180186 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-08-04 11:31:09.648604) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-04 11:31:09.648891) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-08-04 11:31:09.656762) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 57 secs) (at 2017-08-04 11:31:09.657078) ========= /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=516f8d7ca085b4d087ab0a71000001a4-1501871467.645597-2068506153 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:31:09 INFO - MultiFileLogger online at 20170804 11:31:09 in /builds/slave/test 11:31:09 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 11:31:09 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:31:09 INFO - {'append_to_log': False, 11:31:09 INFO - 'base_work_dir': '/builds/slave/test', 11:31:09 INFO - 'blob_upload_branch': 'Firefox', 11:31:09 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:31:09 INFO - 'branch': 'Firefox', 11:31:09 INFO - 'buildbot_json_path': 'buildprops.json', 11:31:09 INFO - 'code_coverage': False, 11:31:09 INFO - 'config_files': ('talos/linux_config.py',), 11:31:09 INFO - 'default_actions': ('clobber', 11:31:09 INFO - 'read-buildbot-config', 11:31:09 INFO - 'download-and-extract', 11:31:09 INFO - 'populate-webroot', 11:31:09 INFO - 'create-virtualenv', 11:31:09 INFO - 'install', 11:31:09 INFO - 'setup-mitmproxy', 11:31:09 INFO - 'run-tests'), 11:31:09 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:31:09 INFO - 'disable_ccov_upload': False, 11:31:09 INFO - 'download_minidump_stackwalk': True, 11:31:09 INFO - 'download_symbols': 'ondemand', 11:31:09 INFO - 'enable_stylo': False, 11:31:09 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:31:09 INFO - 'tooltool.py': '/tools/tooltool.py', 11:31:09 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:31:09 INFO - '/tools/misc-python/virtualenv.py')}, 11:31:09 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:31:09 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:31:09 INFO - 'gecko_profile': False, 11:31:09 INFO - 'gecko_profile_interval': 0, 11:31:09 INFO - 'installer_path': 'installer.exe', 11:31:09 INFO - 'log_level': 'info', 11:31:09 INFO - 'log_name': 'talos', 11:31:09 INFO - 'log_to_console': True, 11:31:09 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:31:09 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:31:09 INFO - 'opt_config_files': (), 11:31:09 INFO - 'pip_index': False, 11:31:09 INFO - 'suite': 'dromaeojs-e10s', 11:31:09 INFO - 'system_bits': '32', 11:31:09 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:31:09 INFO - 'title': 'talos-linux64-ix-061', 11:31:09 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:31:09 INFO - 'use_talos_json': True, 11:31:09 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:31:09 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:31:09 INFO - 'work_dir': 'build'} 11:31:09 INFO - [mozharness: 2017-08-04 18:31:09.688090Z] Running clobber step. 11:31:09 INFO - Running pre-action listener: _resource_record_pre_action 11:31:09 INFO - Running main action method: clobber 11:31:09 INFO - rmtree: /builds/slave/test/build 11:31:09 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:31:10 INFO - Running post-action listener: _resource_record_post_action 11:31:10 INFO - [mozharness: 2017-08-04 18:31:10.788719Z] Finished clobber step (success) 11:31:10 INFO - [mozharness: 2017-08-04 18:31:10.788822Z] Running read-buildbot-config step. 11:31:10 INFO - Running pre-action listener: _resource_record_pre_action 11:31:10 INFO - Running main action method: read_buildbot_config 11:31:10 INFO - Using buildbot properties: 11:31:10 INFO - { 11:31:10 INFO - "project": "", 11:31:10 INFO - "product": "firefox", 11:31:10 INFO - "who": "archaeopteryx@coole-files.de", 11:31:10 INFO - "installer_path": "public/build/target.tar.bz2", 11:31:10 INFO - "builddir": "mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s", 11:31:10 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 11:31:10 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo-sequential mozilla-central talos dromaeojs-e10s", 11:31:10 INFO - "stage_platform": "linux64-stylosequential", 11:31:10 INFO - "basedir": "/builds/slave/test", 11:31:10 INFO - "buildnumber": 169, 11:31:10 INFO - "platform": "ubuntu64_hw_styloseq", 11:31:10 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 11:31:10 INFO - "slavebuilddir": "test", 11:31:10 INFO - "taskId": "EOPaKgH8R82hyfdefQkL4A", 11:31:10 INFO - "branch": "mozilla-central", 11:31:10 INFO - "script_repo_revision": "production", 11:31:10 INFO - "revision": "bc829569880635c52d6e3d54f51cd7d3df180186", 11:31:10 INFO - "slavename": "talos-linux64-ix-061", 11:31:10 INFO - "repo_path": "mozilla-central" 11:31:10 INFO - } 11:31:10 INFO - Finding installer, test and symbols from parent task. 11:31:10 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EOPaKgH8R82hyfdefQkL4A'}, attempt #1 11:31:11 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EOPaKgH8R82hyfdefQkL4A'}, attempt #1 11:31:11 INFO - Task dependencies: Q6EcMmQCRh-0euMeGSZPJw 11:31:11 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Q6EcMmQCRh-0euMeGSZPJw'}, attempt #1 11:31:12 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/Q6EcMmQCRh-0euMeGSZPJw/artifacts/public/build/target.tar.bz2 11:31:12 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/Q6EcMmQCRh-0euMeGSZPJw/artifacts/public/build/target.test_packages.json 11:31:12 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/Q6EcMmQCRh-0euMeGSZPJw/artifacts/public/build/target.crashreporter-symbols.zip 11:31:12 INFO - Running post-action listener: _resource_record_post_action 11:31:12 INFO - [mozharness: 2017-08-04 18:31:12.193805Z] Finished read-buildbot-config step (success) 11:31:12 INFO - [mozharness: 2017-08-04 18:31:12.194029Z] Running download-and-extract step. 11:31:12 INFO - Running pre-action listener: _resource_record_pre_action 11:31:12 INFO - Running main action method: download_and_extract 11:31:12 INFO - mkdir: /builds/slave/test/build/tests 11:31: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')]} 11:31:12 INFO - trying https://queue.taskcluster.net/v1/task/Q6EcMmQCRh-0euMeGSZPJw/artifacts/public/build/target.test_packages.json 11:31:12 INFO - Downloading https://queue.taskcluster.net/v1/task/Q6EcMmQCRh-0euMeGSZPJw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 11:31:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Q6EcMmQCRh-0euMeGSZPJw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 11:31:12 INFO - Downloaded 989 bytes. 11:31:12 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 11:31:12 INFO - Using the following test package requirements: 11:31:12 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 11:31:12 INFO - u'common': [u'target.common.tests.zip'], 11:31:12 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 11:31:12 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 11:31:12 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 11:31:12 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 11:31:12 INFO - u'mozbase': [u'target.common.tests.zip'], 11:31:12 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 11:31:12 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 11:31:12 INFO - u'web-platform': [u'target.common.tests.zip', 11:31:12 INFO - u'target.web-platform.tests.tar.gz'], 11:31:12 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 11:31:12 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 11:31:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Q6EcMmQCRh-0euMeGSZPJw/artifacts/public/build/target.common.tests.zip 11:31:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Q6EcMmQCRh-0euMeGSZPJw/artifacts/public/build/target.common.tests.zip'}, attempt #1 11:31:12 INFO - Fetch https://queue.taskcluster.net/v1/task/Q6EcMmQCRh-0euMeGSZPJw/artifacts/public/build/target.common.tests.zip into memory 11:31:13 INFO - Content-Length response header: 54282354 11:31:13 INFO - Bytes received: 54282354 11:31:24 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 11:31:24 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Q6EcMmQCRh-0euMeGSZPJw/artifacts/public/build/target.common.tests.zip 11:31:24 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Q6EcMmQCRh-0euMeGSZPJw/artifacts/public/build/target.common.tests.zip'}, attempt #1 11:31:24 INFO - Fetch https://queue.taskcluster.net/v1/task/Q6EcMmQCRh-0euMeGSZPJw/artifacts/public/build/target.common.tests.zip into memory 11:31:25 INFO - Content-Length response header: 54282354 11:31:25 INFO - Bytes received: 54282354 11:31:38 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Q6EcMmQCRh-0euMeGSZPJw/artifacts/public/build/target.talos.tests.zip 11:31:38 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Q6EcMmQCRh-0euMeGSZPJw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 11:31:38 INFO - Fetch https://queue.taskcluster.net/v1/task/Q6EcMmQCRh-0euMeGSZPJw/artifacts/public/build/target.talos.tests.zip into memory 11:31:39 INFO - Content-Length response header: 14496008 11:31:39 INFO - Bytes received: 14496008 11:31:39 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')]} 11:31:39 INFO - trying https://queue.taskcluster.net/v1/task/Q6EcMmQCRh-0euMeGSZPJw/artifacts/public/build/target.tar.bz2 11:31:39 INFO - Downloading https://queue.taskcluster.net/v1/task/Q6EcMmQCRh-0euMeGSZPJw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 11:31:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Q6EcMmQCRh-0euMeGSZPJw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 11:32:11 WARNING - Socket error when accessing https://queue.taskcluster.net/v1/task/Q6EcMmQCRh-0euMeGSZPJw/artifacts/public/build/target.tar.bz2: The read operation timed out 11:32:11 INFO - retry: attempt #1 caught SSLError exception: The read operation timed out 11:32:11 INFO - retry: Failed, sleeping 30 seconds before retrying 11:32:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Q6EcMmQCRh-0euMeGSZPJw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #2 11:32:42 INFO - Downloaded 61729187 bytes. 11:32:42 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Q6EcMmQCRh-0euMeGSZPJw/artifacts/public/build/target.tar.bz2 11:32:42 INFO - mkdir: /builds/slave/test/properties 11:32:42 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:32:42 INFO - Writing to file /builds/slave/test/properties/build_url 11:32:42 INFO - Contents: 11:32:42 INFO - build_url:https://queue.taskcluster.net/v1/task/Q6EcMmQCRh-0euMeGSZPJw/artifacts/public/build/target.tar.bz2 11:32:42 INFO - Running post-action listener: _resource_record_post_action 11:32:42 INFO - Running post-action listener: set_extra_try_arguments 11:32:42 INFO - [mozharness: 2017-08-04 18:32:42.345258Z] Finished download-and-extract step (success) 11:32:42 INFO - [mozharness: 2017-08-04 18:32:42.345357Z] Running populate-webroot step. 11:32:42 INFO - Running pre-action listener: _resource_record_pre_action 11:32:42 INFO - Running main action method: populate_webroot 11:32:42 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:32:42 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:32:42 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 11:32:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:32:42 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 11:32:42 INFO - 'tests': ['damp', 'tps']}, 11:32:42 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:32:42 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 11:32:42 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 11:32:42 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 11:32:42 INFO - 'other-e10s': {'tests': ['a11yr', 11:32:42 INFO - 'ts_paint', 11:32:42 INFO - 'tpaint', 11:32:42 INFO - 'sessionrestore', 11:32:42 INFO - 'sessionrestore_many_windows', 11:32:42 INFO - 'sessionrestore_no_auto_restore', 11:32:42 INFO - 'tabpaint']}, 11:32:42 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 11:32:42 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 11:32:42 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:32:42 INFO - 'tsvgr_opacity', 11:32:42 INFO - 'tart', 11:32:42 INFO - 'tscrollx', 11:32:42 INFO - 'tsvg_static']}, 11:32:42 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 11:32:42 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:32:42 INFO - 'talos_options': ['--mitmproxy', 11:32:42 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:32:42 INFO - '--firstNonBlankPaint'], 11:32:42 INFO - 'tests': ['tp6_google', 11:32:42 INFO - 'tp6_youtube', 11:32:42 INFO - 'tp6_amazon', 11:32:42 INFO - 'tp6_facebook']}, 11:32:42 INFO - 'tp6-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:32:42 INFO - 'talos_options': ['--stylo', 11:32:42 INFO - '--mitmproxy', 11:32:42 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:32:42 INFO - '--firstNonBlankPaint'], 11:32:42 INFO - 'tests': ['tp6_google', 11:32:42 INFO - 'tp6_youtube', 11:32:42 INFO - 'tp6_amazon', 11:32:42 INFO - 'tp6_facebook']}, 11:32:42 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:32:42 INFO - 'talos_options': ['--stylo', 11:32:42 INFO - '--stylo-threads=1', 11:32:42 INFO - '--mitmproxy', 11:32:42 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:32:42 INFO - '--firstNonBlankPaint'], 11:32:42 INFO - 'tests': ['tp6_google', 11:32:42 INFO - 'tp6_youtube', 11:32:42 INFO - 'tp6_amazon', 11:32:42 INFO - 'tp6_facebook']}, 11:32:42 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 11:32:42 INFO - 'talos_options': ['--xperf_path', 11:32:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:32:42 INFO - 'tests': ['tp5n']}}} 11:32:42 INFO - Running post-action listener: _resource_record_post_action 11:32:42 INFO - [mozharness: 2017-08-04 18:32:42.353845Z] Finished populate-webroot step (success) 11:32:42 INFO - [mozharness: 2017-08-04 18:32:42.353935Z] Running create-virtualenv step. 11:32:42 INFO - Running pre-action listener: _resource_record_pre_action 11:32:42 INFO - Running main action method: create_virtualenv 11:32:42 INFO - Creating virtualenv /builds/slave/test/build/venv 11:32:42 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 11:32:42 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:32:42 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 11:32:42 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:32:42 INFO - Using real prefix '/usr' 11:32:42 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:32:43 INFO - Installing distribute.............................................................................................................................................................................................done. 11:32:45 INFO - Installing pip.................done. 11:32:45 INFO - Return code: 0 11:32:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 11:32:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 11:32:45 INFO - Reading from file tmpfile_stdout 11:32:45 INFO - Output received: 11:32:45 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) 11:32:45 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:32: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')]} 11:32:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:32: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')]} 11:32:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:32:45 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 0x18d71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aa3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c46d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c43eb0>, '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 0x1c44db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c45240>, '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': '516f8d7ca085b4d087ab0a71000001a4-1501871467.645597-2068506153', '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 11:32:45 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 11:32:45 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 11:32:45 INFO - Using env: {'DISPLAY': ':0', 11:32:45 INFO - 'HOME': '/home/cltbld', 11:32:45 INFO - 'LANG': 'en_US.UTF-8', 11:32:45 INFO - 'LANGUAGE': 'en_US:en', 11:32:45 INFO - 'LOGNAME': 'cltbld', 11:32:45 INFO - 'MAIL': '/var/mail/cltbld', 11:32:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:32:45 INFO - 'MOZ_NO_REMOTE': '1', 11:32:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:32:45 INFO - 'NO_EM_RESTART': '1', 11:32:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:32:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:32:45 INFO - 'PWD': '/builds/slave/test', 11:32:45 INFO - 'SHELL': '/bin/bash', 11:32:45 INFO - 'SHLVL': '1', 11:32:45 INFO - 'TERM': 'linux', 11:32:45 INFO - 'TMOUT': '86400', 11:32:45 INFO - 'USER': 'cltbld', 11:32:45 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1501871467.645597-2068506153', 11:32:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:32:45 INFO - '_': '/tools/buildbot/bin/python'} 11:32:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:32:45 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 11:32:45 INFO - Cleaning up... 11:32:45 INFO - Return code: 0 11:32:45 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:32: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')]} 11:32:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:32: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')]} 11:32:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:32:45 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 0x18d71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aa3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c46d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c43eb0>, '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 0x1c44db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c45240>, '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': '516f8d7ca085b4d087ab0a71000001a4-1501871467.645597-2068506153', '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 11:32:45 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 11:32:45 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 11:32:45 INFO - Using env: {'DISPLAY': ':0', 11:32:45 INFO - 'HOME': '/home/cltbld', 11:32:45 INFO - 'LANG': 'en_US.UTF-8', 11:32:45 INFO - 'LANGUAGE': 'en_US:en', 11:32:45 INFO - 'LOGNAME': 'cltbld', 11:32:45 INFO - 'MAIL': '/var/mail/cltbld', 11:32:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:32:45 INFO - 'MOZ_NO_REMOTE': '1', 11:32:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:32:45 INFO - 'NO_EM_RESTART': '1', 11:32:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:32:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:32:45 INFO - 'PWD': '/builds/slave/test', 11:32:45 INFO - 'SHELL': '/bin/bash', 11:32:45 INFO - 'SHLVL': '1', 11:32:45 INFO - 'TERM': 'linux', 11:32:45 INFO - 'TMOUT': '86400', 11:32:45 INFO - 'USER': 'cltbld', 11:32:45 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1501871467.645597-2068506153', 11:32:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:32:45 INFO - '_': '/tools/buildbot/bin/python'} 11:32:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:32:46 INFO - Downloading/unpacking psutil>=3.1.1 11:32:46 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 11:32:46 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 11:32:46 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 11:32:46 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 11:32:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:32:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:32:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:32:47 INFO - Installing collected packages: psutil 11:32:47 INFO - Running setup.py install for psutil 11:32:47 INFO - building 'psutil._psutil_linux' extension 11:32:47 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 11:32:48 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 11:32:48 INFO - building 'psutil._psutil_posix' extension 11:32:48 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 11:32:48 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 11:32:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:32:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:32:48 INFO - Successfully installed psutil 11:32:48 INFO - Cleaning up... 11:32:48 INFO - Return code: 0 11:32:48 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:32:48 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')]} 11:32:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:32:48 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')]} 11:32:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:32:48 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 0x18d71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aa3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c46d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c43eb0>, '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 0x1c44db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c45240>, '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': '516f8d7ca085b4d087ab0a71000001a4-1501871467.645597-2068506153', '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 11:32:48 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 11:32:48 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 11:32:48 INFO - Using env: {'DISPLAY': ':0', 11:32:48 INFO - 'HOME': '/home/cltbld', 11:32:48 INFO - 'LANG': 'en_US.UTF-8', 11:32:48 INFO - 'LANGUAGE': 'en_US:en', 11:32:48 INFO - 'LOGNAME': 'cltbld', 11:32:48 INFO - 'MAIL': '/var/mail/cltbld', 11:32:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:32:48 INFO - 'MOZ_NO_REMOTE': '1', 11:32:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:32:48 INFO - 'NO_EM_RESTART': '1', 11:32:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:32:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:32:48 INFO - 'PWD': '/builds/slave/test', 11:32:48 INFO - 'SHELL': '/bin/bash', 11:32:48 INFO - 'SHLVL': '1', 11:32:48 INFO - 'TERM': 'linux', 11:32:48 INFO - 'TMOUT': '86400', 11:32:48 INFO - 'USER': 'cltbld', 11:32:48 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1501871467.645597-2068506153', 11:32:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:32:48 INFO - '_': '/tools/buildbot/bin/python'} 11:32:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:32:48 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:32:48 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 11:32:48 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 11:32:48 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 11:32:48 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 11:32:50 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:32:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:32:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:32:50 INFO - Installing collected packages: mozsystemmonitor 11:32:50 INFO - Running setup.py install for mozsystemmonitor 11:32:50 INFO - Successfully installed mozsystemmonitor 11:32:50 INFO - Cleaning up... 11:32:50 INFO - Return code: 0 11:32:50 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:32:50 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')]} 11:32:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:32:50 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')]} 11:32:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:32:50 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 0x18d71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aa3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c46d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c43eb0>, '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 0x1c44db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c45240>, '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': '516f8d7ca085b4d087ab0a71000001a4-1501871467.645597-2068506153', '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 11:32:50 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 11:32:50 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 11:32:50 INFO - Using env: {'DISPLAY': ':0', 11:32:50 INFO - 'HOME': '/home/cltbld', 11:32:50 INFO - 'LANG': 'en_US.UTF-8', 11:32:50 INFO - 'LANGUAGE': 'en_US:en', 11:32:50 INFO - 'LOGNAME': 'cltbld', 11:32:50 INFO - 'MAIL': '/var/mail/cltbld', 11:32:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:32:50 INFO - 'MOZ_NO_REMOTE': '1', 11:32:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:32:50 INFO - 'NO_EM_RESTART': '1', 11:32:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:32:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:32:50 INFO - 'PWD': '/builds/slave/test', 11:32:50 INFO - 'SHELL': '/bin/bash', 11:32:50 INFO - 'SHLVL': '1', 11:32:50 INFO - 'TERM': 'linux', 11:32:50 INFO - 'TMOUT': '86400', 11:32:50 INFO - 'USER': 'cltbld', 11:32:50 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1501871467.645597-2068506153', 11:32:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:32:50 INFO - '_': '/tools/buildbot/bin/python'} 11:32:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:32:50 INFO - Downloading/unpacking jsonschema==2.5.1 11:32:50 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 11:32:50 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 11:32:50 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 11:32:50 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 11:32:51 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:32:51 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:32:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:32:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:32:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:32:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:32:51 INFO - Downloading functools32-3.2.3-2.tar.gz 11:32:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:32:51 INFO - warning: no files found matching '*.txt' 11:32:51 INFO - no previously-included directories found matching 'build' 11:32:51 INFO - no previously-included directories found matching 'dist' 11:32:51 INFO - no previously-included directories found matching '.git*' 11:32:51 INFO - Installing collected packages: jsonschema, functools32 11:32:51 INFO - Running setup.py install for functools32 11:32:51 INFO - warning: no files found matching '*.txt' 11:32:51 INFO - no previously-included directories found matching 'build' 11:32:51 INFO - no previously-included directories found matching 'dist' 11:32:51 INFO - no previously-included directories found matching '.git*' 11:32:51 INFO - Successfully installed jsonschema functools32 11:32:51 INFO - Cleaning up... 11:32:51 INFO - Return code: 0 11:32:51 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:32:51 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')]} 11:32:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:32:51 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')]} 11:32:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:32:51 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 0x18d71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aa3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c46d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c43eb0>, '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 0x1c44db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c45240>, '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': '516f8d7ca085b4d087ab0a71000001a4-1501871467.645597-2068506153', '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 11:32:51 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 11:32:51 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 11:32:51 INFO - Using env: {'DISPLAY': ':0', 11:32:51 INFO - 'HOME': '/home/cltbld', 11:32:51 INFO - 'LANG': 'en_US.UTF-8', 11:32:51 INFO - 'LANGUAGE': 'en_US:en', 11:32:51 INFO - 'LOGNAME': 'cltbld', 11:32:51 INFO - 'MAIL': '/var/mail/cltbld', 11:32:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:32:51 INFO - 'MOZ_NO_REMOTE': '1', 11:32:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:32:51 INFO - 'NO_EM_RESTART': '1', 11:32:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:32:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:32:51 INFO - 'PWD': '/builds/slave/test', 11:32:51 INFO - 'SHELL': '/bin/bash', 11:32:51 INFO - 'SHLVL': '1', 11:32:51 INFO - 'TERM': 'linux', 11:32:51 INFO - 'TMOUT': '86400', 11:32:51 INFO - 'USER': 'cltbld', 11:32:51 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1501871467.645597-2068506153', 11:32:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:32:51 INFO - '_': '/tools/buildbot/bin/python'} 11:32:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:32:52 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:32:52 INFO - Cleaning up... 11:32:52 INFO - Return code: 0 11:32:52 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:32:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:32:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:32:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:32:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:32:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x18d71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aa3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c46d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c43eb0>, '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 0x1c44db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c45240>, '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': '516f8d7ca085b4d087ab0a71000001a4-1501871467.645597-2068506153', '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 11:32:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:32:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 11:32:52 INFO - Using env: {'DISPLAY': ':0', 11:32:52 INFO - 'HOME': '/home/cltbld', 11:32:52 INFO - 'LANG': 'en_US.UTF-8', 11:32:52 INFO - 'LANGUAGE': 'en_US:en', 11:32:52 INFO - 'LOGNAME': 'cltbld', 11:32:52 INFO - 'MAIL': '/var/mail/cltbld', 11:32:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:32:52 INFO - 'MOZ_NO_REMOTE': '1', 11:32:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:32:52 INFO - 'NO_EM_RESTART': '1', 11:32:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:32:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:32:52 INFO - 'PWD': '/builds/slave/test', 11:32:52 INFO - 'SHELL': '/bin/bash', 11:32:52 INFO - 'SHLVL': '1', 11:32:52 INFO - 'TERM': 'linux', 11:32:52 INFO - 'TMOUT': '86400', 11:32:52 INFO - 'USER': 'cltbld', 11:32:52 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1501871467.645597-2068506153', 11:32:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:32:52 INFO - '_': '/tools/buildbot/bin/python'} 11:32:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:32:52 INFO - Downloading/unpacking blobuploader==1.2.4 11:32:52 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 11:32:52 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 11:32:52 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 11:32:52 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 11:32:53 INFO - Downloading blobuploader-1.2.4.tar.gz 11:32:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:32:53 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:32:53 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 11:32:53 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 11:32:53 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 11:32:53 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 11:32:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:32:53 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:32:53 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 11:32:53 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 11:32:53 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 11:32:53 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 11:32:54 INFO - Downloading docopt-0.6.1.tar.gz 11:32:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:32:54 INFO - Installing collected packages: blobuploader, requests, docopt 11:32:54 INFO - Running setup.py install for blobuploader 11:32:54 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:32:54 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:32:54 INFO - Running setup.py install for requests 11:32:54 INFO - Running setup.py install for docopt 11:32:54 INFO - Successfully installed blobuploader requests docopt 11:32:54 INFO - Cleaning up... 11:32:54 INFO - Return code: 0 11:32:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:32:54 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')]} 11:32:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:32:54 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')]} 11:32:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:32:54 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 0x18d71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aa3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c46d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c43eb0>, '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 0x1c44db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c45240>, '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': '516f8d7ca085b4d087ab0a71000001a4-1501871467.645597-2068506153', '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 11:32:54 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 11:32:54 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 11:32:54 INFO - Using env: {'DISPLAY': ':0', 11:32:54 INFO - 'HOME': '/home/cltbld', 11:32:54 INFO - 'LANG': 'en_US.UTF-8', 11:32:54 INFO - 'LANGUAGE': 'en_US:en', 11:32:54 INFO - 'LOGNAME': 'cltbld', 11:32:54 INFO - 'MAIL': '/var/mail/cltbld', 11:32:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:32:54 INFO - 'MOZ_NO_REMOTE': '1', 11:32:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:32:54 INFO - 'NO_EM_RESTART': '1', 11:32:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:32:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:32:54 INFO - 'PWD': '/builds/slave/test', 11:32:54 INFO - 'SHELL': '/bin/bash', 11:32:54 INFO - 'SHLVL': '1', 11:32:54 INFO - 'TERM': 'linux', 11:32:54 INFO - 'TMOUT': '86400', 11:32:54 INFO - 'USER': 'cltbld', 11:32:54 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1501871467.645597-2068506153', 11:32:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:32:54 INFO - '_': '/tools/buildbot/bin/python'} 11:32:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:32:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:32:54 INFO - Running setup.py (path:/tmp/pip-ux7p9p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:32:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:32:54 INFO - Running setup.py (path:/tmp/pip-ET0Ylj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:32:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:32:55 INFO - Running setup.py (path:/tmp/pip-VwlptF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:32:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:32:55 INFO - Running setup.py (path:/tmp/pip-1RyUO8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:32:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:32:55 INFO - Running setup.py (path:/tmp/pip-a1eq_P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:32:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:32:55 INFO - Running setup.py (path:/tmp/pip-0ty3Sk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:32:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:32:55 INFO - Running setup.py (path:/tmp/pip-WQxo6s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:32:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:32:55 INFO - Running setup.py (path:/tmp/pip-C4dw3h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:32:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:32:55 INFO - Running setup.py (path:/tmp/pip-fytlES-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:32:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:32:55 INFO - Running setup.py (path:/tmp/pip-_5NCCC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:32:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:32:55 INFO - Running setup.py (path:/tmp/pip-En1wzS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:32:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:32:55 INFO - Running setup.py (path:/tmp/pip-MoHpN7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:32:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:32:55 INFO - Running setup.py (path:/tmp/pip-1XYbwM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:32:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:32:55 INFO - Running setup.py (path:/tmp/pip-GFKp_y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:32:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:32:55 INFO - Running setup.py (path:/tmp/pip-eU02ff-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:32:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:32:55 INFO - Running setup.py (path:/tmp/pip-tsF0bL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:32:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:32:56 INFO - Running setup.py (path:/tmp/pip-ChlOCH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:32:56 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:32:56 INFO - Running setup.py install for manifestparser 11:32:56 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:32:56 INFO - Running setup.py install for mozcrash 11:32:56 INFO - Running setup.py install for mozdebug 11:32:56 INFO - Running setup.py install for mozdevice 11:32:56 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:32:56 INFO - Running setup.py install for mozfile 11:32:56 INFO - Running setup.py install for mozhttpd 11:32:56 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:32:56 INFO - Running setup.py install for mozinfo 11:32:56 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:32:56 INFO - Running setup.py install for mozInstall 11:32:56 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:32:56 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:32:56 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:32:56 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:32:56 INFO - Running setup.py install for mozleak 11:32:57 INFO - Running setup.py install for mozlog 11:32:57 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:32:57 INFO - Running setup.py install for moznetwork 11:32:57 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:32:57 INFO - Running setup.py install for mozprocess 11:32:57 INFO - Running setup.py install for mozprofile 11:32:57 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:32:57 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:32:57 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:32:57 INFO - Running setup.py install for mozrunner 11:32:57 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:32:57 INFO - Running setup.py install for mozscreenshot 11:32:57 INFO - Running setup.py install for moztest 11:32:57 INFO - Running setup.py install for mozversion 11:32:57 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:32:57 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:32:57 INFO - Cleaning up... 11:32:57 INFO - Return code: 0 11:32:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:32:57 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')]} 11:32:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:32:57 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')]} 11:32:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:32:57 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 0x18d71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aa3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c46d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c43eb0>, '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 0x1c44db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c45240>, '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': '516f8d7ca085b4d087ab0a71000001a4-1501871467.645597-2068506153', '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 11:32:57 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 11:32:57 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 11:32:57 INFO - Using env: {'DISPLAY': ':0', 11:32:57 INFO - 'HOME': '/home/cltbld', 11:32:57 INFO - 'LANG': 'en_US.UTF-8', 11:32:57 INFO - 'LANGUAGE': 'en_US:en', 11:32:57 INFO - 'LOGNAME': 'cltbld', 11:32:57 INFO - 'MAIL': '/var/mail/cltbld', 11:32:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:32:57 INFO - 'MOZ_NO_REMOTE': '1', 11:32:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:32:57 INFO - 'NO_EM_RESTART': '1', 11:32:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:32:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:32:57 INFO - 'PWD': '/builds/slave/test', 11:32:57 INFO - 'SHELL': '/bin/bash', 11:32:57 INFO - 'SHLVL': '1', 11:32:57 INFO - 'TERM': 'linux', 11:32:57 INFO - 'TMOUT': '86400', 11:32:57 INFO - 'USER': 'cltbld', 11:32:57 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1501871467.645597-2068506153', 11:32:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:32:57 INFO - '_': '/tools/buildbot/bin/python'} 11:32:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:32:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:32:58 INFO - Running setup.py (path:/tmp/pip-gia2Do-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:32:58 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)) 11:32:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:32:58 INFO - Running setup.py (path:/tmp/pip-9uBaJb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:32:58 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)) 11:32:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:32:58 INFO - Running setup.py (path:/tmp/pip-NbyjAr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:32:58 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)) 11:32:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:32:58 INFO - Running setup.py (path:/tmp/pip-wmdGQT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:32:58 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)) 11:32:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:32:58 INFO - Running setup.py (path:/tmp/pip-8_RI6o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:32:58 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)) 11:32:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:32:58 INFO - Running setup.py (path:/tmp/pip-b9PpbT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:32:58 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)) 11:32:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:32:58 INFO - Running setup.py (path:/tmp/pip-GcvgSw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:32:58 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)) 11:32:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:32:58 INFO - Running setup.py (path:/tmp/pip-S9LXJV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:32:58 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)) 11:32:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:32:58 INFO - Running setup.py (path:/tmp/pip-ITYsi_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:32:58 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)) 11:32:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:32:58 INFO - Running setup.py (path:/tmp/pip-7WT8DK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:32:58 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)) 11:32:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:32:58 INFO - Running setup.py (path:/tmp/pip-sdmRWa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:32:58 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)) 11:32:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:32:58 INFO - Running setup.py (path:/tmp/pip-vS7LlM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:32:59 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)) 11:32:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:32:59 INFO - Running setup.py (path:/tmp/pip-zHm6CK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:32:59 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)) 11:32:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:32:59 INFO - Running setup.py (path:/tmp/pip-BExWWl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:32:59 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)) 11:32:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:32:59 INFO - Running setup.py (path:/tmp/pip-cEHcru-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:32:59 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)) 11:32:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:32:59 INFO - Running setup.py (path:/tmp/pip-Vxmkfi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:32:59 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)) 11:32:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:32:59 INFO - Running setup.py (path:/tmp/pip-jp1z4N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:32:59 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)) 11:32:59 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)) 11:32:59 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)) 11:32:59 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)) 11:32:59 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)) 11:32:59 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)) 11:32:59 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)) 11:32:59 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:32:59 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 11:32:59 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 11:32:59 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 11:32:59 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 11:33:00 INFO - Downloading blessings-1.6.tar.gz 11:33:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:33:00 INFO - Installing collected packages: blessings 11:33:00 INFO - Running setup.py install for blessings 11:33:00 INFO - Successfully installed blessings 11:33:00 INFO - Cleaning up... 11:33:00 INFO - Return code: 0 11:33:00 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:33:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:33:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:33:00 INFO - Reading from file tmpfile_stdout 11:33:00 INFO - Current package versions: 11:33:00 INFO - argparse == 1.2.1 11:33:00 INFO - blessings == 1.6 11:33:00 INFO - blobuploader == 1.2.4 11:33:00 INFO - docopt == 0.6.1 11:33:00 INFO - functools32 == 3.2.3-2 11:33:00 INFO - jsonschema == 2.5.1 11:33:00 INFO - manifestparser == 1.1 11:33:00 INFO - mozInstall == 1.13 11:33:00 INFO - mozcrash == 1.0 11:33:00 INFO - mozdebug == 0.1 11:33:00 INFO - mozdevice == 0.51 11:33:00 INFO - mozfile == 1.2 11:33:00 INFO - mozhttpd == 0.7 11:33:00 INFO - mozinfo == 0.10 11:33:00 INFO - mozleak == 0.1 11:33:00 INFO - mozlog == 3.5 11:33:00 INFO - moznetwork == 0.27 11:33:00 INFO - mozprocess == 0.25 11:33:00 INFO - mozprofile == 0.28 11:33:00 INFO - mozrunner == 6.13 11:33:00 INFO - mozscreenshot == 0.1 11:33:00 INFO - mozsystemmonitor == 0.3 11:33:00 INFO - moztest == 0.8 11:33:00 INFO - mozversion == 1.4 11:33:00 INFO - psutil == 3.1.1 11:33:00 INFO - requests == 1.2.3 11:33:00 INFO - wsgiref == 0.1.2 11:33:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:33:00 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')]} 11:33:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:33:00 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')]} 11:33:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:33:00 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 0x18d71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aa3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c46d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c43eb0>, '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 0x1c44db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c45240>, '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': '516f8d7ca085b4d087ab0a71000001a4-1501871467.645597-2068506153', '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 11:33:00 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 11:33:00 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 11:33:00 INFO - Using env: {'DISPLAY': ':0', 11:33:00 INFO - 'HOME': '/home/cltbld', 11:33:00 INFO - 'LANG': 'en_US.UTF-8', 11:33:00 INFO - 'LANGUAGE': 'en_US:en', 11:33:00 INFO - 'LOGNAME': 'cltbld', 11:33:00 INFO - 'MAIL': '/var/mail/cltbld', 11:33:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:33:00 INFO - 'MOZ_NO_REMOTE': '1', 11:33:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:33:00 INFO - 'NO_EM_RESTART': '1', 11:33:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:33:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:33:00 INFO - 'PWD': '/builds/slave/test', 11:33:00 INFO - 'SHELL': '/bin/bash', 11:33:00 INFO - 'SHLVL': '1', 11:33:00 INFO - 'TERM': 'linux', 11:33:00 INFO - 'TMOUT': '86400', 11:33:00 INFO - 'USER': 'cltbld', 11:33:00 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1501871467.645597-2068506153', 11:33:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:33:00 INFO - '_': '/tools/buildbot/bin/python'} 11:33:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:33:01 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)) 11:33:01 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)) 11:33:01 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)) 11:33:01 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)) 11:33:01 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)) 11:33:01 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)) 11:33:01 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)) 11:33:01 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)) 11:33:01 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)) 11:33:01 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 11:33:01 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 11:33:01 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 11:33:01 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 11:33:01 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 11:33:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 11:33:02 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)) 11:33:02 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)) 11:33:02 INFO - Installing collected packages: simplejson 11:33:02 INFO - Running setup.py install for simplejson 11:33:02 INFO - building 'simplejson._speedups' extension 11:33:02 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 11:33:03 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 11:33:03 INFO - Successfully installed simplejson 11:33:03 INFO - Cleaning up... 11:33:03 INFO - Return code: 0 11:33:03 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:33:03 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')]} 11:33:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:33:03 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')]} 11:33:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:33:03 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 0x18d71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aa3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c46d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c43eb0>, '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 0x1c44db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c45240>, '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': '516f8d7ca085b4d087ab0a71000001a4-1501871467.645597-2068506153', '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 11:33:03 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 11:33:03 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 11:33:03 INFO - Using env: {'DISPLAY': ':0', 11:33:03 INFO - 'HOME': '/home/cltbld', 11:33:03 INFO - 'LANG': 'en_US.UTF-8', 11:33:03 INFO - 'LANGUAGE': 'en_US:en', 11:33:03 INFO - 'LOGNAME': 'cltbld', 11:33:03 INFO - 'MAIL': '/var/mail/cltbld', 11:33:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:33:03 INFO - 'MOZ_NO_REMOTE': '1', 11:33:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:33:03 INFO - 'NO_EM_RESTART': '1', 11:33:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:33:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:33:03 INFO - 'PWD': '/builds/slave/test', 11:33:03 INFO - 'SHELL': '/bin/bash', 11:33:03 INFO - 'SHLVL': '1', 11:33:03 INFO - 'TERM': 'linux', 11:33:03 INFO - 'TMOUT': '86400', 11:33:03 INFO - 'USER': 'cltbld', 11:33:03 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1501871467.645597-2068506153', 11:33:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:33:03 INFO - '_': '/tools/buildbot/bin/python'} 11:33:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:33:03 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:33:03 INFO - Cleaning up... 11:33:03 INFO - Return code: 0 11:33:03 INFO - Running post-action listener: _resource_record_post_action 11:33:03 INFO - Running post-action listener: _start_resource_monitoring 11:33:03 INFO - Starting resource monitoring. 11:33:03 INFO - [mozharness: 2017-08-04 18:33:03.642910Z] Finished create-virtualenv step (success) 11:33:03 INFO - [mozharness: 2017-08-04 18:33:03.643917Z] Running install step. 11:33:03 INFO - Running pre-action listener: _resource_record_pre_action 11:33:03 INFO - Running main action method: install 11:33:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:33:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:33:03 INFO - Reading from file tmpfile_stdout 11:33:03 INFO - Detecting whether we're running mozinstall >=1.0... 11:33:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:33:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:33:03 INFO - Reading from file tmpfile_stdout 11:33:03 INFO - Output received: 11:33:03 INFO - Usage: mozinstall [options] installer 11:33:03 INFO - Options: 11:33:03 INFO - -h, --help show this help message and exit 11:33:03 INFO - -d DEST, --destination=DEST 11:33:03 INFO - Directory to install application into. [default: 11:33:03 INFO - "/builds/slave/test"] 11:33:03 INFO - --app=APP Application being installed. [default: firefox] 11:33:03 INFO - mkdir: /builds/slave/test/build/application 11:33:03 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'] 11:33:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 11:33:21 INFO - Reading from file tmpfile_stdout 11:33:21 INFO - Output received: 11:33:21 INFO - /builds/slave/test/build/application/firefox/firefox 11:33:21 INFO - Running post-action listener: _resource_record_post_action 11:33:21 INFO - [mozharness: 2017-08-04 18:33:21.916651Z] Finished install step (success) 11:33:21 INFO - [mozharness: 2017-08-04 18:33:21.917132Z] Running setup-mitmproxy step. 11:33:21 INFO - Running pre-action listener: _resource_record_pre_action 11:33:21 INFO - Running main action method: setup_mitmproxy 11:33:21 INFO - Skipping: mitmproxy is not required 11:33:21 INFO - Running post-action listener: _resource_record_post_action 11:33:21 INFO - [mozharness: 2017-08-04 18:33:21.918757Z] Finished setup-mitmproxy step (success) 11:33:21 INFO - [mozharness: 2017-08-04 18:33:21.919071Z] Running run-tests step. 11:33:21 INFO - Running pre-action listener: _resource_record_pre_action 11:33:21 INFO - Running pre-action listener: _set_gcov_prefix 11:33:21 INFO - Running main action method: run_tests 11:33:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:33:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:33:21 INFO - Python 2.7.3 11:33:21 INFO - Return code: 0 11:33:21 INFO - grabbing minidump binary from tooltool 11:33: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')]} 11:33:21 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 0x1c43eb0>, '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 0x1c44db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c45240>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:33:21 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 11:33:21 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 11:33:21 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 11:33:22 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:33:22 INFO - Return code: 0 11:33:22 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:33:22 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:33:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:33:22 INFO - ENV: RUST_BACKTRACE is now 1 11:33:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:33:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:33:22 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/Q6EcMmQCRh-0euMeGSZPJw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--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 11:33:22 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/Q6EcMmQCRh-0euMeGSZPJw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-061 --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 11:33:22 INFO - Using env: {'DISPLAY': ':0', 11:33:22 INFO - 'HOME': '/home/cltbld', 11:33:22 INFO - 'LANG': 'en_US.UTF-8', 11:33:22 INFO - 'LANGUAGE': 'en_US:en', 11:33:22 INFO - 'LOGNAME': 'cltbld', 11:33:22 INFO - 'MAIL': '/var/mail/cltbld', 11:33:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:33:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:33:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:33:22 INFO - 'MOZ_NO_REMOTE': '1', 11:33:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:33:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:33:22 INFO - 'NO_EM_RESTART': '1', 11:33:22 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:33:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:33:22 INFO - 'PWD': '/builds/slave/test', 11:33:22 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:33:22 INFO - 'RUST_BACKTRACE': '1', 11:33:22 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:33:22 INFO - 'SHELL': '/bin/bash', 11:33:22 INFO - 'SHLVL': '1', 11:33:22 INFO - 'STYLO_FORCE_ENABLED': '1', 11:33:22 INFO - 'TERM': 'linux', 11:33:22 INFO - 'TMOUT': '86400', 11:33:22 INFO - 'USER': 'cltbld', 11:33:22 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1501871467.645597-2068506153', 11:33:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:33:22 INFO - '_': '/tools/buildbot/bin/python'} 11:33:22 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/Q6EcMmQCRh-0euMeGSZPJw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--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 11:33:22 INFO - mozversion application_buildid: 20170804172933 11:33:22 INFO - mozversion application_changeset: bc829569880635c52d6e3d54f51cd7d3df180186 11:33:22 INFO - mozversion application_display_name: Nightly 11:33:22 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:33:22 INFO - mozversion application_name: Firefox 11:33:22 INFO - mozversion application_remotingname: firefox 11:33:22 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 11:33:22 INFO - mozversion application_vendor: Mozilla 11:33:22 INFO - mozversion application_version: 57.0a1 11:33:22 INFO - mozversion platform_buildid: 20170804172933 11:33:22 INFO - mozversion platform_changeset: bc829569880635c52d6e3d54f51cd7d3df180186 11:33:22 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 11:33:22 INFO - mozversion platform_version: 57.0a1 11:33:22 INFO - using testdate: 1501871602 11:33:22 INFO - actual date: 1501871602 11:33:22 INFO - starting webserver on 'localhost:59316' 11:33:22 INFO - SUITE-START | Running 2 tests 11:33:22 INFO - TEST-START | dromaeo_css 11:33:22 INFO - Initialising browser for dromaeo_css test... 11:33:22 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:59316/getInfo.html -profile /tmp/tmpo_gAfs/profile 11:33:22 INFO - TEST-INFO | started process 3307 (/builds/slave/test/build/application/firefox/firefox http://localhost:59316/getInfo.html) 11:33:30 INFO - TEST-INFO | 3307: exit 0 11:33:30 INFO - Browser initialized. 11:33:30 INFO - Running cycle 1/1 for dromaeo_css test... 11:33:30 INFO - TEST-INFO | started process 3536 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpo_gAfs/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 11:33:31 INFO - PID 3536 | 11:33:31 INFO - PID 3536 | (/builds/slave/test/build/application/firefox/firefox:3591): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 11:33:31 INFO - PID 3536 | 11:33:41 INFO - PID 3536 | RSS: Main: 174002176 11:33:41 INFO - PID 3536 | 11:36:40 INFO - PID 3536 | Cycle 1(1): loaded http://localhost:59316/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59316/tests/dromaeo/cssquery-ext.html) 11:36:41 INFO - PID 3536 | RSS: Main: 175837184 11:36:41 INFO - PID 3536 | 11:39:43 INFO - PID 3536 | Cycle 1(1): loaded http://localhost:59316/tests/dromaeo/cssquery-ext.html (next: http://localhost:59316/tests/dromaeo/cssquery-jquery.html) 11:39:44 INFO - PID 3536 | RSS: Main: 173424640 11:39:44 INFO - PID 3536 | 11:42:46 INFO - PID 3536 | Cycle 1(1): loaded http://localhost:59316/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59316/tests/dromaeo/cssquery-mootools.html) 11:42:46 INFO - PID 3536 | RSS: Main: 174768128 11:42:46 INFO - PID 3536 | 11:45:48 INFO - PID 3536 | Cycle 1(1): loaded http://localhost:59316/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59316/tests/dromaeo/cssquery-prototype.html) 11:45:49 INFO - PID 3536 | RSS: Main: 173465600 11:45:49 INFO - PID 3536 | 11:48:53 INFO - PID 3536 | Cycle 1(1): loaded http://localhost:59316/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59316/tests/dromaeo/cssquery-yui.html) 11:48:53 INFO - PID 3536 | RSS: Main: 177229824 11:48:53 INFO - PID 3536 | 11:51:55 INFO - PID 3536 | Cycle 1(1): loaded http://localhost:59316/tests/dromaeo/cssquery-yui.html (next: http://localhost:59316/tests/dromaeo/cssquery-dojo.html) 11:51:56 INFO - PID 3536 | RSS: Main: 177979392 11:51:56 INFO - PID 3536 | 11:51:56 INFO - PID 3536 | __start_tp_report 11:51:56 INFO - PID 3536 | _x_x_mozilla_page_load 11:51:56 INFO - PID 3536 | _x_x_mozilla_page_load_details 11:51:56 INFO - PID 3536 | |i|pagename|runs| 11:51:56 INFO - PID 3536 | |0;dojo.html;3149.181212884649;3154.369126174765;3192.6647701991296;3199.79201351912;3244.5619841321413;6289.339619339972;6323.241211054674;6331.39851714087;6342.0486926960975;6362.459190968773;6139;6236.345183755709;6241.157443745093;6255.906161407583;6284.340144284842;5651.9152212716735;5658.575606829484;5664.745086471119;5677.517411020068;5688.97155514224;5708.343540492834;5709.229254050712;5739.225204597388;5782.508486778629;5800.680962547058;5512.80705175317;5707.6575405475805;5718.7426565804435;5779.046457334534;5808.361080281165;5216.869578260574;5617.915731264035;5644.181593668895;5733.054046082391;5754.769809207627;5661.830145095653;5686.0333743263745;5718.1136923776885;5753.683547404891;5767.480926716574;6156.076588511714;6162.7534898604;6214.751409943597;6230.813075607739;6237.438630523275;6678.866422671568;6705.899411508832;6764.391204791543;6765.391114799691;6795.694193761293;6737.157855268091;6755.020522024279;6772.255051944282;6846.383825455733;6866.965665171692;6225.066240063981;6239.563230573816;6298.905516417258;6300.3384644612115;6388.488920886318;6970.477214208955;7024.086868707035;7024.683889224997;7026.332498412643;7034.120734908137;6536.0522724205675;6537;6571.57284776488;6624.072629831828;6624.6025238485845;6613.503987200979;6638.070670106189;6693.2972037935315;6715.731370745116;6718.361755633207;6608.173978252718;6724.966375168191;6728.259891411941;6731.697073631698;6733.528652994341;6735.29279425663;6773.559718618372;6826.146731658543;6833.726650934006;6842.076319696777;5019.749012549358;5028.145215313332;5033.647644664911;5105.310783044316;5115.948840511622;4267.1892340455215;4294.871153865389;4350.934735978963;4354.4992325882295;4440.934175797785;5880.411958804171;5900.232969713909;5908.054711246266;5916.1421593868645;5927.644341339447;6788.185417749803;6804.76183333581;6869.965650171717;6875.759348422781;6892.931070689329;5721.5136713379825;5819.330776960619;5822.7670893163795;5865.882682346414;5920.437558431942;5900.321463031721;5915.822525324247;5928.703564821742;5929.733162007634;5932.169496270526;6518.543701940914;6545.247296560957;6563.146790917151;6567.507436942248;6570.77002304917;6707.262201157771;6762.425193858577;6775.593464392152;6792.049113124265;6796.830079248059;6492.220933488012;6537.313582073813;6539.476841852736;6551.4103730664465;6554;6557.082008518716;6583.506237032146;6595.604263744191;6654.467642588678;6673.165854268216;6643.069970204078;6663.633500157344;6746.898796517958;6766.830829229309;6804.965975170093;6521.184851893513;6524.412802847766;6530.118434011348;6542.8364290893105;6546.378094081055;6515.804525864231;6543.869122617426;6544.607323560602;6560.081588577507;6577.046328282468;6417.197850268716;6485.513586481127;6490.448311893353;6515.446187074152;6524;6432.3567643237175;6532.510061745293;6608.8347791305605;6628.5691430056895;6630.204375474974;6264.091706702594;6350.745970161327;6360.522960777867;6411.903821442589;6442.742290308335 11:51:56 INFO - PID 3536 | |1;ext.html;816.085983698258;863.2101627011283;887.4896934262797;890.4256754393416;1190.3096204201563;31826.20434489139;43881;44598.108037839265;44603.33095003577;44608.55391446085;44521.77739111308;44858.32712509315;44973.77513112438;45022.774886125604;45143.322850157194;7328.230535793745;7820.608969551514;7976.441649084566;7976.521408715466;7979.281864632182;7762.7671169865;7852.882206766903;7935.880961785578;7938.245866642688;7940.1265860755275;7887.526748395115;7893.763187104368;7924.643391047388;7930.405219608552;7954.761357159295;7868.567228802413;7885.369170466378;7887.60561971902;7905.604719763989;7918.485298455582;7419.554826710415;7428.9628551856895;7433.070866141732;7457.328840404335;7458.701651933916;40004;40462;40467.17897694611;40510.392344114865;40558.1888362234;3582.946255806165;3655;3657.6708096271464;3665.816709164531;3669.284489524544;32293.70825167014;32447.51328730071;32469.188270293194;32488.350232995443;32501.674983250337;5013.949860501385;5071.188609822448;5083.720395378253;5098.235264710286;5101.948980510221;187762;188735;188918;189209;189387;50193.24710129351;50196;50233.24650130251;50336.24495632568;50363.748181259594;51904.48095518997;52603.73962603709;52612.73693631507;52674.20988685173;52687;16620.501384958472;17010.48968530946;17050.658986820443;17070.573235669206;17088.829111708725;11376.203665743318;11518.178046378524;13950.511732089328;14053.43786248559;14174.574762757135;14564.63588410277;14617.78073328901;14629.487967921072;14744.705105897821;14871.405143794344;5937.881242375215;5955.37468565803;6010.4891084258325;6020.638761674313;6022.488088512438;987.6641742279601;1014.8680671512656;1022.846573014039;1026.1893104447404;1036.7822757220918;22853.542929141324;22861.31416057521;22880.88559557225;23247.53504929892;23284.06863725466;1110.5058249079243;1113.3431275547305;1115.6653004098737;1121.0359091181576;1128.768602436515;12144.210626309261;12201.755964880653;12225.388730563436;12310.876891230973;12363.814542781865;220040;221872;222359;222604;223370;54464.45535544594;54830;54934.45065549293;54948.725256373466;55335.723321383135;1497.5657059452853;1535.462588094158;1538.7768773527775;1540.7611820167667;1544.3127808125275;22674;22691;22848.543029139655;22971.081156753542;23078.653820193045;37736.62263377331;37780;37889.4316585257;37932.43101353427;38185.236295274495;188298;190881;191159;192989;193585;35166.296674066885;36952.81523592365;38600.80699596484;38666.42000369941;38669;47008.764956175;48614.756926215145;49178.262326064425;49201.78591963442;49362.75318623384;35022.29955400827;35514.11214719652;35703.28593428169;35856.820715896254;36187.45718814167;35029.299414012086;35146.12134696653;35328.64671353356;35698.46452303165;35949;37066.62933370632;38644.420333695576;38855.22289554137;38919.41620875632;39034.80482597569;30142.397152057274;30334.241643959078;30440;30485.23786905345;30565.388692226476;24780.514025203673;24820.503589928463;25025.74459363554;25156.622650659887;25208.74791252064 11:51:56 INFO - PID 3536 | |2;jquery.html;563.6561697364607;570.3583468597827;577.627430307452;584.5907864494854;603.9245094363205;22472.101115955364;23082.19212327569;23294.767052329473;23311.06755729773;23468.17861374852;25273.241802745903;27313.590296145525;27315.72684273157;27332.863335683294;27383.178504644842;6399;6555.475561955032;6560.475161987029;6560.7047682854145;6569.671516424183;6265.780697675582;6539.117219175398;6542.313057129004;6576.868462630745;6621.73513059477;6494.383033611799;6541.738330466799;6547.967260163692;6553;6553.5740176888585;6491.448226900719;6496.805095847132;6510.869782604369;6521.510886683494;6527.347265273458;6008.639481631116;6041.5468839837185;6052.334243233241;6057.787977420813;6069.211002569682;29215;30165.547516787265;30659.233519161975;30785.38429231425;30972.690273097207;1940.4178746376172;1968.3799603125112;1968.793276705954;1970.2020681623965;1980.9603807923904;19076.90461547697;19597.41207763755;19791.406257812145;19798.802011979984;19814.900925495425;2375.572396968545;2400.59189937711;2418.733939266679;2447.021191523387;2523.116909081825;137609.3119534406;141063;141280;142271.57728422686;143442.28278858642;14318.067060946847;15021.624459388602;15235.695286094438;15398.307076181598;15539.922300388425;23612.64581031286;23771.762282376956;23798.167064152673;23832.404189895045;23848;9997.250206234561;10059.798804023878;10152;10180.083792458714;10369.9481502592;8771.692990745294;9370.90629093714;9382.10869967352;9456.90543094574;9499.810003799885;7889.408294377945;9069.954650226706;9183.127602877716;9241.768955776024;9243.613457981357;2612.6342312076326;2633.433811730487;2719.877605507757;2724.2644485989067;2737.1925282041843;954.7517645412242;976.969297391259;988.3378136648463;993.9353941993747;994.6518718448485;19815.801841981684;20063.29778457747;20304.898475507824;20543.4864128398;20768.169273229203;1047.4396198034167;1051.279873286801;1053.5891002509027;1057.6404022632341;1063.4629512096496;11008.504617292241;11244.26912250701;11419.942900285445;11426.885731142582;11496.252743571642;442143;451827;461363;463734;463879;110496.4475177619;110502.44748776205;111939;112117.43941280404;113665.4316728411;1215.5077193736552;1221.4564518789232;1248.4694005048;1248.6940699528673;1258.5343422933572;18013.369532066314;18042.72935905936;18176.72734908951;18490.722639160693;18686.252549898396;54823.177652336046;54897.45102549083;55966;56311.43688563226;56933;67085;69700.6514967422;69753;69871;70390;12553;13002.934985325013;14503.782443263148;15091.094534327976;21579.676304855755;24405.38986525351;24548.877255613606;24876.12933547317;25235.747642524075;25387;18568.5357866049;18699.34552290663;19630;19662.606747865248;19689.507762305482;17024.489265321565;17396;17436.21537030862;17655.911720441316;17948.55128621795;19461.221551138362;20054.197832086553;20090.799092009478;20103.396898092495;20236.089375978412;21525.138994440673;21537.784622153576;21603.243886463897;21631.675524866823;21632.242871500053;19125.713114303573;19229.90385048066;19286.22855085781;19287.517812054248;19396.2241510338 11:51:56 INFO - PID 3536 | |3;mootools.html;1380.365032085241;1417.865302796234;1438.3671184678747;1438.4246301479407;1442.3653592419334;13345.199288042711;13951.302434878266;13964.581062568139;13980.860191398084;13982.650433739149;13356.732865342712;13947;14338.42646294147;14360.353784079716;14433.27833608318;2348.236823032513;2354.411397150712;2354.540864531417;2358.905643774247;2364.8581085134947;2293.2317673579287;2318.385627808632;2335.3344296875393;2367.2898130560848;2369.9289021329387;2318.4435735423463;2340.8361414700976;2346.9061237550563;2372.79831214347;2386.9283921482383;2285.4514916420108;2299.6895419118455;2308.2959697292317;2316.4787922717337;2316.756740542244;2236.630955892276;2243.4279258789065;2249.4488850231796;2250.2124256510256;2255.2444930947986;13285.3357332133;13606.931965340209;13626.659333516642;13630.727385452334;13631.113977591425;6983.3714965653335;7232.421406287484;7239.674214660353;7239.746608868664;7257.52826066304;4736.242201247784;4907.759021976159;4989.750512474362;5031.245313203049;5031.949680503221;1838.7609610750517;1866.785319688226;1881.9341323053627;1902.3817259390614;1942.1357495914324;21654.675179872156;21767.891160544255;21796.346109616738;21889.452763680874;21949.67075493853;6037.818865434044;6053.424924632153;6067.939320606825;6149;6206.472449841724;15381.538553843402;15464.304106315018;15486.070835749892;15580.688386232212;15676.68646627061;7093.042439270633;7227.457940654472;7234.276572342724;7240.420766338786;7324.523905946096;5371.382291036581;5646.85882852932;5802.65184088956;6778.389944904982;6786;4756.120117778222;4850.078485087822;4855.393075865517;4878.682885612424;4953.7523123844385;1397.1896300146095;1401.0682895874334;1410.4781230944411;1412.4420853762706;1415.8654927781845;888.7333799860146;917.6375331744057;918.9954050229707;922.4603606890045;926.9119433653792;7357.227491113356;7504.474686771873;7521.7743467696055;7560.092788865371;7572.242775722384;702.1188408547342;725.4232884856551;978.5254151736402;1014.5130337438071;1016.7966406718538;4788.162071637449;5035.79856805731;5066.417362003343;5071.721055341992;5116.155834287375;18460.07699615014;18861.339853105077;19011.1444984976;19074.2370305189;19413.611727765365;17714.645707086045;18589.256429742658;18623.348182813806;18625.534361640795;18668;10669.253152279422;10881.183911206534;10881.727956801144;10889.183311251687;10942.343459392461;7620.923790762022;8039.276465118168;8264.669413223404;8364.456310340052;8678;15675.921620391826;16683.49949501517;16779.412720554723;17217.22522486516;17218.05300708473;16723.581910452336;16915.407960721317;16984.66030679404;17188.82811171872;17288.65422691514;11191.72020699489;11515.884841151481;11526.481308340977;11527.250728702607;11529.538818447169;11915.880841191478;12353.567625133077;12498.187617804813;12499.812502812647;12502.937485312515;10530.684079477627;10625.681229563126;10720.517576708911;10772.138228941823;10972.890271097187;10262.589496420358;10376.221783366127;10404.791904161722;10534.631287905193;10605.151587873106;9400.670976515788;9539.666111686058;9543.18882894934;9569.808603828023;9576.90423095788;7266.764650009405;7295.179007627885;7327.157376901724;7344.081989751281;7348.889766653611;7286.890696639449;7331.633418329169;7436.256374362521;7459.813504662427;7497.962510187414 11:51:56 INFO - PID 3536 | |4;prototype.html;502.520093310888;504.53398786391216;512.5771238728048;520.3053923012777;526.037351646487;6204.224471941007;6219.129321894933;6316.4315211631;6333.22669652498;6343.397377249154;5983.252093488314;6087.878242435148;6115.663638499881;6149.784757533487;6152.415520525554;4941.975290123544;4977.576905962997;4992.650514463989;4996.175631020896;5011.3485246918035;4868.659193856432;4938.80244790208;4970.577500912426;4987.75061246938;5020.397552293712;4875.756212189394;4913.82801601944;4924.80300787968;4941.234108713155;4988.201887697969;4934.753262336869;4943.382077240345;4968.453470118284;4979.402471703401;4997.800087996476;4495.550444955511;4506.5493450655;4511.954880451186;4530.365748795171;4557.407537020199;6086;6139.083935130777;6139.3388173831445;6160.2915664698685;6194.1018552310115;5632.8595133849285;5648.943510564883;5740.282464691913;5755.453231942959;5776.797812076557;6572.868542629169;6579.34206579343;6587.736490540373;6598.2822282068555;6624.205095388585;4891.657583969123;4909.361782968192;4933.28467372229;4937.086638971766;4938.38270216223;6858.6570671466225;6892;6953.374196322356;6988.930110698879;7009.859802803915;4917.729524876095;5022.3219865317715;5030.84907452777;5055.140626093573;5066.82266120684;5095.745212739348;5111.846644600668;5117.820876269313;5122.436531981479;5130.48695130484;5697.145428185805;5706.372299047184;5718.285214348207;5764.279465066867;5781.479666830005;6488.971047438273;6532;6562.179727534059;6582.605043697394;6600.372964568358;1694.9406770762964;1697.125980120239;1716.0990479997852;1719.905405202726;1739.1825841854309;1213.5570516761318;1231.5812623707982;1232.7226374065763;1233.6730766346925;1242.6831158054638;5755.625884317506;5772.740226689809;5774.335951365562;5780.1907732917425;5802;6539.313372095861;6584.176977877765;6585.6377899216;6715.966420167868;6744.12326397575;5747.339056008613;5779.913301300484;5798.159266906359;5825.359210486843;5833.970830145822;3528.9823550882084;3566.1262990566956;3580.6240344763423;3599.6220396858475;3615.6565126312958;6497;6543.20494113413;6543.378379053982;6555.508336874658;6630.138082049302;6840.794776156723;6917.827054323682;6946.479014073965;6947.51367404287;7022.12223472066;6445.484361251089;6480.351964803576;6516.380943810331;6562.245341785756;6573.57271777333;6699.76550820719;6777.559458635173;6789.72841086351;6831.248562658005;6839.316068393121;6536.614135840479;6618.933810661832;6703.798886033427;6715.227748808949;6731.259561448334;6371.6814159290925;6478.125453063776;6497.155369801895;6503.382178693017;6546.967265163644;5016.448190699093;5025.422076461107;5045.697258164522;5063.898722025465;5077.644564880571;6711.765088221889;6720.9327906722265;6754.93245067543;6827.385535301847;6879.6560171992205;6447.806565803034;6492.805215843532;6516.250631177475;6529.738810447719;6543.149390579385;6441.323661015714;6525.314841941527;6544.181977252843;6559.868802624016;6566.4418524425955;6166.753329866755;6382.6170429774365;6395.968020159869;6468.611883287018;6470.838229044311;6442.231294692658;6521.445677117498;6543.770968016287;6547.181602299713;6580.2363007536;6306.400891915261;6321.30465648769;6356.586821856565;6373.565947661739;6385.553011289351 11:51:56 INFO - PID 3536 | |5;yui.html;905.9048799876012;912.4160537256155;933.7245512573792;940.482734496027;942.8161508505844;18830.717539236906;19929.202831886727;19944.999999999964;19946.102425390854;21949.890250548724;21787.564248715014;22642;22749;22809.771902280972;22862.88568557159;1034.053840735726;1059.099765199582;1065.5471424644534;1071.464267866067;1072.404815327493;1059.6503153959213;1059.899309565594;1060.8249638809586;1061.4533515239618;1062.7449412141107;1058.767071244325;1110.0564520157882;1110.4836251143217;1112.855328807258;1113.1373185781003;1096.4846522134585;1110.7500812317244;1111.2998810749216;1111.7053980695123;1111.7220694826294;791.8455901099288;796.7251298302076;800.1758189065272;803.9276465118168;804.8229389534351;19806.70289945652;19938.501537461678;20015;20098.598028039505;20526.692099618518;20415.693764593543;20906.268280610257;21883.12467501298;22395.776042239533;22434.88782556093;16603.169841507875;16682.416115435903;16753.329866805314;16755.748663770053;16877.91561042187;3606.9819650901577;3648.033271183112;3655.2872189922978;3656.3966945453967;3662.7252956028406;128716;129449;130656.34671826675;133053;133978;16909.7463538047;17063.744043839353;17354.479365619052;17651.911740441217;17751.99999999974;32733.508997365057;32893.67106328954;32958.34083318368;33344.49983250253;33528.497072543934;7703.460757746904;8000.439969202216;8730.956345218361;8827.426217295855;9276.11876871696;3826.617338266151;3935.940960885589;3953;3960.5643379228263;3965.940510892339;5360.061989151883;5491.533219676372;5516.503514683698;5533.22534845122;5578.972105139448;1034.1726618705006;1041.2971244409994;1050.9421981791074;1055.4933631856597;1065.211743309945;675.4056430341268;692.7229108356597;709.8793205155137;711.1999001123736;720.7765592666291;12393.256404615571;12473.875261247453;12494.562690305978;12728.80906786399;12777.425015874122;642.4988508962923;658.1181217169017;672.4553111979312;689.2418339826152;703.2053779229439;5337.8131765388025;5688.089905615082;5775.422457754191;5845.766169353264;6057.212562366864;105039;107540.462297688;110348;110960.4451977735;112982;87936.56031719928;94144;94754;97402;97771.51114244384;81133.59433202914;82394.76407853886;82491.58754206191;85920;86448.13551864527;11552;11671.824922626338;11958.701032474257;12853.16454430459;12859.421326040538;36552.45171322486;36730.44904326384;37155;38497;39034.80482597569;67913;69236.6538167326;70233.64883175552;72254.63872680813;72491.63754181196;17703.557411064827;19114.52213694669;20003.09986050602;20117.19531218735;20232.89883550573;19530.121144548244;19540.511487212934;20637.380878573666;21044.579108418053;21358.78641213568;19250.326238581583;19897;20091.19635214575;20272.18911243534;20334.898325508868;20061.398158055283;20233.077857603505;20262.797372026092;20263.898680507093;20476.38570842877;18965.90517047406;19230.23079076821;19394.127264272858;19492.512687182934;19810.40568782939;14221.928890355483;14356;14372.640683982983;14373;14497.420103195755;14978.325975330918;14988.400463981754;15503.767443488132;15527.767083493982;15970.20148992569 11:51:56 INFO - PID 3536 | __end_tp_report 11:51:56 INFO - PID 3536 | __start_cc_report 11:51:56 INFO - PID 3536 | _x_x_mozilla_cycle_collect,394 11:51:56 INFO - PID 3536 | __end_cc_report 11:51:56 INFO - PID 3536 | __startTimestamp1501872716002__endTimestamp 11:51:56 INFO - PID 3536 | 11:51:56 INFO - PID 3536 | ------- Summary: start ------- 11:51:56 INFO - PID 3536 | Number of tests: 6 11:51:56 INFO - PID 3536 | 11:51:56 INFO - PID 3536 | [#0] dojo.html Cycles:165 Average:6169.31 Median:6485.51 stddev:776.07 (12.0%) stddev-sans-first:741.41 11:51:56 INFO - PID 3536 | Values: 3149.2 3154.4 3192.7 3199.8 3244.6 6289.3 6323.2 6331.4 6342.0 6362.5 6139.0 6236.3 6241.2 6255.9 6284.3 5651.9 5658.6 5664.7 5677.5 5689.0 5708.3 5709.2 5739.2 5782.5 5800.7 5512.8 5707.7 5718.7 5779.0 5808.4 5216.9 5617.9 5644.2 5733.1 5754.8 5661.8 5686.0 5718.1 5753.7 5767.5 6156.1 6162.8 6214.8 6230.8 6237.4 6678.9 6705.9 6764.4 6765.4 6795.7 6737.2 6755.0 6772.3 6846.4 6867.0 6225.1 6239.6 6298.9 6300.3 6388.5 6970.5 7024.1 7024.7 7026.3 7034.1 6536.1 6537.0 6571.6 6624.1 6624.6 6613.5 6638.1 6693.3 6715.7 6718.4 6608.2 6725.0 6728.3 6731.7 6733.5 6735.3 6773.6 6826.1 6833.7 6842.1 5019.7 5028.1 5033.6 5105.3 5115.9 4267.2 4294.9 4350.9 4354.5 4440.9 5880.4 5900.2 5908.1 5916.1 5927.6 6788.2 6804.8 6870.0 6875.8 6892.9 5721.5 5819.3 5822.8 5865.9 5920.4 5900.3 5915.8 5928.7 5929.7 5932.2 6518.5 6545.2 6563.1 6567.5 6570.8 6707.3 6762.4 6775.6 6792.0 6796.8 6492.2 6537.3 6539.5 6551.4 6554.0 6557.1 6583.5 6595.6 6654.5 6673.2 6643.1 6663.6 6746.9 6766.8 6805.0 6521.2 6524.4 6530.1 6542.8 6546.4 6515.8 6543.9 6544.6 6560.1 6577.0 6417.2 6485.5 6490.4 6515.4 6524.0 6432.4 6532.5 6608.8 6628.6 6630.2 6264.1 6350.7 6360.5 6411.9 6442.7 11:51:56 INFO - PID 3536 | 11:51:56 INFO - PID 3536 | [#1] ext.html Cycles:180 Average:38049.22 Median:3667.55 stddev:52130.06 (1421.4%) stddev-sans-first:52201.33 11:51:56 INFO - PID 3536 | Values: 816.1 863.2 887.5 890.4 1190.3 31826.2 43881.0 44598.1 44603.3 44608.6 44521.8 44858.3 44973.8 45022.8 45143.3 7328.2 7820.6 7976.4 7976.5 7979.3 7762.8 7852.9 7935.9 7938.2 7940.1 7887.5 7893.8 7924.6 7930.4 7954.8 7868.6 7885.4 7887.6 7905.6 7918.5 7419.6 7429.0 7433.1 7457.3 7458.7 40004.0 40462.0 40467.2 40510.4 40558.2 3582.9 3655.0 3657.7 3665.8 3669.3 32293.7 32447.5 32469.2 32488.4 32501.7 5013.9 5071.2 5083.7 5098.2 5101.9 187762.0 188735.0 188918.0 189209.0 189387.0 50193.2 50196.0 50233.2 50336.2 50363.7 51904.5 52603.7 52612.7 52674.2 52687.0 16620.5 17010.5 17050.7 17070.6 17088.8 11376.2 11518.2 13950.5 14053.4 14174.6 14564.6 14617.8 14629.5 14744.7 14871.4 5937.9 5955.4 6010.5 6020.6 6022.5 987.7 1014.9 1022.8 1026.2 1036.8 22853.5 22861.3 22880.9 23247.5 23284.1 1110.5 1113.3 1115.7 1121.0 1128.8 12144.2 12201.8 12225.4 12310.9 12363.8 220040.0 221872.0 222359.0 222604.0 223370.0 54464.5 54830.0 54934.5 54948.7 55335.7 1497.6 1535.5 1538.8 1540.8 1544.3 22674.0 22691.0 22848.5 22971.1 23078.7 37736.6 37780.0 37889.4 37932.4 38185.2 188298.0 190881.0 191159.0 192989.0 193585.0 35166.3 36952.8 38600.8 38666.4 38669.0 47008.8 48614.8 49178.3 49201.8 49362.8 35022.3 35514.1 35703.3 35856.8 36187.5 35029.3 35146.1 35328.6 35698.5 35949.0 37066.6 38644.4 38855.2 38919.4 39034.8 30142.4 30334.2 30440.0 30485.2 30565.4 24780.5 24820.5 25025.7 25156.6 25208.7 11:51:56 INFO - PID 3536 | 11:51:56 INFO - PID 3536 | [#2] jquery.html Cycles:180 Average:34241.03 Median:13073.67 stddev:77348.66 (591.6%) stddev-sans-first:77524.31 11:51:56 INFO - PID 3536 | Values: 563.7 570.4 577.6 584.6 603.9 22472.1 23082.2 23294.8 23311.1 23468.2 25273.2 27313.6 27315.7 27332.9 27383.2 6399.0 6555.5 6560.5 6560.7 6569.7 6265.8 6539.1 6542.3 6576.9 6621.7 6494.4 6541.7 6548.0 6553.0 6553.6 6491.4 6496.8 6510.9 6521.5 6527.3 6008.6 6041.5 6052.3 6057.8 6069.2 29215.0 30165.5 30659.2 30785.4 30972.7 1940.4 1968.4 1968.8 1970.2 1981.0 19076.9 19597.4 19791.4 19798.8 19814.9 2375.6 2400.6 2418.7 2447.0 2523.1 137609.3 141063.0 141280.0 142271.6 143442.3 14318.1 15021.6 15235.7 15398.3 15539.9 23612.6 23771.8 23798.2 23832.4 23848.0 9997.3 10059.8 10152.0 10180.1 10369.9 8771.7 9370.9 9382.1 9456.9 9499.8 7889.4 9070.0 9183.1 9241.8 9243.6 2612.6 2633.4 2719.9 2724.3 2737.2 954.8 977.0 988.3 993.9 994.7 19815.8 20063.3 20304.9 20543.5 20768.2 1047.4 1051.3 1053.6 1057.6 1063.5 11008.5 11244.3 11419.9 11426.9 11496.3 442143.0 451827.0 461363.0 463734.0 463879.0 110496.4 110502.4 111939.0 112117.4 113665.4 1215.5 1221.5 1248.5 1248.7 1258.5 18013.4 18042.7 18176.7 18490.7 18686.3 54823.2 54897.5 55966.0 56311.4 56933.0 67085.0 69700.7 69753.0 69871.0 70390.0 12553.0 13002.9 14503.8 15091.1 21579.7 24405.4 24548.9 24876.1 25235.7 25387.0 18568.5 18699.3 19630.0 19662.6 19689.5 17024.5 17396.0 17436.2 17655.9 17948.6 19461.2 20054.2 20090.8 20103.4 20236.1 21525.1 21537.8 21603.2 21631.7 21632.2 19125.7 19229.9 19286.2 19287.5 19396.2 11:51:56 INFO - PID 3536 | 11:51:56 INFO - PID 3536 | [#3] mootools.html Cycles:180 Average:8479.31 Median:2252.73 stddev:5808.85 (257.9%) stddev-sans-first:5800.66 11:51:56 INFO - PID 3536 | Values: 1380.4 1417.9 1438.4 1438.4 1442.4 13345.2 13951.3 13964.6 13980.9 13982.7 13356.7 13947.0 14338.4 14360.4 14433.3 2348.2 2354.4 2354.5 2358.9 2364.9 2293.2 2318.4 2335.3 2367.3 2369.9 2318.4 2340.8 2346.9 2372.8 2386.9 2285.5 2299.7 2308.3 2316.5 2316.8 2236.6 2243.4 2249.4 2250.2 2255.2 13285.3 13606.9 13626.7 13630.7 13631.1 6983.4 7232.4 7239.7 7239.7 7257.5 4736.2 4907.8 4989.8 5031.2 5031.9 1838.8 1866.8 1881.9 1902.4 1942.1 21654.7 21767.9 21796.3 21889.5 21949.7 6037.8 6053.4 6067.9 6149.0 6206.5 15381.5 15464.3 15486.1 15580.7 15676.7 7093.0 7227.5 7234.3 7240.4 7324.5 5371.4 5646.9 5802.7 6778.4 6786.0 4756.1 4850.1 4855.4 4878.7 4953.8 1397.2 1401.1 1410.5 1412.4 1415.9 888.7 917.6 919.0 922.5 926.9 7357.2 7504.5 7521.8 7560.1 7572.2 702.1 725.4 978.5 1014.5 1016.8 4788.2 5035.8 5066.4 5071.7 5116.2 18460.1 18861.3 19011.1 19074.2 19413.6 17714.6 18589.3 18623.3 18625.5 18668.0 10669.3 10881.2 10881.7 10889.2 10942.3 7620.9 8039.3 8264.7 8364.5 8678.0 15675.9 16683.5 16779.4 17217.2 17218.1 16723.6 16915.4 16984.7 17188.8 17288.7 11191.7 11515.9 11526.5 11527.3 11529.5 11915.9 12353.6 12498.2 12499.8 12502.9 10530.7 10625.7 10720.5 10772.1 10972.9 10262.6 10376.2 10404.8 10534.6 10605.2 9400.7 9539.7 9543.2 9569.8 9576.9 7266.8 7295.2 7327.2 7344.1 7348.9 7286.9 7331.6 7436.3 7459.8 7498.0 11:51:56 INFO - PID 3536 | 11:51:56 INFO - PID 3536 | [#4] prototype.html Cycles:180 Average:5520.93 Median:6144.56 stddev:1549.62 (25.2%) stddev-sans-first:1507.50 11:51:56 INFO - PID 3536 | Values: 502.5 504.5 512.6 520.3 526.0 6204.2 6219.1 6316.4 6333.2 6343.4 5983.3 6087.9 6115.7 6149.8 6152.4 4942.0 4977.6 4992.7 4996.2 5011.3 4868.7 4938.8 4970.6 4987.8 5020.4 4875.8 4913.8 4924.8 4941.2 4988.2 4934.8 4943.4 4968.5 4979.4 4997.8 4495.6 4506.5 4512.0 4530.4 4557.4 6086.0 6139.1 6139.3 6160.3 6194.1 5632.9 5648.9 5740.3 5755.5 5776.8 6572.9 6579.3 6587.7 6598.3 6624.2 4891.7 4909.4 4933.3 4937.1 4938.4 6858.7 6892.0 6953.4 6988.9 7009.9 4917.7 5022.3 5030.8 5055.1 5066.8 5095.7 5111.8 5117.8 5122.4 5130.5 5697.1 5706.4 5718.3 5764.3 5781.5 6489.0 6532.0 6562.2 6582.6 6600.4 1694.9 1697.1 1716.1 1719.9 1739.2 1213.6 1231.6 1232.7 1233.7 1242.7 5755.6 5772.7 5774.3 5780.2 5802.0 6539.3 6584.2 6585.6 6716.0 6744.1 5747.3 5779.9 5798.2 5825.4 5834.0 3529.0 3566.1 3580.6 3599.6 3615.7 6497.0 6543.2 6543.4 6555.5 6630.1 6840.8 6917.8 6946.5 6947.5 7022.1 6445.5 6480.4 6516.4 6562.2 6573.6 6699.8 6777.6 6789.7 6831.2 6839.3 6536.6 6618.9 6703.8 6715.2 6731.3 6371.7 6478.1 6497.2 6503.4 6547.0 5016.4 5025.4 5045.7 5063.9 5077.6 6711.8 6720.9 6754.9 6827.4 6879.7 6447.8 6492.8 6516.3 6529.7 6543.1 6441.3 6525.3 6544.2 6559.9 6566.4 6166.8 6382.6 6396.0 6468.6 6470.8 6442.2 6521.4 6543.8 6547.2 6580.2 6306.4 6321.3 6356.6 6373.6 6385.6 11:51:56 INFO - PID 3536 | 11:51:56 INFO - PID 3536 | [#5] yui.html Cycles:180 Average:24110.17 Median:20263.35 stddev:32117.00 (158.5%) stddev-sans-first:32159.83 11:51:56 INFO - PID 3536 | Values: 905.9 912.4 933.7 940.5 942.8 18830.7 19929.2 19945.0 19946.1 21949.9 21787.6 22642.0 22749.0 22809.8 22862.9 1034.1 1059.1 1065.5 1071.5 1072.4 1059.7 1059.9 1060.8 1061.5 1062.7 1058.8 1110.1 1110.5 1112.9 1113.1 1096.5 1110.8 1111.3 1111.7 1111.7 791.8 796.7 800.2 803.9 804.8 19806.7 19938.5 20015.0 20098.6 20526.7 20415.7 20906.3 21883.1 22395.8 22434.9 16603.2 16682.4 16753.3 16755.7 16877.9 3607.0 3648.0 3655.3 3656.4 3662.7 128716.0 129449.0 130656.3 133053.0 133978.0 16909.7 17063.7 17354.5 17651.9 17752.0 32733.5 32893.7 32958.3 33344.5 33528.5 7703.5 8000.4 8731.0 8827.4 9276.1 3826.6 3935.9 3953.0 3960.6 3965.9 5360.1 5491.5 5516.5 5533.2 5579.0 1034.2 1041.3 1050.9 1055.5 1065.2 675.4 692.7 709.9 711.2 720.8 12393.3 12473.9 12494.6 12728.8 12777.4 642.5 658.1 672.5 689.2 703.2 5337.8 5688.1 5775.4 5845.8 6057.2 105039.0 107540.5 110348.0 110960.4 112982.0 87936.6 94144.0 94754.0 97402.0 97771.5 81133.6 82394.8 82491.6 85920.0 86448.1 11552.0 11671.8 11958.7 12853.2 12859.4 36552.5 36730.4 37155.0 38497.0 39034.8 67913.0 69236.7 70233.6 72254.6 72491.6 17703.6 19114.5 20003.1 20117.2 20232.9 19530.1 19540.5 20637.4 21044.6 21358.8 19250.3 19897.0 20091.2 20272.2 20334.9 20061.4 20233.1 20262.8 20263.9 20476.4 18965.9 19230.2 19394.1 19492.5 19810.4 14221.9 14356.0 14372.6 14373.0 14497.4 14978.3 14988.4 15503.8 15527.8 15970.2 11:51:56 INFO - PID 3536 | -------- Summary: end -------- 11:51:56 INFO - PID 3536 | 11:51:56 INFO - TEST-INFO | 3536: exit 0 11:51:56 INFO - TEST-OK | dromaeo_css | took 1113918ms 11:51:56 INFO - TEST-START | kraken 11:51:56 INFO - Initialising browser for kraken test... 11:51:56 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:59316/getInfo.html -profile /tmp/tmpPJI9as/profile 11:51:56 INFO - TEST-INFO | started process 3905 (/builds/slave/test/build/application/firefox/firefox http://localhost:59316/getInfo.html) 11:52:02 INFO - TEST-INFO | 3905: exit 0 11:52:02 INFO - Browser initialized. 11:52:02 INFO - Running cycle 1/1 for kraken test... 11:52:02 INFO - TEST-INFO | started process 4131 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPJI9as/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 11:52:03 INFO - PID 4131 | 11:52:03 INFO - PID 4131 | (/builds/slave/test/build/application/firefox/firefox:4185): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 11:52:03 INFO - PID 4131 | 11:52:13 INFO - PID 4131 | RSS: Main: 173817856 11:52:13 INFO - PID 4131 | 11:52:16 INFO - PID 4131 | Cycle 1(1): loaded http://localhost:59316/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59316/tests/kraken/driver.html?testName=audio-beat-detection) 11:52:17 INFO - PID 4131 | RSS: Main: 179056640 11:52:17 INFO - PID 4131 | 11:52:20 INFO - PID 4131 | Cycle 1(1): loaded http://localhost:59316/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59316/tests/kraken/driver.html?testName=audio-dft) 11:52:20 INFO - PID 4131 | RSS: Main: 179253248 11:52:20 INFO - PID 4131 | 11:52:23 INFO - PID 4131 | Cycle 1(1): loaded http://localhost:59316/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59316/tests/kraken/driver.html?testName=audio-fft) 11:52:24 INFO - PID 4131 | RSS: Main: 174186496 11:52:24 INFO - PID 4131 | 11:52:26 INFO - PID 4131 | Cycle 1(1): loaded http://localhost:59316/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59316/tests/kraken/driver.html?testName=audio-oscillator) 11:52:27 INFO - PID 4131 | RSS: Main: 174796800 11:52:27 INFO - PID 4131 | 11:52:29 INFO - PID 4131 | Cycle 1(1): loaded http://localhost:59316/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59316/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:52:30 INFO - PID 4131 | RSS: Main: 175714304 11:52:30 INFO - PID 4131 | 11:52:33 INFO - PID 4131 | Cycle 1(1): loaded http://localhost:59316/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59316/tests/kraken/driver.html?testName=imaging-darkroom) 11:52:33 INFO - PID 4131 | RSS: Main: 177590272 11:52:33 INFO - PID 4131 | 11:52:37 INFO - PID 4131 | Cycle 1(1): loaded http://localhost:59316/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59316/tests/kraken/driver.html?testName=imaging-desaturate) 11:52:38 INFO - PID 4131 | RSS: Main: 176799744 11:52:38 INFO - PID 4131 | 11:52:41 INFO - PID 4131 | Cycle 1(1): loaded http://localhost:59316/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59316/tests/kraken/driver.html?testName=json-parse-financial) 11:52:41 INFO - PID 4131 | RSS: Main: 177545216 11:52:41 INFO - PID 4131 | 11:52:43 INFO - PID 4131 | Cycle 1(1): loaded http://localhost:59316/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59316/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:52:44 INFO - PID 4131 | RSS: Main: 177848320 11:52:44 INFO - PID 4131 | 11:52:45 INFO - PID 4131 | Cycle 1(1): loaded http://localhost:59316/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59316/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:52:46 INFO - PID 4131 | RSS: Main: 175067136 11:52:46 INFO - PID 4131 | 11:52:48 INFO - PID 4131 | Cycle 1(1): loaded http://localhost:59316/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59316/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:52:49 INFO - PID 4131 | RSS: Main: 175095808 11:52:49 INFO - PID 4131 | 11:52:52 INFO - PID 4131 | Cycle 1(1): loaded http://localhost:59316/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59316/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:52:52 INFO - PID 4131 | RSS: Main: 175386624 11:52:52 INFO - PID 4131 | 11:52:56 INFO - PID 4131 | Cycle 1(1): loaded http://localhost:59316/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59316/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:52:56 INFO - PID 4131 | RSS: Main: 175521792 11:52:56 INFO - PID 4131 | 11:52:58 INFO - PID 4131 | Cycle 1(1): loaded http://localhost:59316/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59316/tests/kraken/driver.html?testName=ai-astar) 11:52:58 INFO - PID 4131 | RSS: Main: 176328704 11:52:58 INFO - PID 4131 | 11:52:58 INFO - PID 4131 | __start_tp_report 11:52:58 INFO - PID 4131 | _x_x_mozilla_page_load 11:52:58 INFO - PID 4131 | _x_x_mozilla_page_load_details 11:52:58 INFO - PID 4131 | |i|pagename|runs| 11:52:58 INFO - PID 4131 | |0;ai-astar;101;109;105;109;107;108;112;100;109;108 11:52:58 INFO - PID 4131 | |1;audio-beat-detection;150;120;154;167;126;157;152;119;173;118 11:52:58 INFO - PID 4131 | |2;audio-dft;164;167;167;163;162;160;167;167;166;174 11:52:58 INFO - PID 4131 | |3;audio-fft;84;75;74;177;76;77;74;94;101;75 11:52:58 INFO - PID 4131 | |4;audio-oscillator;79;85;129;84;80;81;136;79;87;129 11:52:58 INFO - PID 4131 | |5;imaging-gaussian-blur;118;114;115;114;114;116;117;120;118;115 11:52:58 INFO - PID 4131 | |6;imaging-darkroom;155;157;151;150;151;151;152;151;151;151 11:52:58 INFO - PID 4131 | |7;imaging-desaturate;95;94;94;95;99;98;95;96;96;96 11:52:58 INFO - PID 4131 | |8;json-parse-financial;56;57;55;57;63;59;56;55;59;54 11:52:58 INFO - PID 4131 | |9;json-stringify-tinderbox;54;54;54;54;54;55;53;54;53;56 11:52:58 INFO - PID 4131 | |10;stanford-crypto-aes;84;87;88;103;92;88;79;98;87;76 11:52:58 INFO - PID 4131 | |11;stanford-crypto-ccm;126;136;139;126;139;126;130;127;128;158 11:52:58 INFO - PID 4131 | |12;stanford-crypto-pbkdf2;182;184;175;173;170;177;175;183;175;174 11:52:58 INFO - PID 4131 | |13;stanford-crypto-sha256-iterative;73;65;66;69;67;67;66;67;65;66 11:52:58 INFO - PID 4131 | __end_tp_report 11:52:58 INFO - PID 4131 | __start_cc_report 11:52:58 INFO - PID 4131 | _x_x_mozilla_cycle_collect,989 11:52:58 INFO - PID 4131 | __end_cc_report 11:52:58 INFO - PID 4131 | __startTimestamp1501872778756__endTimestamp 11:52:58 INFO - PID 4131 | 11:52:58 INFO - PID 4131 | ------- Summary: start ------- 11:52:58 INFO - PID 4131 | Number of tests: 14 11:52:58 INFO - PID 4131 | 11:52:58 INFO - PID 4131 | [#0] ai-astar Cycles:10 Average:106.80 Median:108.50 stddev:3.77 (3.5%) stddev-sans-first:3.36 11:52:58 INFO - PID 4131 | Values: 101.0 109.0 105.0 109.0 107.0 108.0 112.0 100.0 109.0 108.0 11:52:58 INFO - PID 4131 | 11:52:58 INFO - PID 4131 | [#1] audio-beat-detection Cycles:10 Average:143.60 Median:153.00 stddev:20.92 (13.7%) stddev-sans-first:22.06 11:52:58 INFO - PID 4131 | Values: 150.0 120.0 154.0 167.0 126.0 157.0 152.0 119.0 173.0 118.0 11:52:58 INFO - PID 4131 | 11:52:58 INFO - PID 4131 | [#2] audio-dft Cycles:10 Average:165.70 Median:167.00 stddev:3.83 (2.3%) stddev-sans-first:4.01 11:52:58 INFO - PID 4131 | Values: 164.0 167.0 167.0 163.0 162.0 160.0 167.0 167.0 166.0 174.0 11:52:58 INFO - PID 4131 | 11:52:58 INFO - PID 4131 | [#3] audio-fft Cycles:10 Average:90.70 Median:75.50 stddev:31.74 (42.0%) stddev-sans-first:33.57 11:52:58 INFO - PID 4131 | Values: 84.0 75.0 74.0 177.0 76.0 77.0 74.0 94.0 101.0 75.0 11:52:58 INFO - PID 4131 | 11:52:58 INFO - PID 4131 | [#4] audio-oscillator Cycles:10 Average:96.90 Median:80.50 stddev:23.98 (29.8%) stddev-sans-first:24.54 11:52:58 INFO - PID 4131 | Values: 79.0 85.0 129.0 84.0 80.0 81.0 136.0 79.0 87.0 129.0 11:52:58 INFO - PID 4131 | 11:52:58 INFO - PID 4131 | [#5] imaging-gaussian-blur Cycles:10 Average:116.10 Median:116.50 stddev:2.08 (1.8%) stddev-sans-first:2.09 11:52:58 INFO - PID 4131 | Values: 118.0 114.0 115.0 114.0 114.0 116.0 117.0 120.0 118.0 115.0 11:52:58 INFO - PID 4131 | 11:52:58 INFO - PID 4131 | [#6] imaging-darkroom Cycles:10 Average:152.00 Median:151.00 stddev:2.21 (1.5%) stddev-sans-first:2.06 11:52:58 INFO - PID 4131 | Values: 155.0 157.0 151.0 150.0 151.0 151.0 152.0 151.0 151.0 151.0 11:52:58 INFO - PID 4131 | 11:52:58 INFO - PID 4131 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:1.62 (1.7%) stddev-sans-first:1.69 11:52:58 INFO - PID 4131 | Values: 95.0 94.0 94.0 95.0 99.0 98.0 95.0 96.0 96.0 96.0 11:52:58 INFO - PID 4131 | 11:52:58 INFO - PID 4131 | [#8] json-parse-financial Cycles:10 Average:57.10 Median:57.00 stddev:2.64 (4.6%) stddev-sans-first:2.77 11:52:58 INFO - PID 4131 | Values: 56.0 57.0 55.0 57.0 63.0 59.0 56.0 55.0 59.0 54.0 11:52:58 INFO - PID 4131 | 11:52:58 INFO - PID 4131 | [#9] json-stringify-tinderbox Cycles:10 Average:54.10 Median:54.00 stddev:0.88 (1.6%) stddev-sans-first:0.93 11:52:58 INFO - PID 4131 | Values: 54.0 54.0 54.0 54.0 54.0 55.0 53.0 54.0 53.0 56.0 11:52:58 INFO - PID 4131 | 11:52:58 INFO - PID 4131 | [#10] stanford-crypto-aes Cycles:10 Average:88.20 Median:87.50 stddev:8.05 (9.2%) stddev-sans-first:8.40 11:52:58 INFO - PID 4131 | Values: 84.0 87.0 88.0 103.0 92.0 88.0 79.0 98.0 87.0 76.0 11:52:58 INFO - PID 4131 | 11:52:58 INFO - PID 4131 | [#11] stanford-crypto-ccm Cycles:10 Average:133.50 Median:133.00 stddev:10.11 (7.6%) stddev-sans-first:10.36 11:52:58 INFO - PID 4131 | Values: 126.0 136.0 139.0 126.0 139.0 126.0 130.0 127.0 128.0 158.0 11:52:58 INFO - PID 4131 | 11:52:58 INFO - PID 4131 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.80 Median:176.00 stddev:4.66 (2.6%) stddev-sans-first:4.55 11:52:58 INFO - PID 4131 | Values: 182.0 184.0 175.0 173.0 170.0 177.0 175.0 183.0 175.0 174.0 11:52:58 INFO - PID 4131 | 11:52:58 INFO - PID 4131 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.10 Median:67.00 stddev:2.38 (3.5%) stddev-sans-first:1.24 11:52:58 INFO - PID 4131 | Values: 73.0 65.0 66.0 69.0 67.0 67.0 66.0 67.0 65.0 66.0 11:52:58 INFO - PID 4131 | -------- Summary: end -------- 11:52:58 INFO - PID 4131 | 11:52:59 INFO - PID 4131 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 11:52:59 INFO - TEST-INFO | 4131: exit 0 11:52:59 INFO - TEST-OK | kraken | took 62843ms 11:52:59 INFO - SUITE-END | took 1176s 11:52:59 INFO - Completed test suite (00:19:37) 11:52:59 INFO - javascript benchmark 11:52:59 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8536.485354794097, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3149.181212884649, 3154.369126174765, 3192.6647701991296, 3199.79201351912, 3244.5619841321413, 6289.339619339972, 6323.241211054674, 6331.39851714087, 6342.0486926960975, 6362.459190968773, 6139.0, 6236.345183755709, 6241.157443745093, 6255.906161407583, 6284.340144284842, 5651.9152212716735, 5658.575606829484, 5664.745086471119, 5677.517411020068, 5688.97155514224, 5708.343540492834, 5709.229254050712, 5739.225204597388, 5782.508486778629, 5800.680962547058, 5512.80705175317, 5707.6575405475805, 5718.7426565804435, 5779.046457334534, 5808.361080281165, 5216.869578260574, 5617.915731264035, 5644.181593668895, 5733.054046082391, 5754.769809207627, 5661.830145095653, 5686.0333743263745, 5718.1136923776885, 5753.683547404891, 5767.480926716574, 6156.076588511714, 6162.7534898604, 6214.751409943597, 6230.813075607739, 6237.438630523275, 6678.866422671568, 6705.899411508832, 6764.391204791543, 6765.391114799691, 6795.694193761293, 6737.157855268091, 6755.020522024279, 6772.255051944282, 6846.383825455733, 6866.965665171692, 6225.066240063981, 6239.563230573816, 6298.905516417258, 6300.3384644612115, 6388.488920886318, 6970.477214208955, 7024.086868707035, 7024.683889224997, 7026.332498412643, 7034.120734908137, 6536.0522724205675, 6537.0, 6571.57284776488, 6624.072629831828, 6624.6025238485845, 6613.503987200979, 6638.070670106189, 6693.2972037935315, 6715.731370745116, 6718.361755633207, 6608.173978252718, 6724.966375168191, 6728.259891411941, 6731.697073631698, 6733.528652994341, 6735.29279425663, 6773.559718618372, 6826.146731658543, 6833.726650934006, 6842.076319696777, 5019.749012549358, 5028.145215313332, 5033.647644664911, 5105.310783044316, 5115.948840511622, 4267.1892340455215, 4294.871153865389, 4350.934735978963, 4354.4992325882295, 4440.934175797785, 5880.411958804171, 5900.232969713909, 5908.054711246266, 5916.1421593868645, 5927.644341339447, 6788.185417749803, 6804.76183333581, 6869.965650171717, 6875.759348422781, 6892.931070689329, 5721.5136713379825, 5819.330776960619, 5822.7670893163795, 5865.882682346414, 5920.437558431942, 5900.321463031721, 5915.822525324247, 5928.703564821742, 5929.733162007634, 5932.169496270526, 6518.543701940914, 6545.247296560957, 6563.146790917151, 6567.507436942248, 6570.77002304917, 6707.262201157771, 6762.425193858577, 6775.593464392152, 6792.049113124265, 6796.830079248059, 6492.220933488012, 6537.313582073813, 6539.476841852736, 6551.4103730664465, 6554.0, 6557.082008518716, 6583.506237032146, 6595.604263744191, 6654.467642588678, 6673.165854268216, 6643.069970204078, 6663.633500157344, 6746.898796517958, 6766.830829229309, 6804.965975170093, 6521.184851893513, 6524.412802847766, 6530.118434011348, 6542.8364290893105, 6546.378094081055, 6515.804525864231, 6543.869122617426, 6544.607323560602, 6560.081588577507, 6577.046328282468, 6417.197850268716, 6485.513586481127, 6490.448311893353, 6515.446187074152, 6524.0, 6432.3567643237175, 6532.510061745293, 6608.8347791305605, 6628.5691430056895, 6630.204375474974, 6264.091706702594, 6350.745970161327, 6360.522960777867, 6411.903821442589, 6442.742290308335], "value": 6108.097803557259, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [816.085983698258, 863.2101627011283, 887.4896934262797, 890.4256754393416, 1190.3096204201563, 31826.20434489139, 43881.0, 44598.108037839265, 44603.33095003577, 44608.55391446085, 44521.77739111308, 44858.32712509315, 44973.77513112438, 45022.774886125604, 45143.322850157194, 7328.230535793745, 7820.608969551514, 7976.441649084566, 7976.521408715466, 7979.281864632182, 7762.7671169865, 7852.882206766903, 7935.880961785578, 7938.245866642688, 7940.1265860755275, 7887.526748395115, 7893.763187104368, 7924.643391047388, 7930.405219608552, 7954.761357159295, 7868.567228802413, 7885.369170466378, 7887.60561971902, 7905.604719763989, 7918.485298455582, 7419.554826710415, 7428.9628551856895, 7433.070866141732, 7457.328840404335, 7458.701651933916, 40004.0, 40462.0, 40467.17897694611, 40510.392344114865, 40558.1888362234, 3582.946255806165, 3655.0, 3657.6708096271464, 3665.816709164531, 3669.284489524544, 32293.70825167014, 32447.51328730071, 32469.188270293194, 32488.350232995443, 32501.674983250337, 5013.949860501385, 5071.188609822448, 5083.720395378253, 5098.235264710286, 5101.948980510221, 187762.0, 188735.0, 188918.0, 189209.0, 189387.0, 50193.24710129351, 50196.0, 50233.24650130251, 50336.24495632568, 50363.748181259594, 51904.48095518997, 52603.73962603709, 52612.73693631507, 52674.20988685173, 52687.0, 16620.501384958472, 17010.48968530946, 17050.658986820443, 17070.573235669206, 17088.829111708725, 11376.203665743318, 11518.178046378524, 13950.511732089328, 14053.43786248559, 14174.574762757135, 14564.63588410277, 14617.78073328901, 14629.487967921072, 14744.705105897821, 14871.405143794344, 5937.881242375215, 5955.37468565803, 6010.4891084258325, 6020.638761674313, 6022.488088512438, 987.6641742279601, 1014.8680671512656, 1022.846573014039, 1026.1893104447404, 1036.7822757220918, 22853.542929141324, 22861.31416057521, 22880.88559557225, 23247.53504929892, 23284.06863725466, 1110.5058249079243, 1113.3431275547305, 1115.6653004098737, 1121.0359091181576, 1128.768602436515, 12144.210626309261, 12201.755964880653, 12225.388730563436, 12310.876891230973, 12363.814542781865, 220040.0, 221872.0, 222359.0, 222604.0, 223370.0, 54464.45535544594, 54830.0, 54934.45065549293, 54948.725256373466, 55335.723321383135, 1497.5657059452853, 1535.462588094158, 1538.7768773527775, 1540.7611820167667, 1544.3127808125275, 22674.0, 22691.0, 22848.543029139655, 22971.081156753542, 23078.653820193045, 37736.62263377331, 37780.0, 37889.4316585257, 37932.43101353427, 38185.236295274495, 188298.0, 190881.0, 191159.0, 192989.0, 193585.0, 35166.296674066885, 36952.81523592365, 38600.80699596484, 38666.42000369941, 38669.0, 47008.764956175, 48614.756926215145, 49178.262326064425, 49201.78591963442, 49362.75318623384, 35022.29955400827, 35514.11214719652, 35703.28593428169, 35856.820715896254, 36187.45718814167, 35029.299414012086, 35146.12134696653, 35328.64671353356, 35698.46452303165, 35949.0, 37066.62933370632, 38644.420333695576, 38855.22289554137, 38919.41620875632, 39034.80482597569, 30142.397152057274, 30334.241643959078, 30440.0, 30485.23786905345, 30565.388692226476, 24780.514025203673, 24820.503589928463, 25025.74459363554, 25156.622650659887, 25208.74791252064], "value": 17668.62350999837, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [563.6561697364607, 570.3583468597827, 577.627430307452, 584.5907864494854, 603.9245094363205, 22472.101115955364, 23082.19212327569, 23294.767052329473, 23311.06755729773, 23468.17861374852, 25273.241802745903, 27313.590296145525, 27315.72684273157, 27332.863335683294, 27383.178504644842, 6399.0, 6555.475561955032, 6560.475161987029, 6560.7047682854145, 6569.671516424183, 6265.780697675582, 6539.117219175398, 6542.313057129004, 6576.868462630745, 6621.73513059477, 6494.383033611799, 6541.738330466799, 6547.967260163692, 6553.0, 6553.5740176888585, 6491.448226900719, 6496.805095847132, 6510.869782604369, 6521.510886683494, 6527.347265273458, 6008.639481631116, 6041.5468839837185, 6052.334243233241, 6057.787977420813, 6069.211002569682, 29215.0, 30165.547516787265, 30659.233519161975, 30785.38429231425, 30972.690273097207, 1940.4178746376172, 1968.3799603125112, 1968.793276705954, 1970.2020681623965, 1980.9603807923904, 19076.90461547697, 19597.41207763755, 19791.406257812145, 19798.802011979984, 19814.900925495425, 2375.572396968545, 2400.59189937711, 2418.733939266679, 2447.021191523387, 2523.116909081825, 137609.3119534406, 141063.0, 141280.0, 142271.57728422686, 143442.28278858642, 14318.067060946847, 15021.624459388602, 15235.695286094438, 15398.307076181598, 15539.922300388425, 23612.64581031286, 23771.762282376956, 23798.167064152673, 23832.404189895045, 23848.0, 9997.250206234561, 10059.798804023878, 10152.0, 10180.083792458714, 10369.9481502592, 8771.692990745294, 9370.90629093714, 9382.10869967352, 9456.90543094574, 9499.810003799885, 7889.408294377945, 9069.954650226706, 9183.127602877716, 9241.768955776024, 9243.613457981357, 2612.6342312076326, 2633.433811730487, 2719.877605507757, 2724.2644485989067, 2737.1925282041843, 954.7517645412242, 976.969297391259, 988.3378136648463, 993.9353941993747, 994.6518718448485, 19815.801841981684, 20063.29778457747, 20304.898475507824, 20543.4864128398, 20768.169273229203, 1047.4396198034167, 1051.279873286801, 1053.5891002509027, 1057.6404022632341, 1063.4629512096496, 11008.504617292241, 11244.26912250701, 11419.942900285445, 11426.885731142582, 11496.252743571642, 442143.0, 451827.0, 461363.0, 463734.0, 463879.0, 110496.4475177619, 110502.44748776205, 111939.0, 112117.43941280404, 113665.4316728411, 1215.5077193736552, 1221.4564518789232, 1248.4694005048, 1248.6940699528673, 1258.5343422933572, 18013.369532066314, 18042.72935905936, 18176.72734908951, 18490.722639160693, 18686.252549898396, 54823.177652336046, 54897.45102549083, 55966.0, 56311.43688563226, 56933.0, 67085.0, 69700.6514967422, 69753.0, 69871.0, 70390.0, 12553.0, 13002.934985325013, 14503.782443263148, 15091.094534327976, 21579.676304855755, 24405.38986525351, 24548.877255613606, 24876.12933547317, 25235.747642524075, 25387.0, 18568.5357866049, 18699.34552290663, 19630.0, 19662.606747865248, 19689.507762305482, 17024.489265321565, 17396.0, 17436.21537030862, 17655.911720441316, 17948.55128621795, 19461.221551138362, 20054.197832086553, 20090.799092009478, 20103.396898092495, 20236.089375978412, 21525.138994440673, 21537.784622153576, 21603.243886463897, 21631.675524866823, 21632.242871500053, 19125.713114303573, 19229.90385048066, 19286.22855085781, 19287.517812054248, 19396.2241510338], "value": 12246.34842077692, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1380.365032085241, 1417.865302796234, 1438.3671184678747, 1438.4246301479407, 1442.3653592419334, 13345.199288042711, 13951.302434878266, 13964.581062568139, 13980.860191398084, 13982.650433739149, 13356.732865342712, 13947.0, 14338.42646294147, 14360.353784079716, 14433.27833608318, 2348.236823032513, 2354.411397150712, 2354.540864531417, 2358.905643774247, 2364.8581085134947, 2293.2317673579287, 2318.385627808632, 2335.3344296875393, 2367.2898130560848, 2369.9289021329387, 2318.4435735423463, 2340.8361414700976, 2346.9061237550563, 2372.79831214347, 2386.9283921482383, 2285.4514916420108, 2299.6895419118455, 2308.2959697292317, 2316.4787922717337, 2316.756740542244, 2236.630955892276, 2243.4279258789065, 2249.4488850231796, 2250.2124256510256, 2255.2444930947986, 13285.3357332133, 13606.931965340209, 13626.659333516642, 13630.727385452334, 13631.113977591425, 6983.3714965653335, 7232.421406287484, 7239.674214660353, 7239.746608868664, 7257.52826066304, 4736.242201247784, 4907.759021976159, 4989.750512474362, 5031.245313203049, 5031.949680503221, 1838.7609610750517, 1866.785319688226, 1881.9341323053627, 1902.3817259390614, 1942.1357495914324, 21654.675179872156, 21767.891160544255, 21796.346109616738, 21889.452763680874, 21949.67075493853, 6037.818865434044, 6053.424924632153, 6067.939320606825, 6149.0, 6206.472449841724, 15381.538553843402, 15464.304106315018, 15486.070835749892, 15580.688386232212, 15676.68646627061, 7093.042439270633, 7227.457940654472, 7234.276572342724, 7240.420766338786, 7324.523905946096, 5371.382291036581, 5646.85882852932, 5802.65184088956, 6778.389944904982, 6786.0, 4756.120117778222, 4850.078485087822, 4855.393075865517, 4878.682885612424, 4953.7523123844385, 1397.1896300146095, 1401.0682895874334, 1410.4781230944411, 1412.4420853762706, 1415.8654927781845, 888.7333799860146, 917.6375331744057, 918.9954050229707, 922.4603606890045, 926.9119433653792, 7357.227491113356, 7504.474686771873, 7521.7743467696055, 7560.092788865371, 7572.242775722384, 702.1188408547342, 725.4232884856551, 978.5254151736402, 1014.5130337438071, 1016.7966406718538, 4788.162071637449, 5035.79856805731, 5066.417362003343, 5071.721055341992, 5116.155834287375, 18460.07699615014, 18861.339853105077, 19011.1444984976, 19074.2370305189, 19413.611727765365, 17714.645707086045, 18589.256429742658, 18623.348182813806, 18625.534361640795, 18668.0, 10669.253152279422, 10881.183911206534, 10881.727956801144, 10889.183311251687, 10942.343459392461, 7620.923790762022, 8039.276465118168, 8264.669413223404, 8364.456310340052, 8678.0, 15675.921620391826, 16683.49949501517, 16779.412720554723, 17217.22522486516, 17218.05300708473, 16723.581910452336, 16915.407960721317, 16984.66030679404, 17188.82811171872, 17288.65422691514, 11191.72020699489, 11515.884841151481, 11526.481308340977, 11527.250728702607, 11529.538818447169, 11915.880841191478, 12353.567625133077, 12498.187617804813, 12499.812502812647, 12502.937485312515, 10530.684079477627, 10625.681229563126, 10720.517576708911, 10772.138228941823, 10972.890271097187, 10262.589496420358, 10376.221783366127, 10404.791904161722, 10534.631287905193, 10605.151587873106, 9400.670976515788, 9539.666111686058, 9543.18882894934, 9569.808603828023, 9576.90423095788, 7266.764650009405, 7295.179007627885, 7327.157376901724, 7344.081989751281, 7348.889766653611, 7286.890696639449, 7331.633418329169, 7436.256374362521, 7459.813504662427, 7497.962510187414], "value": 6137.167376990761, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [502.520093310888, 504.53398786391216, 512.5771238728048, 520.3053923012777, 526.037351646487, 6204.224471941007, 6219.129321894933, 6316.4315211631, 6333.22669652498, 6343.397377249154, 5983.252093488314, 6087.878242435148, 6115.663638499881, 6149.784757533487, 6152.415520525554, 4941.975290123544, 4977.576905962997, 4992.650514463989, 4996.175631020896, 5011.3485246918035, 4868.659193856432, 4938.80244790208, 4970.577500912426, 4987.75061246938, 5020.397552293712, 4875.756212189394, 4913.82801601944, 4924.80300787968, 4941.234108713155, 4988.201887697969, 4934.753262336869, 4943.382077240345, 4968.453470118284, 4979.402471703401, 4997.800087996476, 4495.550444955511, 4506.5493450655, 4511.954880451186, 4530.365748795171, 4557.407537020199, 6086.0, 6139.083935130777, 6139.3388173831445, 6160.2915664698685, 6194.1018552310115, 5632.8595133849285, 5648.943510564883, 5740.282464691913, 5755.453231942959, 5776.797812076557, 6572.868542629169, 6579.34206579343, 6587.736490540373, 6598.2822282068555, 6624.205095388585, 4891.657583969123, 4909.361782968192, 4933.28467372229, 4937.086638971766, 4938.38270216223, 6858.6570671466225, 6892.0, 6953.374196322356, 6988.930110698879, 7009.859802803915, 4917.729524876095, 5022.3219865317715, 5030.84907452777, 5055.140626093573, 5066.82266120684, 5095.745212739348, 5111.846644600668, 5117.820876269313, 5122.436531981479, 5130.48695130484, 5697.145428185805, 5706.372299047184, 5718.285214348207, 5764.279465066867, 5781.479666830005, 6488.971047438273, 6532.0, 6562.179727534059, 6582.605043697394, 6600.372964568358, 1694.9406770762964, 1697.125980120239, 1716.0990479997852, 1719.905405202726, 1739.1825841854309, 1213.5570516761318, 1231.5812623707982, 1232.7226374065763, 1233.6730766346925, 1242.6831158054638, 5755.625884317506, 5772.740226689809, 5774.335951365562, 5780.1907732917425, 5802.0, 6539.313372095861, 6584.176977877765, 6585.6377899216, 6715.966420167868, 6744.12326397575, 5747.339056008613, 5779.913301300484, 5798.159266906359, 5825.359210486843, 5833.970830145822, 3528.9823550882084, 3566.1262990566956, 3580.6240344763423, 3599.6220396858475, 3615.6565126312958, 6497.0, 6543.20494113413, 6543.378379053982, 6555.508336874658, 6630.138082049302, 6840.794776156723, 6917.827054323682, 6946.479014073965, 6947.51367404287, 7022.12223472066, 6445.484361251089, 6480.351964803576, 6516.380943810331, 6562.245341785756, 6573.57271777333, 6699.76550820719, 6777.559458635173, 6789.72841086351, 6831.248562658005, 6839.316068393121, 6536.614135840479, 6618.933810661832, 6703.798886033427, 6715.227748808949, 6731.259561448334, 6371.6814159290925, 6478.125453063776, 6497.155369801895, 6503.382178693017, 6546.967265163644, 5016.448190699093, 5025.422076461107, 5045.697258164522, 5063.898722025465, 5077.644564880571, 6711.765088221889, 6720.9327906722265, 6754.93245067543, 6827.385535301847, 6879.6560171992205, 6447.806565803034, 6492.805215843532, 6516.250631177475, 6529.738810447719, 6543.149390579385, 6441.323661015714, 6525.314841941527, 6544.181977252843, 6559.868802624016, 6566.4418524425955, 6166.753329866755, 6382.6170429774365, 6395.968020159869, 6468.611883287018, 6470.838229044311, 6442.231294692658, 6521.445677117498, 6543.770968016287, 6547.181602299713, 6580.2363007536, 6306.400891915261, 6321.30465648769, 6356.586821856565, 6373.565947661739, 6385.553011289351], "value": 5063.438216049693, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [905.9048799876012, 912.4160537256155, 933.7245512573792, 940.482734496027, 942.8161508505844, 18830.717539236906, 19929.202831886727, 19944.999999999964, 19946.102425390854, 21949.890250548724, 21787.564248715014, 22642.0, 22749.0, 22809.771902280972, 22862.88568557159, 1034.053840735726, 1059.099765199582, 1065.5471424644534, 1071.464267866067, 1072.404815327493, 1059.6503153959213, 1059.899309565594, 1060.8249638809586, 1061.4533515239618, 1062.7449412141107, 1058.767071244325, 1110.0564520157882, 1110.4836251143217, 1112.855328807258, 1113.1373185781003, 1096.4846522134585, 1110.7500812317244, 1111.2998810749216, 1111.7053980695123, 1111.7220694826294, 791.8455901099288, 796.7251298302076, 800.1758189065272, 803.9276465118168, 804.8229389534351, 19806.70289945652, 19938.501537461678, 20015.0, 20098.598028039505, 20526.692099618518, 20415.693764593543, 20906.268280610257, 21883.12467501298, 22395.776042239533, 22434.88782556093, 16603.169841507875, 16682.416115435903, 16753.329866805314, 16755.748663770053, 16877.91561042187, 3606.9819650901577, 3648.033271183112, 3655.2872189922978, 3656.3966945453967, 3662.7252956028406, 128716.0, 129449.0, 130656.34671826675, 133053.0, 133978.0, 16909.7463538047, 17063.744043839353, 17354.479365619052, 17651.911740441217, 17751.99999999974, 32733.508997365057, 32893.67106328954, 32958.34083318368, 33344.49983250253, 33528.497072543934, 7703.460757746904, 8000.439969202216, 8730.956345218361, 8827.426217295855, 9276.11876871696, 3826.617338266151, 3935.940960885589, 3953.0, 3960.5643379228263, 3965.940510892339, 5360.061989151883, 5491.533219676372, 5516.503514683698, 5533.22534845122, 5578.972105139448, 1034.1726618705006, 1041.2971244409994, 1050.9421981791074, 1055.4933631856597, 1065.211743309945, 675.4056430341268, 692.7229108356597, 709.8793205155137, 711.1999001123736, 720.7765592666291, 12393.256404615571, 12473.875261247453, 12494.562690305978, 12728.80906786399, 12777.425015874122, 642.4988508962923, 658.1181217169017, 672.4553111979312, 689.2418339826152, 703.2053779229439, 5337.8131765388025, 5688.089905615082, 5775.422457754191, 5845.766169353264, 6057.212562366864, 105039.0, 107540.462297688, 110348.0, 110960.4451977735, 112982.0, 87936.56031719928, 94144.0, 94754.0, 97402.0, 97771.51114244384, 81133.59433202914, 82394.76407853886, 82491.58754206191, 85920.0, 86448.13551864527, 11552.0, 11671.824922626338, 11958.701032474257, 12853.16454430459, 12859.421326040538, 36552.45171322486, 36730.44904326384, 37155.0, 38497.0, 39034.80482597569, 67913.0, 69236.6538167326, 70233.64883175552, 72254.63872680813, 72491.63754181196, 17703.557411064827, 19114.52213694669, 20003.09986050602, 20117.19531218735, 20232.89883550573, 19530.121144548244, 19540.511487212934, 20637.380878573666, 21044.579108418053, 21358.78641213568, 19250.326238581583, 19897.0, 20091.19635214575, 20272.18911243534, 20334.898325508868, 20061.398158055283, 20233.077857603505, 20262.797372026092, 20263.898680507093, 20476.38570842877, 18965.90517047406, 19230.23079076821, 19394.127264272858, 19492.512687182934, 19810.40568782939, 14221.928890355483, 14356.0, 14372.640683982983, 14373.0, 14497.420103195755, 14978.325975330918, 14988.400463981754, 15503.767443488132, 15527.767083493982, 15970.20148992569], "value": 9421.439965664818, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1544.3999999999996, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 109.0, 105.0, 109.0, 107.0, 108.0, 112.0, 100.0, 109.0, 108.0], "value": 106.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 120.0, 154.0, 167.0, 126.0, 157.0, 152.0, 119.0, 173.0, 118.0], "value": 143.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 167.0, 167.0, 163.0, 162.0, 160.0, 167.0, 167.0, 166.0, 174.0], "value": 165.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 75.0, 74.0, 177.0, 76.0, 77.0, 74.0, 94.0, 101.0, 75.0], "value": 90.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 85.0, 129.0, 84.0, 80.0, 81.0, 136.0, 79.0, 87.0, 129.0], "value": 96.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 114.0, 115.0, 114.0, 114.0, 116.0, 117.0, 120.0, 118.0, 115.0], "value": 116.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 157.0, 151.0, 150.0, 151.0, 151.0, 152.0, 151.0, 151.0, 151.0], "value": 152.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 94.0, 95.0, 99.0, 98.0, 95.0, 96.0, 96.0, 96.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 57.0, 55.0, 57.0, 63.0, 59.0, 56.0, 55.0, 59.0, 54.0], "value": 57.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 54.0, 54.0, 54.0, 55.0, 53.0, 54.0, 53.0, 56.0], "value": 54.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 87.0, 88.0, 103.0, 92.0, 88.0, 79.0, 98.0, 87.0, 76.0], "value": 88.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 136.0, 139.0, 126.0, 139.0, 126.0, 130.0, 127.0, 128.0, 158.0], "value": 133.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 184.0, 175.0, 173.0, 170.0, 177.0, 175.0, 183.0, 175.0, 174.0], "value": 176.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 65.0, 66.0, 69.0, 67.0, 67.0, 66.0, 67.0, 65.0, 66.0], "value": 67.1, "unit": "score"}]}]} 11:52:59 INFO - Return code: 0 11:53:00 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:53:00 INFO - # TBPL SUCCESS # 11:53:00 INFO - Running post-action listener: _package_coverage_data 11:53:00 INFO - Running post-action listener: _resource_record_post_action 11:53:00 INFO - [mozharness: 2017-08-04 18:53:00.064376Z] Finished run-tests step (success) 11:53:00 INFO - Running post-run listener: _resource_record_post_run 11:53:00 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 5541888; Write bytes: 340201472; Read time: 2184; Write time: 273216 11:53:00 INFO - TinderboxPrint: CPU usage
13.2% 11:53:00 INFO - TinderboxPrint: I/O read bytes / time
5,541,888 / 2,184 11:53:00 INFO - TinderboxPrint: I/O write bytes / time
340,201,472 / 273,216 11:53:00 INFO - TinderboxPrint: CPU idle
8,275.8 (86.8%) 11:53:00 INFO - TinderboxPrint: CPU user
1,206.2 (12.6%) 11:53:00 INFO - TinderboxPrint: Swap in / out
0 / 0 11:53:00 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 13164544; Read time: 0; Write time: 9076 11:53:00 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 11:53:00 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 3506176; Write bytes: 289968128; Read time: 1928; Write time: 246672 11:53:00 INFO - Running post-run listener: _upload_blobber_files 11:53:00 INFO - Blob upload gear active. 11:53:00 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:53:00 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 11:53:00 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'] 11:53:00 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 11:53:01 INFO - (blobuploader) - INFO - Open directory for files ... 11:53:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:53:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:53:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:53:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:53:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:53:01 INFO - (blobuploader) - INFO - Done attempting. 11:53:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 11:53:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:53:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:53:02 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 11:53:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:53:02 INFO - (blobuploader) - INFO - Done attempting. 11:53:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:53:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:53:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:53:06 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:53:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:53:06 INFO - (blobuploader) - INFO - Done attempting. 11:53:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:53:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:53:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:53:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:53:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:53:06 INFO - (blobuploader) - INFO - Done attempting. 11:53:06 INFO - (blobuploader) - INFO - Iteration through files over. 11:53:06 INFO - Return code: 0 11:53:06 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:53:06 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:53:06 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8777336643ee91e104fec56fe384804a43d0a65c58f110c253e1cd15f634b156a52bf999ec272b3916018ab7947a9fa168ae047a4362c1133c04b5607bcb8452", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b994c452fc5176f671f4dda3a50134b2abf51d94c87946a97dd3f1c4d374924df5d999b1a37791ba76524ac6e3388be6f478c04cb8fd86b9e8f0ef0917bdc314", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/de9b161fd28a2e337ecf4289dedce308a63d0cd669603815e81f6fcb76f5c5bd00ab2cb7c8afc85ba2bcfcff7fc7748bae16340e04f1d9d6937456c40351d5f6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dbdd1286e4158e181af1a5edf18131d34a4e428a7348cb175f8c935014d3d96e7948195c27c5636fc73efc3b86d808165049abb4bd37572636bc3ef0fef6916f"} 11:53:06 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:53:06 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:53:06 INFO - Contents: 11:53:06 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8777336643ee91e104fec56fe384804a43d0a65c58f110c253e1cd15f634b156a52bf999ec272b3916018ab7947a9fa168ae047a4362c1133c04b5607bcb8452", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b994c452fc5176f671f4dda3a50134b2abf51d94c87946a97dd3f1c4d374924df5d999b1a37791ba76524ac6e3388be6f478c04cb8fd86b9e8f0ef0917bdc314", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/de9b161fd28a2e337ecf4289dedce308a63d0cd669603815e81f6fcb76f5c5bd00ab2cb7c8afc85ba2bcfcff7fc7748bae16340e04f1d9d6937456c40351d5f6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dbdd1286e4158e181af1a5edf18131d34a4e428a7348cb175f8c935014d3d96e7948195c27c5636fc73efc3b86d808165049abb4bd37572636bc3ef0fef6916f"} 11:53:06 INFO - Running post-run listener: copy_logs_to_upload_dir 11:53:06 INFO - Copying logs to upload dir... 11:53:06 INFO - mkdir: /builds/slave/test/build/upload/logs 11:53:06 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1317.547491 ========= master_lag: -0.46 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 57 secs) (at 2017-08-04 11:53:06.741586) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-04 11:53:06.745410) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1501871467.645597-2068506153 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8777336643ee91e104fec56fe384804a43d0a65c58f110c253e1cd15f634b156a52bf999ec272b3916018ab7947a9fa168ae047a4362c1133c04b5607bcb8452", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b994c452fc5176f671f4dda3a50134b2abf51d94c87946a97dd3f1c4d374924df5d999b1a37791ba76524ac6e3388be6f478c04cb8fd86b9e8f0ef0917bdc314", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/de9b161fd28a2e337ecf4289dedce308a63d0cd669603815e81f6fcb76f5c5bd00ab2cb7c8afc85ba2bcfcff7fc7748bae16340e04f1d9d6937456c40351d5f6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dbdd1286e4158e181af1a5edf18131d34a4e428a7348cb175f8c935014d3d96e7948195c27c5636fc73efc3b86d808165049abb4bd37572636bc3ef0fef6916f"} build_url:https://queue.taskcluster.net/v1/task/Q6EcMmQCRh-0euMeGSZPJw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011258 build_url: 'https://queue.taskcluster.net/v1/task/Q6EcMmQCRh-0euMeGSZPJw/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8777336643ee91e104fec56fe384804a43d0a65c58f110c253e1cd15f634b156a52bf999ec272b3916018ab7947a9fa168ae047a4362c1133c04b5607bcb8452", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b994c452fc5176f671f4dda3a50134b2abf51d94c87946a97dd3f1c4d374924df5d999b1a37791ba76524ac6e3388be6f478c04cb8fd86b9e8f0ef0917bdc314", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/de9b161fd28a2e337ecf4289dedce308a63d0cd669603815e81f6fcb76f5c5bd00ab2cb7c8afc85ba2bcfcff7fc7748bae16340e04f1d9d6937456c40351d5f6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dbdd1286e4158e181af1a5edf18131d34a4e428a7348cb175f8c935014d3d96e7948195c27c5636fc73efc3b86d808165049abb4bd37572636bc3ef0fef6916f"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-08-04 11:53:06.769985) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-04 11:53:06.770305) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1501871467.645597-2068506153 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004443 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-08-04 11:53:06.855006) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-04 11:53:06.855331) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-08-04 11:53:06.855620) ========= ========= Total master_lag: -0.31 =========