builder: mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s slave: talos-linux64-ix-062 starttime: 1495719963.43 results: success (0) revision: 23a341e9b53d04f80ea6a66ced2d72cdc17afffb ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-25 06:46:03.431695) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-25 06:46:03.432165) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-25 06:46:03.432440) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-25 06:46:03.448009) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-25 06:46:03.448320) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1495719963.68497-806580313 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-25 06:46:03-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 119M=0s 2017-05-25 06:46:03 (119 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.113090 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-25 06:46:03.574658) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-25 06:46:03.575004) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1495719963.68497-806580313 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017622 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-25 06:46:03.624484) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-25 06:46:03.624821) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 23a341e9b53d04f80ea6a66ced2d72cdc17afffb --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 23a341e9b53d04f80ea6a66ced2d72cdc17afffb --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=a4ce256d2ec601f24a60a71e000001bc-1495719963.68497-806580313 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-25 06:46:03,910 truncating revision to first 12 chars 2017-05-25 06:46:03,910 Setting DEBUG logging. 2017-05-25 06:46:03,910 attempt 1/10 2017-05-25 06:46:03,910 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/23a341e9b53d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-25 06:46:04,222 unpacking tar archive at: mozilla-central-23a341e9b53d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.628783 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-25 06:46:04.265827) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-25 06:46:04.266145) ========= script_repo_revision: 23a341e9b53d04f80ea6a66ced2d72cdc17afffb ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-25 06:46:04.266506) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-25 06:46:04.266779) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-25 06:46:04.273255) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 55 secs) (at 2017-05-25 06:46:04.273557) ========= /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=a4ce256d2ec601f24a60a71e000001bc-1495719963.68497-806580313 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:46:04 INFO - MultiFileLogger online at 20170525 06:46:04 in /builds/slave/test 06:46:04 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 06:46:04 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:46:04 INFO - {'append_to_log': False, 06:46:04 INFO - 'base_work_dir': '/builds/slave/test', 06:46:04 INFO - 'blob_upload_branch': 'Firefox', 06:46:04 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:46:04 INFO - 'branch': 'Firefox', 06:46:04 INFO - 'buildbot_json_path': 'buildprops.json', 06:46:04 INFO - 'config_files': ('talos/linux_config.py',), 06:46:04 INFO - 'default_actions': ('clobber', 06:46:04 INFO - 'read-buildbot-config', 06:46:04 INFO - 'download-and-extract', 06:46:04 INFO - 'populate-webroot', 06:46:04 INFO - 'create-virtualenv', 06:46:04 INFO - 'install', 06:46:04 INFO - 'run-tests'), 06:46:04 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:46:04 INFO - 'download_minidump_stackwalk': True, 06:46:04 INFO - 'download_symbols': 'ondemand', 06:46:04 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:46:04 INFO - 'tooltool.py': '/tools/tooltool.py', 06:46:04 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:46:04 INFO - '/tools/misc-python/virtualenv.py')}, 06:46:04 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:46:04 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:46:04 INFO - 'gecko_profile': False, 06:46:04 INFO - 'gecko_profile_interval': 0, 06:46:04 INFO - 'installer_path': 'installer.exe', 06:46:04 INFO - 'log_level': 'info', 06:46:04 INFO - 'log_name': 'talos', 06:46:04 INFO - 'log_to_console': True, 06:46:04 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:46:04 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:46:04 INFO - 'opt_config_files': (), 06:46:04 INFO - 'pip_index': False, 06:46:04 INFO - 'suite': 'dromaeojs-e10s', 06:46:04 INFO - 'system_bits': '32', 06:46:04 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:46:04 INFO - 'title': 'talos-linux64-ix-062', 06:46:04 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:46:04 INFO - 'use_talos_json': True, 06:46:04 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:46:04 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:46:04 INFO - 'work_dir': 'build'} 06:46:04 INFO - [mozharness: 2017-05-25 13:46:04.665845Z] Running clobber step. 06:46:04 INFO - Running pre-action listener: _resource_record_pre_action 06:46:04 INFO - Running main action method: clobber 06:46:04 INFO - rmtree: /builds/slave/test/build 06:46:04 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:46:05 INFO - Running post-action listener: _resource_record_post_action 06:46:05 INFO - [mozharness: 2017-05-25 13:46:05.795961Z] Finished clobber step (success) 06:46:05 INFO - [mozharness: 2017-05-25 13:46:05.796063Z] Running read-buildbot-config step. 06:46:05 INFO - Running pre-action listener: _resource_record_pre_action 06:46:05 INFO - Running main action method: read_buildbot_config 06:46:05 INFO - Using buildbot properties: 06:46:05 INFO - { 06:46:05 INFO - "project": "", 06:46:05 INFO - "product": "firefox", 06:46:05 INFO - "who": "Callek@gmail.com", 06:46:05 INFO - "installer_path": "public/build/target.tar.bz2", 06:46:05 INFO - "builddir": "mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s", 06:46:05 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 06:46:05 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo-sequential mozilla-central talos dromaeojs-e10s", 06:46:05 INFO - "stage_platform": "linux64-stylosequential", 06:46:05 INFO - "basedir": "/builds/slave/test", 06:46:05 INFO - "buildnumber": 18, 06:46:05 INFO - "platform": "ubuntu64_hw_styloseq", 06:46:05 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 06:46:05 INFO - "slavebuilddir": "test", 06:46:05 INFO - "taskId": "IiPQajeVQ1Gy4we3mObTEg", 06:46:05 INFO - "branch": "mozilla-central", 06:46:05 INFO - "script_repo_revision": "production", 06:46:05 INFO - "revision": "23a341e9b53d04f80ea6a66ced2d72cdc17afffb", 06:46:05 INFO - "slavename": "talos-linux64-ix-062", 06:46:05 INFO - "repo_path": "mozilla-central" 06:46:05 INFO - } 06:46:05 INFO - Finding installer, test and symbols from parent task. 06:46:05 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IiPQajeVQ1Gy4we3mObTEg'}, attempt #1 06:46:06 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IiPQajeVQ1Gy4we3mObTEg'}, attempt #1 06:46:06 INFO - Task dependencies: SRns4UVsTaicCBZLhqaQ2w 06:46:06 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SRns4UVsTaicCBZLhqaQ2w'}, attempt #1 06:46:07 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/SRns4UVsTaicCBZLhqaQ2w/artifacts/public/build/target.tar.bz2 06:46:07 INFO - Set test_url: https://queue.taskcluster.net/v1/task/SRns4UVsTaicCBZLhqaQ2w/artifacts/public/build/test_packages.json 06:46:07 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/SRns4UVsTaicCBZLhqaQ2w/artifacts/public/build/target.crashreporter-symbols.zip 06:46:07 INFO - Running post-action listener: _resource_record_post_action 06:46:07 INFO - [mozharness: 2017-05-25 13:46:07.158347Z] Finished read-buildbot-config step (success) 06:46:07 INFO - [mozharness: 2017-05-25 13:46:07.158568Z] Running download-and-extract step. 06:46:07 INFO - Running pre-action listener: _resource_record_pre_action 06:46:07 INFO - Running main action method: download_and_extract 06:46:07 INFO - mkdir: /builds/slave/test/build/tests 06:46:07 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')]} 06:46:07 INFO - trying https://queue.taskcluster.net/v1/task/SRns4UVsTaicCBZLhqaQ2w/artifacts/public/build/target.test_packages.json 06:46:07 INFO - Downloading https://queue.taskcluster.net/v1/task/SRns4UVsTaicCBZLhqaQ2w/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 06:46:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SRns4UVsTaicCBZLhqaQ2w/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 06:46:07 INFO - Downloaded 986 bytes. 06:46:07 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 06:46:07 INFO - Using the following test package requirements: 06:46:07 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 06:46:07 INFO - u'common': [u'target.common.tests.zip'], 06:46:07 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 06:46:07 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 06:46:07 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 06:46:07 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 06:46:07 INFO - u'mozbase': [u'target.common.tests.zip'], 06:46:07 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 06:46:07 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 06:46:07 INFO - u'web-platform': [u'target.common.tests.zip', 06:46:07 INFO - u'target.web-platform.tests.zip'], 06:46:07 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 06:46:07 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 06:46:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SRns4UVsTaicCBZLhqaQ2w/artifacts/public/build/target.common.tests.zip 06:46:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SRns4UVsTaicCBZLhqaQ2w/artifacts/public/build/target.common.tests.zip'}, attempt #1 06:46:07 INFO - Fetch https://queue.taskcluster.net/v1/task/SRns4UVsTaicCBZLhqaQ2w/artifacts/public/build/target.common.tests.zip into memory 06:46:08 INFO - Content-Length response header: 63524836 06:46:08 INFO - Bytes received: 63524836 06:46:19 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 06:46:19 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SRns4UVsTaicCBZLhqaQ2w/artifacts/public/build/target.common.tests.zip 06:46:19 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SRns4UVsTaicCBZLhqaQ2w/artifacts/public/build/target.common.tests.zip'}, attempt #1 06:46:19 INFO - Fetch https://queue.taskcluster.net/v1/task/SRns4UVsTaicCBZLhqaQ2w/artifacts/public/build/target.common.tests.zip into memory 06:46:20 INFO - Content-Length response header: 63524836 06:46:20 INFO - Bytes received: 63524836 06:46:32 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SRns4UVsTaicCBZLhqaQ2w/artifacts/public/build/target.talos.tests.zip 06:46:32 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SRns4UVsTaicCBZLhqaQ2w/artifacts/public/build/target.talos.tests.zip'}, attempt #1 06:46:32 INFO - Fetch https://queue.taskcluster.net/v1/task/SRns4UVsTaicCBZLhqaQ2w/artifacts/public/build/target.talos.tests.zip into memory 06:46:33 INFO - Content-Length response header: 14411859 06:46:33 INFO - Bytes received: 14411859 06:46:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:46:33 INFO - trying https://queue.taskcluster.net/v1/task/SRns4UVsTaicCBZLhqaQ2w/artifacts/public/build/target.tar.bz2 06:46:33 INFO - Downloading https://queue.taskcluster.net/v1/task/SRns4UVsTaicCBZLhqaQ2w/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 06:46:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SRns4UVsTaicCBZLhqaQ2w/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 06:46:34 INFO - Downloaded 55586350 bytes. 06:46:34 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/SRns4UVsTaicCBZLhqaQ2w/artifacts/public/build/target.tar.bz2 06:46:34 INFO - mkdir: /builds/slave/test/properties 06:46:34 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:46:34 INFO - Writing to file /builds/slave/test/properties/build_url 06:46:34 INFO - Contents: 06:46:34 INFO - build_url:https://queue.taskcluster.net/v1/task/SRns4UVsTaicCBZLhqaQ2w/artifacts/public/build/target.tar.bz2 06:46:34 INFO - Running post-action listener: _resource_record_post_action 06:46:34 INFO - Running post-action listener: set_extra_try_arguments 06:46:34 INFO - [mozharness: 2017-05-25 13:46:34.900629Z] Finished download-and-extract step (success) 06:46:34 INFO - [mozharness: 2017-05-25 13:46:34.900726Z] Running populate-webroot step. 06:46:34 INFO - Running pre-action listener: _resource_record_pre_action 06:46:34 INFO - Running main action method: populate_webroot 06:46:34 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:46:34 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:46:34 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:46:34 INFO - '--tppagecycles', 06:46:34 INFO - '7'], 06:46:34 INFO - 'tests': ['tsvgm']}}, 06:46:34 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:46:34 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:46:34 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:46:34 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:46:34 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:46:34 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:46:34 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 06:46:34 INFO - 'talos_options': ['--disable-e10s'], 06:46:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:46:34 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 06:46:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:46:34 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 06:46:34 INFO - 'talos_options': ['--disable-e10s'], 06:46:34 INFO - 'tests': ['damp', 'tps']}, 06:46:34 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 06:46:34 INFO - 'tests': ['damp', 'tps']}, 06:46:34 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:46:34 INFO - 'tests': ['dromaeo_dom']}, 06:46:34 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:46:34 INFO - 'g4': {'talos_options': ['--disable-e10s'], 06:46:34 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 06:46:34 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 06:46:34 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 06:46:34 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 06:46:34 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:46:34 INFO - 'tests': ['a11yr', 06:46:34 INFO - 'ts_paint', 06:46:34 INFO - 'tpaint', 06:46:34 INFO - 'sessionrestore', 06:46:34 INFO - 'sessionrestore_no_auto_restore', 06:46:34 INFO - 'tabpaint']}, 06:46:34 INFO - 'other-e10s': {'tests': ['a11yr', 06:46:34 INFO - 'ts_paint', 06:46:34 INFO - 'tpaint', 06:46:34 INFO - 'sessionrestore', 06:46:34 INFO - 'sessionrestore_no_auto_restore', 06:46:34 INFO - 'tabpaint']}, 06:46:34 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:46:34 INFO - 'ts_paint', 06:46:34 INFO - 'tpaint', 06:46:34 INFO - 'sessionrestore', 06:46:34 INFO - 'sessionrestore_no_auto_restore', 06:46:34 INFO - 'tabpaint']}, 06:46:34 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:46:34 INFO - 'ts_paint', 06:46:34 INFO - 'tpaint', 06:46:34 INFO - 'sessionrestore', 06:46:34 INFO - 'sessionrestore_no_auto_restore', 06:46:34 INFO - 'tabpaint']}, 06:46:34 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:46:34 INFO - 'tests': ['a11yr', 06:46:34 INFO - 'ts_paint', 06:46:34 INFO - 'tpaint', 06:46:34 INFO - 'sessionrestore', 06:46:34 INFO - 'sessionrestore_no_auto_restore', 06:46:34 INFO - 'tabpaint']}, 06:46:34 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:46:34 INFO - 'tests': ['a11yr', 06:46:34 INFO - 'ts_paint', 06:46:34 INFO - 'tpaint', 06:46:34 INFO - 'sessionrestore', 06:46:34 INFO - 'sessionrestore_no_auto_restore', 06:46:34 INFO - 'tabpaint']}, 06:46:34 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 06:46:34 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 06:46:34 INFO - 'bloom_basic_ref']}, 06:46:34 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:46:34 INFO - 'tests': ['tsvgx', 06:46:34 INFO - 'tsvgr_opacity', 06:46:34 INFO - 'tart', 06:46:34 INFO - 'tscrollx', 06:46:34 INFO - 'cart', 06:46:34 INFO - 'tsvg_static']}, 06:46:34 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:46:34 INFO - 'tsvgr_opacity', 06:46:34 INFO - 'tart', 06:46:34 INFO - 'tscrollx', 06:46:34 INFO - 'cart', 06:46:34 INFO - 'tsvg_static']}, 06:46:34 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 06:46:34 INFO - 'talos_options': ['--disable-e10s'], 06:46:34 INFO - 'tests': ['tp5o']}, 06:46:34 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 06:46:34 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 06:46:34 INFO - 'talos_options': ['--disable-e10s', 06:46:34 INFO - '--xperf_path', 06:46:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:46:34 INFO - 'tests': ['tp5n']}, 06:46:34 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 06:46:34 INFO - 'talos_options': ['--xperf_path', 06:46:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:46:34 INFO - 'tests': ['tp5n']}}, 06:46:34 INFO - 'talos.zip': {'path': '', 06:46:34 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:46:34 INFO - Running post-action listener: _resource_record_post_action 06:46:34 INFO - [mozharness: 2017-05-25 13:46:34.914647Z] Finished populate-webroot step (success) 06:46:34 INFO - [mozharness: 2017-05-25 13:46:34.914736Z] Running create-virtualenv step. 06:46:34 INFO - Running pre-action listener: _resource_record_pre_action 06:46:34 INFO - Running main action method: create_virtualenv 06:46:34 INFO - Creating virtualenv /builds/slave/test/build/venv 06:46:34 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 06:46:34 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:46:35 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:46:35 INFO - Using real prefix '/usr' 06:46:35 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:46:35 INFO - Installing distribute.............................................................................................................................................................................................done. 06:46:37 INFO - Installing pip.................done. 06:46:37 INFO - Return code: 0 06:46:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 06:46:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 06:46:37 INFO - Reading from file tmpfile_stdout 06:46:37 INFO - Output received: 06:46:37 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) 06:46:37 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:46:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:46:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:46:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:46:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:46:37 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 0x21a01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x236da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25135c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25107a0>, '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 0x25116a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2511b30>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1495719963.68497-806580313', '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 06:46:37 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 06:46:37 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 06:46:37 INFO - Using env: {'DISPLAY': ':0', 06:46:37 INFO - 'HOME': '/home/cltbld', 06:46:37 INFO - 'LANG': 'en_US.UTF-8', 06:46:37 INFO - 'LANGUAGE': 'en_US:en', 06:46:37 INFO - 'LOGNAME': 'cltbld', 06:46:37 INFO - 'MAIL': '/var/mail/cltbld', 06:46:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:46:37 INFO - 'MOZ_NO_REMOTE': '1', 06:46:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:46:37 INFO - 'NO_EM_RESTART': '1', 06:46:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:46:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:46:37 INFO - 'PWD': '/builds/slave/test', 06:46:37 INFO - 'SHELL': '/bin/bash', 06:46:37 INFO - 'SHLVL': '1', 06:46:37 INFO - 'TERM': 'linux', 06:46:37 INFO - 'TMOUT': '86400', 06:46:37 INFO - 'USER': 'cltbld', 06:46:37 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1495719963.68497-806580313', 06:46:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:46:37 INFO - '_': '/tools/buildbot/bin/python'} 06:46:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:46:37 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 06:46:37 INFO - Cleaning up... 06:46:37 INFO - Return code: 0 06:46:37 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:46:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:46:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:46:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:46:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:46:37 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 0x21a01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x236da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25135c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25107a0>, '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 0x25116a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2511b30>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1495719963.68497-806580313', '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 06:46:37 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 06:46:37 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 06:46:37 INFO - Using env: {'DISPLAY': ':0', 06:46:37 INFO - 'HOME': '/home/cltbld', 06:46:37 INFO - 'LANG': 'en_US.UTF-8', 06:46:37 INFO - 'LANGUAGE': 'en_US:en', 06:46:37 INFO - 'LOGNAME': 'cltbld', 06:46:37 INFO - 'MAIL': '/var/mail/cltbld', 06:46:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:46:37 INFO - 'MOZ_NO_REMOTE': '1', 06:46:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:46:37 INFO - 'NO_EM_RESTART': '1', 06:46:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:46:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:46:37 INFO - 'PWD': '/builds/slave/test', 06:46:37 INFO - 'SHELL': '/bin/bash', 06:46:37 INFO - 'SHLVL': '1', 06:46:37 INFO - 'TERM': 'linux', 06:46:37 INFO - 'TMOUT': '86400', 06:46:37 INFO - 'USER': 'cltbld', 06:46:37 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1495719963.68497-806580313', 06:46:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:46:37 INFO - '_': '/tools/buildbot/bin/python'} 06:46:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:46:38 INFO - Downloading/unpacking psutil>=3.1.1 06:46:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:46:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:46:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:46:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:46:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:46:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:46:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:46:39 INFO - Installing collected packages: psutil 06:46:39 INFO - Running setup.py install for psutil 06:46:39 INFO - building 'psutil._psutil_linux' extension 06:46:39 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 06:46:39 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 06:46:39 INFO - building 'psutil._psutil_posix' extension 06:46:39 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 06:46:39 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 06:46:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:46:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:46:39 INFO - Successfully installed psutil 06:46:39 INFO - Cleaning up... 06:46:39 INFO - Return code: 0 06:46:39 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:46: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')]} 06:46:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:46: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')]} 06:46:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:46:39 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 0x21a01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x236da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25135c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25107a0>, '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 0x25116a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2511b30>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1495719963.68497-806580313', '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 06:46:39 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 06:46:39 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 06:46:39 INFO - Using env: {'DISPLAY': ':0', 06:46:39 INFO - 'HOME': '/home/cltbld', 06:46:39 INFO - 'LANG': 'en_US.UTF-8', 06:46:39 INFO - 'LANGUAGE': 'en_US:en', 06:46:39 INFO - 'LOGNAME': 'cltbld', 06:46:39 INFO - 'MAIL': '/var/mail/cltbld', 06:46:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:46:39 INFO - 'MOZ_NO_REMOTE': '1', 06:46:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:46:39 INFO - 'NO_EM_RESTART': '1', 06:46:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:46:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:46:39 INFO - 'PWD': '/builds/slave/test', 06:46:39 INFO - 'SHELL': '/bin/bash', 06:46:39 INFO - 'SHLVL': '1', 06:46:39 INFO - 'TERM': 'linux', 06:46:39 INFO - 'TMOUT': '86400', 06:46:39 INFO - 'USER': 'cltbld', 06:46:39 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1495719963.68497-806580313', 06:46:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:46:39 INFO - '_': '/tools/buildbot/bin/python'} 06:46:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:46:40 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:46:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:46:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:46:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:46:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:46:41 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:46:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:46:41 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:46:41 INFO - Installing collected packages: mozsystemmonitor 06:46:41 INFO - Running setup.py install for mozsystemmonitor 06:46:41 INFO - Successfully installed mozsystemmonitor 06:46:41 INFO - Cleaning up... 06:46:41 INFO - Return code: 0 06:46:41 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:46:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:46:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:46:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:46:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:46:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21a01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x236da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25135c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25107a0>, '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 0x25116a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2511b30>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1495719963.68497-806580313', '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 06:46:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 06:46:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 06:46:41 INFO - Using env: {'DISPLAY': ':0', 06:46:41 INFO - 'HOME': '/home/cltbld', 06:46:41 INFO - 'LANG': 'en_US.UTF-8', 06:46:41 INFO - 'LANGUAGE': 'en_US:en', 06:46:41 INFO - 'LOGNAME': 'cltbld', 06:46:41 INFO - 'MAIL': '/var/mail/cltbld', 06:46:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:46:41 INFO - 'MOZ_NO_REMOTE': '1', 06:46:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:46:41 INFO - 'NO_EM_RESTART': '1', 06:46:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:46:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:46:41 INFO - 'PWD': '/builds/slave/test', 06:46:41 INFO - 'SHELL': '/bin/bash', 06:46:41 INFO - 'SHLVL': '1', 06:46:41 INFO - 'TERM': 'linux', 06:46:41 INFO - 'TMOUT': '86400', 06:46:41 INFO - 'USER': 'cltbld', 06:46:41 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1495719963.68497-806580313', 06:46:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:46:41 INFO - '_': '/tools/buildbot/bin/python'} 06:46:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:46:41 INFO - Downloading/unpacking jsonschema==2.5.1 06:46:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:46:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:46:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:46:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:46:42 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:46:42 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:46:42 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 06:46:42 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 06:46:42 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 06:46:42 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 06:46:42 INFO - Downloading functools32-3.2.3-2.tar.gz 06:46:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:46:42 INFO - warning: no files found matching '*.txt' 06:46:42 INFO - no previously-included directories found matching 'build' 06:46:42 INFO - no previously-included directories found matching 'dist' 06:46:42 INFO - no previously-included directories found matching '.git*' 06:46:42 INFO - Installing collected packages: jsonschema, functools32 06:46:42 INFO - Running setup.py install for functools32 06:46:43 INFO - warning: no files found matching '*.txt' 06:46:43 INFO - no previously-included directories found matching 'build' 06:46:43 INFO - no previously-included directories found matching 'dist' 06:46:43 INFO - no previously-included directories found matching '.git*' 06:46:43 INFO - Successfully installed jsonschema functools32 06:46:43 INFO - Cleaning up... 06:46:43 INFO - Return code: 0 06:46:43 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 06:46:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:46:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:46:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:46:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:46:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21a01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x236da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25135c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25107a0>, '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 0x25116a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2511b30>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1495719963.68497-806580313', '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 06:46:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 06:46:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 06:46:43 INFO - Using env: {'DISPLAY': ':0', 06:46:43 INFO - 'HOME': '/home/cltbld', 06:46:43 INFO - 'LANG': 'en_US.UTF-8', 06:46:43 INFO - 'LANGUAGE': 'en_US:en', 06:46:43 INFO - 'LOGNAME': 'cltbld', 06:46:43 INFO - 'MAIL': '/var/mail/cltbld', 06:46:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:46:43 INFO - 'MOZ_NO_REMOTE': '1', 06:46:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:46:43 INFO - 'NO_EM_RESTART': '1', 06:46:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:46:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:46:43 INFO - 'PWD': '/builds/slave/test', 06:46:43 INFO - 'SHELL': '/bin/bash', 06:46:43 INFO - 'SHLVL': '1', 06:46:43 INFO - 'TERM': 'linux', 06:46:43 INFO - 'TMOUT': '86400', 06:46:43 INFO - 'USER': 'cltbld', 06:46:43 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1495719963.68497-806580313', 06:46:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:46:43 INFO - '_': '/tools/buildbot/bin/python'} 06:46:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:46:43 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 06:46:43 INFO - Cleaning up... 06:46:43 INFO - Return code: 0 06:46:43 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:46:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:46:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:46:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:46:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:46:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21a01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x236da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25135c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25107a0>, '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 0x25116a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2511b30>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1495719963.68497-806580313', '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 06:46:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 06:46:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 06:46:43 INFO - Using env: {'DISPLAY': ':0', 06:46:43 INFO - 'HOME': '/home/cltbld', 06:46:43 INFO - 'LANG': 'en_US.UTF-8', 06:46:43 INFO - 'LANGUAGE': 'en_US:en', 06:46:43 INFO - 'LOGNAME': 'cltbld', 06:46:43 INFO - 'MAIL': '/var/mail/cltbld', 06:46:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:46:43 INFO - 'MOZ_NO_REMOTE': '1', 06:46:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:46:43 INFO - 'NO_EM_RESTART': '1', 06:46:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:46:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:46:43 INFO - 'PWD': '/builds/slave/test', 06:46:43 INFO - 'SHELL': '/bin/bash', 06:46:43 INFO - 'SHLVL': '1', 06:46:43 INFO - 'TERM': 'linux', 06:46:43 INFO - 'TMOUT': '86400', 06:46:43 INFO - 'USER': 'cltbld', 06:46:43 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1495719963.68497-806580313', 06:46:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:46:43 INFO - '_': '/tools/buildbot/bin/python'} 06:46:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:46:43 INFO - Downloading/unpacking blobuploader==1.2.4 06:46:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:46:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:46:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:46:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:46:44 INFO - Downloading blobuploader-1.2.4.tar.gz 06:46:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:46:44 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:46:44 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 06:46:44 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 06:46:44 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 06:46:44 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 06:46:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:46:45 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:46:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:46:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:46:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:46:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:46:45 INFO - Downloading docopt-0.6.1.tar.gz 06:46:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:46:45 INFO - Installing collected packages: blobuploader, requests, docopt 06:46:45 INFO - Running setup.py install for blobuploader 06:46:45 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:46:45 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:46:45 INFO - Running setup.py install for requests 06:46:45 INFO - Running setup.py install for docopt 06:46:45 INFO - Successfully installed blobuploader requests docopt 06:46:45 INFO - Cleaning up... 06:46:45 INFO - Return code: 0 06:46:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:46: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')]} 06:46:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:46: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')]} 06:46:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:46:45 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 0x21a01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x236da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25135c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25107a0>, '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 0x25116a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2511b30>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1495719963.68497-806580313', '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 06:46:45 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 06:46:45 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 06:46:45 INFO - Using env: {'DISPLAY': ':0', 06:46:45 INFO - 'HOME': '/home/cltbld', 06:46:45 INFO - 'LANG': 'en_US.UTF-8', 06:46:45 INFO - 'LANGUAGE': 'en_US:en', 06:46:45 INFO - 'LOGNAME': 'cltbld', 06:46:45 INFO - 'MAIL': '/var/mail/cltbld', 06:46:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:46:45 INFO - 'MOZ_NO_REMOTE': '1', 06:46:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:46:45 INFO - 'NO_EM_RESTART': '1', 06:46:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:46:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:46:45 INFO - 'PWD': '/builds/slave/test', 06:46:45 INFO - 'SHELL': '/bin/bash', 06:46:45 INFO - 'SHLVL': '1', 06:46:45 INFO - 'TERM': 'linux', 06:46:45 INFO - 'TMOUT': '86400', 06:46:45 INFO - 'USER': 'cltbld', 06:46:45 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1495719963.68497-806580313', 06:46:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:46:45 INFO - '_': '/tools/buildbot/bin/python'} 06:46:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:46:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:46:46 INFO - Running setup.py (path:/tmp/pip-TABiEe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:46:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:46:46 INFO - Running setup.py (path:/tmp/pip-_0RJWX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:46:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:46:46 INFO - Running setup.py (path:/tmp/pip-Ts52ex-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:46:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:46:46 INFO - Running setup.py (path:/tmp/pip-yG6Fuu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:46:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:46:46 INFO - Running setup.py (path:/tmp/pip-xgQItY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:46:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:46:46 INFO - Running setup.py (path:/tmp/pip-3nLVLV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:46:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:46:46 INFO - Running setup.py (path:/tmp/pip-ZFotOq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:46:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:46:46 INFO - Running setup.py (path:/tmp/pip-uNvrIH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:46:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:46:46 INFO - Running setup.py (path:/tmp/pip-AgaSHx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:46:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:46:46 INFO - Running setup.py (path:/tmp/pip-NmWCWV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:46:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:46:46 INFO - Running setup.py (path:/tmp/pip-B010fB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:46:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:46:46 INFO - Running setup.py (path:/tmp/pip-5L_uPH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:46:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:46:46 INFO - Running setup.py (path:/tmp/pip-06RmzZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:46:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:46:47 INFO - Running setup.py (path:/tmp/pip-IuEjQV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:46:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:46:47 INFO - Running setup.py (path:/tmp/pip-kBUzh2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:46:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:46:47 INFO - Running setup.py (path:/tmp/pip-t8v6kE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:46:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:46:47 INFO - Running setup.py (path:/tmp/pip-e3BArT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:46:47 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:46:47 INFO - Running setup.py install for manifestparser 06:46:47 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:46:47 INFO - Running setup.py install for mozcrash 06:46:47 INFO - Running setup.py install for mozdebug 06:46:47 INFO - Running setup.py install for mozdevice 06:46:47 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:46:47 INFO - Running setup.py install for mozfile 06:46:47 INFO - Running setup.py install for mozhttpd 06:46:47 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:46:47 INFO - Running setup.py install for mozinfo 06:46:47 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:46:47 INFO - Running setup.py install for mozInstall 06:46:48 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:46:48 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:46:48 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:46:48 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:46:48 INFO - Running setup.py install for mozleak 06:46:48 INFO - Running setup.py install for mozlog 06:46:48 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:46:48 INFO - Running setup.py install for moznetwork 06:46:48 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:46:48 INFO - Running setup.py install for mozprocess 06:46:48 INFO - Running setup.py install for mozprofile 06:46:48 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:46:48 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:46:48 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:46:48 INFO - Running setup.py install for mozrunner 06:46:48 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:46:48 INFO - Running setup.py install for mozscreenshot 06:46:48 INFO - Running setup.py install for moztest 06:46:48 INFO - Running setup.py install for mozversion 06:46:49 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:46:49 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:46:49 INFO - Cleaning up... 06:46:49 INFO - Return code: 0 06:46:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:46:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:46:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:46:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:46:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:46:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21a01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x236da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25135c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25107a0>, '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 0x25116a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2511b30>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1495719963.68497-806580313', '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 06:46:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 06:46:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:46:49 INFO - Using env: {'DISPLAY': ':0', 06:46:49 INFO - 'HOME': '/home/cltbld', 06:46:49 INFO - 'LANG': 'en_US.UTF-8', 06:46:49 INFO - 'LANGUAGE': 'en_US:en', 06:46:49 INFO - 'LOGNAME': 'cltbld', 06:46:49 INFO - 'MAIL': '/var/mail/cltbld', 06:46:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:46:49 INFO - 'MOZ_NO_REMOTE': '1', 06:46:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:46:49 INFO - 'NO_EM_RESTART': '1', 06:46:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:46:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:46:49 INFO - 'PWD': '/builds/slave/test', 06:46:49 INFO - 'SHELL': '/bin/bash', 06:46:49 INFO - 'SHLVL': '1', 06:46:49 INFO - 'TERM': 'linux', 06:46:49 INFO - 'TMOUT': '86400', 06:46:49 INFO - 'USER': 'cltbld', 06:46:49 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1495719963.68497-806580313', 06:46:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:46:49 INFO - '_': '/tools/buildbot/bin/python'} 06:46:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:46:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:46:49 INFO - Running setup.py (path:/tmp/pip-NX019R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:46:49 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 06:46:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:46:49 INFO - Running setup.py (path:/tmp/pip-Gmppmv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:46:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:46:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:46:49 INFO - Running setup.py (path:/tmp/pip-LJcbsd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:46:49 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)) 06:46:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:46:49 INFO - Running setup.py (path:/tmp/pip-9sEtVm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:46:49 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)) 06:46:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:46:49 INFO - Running setup.py (path:/tmp/pip-obfMov-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:46:49 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)) 06:46:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:46:49 INFO - Running setup.py (path:/tmp/pip-BVE9Bt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:46:49 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)) 06:46:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:46:49 INFO - Running setup.py (path:/tmp/pip-cBFLQT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:46:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 06:46:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:46:49 INFO - Running setup.py (path:/tmp/pip-YXE_NK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:46:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 06:46:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:46:49 INFO - Running setup.py (path:/tmp/pip-hZYavn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:46:49 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)) 06:46:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:46:49 INFO - Running setup.py (path:/tmp/pip-n4JFci-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:46:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:46:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:46:50 INFO - Running setup.py (path:/tmp/pip-oEx92h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:46:50 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 06:46:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:46:50 INFO - Running setup.py (path:/tmp/pip-PN6DIv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:46:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 06:46:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:46:50 INFO - Running setup.py (path:/tmp/pip-V1GV0L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:46:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 06:46:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:46:50 INFO - Running setup.py (path:/tmp/pip-iYU7e7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:46:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 06:46:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:46:50 INFO - Running setup.py (path:/tmp/pip-MmLmk0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:46:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 06:46:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:46:50 INFO - Running setup.py (path:/tmp/pip-7FWrMb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:46:50 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 06:46:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:46:50 INFO - Running setup.py (path:/tmp/pip-zgVgNL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:46:50 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)) 06:46:50 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)) 06:46:50 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)) 06:46:50 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)) 06:46:50 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)) 06:46:50 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)) 06:46:50 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:46: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 06:46: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 06:46: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 06:46: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 06:46:51 INFO - Downloading blessings-1.6.tar.gz 06:46:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:46:51 INFO - Installing collected packages: blessings 06:46:51 INFO - Running setup.py install for blessings 06:46:51 INFO - Successfully installed blessings 06:46:51 INFO - Cleaning up... 06:46:51 INFO - Return code: 0 06:46:51 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:46:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:46:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:46:52 INFO - Reading from file tmpfile_stdout 06:46:52 INFO - Current package versions: 06:46:52 INFO - argparse == 1.2.1 06:46:52 INFO - blessings == 1.6 06:46:52 INFO - blobuploader == 1.2.4 06:46:52 INFO - docopt == 0.6.1 06:46:52 INFO - functools32 == 3.2.3-2 06:46:52 INFO - jsonschema == 2.5.1 06:46:52 INFO - manifestparser == 1.1 06:46:52 INFO - mozInstall == 1.12 06:46:52 INFO - mozcrash == 1.0 06:46:52 INFO - mozdebug == 0.1 06:46:52 INFO - mozdevice == 0.51 06:46:52 INFO - mozfile == 1.2 06:46:52 INFO - mozhttpd == 0.7 06:46:52 INFO - mozinfo == 0.9 06:46:52 INFO - mozleak == 0.1 06:46:52 INFO - mozlog == 3.4 06:46:52 INFO - moznetwork == 0.27 06:46:52 INFO - mozprocess == 0.25 06:46:52 INFO - mozprofile == 0.28 06:46:52 INFO - mozrunner == 6.13 06:46:52 INFO - mozscreenshot == 0.1 06:46:52 INFO - mozsystemmonitor == 0.3 06:46:52 INFO - moztest == 0.8 06:46:52 INFO - mozversion == 1.4 06:46:52 INFO - psutil == 3.1.1 06:46:52 INFO - requests == 1.2.3 06:46:52 INFO - wsgiref == 0.1.2 06:46:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:46: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')]} 06:46:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:46: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')]} 06:46:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:46:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21a01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x236da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25135c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25107a0>, '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 0x25116a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2511b30>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1495719963.68497-806580313', '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 06:46:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 06:46:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:46:52 INFO - Using env: {'DISPLAY': ':0', 06:46:52 INFO - 'HOME': '/home/cltbld', 06:46:52 INFO - 'LANG': 'en_US.UTF-8', 06:46:52 INFO - 'LANGUAGE': 'en_US:en', 06:46:52 INFO - 'LOGNAME': 'cltbld', 06:46:52 INFO - 'MAIL': '/var/mail/cltbld', 06:46:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:46:52 INFO - 'MOZ_NO_REMOTE': '1', 06:46:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:46:52 INFO - 'NO_EM_RESTART': '1', 06:46:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:46:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:46:52 INFO - 'PWD': '/builds/slave/test', 06:46:52 INFO - 'SHELL': '/bin/bash', 06:46:52 INFO - 'SHLVL': '1', 06:46:52 INFO - 'TERM': 'linux', 06:46:52 INFO - 'TMOUT': '86400', 06:46:52 INFO - 'USER': 'cltbld', 06:46:52 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1495719963.68497-806580313', 06:46:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:46:52 INFO - '_': '/tools/buildbot/bin/python'} 06:46:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:46:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 06:46:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 06:46:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 06:46:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 06:46:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 06:46:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 06:46:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 06:46:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 06:46:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 06:46:52 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 06:46: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 06:46: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 06:46: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 06:46: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 06:46:53 INFO - Downloading marionette_driver-1.4.0.tar.gz 06:46:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 06:46:53 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)) 06:46:53 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)) 06:46:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner>=6.9 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 06:46:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice>=0.37 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozrunner>=6.9->marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 06:46:53 INFO - Installing collected packages: marionette-driver 06:46:53 INFO - Running setup.py install for marionette-driver 06:46:53 INFO - Successfully installed marionette-driver 06:46:53 INFO - Cleaning up... 06:46:53 INFO - Return code: 0 06:46:53 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:46:53 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')]} 06:46:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:46:53 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')]} 06:46:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:46:53 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 0x21a01f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x236da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25135c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25107a0>, '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 0x25116a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2511b30>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1495719963.68497-806580313', '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 06:46:53 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 06:46:53 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 06:46:53 INFO - Using env: {'DISPLAY': ':0', 06:46:53 INFO - 'HOME': '/home/cltbld', 06:46:53 INFO - 'LANG': 'en_US.UTF-8', 06:46:53 INFO - 'LANGUAGE': 'en_US:en', 06:46:53 INFO - 'LOGNAME': 'cltbld', 06:46:53 INFO - 'MAIL': '/var/mail/cltbld', 06:46:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:46:53 INFO - 'MOZ_NO_REMOTE': '1', 06:46:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:46:53 INFO - 'NO_EM_RESTART': '1', 06:46:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:46:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:46:53 INFO - 'PWD': '/builds/slave/test', 06:46:53 INFO - 'SHELL': '/bin/bash', 06:46:53 INFO - 'SHLVL': '1', 06:46:53 INFO - 'TERM': 'linux', 06:46:53 INFO - 'TMOUT': '86400', 06:46:53 INFO - 'USER': 'cltbld', 06:46:53 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1495719963.68497-806580313', 06:46:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:46:53 INFO - '_': '/tools/buildbot/bin/python'} 06:46:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:46:53 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:46:53 INFO - Cleaning up... 06:46:53 INFO - Return code: 0 06:46:53 INFO - Running post-action listener: _resource_record_post_action 06:46:53 INFO - Running post-action listener: _start_resource_monitoring 06:46:53 INFO - Starting resource monitoring. 06:46:53 INFO - [mozharness: 2017-05-25 13:46:53.858279Z] Finished create-virtualenv step (success) 06:46:53 INFO - [mozharness: 2017-05-25 13:46:53.858735Z] Running install step. 06:46:53 INFO - Running pre-action listener: _resource_record_pre_action 06:46:53 INFO - Running main action method: install 06:46:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:46:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:46:54 INFO - Reading from file tmpfile_stdout 06:46:54 INFO - Detecting whether we're running mozinstall >=1.0... 06:46:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:46:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:46:54 INFO - Reading from file tmpfile_stdout 06:46:54 INFO - Output received: 06:46:54 INFO - Usage: mozinstall [options] installer 06:46:54 INFO - Options: 06:46:54 INFO - -h, --help show this help message and exit 06:46:54 INFO - -d DEST, --destination=DEST 06:46:54 INFO - Directory to install application into. [default: 06:46:54 INFO - "/builds/slave/test"] 06:46:54 INFO - --app=APP Application being installed. [default: firefox] 06:46:54 INFO - mkdir: /builds/slave/test/build/application 06:46:54 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'] 06:46:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 06:47:10 INFO - Reading from file tmpfile_stdout 06:47:10 INFO - Output received: 06:47:10 INFO - /builds/slave/test/build/application/firefox/firefox 06:47:10 INFO - Running post-action listener: _resource_record_post_action 06:47:10 INFO - [mozharness: 2017-05-25 13:47:10.180098Z] Finished install step (success) 06:47:10 INFO - [mozharness: 2017-05-25 13:47:10.180380Z] Running run-tests step. 06:47:10 INFO - Running pre-action listener: _resource_record_pre_action 06:47:10 INFO - Running main action method: run_tests 06:47:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:47:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:47:10 INFO - Python 2.7.3 06:47:10 INFO - Return code: 0 06:47:10 INFO - grabbing minidump binary from tooltool 06:47:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:47:10 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25107a0>, '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 0x25116a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2511b30>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:47:10 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 06:47:10 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 06:47:10 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 06:47:10 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:47:10 INFO - Return code: 0 06:47:10 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:47:10 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:47:10 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:47:10 INFO - ENV: RUST_BACKTRACE is now 1 06:47:10 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:47:10 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:47:10 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/SRns4UVsTaicCBZLhqaQ2w/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-062', '--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 06:47:10 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/SRns4UVsTaicCBZLhqaQ2w/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-062 --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 06:47:10 INFO - Using env: {'DISPLAY': ':0', 06:47:10 INFO - 'HOME': '/home/cltbld', 06:47:10 INFO - 'LANG': 'en_US.UTF-8', 06:47:10 INFO - 'LANGUAGE': 'en_US:en', 06:47:10 INFO - 'LOGNAME': 'cltbld', 06:47:10 INFO - 'MAIL': '/var/mail/cltbld', 06:47:10 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:47:10 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:47:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:47:10 INFO - 'MOZ_NO_REMOTE': '1', 06:47:10 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:47:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:47:10 INFO - 'NO_EM_RESTART': '1', 06:47:10 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:47:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:47:10 INFO - 'PWD': '/builds/slave/test', 06:47:10 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:47:10 INFO - 'RUST_BACKTRACE': '1', 06:47:10 INFO - 'SHELL': '/bin/bash', 06:47:10 INFO - 'SHLVL': '1', 06:47:10 INFO - 'TERM': 'linux', 06:47:10 INFO - 'TMOUT': '86400', 06:47:10 INFO - 'USER': 'cltbld', 06:47:10 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1495719963.68497-806580313', 06:47:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:47:10 INFO - '_': '/tools/buildbot/bin/python'} 06:47:10 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/SRns4UVsTaicCBZLhqaQ2w/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-062', '--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 06:47:10 INFO - mozversion application_buildid: 20170525130908 06:47:10 INFO - mozversion application_changeset: 23a341e9b53d04f80ea6a66ced2d72cdc17afffb 06:47:10 INFO - mozversion application_display_name: Nightly 06:47:10 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:47:10 INFO - mozversion application_name: Firefox 06:47:10 INFO - mozversion application_remotingname: firefox 06:47:10 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 06:47:10 INFO - mozversion application_vendor: Mozilla 06:47:10 INFO - mozversion application_version: 55.0a1 06:47:10 INFO - mozversion platform_buildid: 20170525130908 06:47:10 INFO - mozversion platform_changeset: 23a341e9b53d04f80ea6a66ced2d72cdc17afffb 06:47:10 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 06:47:10 INFO - mozversion platform_version: 55.0a1 06:47:10 INFO - using testdate: 1495720030 06:47:10 INFO - actual date: 1495720030 06:47:10 INFO - starting webserver on 'localhost:37101' 06:47:10 INFO - SUITE-START | Running 2 tests 06:47:10 INFO - TEST-START | dromaeo_css 06:47:10 INFO - operating with platform_type : linux_ 06:47:10 INFO - Initialising browser for dromaeo_css test... 06:47:10 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:37101/getInfo.html -profile /tmp/tmpASN_h9/profile 06:47:10 INFO - TEST-INFO | started process 1985 (/builds/slave/test/build/application/firefox/firefox http://localhost:37101/getInfo.html) 06:47:45 INFO - TEST-INFO | 1985: killed by SIGTERM 06:47:45 INFO - Browser initialized. 06:47:45 INFO - Running cycle 1/1 for dromaeo_css test... 06:47:45 INFO - TEST-INFO | started process 2208 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpASN_h9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:47:57 INFO - PID 2208 | RSS: Main: 176361472 06:47:57 INFO - PID 2208 | 06:51:02 INFO - PID 2208 | Cycle 1(1): loaded http://localhost:37101/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37101/tests/dromaeo/cssquery-ext.html) 06:51:03 INFO - PID 2208 | RSS: Main: 173674496 06:51:03 INFO - PID 2208 | 06:54:05 INFO - PID 2208 | Cycle 1(1): loaded http://localhost:37101/tests/dromaeo/cssquery-ext.html (next: http://localhost:37101/tests/dromaeo/cssquery-jquery.html) 06:54:06 INFO - PID 2208 | RSS: Main: 180109312 06:54:06 INFO - PID 2208 | 06:57:07 INFO - PID 2208 | Cycle 1(1): loaded http://localhost:37101/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37101/tests/dromaeo/cssquery-mootools.html) 06:57:08 INFO - PID 2208 | RSS: Main: 178057216 06:57:08 INFO - PID 2208 | 07:00:10 INFO - PID 2208 | Cycle 1(1): loaded http://localhost:37101/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37101/tests/dromaeo/cssquery-prototype.html) 07:00:10 INFO - PID 2208 | RSS: Main: 182132736 07:00:10 INFO - PID 2208 | 07:03:13 INFO - PID 2208 | Cycle 1(1): loaded http://localhost:37101/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37101/tests/dromaeo/cssquery-yui.html) 07:03:14 INFO - PID 2208 | RSS: Main: 180596736 07:03:14 INFO - PID 2208 | 07:06:16 INFO - PID 2208 | Cycle 1(1): loaded http://localhost:37101/tests/dromaeo/cssquery-yui.html (next: http://localhost:37101/tests/dromaeo/cssquery-dojo.html) 07:06:16 INFO - PID 2208 | RSS: Main: 179150848 07:06:16 INFO - PID 2208 | 07:06:16 INFO - PID 2208 | __start_tp_report 07:06:16 INFO - PID 2208 | _x_x_mozilla_page_load 07:06:16 INFO - PID 2208 | _x_x_mozilla_page_load_details 07:06:16 INFO - PID 2208 | |i|pagename|runs| 07:06:16 INFO - PID 2208 | |0;dojo.html;2697.3391519077823;2729.5496243119887;2730.9726902730968;2761.3786897947966;2764.8755805988735;5143.691378517282;5302.92045619316;5313.601479889005;5316.016536940659;5395.406505284421;5311.973440132803;5363.249145119687;5378.193271009351;5466.671999680022;5474.507294343508;4721.173794585951;4741.336212930192;4756.405449318835;4787.61699064074;4831.589314908237;4792.281157826336;4830.347903033081;4833.7824797884;4839.370881785363;4871.171900776876;4701.294805779126;4757.333973243749;4799.208130658437;4800.039992001613;4848.757562121879;4744.810207591692;4758.477287268076;4776.379070720819;4785.521447855187;4789.664723469358;4687.88280292992;4698.271767875985;4702.482726900038;4713.811447542129;4762.833300834454;5239.659422137549;5256.605754568384;5291.841244762663;5294.973525132388;5376.059189641836;5711.514521265697;5785.652860828363;5795.710214489259;5848.035074212749;5868.706564671749;5740.425957404268;5747.856303592402;5750.367459579443;5773.653580785166;5804.970975145139;5340.172273297645;5342.252084708144;5350.170723537858;5352.866178345573;5371.543418809406;5900.940990590125;5915.260592425947;5952.226210592682;5962.612430192024;5983.760649574056;5726.484616384545;5759.596828221985;5762.2509073820975;5762.596618236767;5790.189373487715;5821.417858214145;5830.7084645767545;5831.620944638585;5852.824415267549;5869.413058694096;5673.375928647845;5695.800646977336;5809.215755872988;5813.563982701315;5827.854303642443;5649.943500565024;5696.401877802854;5727.398623144593;5739.799107031234;5742.799002034909;4815.518448155157;4816.783244753994;4821.831235906797;4846.733429661403;4856.635752318591;4058.939115913264;4086.5504794472586;4100.097978444737;4146.274401979642;4155.729877558009;4728.456227533878;4855.490173531799;4859.173940430064;4877.487863774323;4887.975560122177;5794.478496935296;5805.941940580625;5851.063829787214;5894.292684877756;5897.852553686106;4771.73755443447;4772.7136371817805;4778.665493415497;4813.03739252151;4855.223164293696;5066.316047333637;5066.594672426197;5077.416097148801;5087.084324821568;5131.332926719577;5280.260763493191;5350.866228344167;5358.544523715528;5373.382061062872;5431.049566325956;5648.661080335193;5749.9712501437225;5828.737706803119;5837.5329973601165;5903.380145084876;5304.681719096867;5308.920366194588;5319.521243087986;5324.334458192726;5459.617826752089;5666.263385759825;5672.780352224291;5732.656040637575;5755.942440575708;5756.3380211276235;5747.8563035924435;5767.68277744728;5771.07662773971;5845.386234445322;5848.0350742127075;5535.335759708861;5565.443455654402;5614.905093506727;5646.802361917313;5652.915206271827;5585.525230355465;5674.092145256739;5679.318481782213;5712.571557133315;5731.770729170953;5528.502434780889;5583.74873130702;5594.972025140011;5595.356533998643;5600.299962504687;5595.188697638738;5669.688167150846;5698.287714035746;5703.116017017369;5714.828555143353;5396.3524377075;5439.918401224064;5454.400015998158;5491.368492623399;5502.972485137549 07:06:16 INFO - PID 2208 | |1;ext.html;623.2085251730302;673.3165836675773;675.0684056002716;1182.8994535464485;1193.427154965616;34256.82871585642;35041.64958350416;35097.64902350976;35099;35218.11954701134;32858;33133.171670708245;33272.50091248627;33285;33423.331533369375;6362.681865906709;6523.9673801630925;6674.699638516278;6682.632455214961;6682.866342673144;6688.431483323923;6768.864622707543;6792.18493780747;6813.3527314905;6825.6587170641515;6731.798046058626;6751.898721519181;6763.763268285611;6764.086848275469;6795.286494918037;6717.59694418334;6748.156480439945;6758.121444212221;6771.645670865846;6811.284815094443;6711.664416779142;6719.832004199885;6741.3258674132685;6752.527323087385;6754.729810807562;31170.532442013387;31172.37655246905;31191.376172476423;31230.37539249225;31236.375272494424;2972.3758010817537;2976.255936015996;2999.6700362960055;3010.3678227572236;3025.6066711327385;24379.390515237083;24482.877585611957;24568;24617.753822461724;24658.506829863483;2931.2818359502057;2935.0461100142325;2954.6454425468864;2968.5250359942306;2971.821690698565;132947;133008;133273;154774;158113;39389.40915886264;39514.209715805526;39781.80109099494;39800.40299395511;39908.80045599753;40980.59019409768;41369;41389.586104139176;41428;41527.37708934308;11762;11957.402129893471;11970.102242331859;12043.578474753342;12067.094967877445;9420.764480887896;9491.572879220452;9495.477748723748;9508.334416590773;9546.284028697875;11921.761564768656;11990.580329688419;11999.520139159546;12078.577249796215;12269;5348.9836930983765;5414.8917021659345;5469.288992431038;5493.587980901369;5498.120300751941;852.624845068168;901.121406628532;910.9590068446936;913.1097180249204;931.1991687149047;20892.791072089083;21444.24945126913;21644.35066947994;21709.56580868374;21750.782492174876;965.1844191658038;977.5747549815853;993.4039576254335;995.6564985080136;1000.7498125468633;11100.448815985406;11144.219904606762;11419.714507137222;11480.712982175512;11489.195756297146;176469;176719;177240;178414;178760;40408;40840.795796021426;40902;41013.384799228035;41052;1196.9940150299367;1229.5081967213187;1236.5795629486017;1238.448890243833;1243.1173866554848;19806.70289945623;20296;20715.68926466074;20870.478238044172;21228.363149105553;28992.710072899845;29170.270743231587;29264.56103158412;29348.266293342836;29390.559141612466;146689;146721;146861;147024;147320.21438284699;28448.43103137967;28471.43057138887;28485;28992.13023609295;29008.41983160367;35498.82250588731;35756.28487430289;35820;35921.64078359288;36221.27557448889;25105.74894251034;26631.33421664474;26688.733112668626;27122.72877271281;27525.587116193674;27132.864335678983;27297.31756706098;27717.58423623607;27938.441231175668;27967.72032279651;31321.216969575944;31578.210544736565;31656.20859478439;31775.121602503612;31835.522467163475;26039.479210416066;26581.867090664422;27230.046948357503;27699.86150069237;27711.030113945915;20680.276190333265;21650.24224152147;21671.45821354479;21900.23349182771;22104.66842997324 07:06:16 INFO - PID 2208 | |2;jquery.html;394.98685870741565;399.07613873881945;410.24514892597614;425.5616714783772;429.3066697283887;14536.781948270784;15858.20708964553;17042.659146817055;17755.934643921373;17775.466735997925;18323.908380458113;18336.633267334677;18402.447926562225;18549.53626159347;18651.813481865178;4931.087748766472;5078.898422031557;5108.923366149511;5113.437521872591;5126.410462796789;4728;5466.945330546703;5558.777648894039;5589.944100559003;5633.60564760467;5595.552355811526;5597.63615365002;5608.747606357723;5609.3268807743125;5617.157426386034;5215.113430716769;5374.301340825707;5398.379186393576;5422.810201642943;5531.9723401382935;4853.174960256765;4871.196252618313;4877.609791216694;4888.144574699449;4889.217725163957;21824.345269641937;22201.888990554944;22373;22550.210742624095;22683.319500415015;1600.0719582642039;1608.7747715319865;1652.1408867389011;1654.2225154177518;1658.4029749290246;14493.565193044225;14580.927095364561;14997.17515536645;15020.248987550687;15167.696646067017;1392.296890070518;1394.7419727350473;1412.9858701412957;1415.6248594122567;1427.9286035698174;87405;89887.99999999935;90616;91519;92450;10859;10880.347179169275;11025.779484410266;11194.041042817475;11364.261323013978;15402.691946161238;15471.845281547041;15484.380624775109;15519.594462858275;15523.45667901618;7138.64306784669;7252.927470725331;7307.3058059484265;7396.297351751575;7417.109946806418;6395.392437718409;6430.5177111715875;6617.073609694647;6637.933620663828;6655.401013908771;6767.560108592926;6981.197162326397;6986.860262794818;6994.971458277145;7093.89359159613;1989.8806071635747;2021.8887961161984;2029.8579099462895;2052.8563000589816;2130.62714025045;764.6296480909137;814.2386868278179;821.9095899451056;832.3382910586099;840.8234270803077;15700.92149539245;16030.519084427486;16145.677086458205;16640.916795415946;16768.6646267074;823.9340852731767;825.3892119831281;826.6569373709963;833.8665813469937;851.586980314547;8768.386212965032;8860.8670869937;8964;9101.635934562675;9119;370837;375895;376395;376788;377108;71985;74608;75303.24696753072;76653.12153675682;78677;1036.2435422141727;1038.4236748604446;1047.7956798424234;1053.8735351757684;1062.219268837404;16193.514194574182;16767.580810479834;17047.48857534276;17992.100394979938;18079.36722214716;38848.61151388563;38954.80522597369;39737;40181.39727904142;40667.3899891496;48547.27179092387;49631.503684962685;49951.500484994685;49991.25013124733;49993.75003124961;7461.701531938662;7757.681194196887;7957.204279571996;8002.359811215205;8236.958815205886;11266.605668801552;11338.716532086764;11850.822237666614;12373.814392783936;12784.552540661032;9704.320697551104;10036.598536058767;10133.949330253596;10317.17462603005;10569.943005699675;7837.098733645704;9040.141186587263;9640.566174522304;10067.590537324633;10113.443760593238;9993.750156246151;10201.38791672502;10682.145428365557;10731.195160362848;11053.83419248728;8050;8169.223923727236;8175.427720059539;8255.752327430188;8281.17188281167;10326.535305911402;10408.481943049013;10536.15710743154;10608.575656973944;10784.19118566095 07:06:16 INFO - PID 2208 | |3;mootools.html;1269.206745783885;1303.6414985878882;1329.807177959196;1329.9268540230285;1331.407523651975;10190;10522.684319470418;10530.210234232425;10951.671449856518;11187.272827266223;10978.670639880796;11199.160062995288;11219;11262.887371126286;11326.943365283183;2100.401385605103;2118;2125.043730321354;2133.434639820449;2145.0561752828785;2229.888505574723;2262.6153553895797;2266.036934302923;2267.285804971437;2272.6363781794917;2157.611629906616;2188.157559339658;2191.923282685106;2192.199847055821;2206.095500844654;2154.709114269569;2160.6975023496725;2167.1114842914485;2169.750478694939;2171.0772921508374;1808.4574627611664;1860.7953125156223;1939.0983192815268;2038.7961203879643;2041.428400047989;10654.62708805188;10670.733231669194;10725.731856703567;10736.892631073668;10756.300840445425;5588.580856435743;5796.942030579682;5808.215890854765;5810.070388737824;5812.738426770806;3152.180433087391;3292.9176770580925;3314.585676790401;3323.667633236681;3336.5328853960464;1090.0080926356977;1095.6822521468764;1135.903448206895;1137.454022069403;1182.8639706433698;15122.773158402742;15199.848001519953;15438.845611543853;15444.613884652861;15445.0732956023;4541.3188021797;4707.599854012379;4852.781624826891;4853.538913803183;4921.729304888194;10549.630762923261;10570.15438764897;10571.94714026425;10584.312019718695;10622.787544249071;5485.314335708036;5537.446255374431;5575.358833734173;5580.051391263495;5601;5169.922451163236;5186.740662966837;5207.453217412193;5214.921776173361;5287.312649355559;4281.721688090264;4282.843632219284;4400.647948164139;4428.977855110704;4437.156940181355;1247.2703468470866;1305.8432988041495;1323.8279023726855;1333.673250053743;1339.82582264305;667.6695035957232;685.6708779785631;688.5352387138762;693.3759616345329;712.7861641507527;5554.805581804618;5704.80033198836;5709.314882214161;5759.740811663485;5794.536437085023;538.6498775795764;558.2686680448626;558.5447859994092;562.9240052592929;565.5108331293402;3473.5310733050715;3803.353429916921;3854.807259637007;3878.243742470191;3976.5029371328583;13693.315334233248;13843.446262149602;13944.58166255014;14003.369848356848;14062.859371406155;13323.467061317438;13991.720165596835;14018.369173387222;14023.719525609635;14295.07082039664;7570.485902819458;7592.582407967504;7615.314621683964;7621.69513219465;7624.313811756858;5829.5336373090895;5975.551833612583;5984.311804142405;6004.369541198286;6197.845053873689;12700.237985720887;12865.292408917225;12908.16096953695;13014.544490942772;13132.474701012236;12617.116801824151;12882.549110781078;13083.607491775261;13160.670983225496;13290.800637990631;8315.542645154575;8470.407071504935;8491.702790402307;8504.872426913478;8526.531040792815;9964;10002.899971000197;10039.849402259119;10072.345297555636;10076.546555404877;8277.54473503939;8367.95816020916;8581.95709021451;8586.484810911365;8844.248238899765;8279.710210142615;8303.629052276274;8336.12470690593;8482.915170848459;8581.785455363666;7708.152103268524;7831.530108193527;7851.764447066597;7864.4888082274465;7867.685292588232;4519.525449827721;5271.551918087006;5333.093374126331;5364.30264065669;5576.498115169654;5099.923501147411;5128.128218202989;5192.402873669576;5322.254884316276;5398.217258497574 07:06:16 INFO - PID 2208 | |4;prototype.html;350.24871650310087;369.2596344329619;373.6133102239183;377.47907887115775;383.26987089594326;5376.677399356041;5523.337199536057;5553.555715542757;5596.608237423382;5605.271314729084;5324.733763311829;5388.757505912234;5405.27028851105;5410.756515956781;5414.40441551429;4093.836246550142;4119.2997190477545;4126.133511962492;4128.153728485653;4133.896652583694;4093.488313960755;4112.3625837995005;4131;4136.400221967813;4143.917121657565;4057.9594204057876;4071.694622903279;4080.6939479539005;4081.1837632473475;4094.651954583864;4049.4128351389177;4074;4077.103037331782;4083.3874918762126;4091.713580049398;3555.377808883461;3566;3569.3218288525095;3574.696150827183;3576.695980841632;5174.379074511083;5262.2632831403635;5278.709670968095;5297.655652382583;5319.494648008433;4794.592459640935;4813.628115986962;4813.687110337817;4817.590504807061;4822.252550854623;5486.835394938158;5668.801591944303;5672.659640421588;5719.7140142992685;5722.738039317591;3982.38273067675;4012.799360031987;4019.41718450823;4020.8994775130564;4032.919341613151;5921.407859214087;6097.298810636789;6130.938690613081;6148.907766383508;6154.984427569446;4085.9785053736564;4111.362738775435;4112.547619761824;4121.1345617420075;4124.154548317588;4167.99968007682;4174.3947127666315;4177.164567086595;4181.1010632713505;4184.66522678185;4665.323528088408;4787.305840653085;4817.205161148441;4833.275008748716;4835.758212089452;5803;5821.970890145522;5825.330087040044;5826.679532625746;5831;1408.2817762940974;1410.7883817427469;1420.7868819676924;1422.8648278413534;1436.676747731752;939.9436033837992;969.5540051576213;970.0493516353872;1118.9440527973568;1129.0064743026085;4958.975205123951;4963.404391472975;4988.825391111293;4989.525995030466;5013;5940.6435613863305;5941.22764040672;5947.524198064145;5978.222831032025;6001.2498437695285;4812.951870481321;4967.726775027409;4968;4973.706836222608;4997.525235102659;3164;3170.937735858467;3183.4906414973957;3183.6657150999276;3201.9039428817173;5440.347158341025;5565.525135839006;5577.657383898772;5585.273914391103;5589.552835773128;6096.69516524172;6175.202250615839;6214.906776398358;6226.906596401058;6236.656983865931;5562.777488900399;5566.582506312043;5605.243292155588;5614.9719251403485;5621.409751976065;5855.36049906027;5939.406059394199;5984.521238301013;6011.308699499614;6024.578279520391;5896.292444906639;5908.143319218603;5911.704414779158;5929.851753706192;5931;5337.519623233928;5505.862353441035;5533.5849811265125;5561.6663000220115;5578.135389014709;4033.596640335943;4065.430839682506;4066.3290557057753;4067.471228740245;4083.1629515948566;5885.293764748258;5943.435373639497;5948.643081415129;5994.430529099728;6025.849353766015;5824.097264923944;5829.300483941955;5838.211841401527;5838.883222335615;5839.941600583939;5767.711614419179;5773.191753154646;5816.563757718103;5818.214541036906;5822.3304320003745;5655.604107712586;5692.580653222281;5742.196092546963;5742.36833948257;5750.856228594319;5847.8245652630485;5878.441548052928;5884.6469211847425;5891.204687367322;5899.557533185114;5584.274044374205;5605.862444215902;5662.235598194191;5699.774548472098;5722.284714410699 07:06:16 INFO - PID 2208 | |5;yui.html;729.5987207036129;734.8052766017006;746.8991686122375;759.8184822600854;762.5615271219049;11334.829977550344;11844.763104737922;13268.270245136513;13973.650658733524;14157.150570965749;14697.485588004422;15317.157556334398;15348.309326080325;15374.308156132973;15384.23078846056;877.9692710755124;894.1014280647939;896.5158814240302;897.3808072430003;898.3486971945352;900.6847603338845;901.7204666553357;902.309733054214;903.3315346643502;903.9457632542036;931.7018554062669;937.6015193542751;939.178219058324;940.4498368454463;943.5612440215299;897.6229983406952;925.1765928323797;932.5756780664781;933.304688007432;941.8775559177298;671.378974448633;677.5358879167736;677.9898301525432;678.3318431345122;678.6097993653669;13441.731165376637;13493.730125397535;13608.523701670394;13719.588412347646;13918.09532380392;15736.291866866019;16391.59021024472;16722.16389180536;16770.07764572948;16905.323787048503;12494.312812795293;12535.24788512692;12800.231986080866;13215.801762973562;13221.735565288736;3096.8916087936814;3107.7513798896034;3108.4870996285586;3119.4229067622564;3120.0327898351356;74846;75708.24291757066;76815.23184768192;77301.22698772997;78839.21160788376;12391.814122788166;12413.193142445713;12597.496100156075;12643.051771117203;12749.745005099847;23165.88417057904;23220.883895580413;23283.06867725306;23639.527209455715;23918.521629567313;6080.452759251689;6117.449429551361;6122.938770612326;6126.509879209652;6175.938240617536;2908.8691008904652;2956.438276727415;2985.9402811944074;2988.237999310162;2993.191838203673;3575.3385623659706;3692.8153592320814;3782.924341513154;3825.3496905526126;3825.5026846509777;653.0302500786329;654.8886689262837;661.751843058853;713.6895450478954;754.8603508350973;548;564.7232855900579;580.9890790025325;587.8500982249499;597.0089651179022;10195.615280024502;10416.791664166674;10661;10876.728081798019;10897.891021089847;581.3924448950856;589.6226415094343;593.7387549478216;601.7653115285042;609.8841220168154;4501.41481607389;4648.953985353269;4700.600448961808;4740.146773580788;4866.126541281561;84729.15270847213;84822;86215;86813.1318686805;88204.55897720471;74137.62931185309;74144;74297;74941.62529187319;75762;67756.6612166936;68452.65773671199;68562.3143768566;68864.65567672129;69687;9091.181793638605;9310.068993100636;9445.197158241352;9462.668806592012;9766.56050477716;29275.7072429273;29848.104556863327;30007.399852003273;31301.84349078331;31460.52809207818;39346.75351292501;39418.21163576655;39645.40531892081;39646.60353396429;40056;11872.168948173545;12107.213031152947;12143.271403715806;12163.2702037878;12319.75360492803;13159.60521184366;13165.736685266433;13296.268705221306;13328.666783330495;13523.256220907944;12957.093003489665;13157.53948611794;13257.270850103338;13259.138156019828;13369.732605348034;12629.74740505203;12669.113162078565;12724.300163491096;12842.935785321013;12977.480900763863;12062.336571488653;12134;12319.507219711111;12377.443015064164;12519.499220031461;9371.671991480265;9391.765205869635;9693.22454203648;9715.271354648288;9718.805623887623;9790.167835733757;9793.657221997197;9878.654247101316;9914.752131196488;10165.898341016495 07:06:16 INFO - PID 2208 | __end_tp_report 07:06:16 INFO - PID 2208 | __start_cc_report 07:06:16 INFO - PID 2208 | _x_x_mozilla_cycle_collect,356 07:06:16 INFO - PID 2208 | __end_cc_report 07:06:16 INFO - PID 2208 | __startTimestamp1495721176267__endTimestamp 07:06:16 INFO - PID 2208 | 07:06:16 INFO - PID 2208 | ------- Summary: start ------- 07:06:16 INFO - PID 2208 | Number of tests: 6 07:06:16 INFO - PID 2208 | 07:06:16 INFO - PID 2208 | [#0] dojo.html Cycles:165 Average:5274.01 Median:5431.05 stddev:638.70 (11.8%) stddev-sans-first:607.84 07:06:16 INFO - PID 2208 | Values: 2697.3 2729.5 2731.0 2761.4 2764.9 5143.7 5302.9 5313.6 5316.0 5395.4 5312.0 5363.2 5378.2 5466.7 5474.5 4721.2 4741.3 4756.4 4787.6 4831.6 4792.3 4830.3 4833.8 4839.4 4871.2 4701.3 4757.3 4799.2 4800.0 4848.8 4744.8 4758.5 4776.4 4785.5 4789.7 4687.9 4698.3 4702.5 4713.8 4762.8 5239.7 5256.6 5291.8 5295.0 5376.1 5711.5 5785.7 5795.7 5848.0 5868.7 5740.4 5747.9 5750.4 5773.7 5805.0 5340.2 5342.3 5350.2 5352.9 5371.5 5900.9 5915.3 5952.2 5962.6 5983.8 5726.5 5759.6 5762.3 5762.6 5790.2 5821.4 5830.7 5831.6 5852.8 5869.4 5673.4 5695.8 5809.2 5813.6 5827.9 5649.9 5696.4 5727.4 5739.8 5742.8 4815.5 4816.8 4821.8 4846.7 4856.6 4058.9 4086.6 4100.1 4146.3 4155.7 4728.5 4855.5 4859.2 4877.5 4888.0 5794.5 5805.9 5851.1 5894.3 5897.9 4771.7 4772.7 4778.7 4813.0 4855.2 5066.3 5066.6 5077.4 5087.1 5131.3 5280.3 5350.9 5358.5 5373.4 5431.0 5648.7 5750.0 5828.7 5837.5 5903.4 5304.7 5308.9 5319.5 5324.3 5459.6 5666.3 5672.8 5732.7 5755.9 5756.3 5747.9 5767.7 5771.1 5845.4 5848.0 5535.3 5565.4 5614.9 5646.8 5652.9 5585.5 5674.1 5679.3 5712.6 5731.8 5528.5 5583.7 5595.0 5595.4 5600.3 5595.2 5669.7 5698.3 5703.1 5714.8 5396.4 5439.9 5454.4 5491.4 5503.0 07:06:16 INFO - PID 2208 | 07:06:16 INFO - PID 2208 | [#1] ext.html Cycles:180 Average:29910.63 Median:3005.02 stddev:40411.26 (1344.8%) stddev-sans-first:40464.78 07:06:16 INFO - PID 2208 | Values: 623.2 673.3 675.1 1182.9 1193.4 34256.8 35041.6 35097.6 35099.0 35218.1 32858.0 33133.2 33272.5 33285.0 33423.3 6362.7 6524.0 6674.7 6682.6 6682.9 6688.4 6768.9 6792.2 6813.4 6825.7 6731.8 6751.9 6763.8 6764.1 6795.3 6717.6 6748.2 6758.1 6771.6 6811.3 6711.7 6719.8 6741.3 6752.5 6754.7 31170.5 31172.4 31191.4 31230.4 31236.4 2972.4 2976.3 2999.7 3010.4 3025.6 24379.4 24482.9 24568.0 24617.8 24658.5 2931.3 2935.0 2954.6 2968.5 2971.8 132947.0 133008.0 133273.0 154774.0 158113.0 39389.4 39514.2 39781.8 39800.4 39908.8 40980.6 41369.0 41389.6 41428.0 41527.4 11762.0 11957.4 11970.1 12043.6 12067.1 9420.8 9491.6 9495.5 9508.3 9546.3 11921.8 11990.6 11999.5 12078.6 12269.0 5349.0 5414.9 5469.3 5493.6 5498.1 852.6 901.1 911.0 913.1 931.2 20892.8 21444.2 21644.4 21709.6 21750.8 965.2 977.6 993.4 995.7 1000.7 11100.4 11144.2 11419.7 11480.7 11489.2 176469.0 176719.0 177240.0 178414.0 178760.0 40408.0 40840.8 40902.0 41013.4 41052.0 1197.0 1229.5 1236.6 1238.4 1243.1 19806.7 20296.0 20715.7 20870.5 21228.4 28992.7 29170.3 29264.6 29348.3 29390.6 146689.0 146721.0 146861.0 147024.0 147320.2 28448.4 28471.4 28485.0 28992.1 29008.4 35498.8 35756.3 35820.0 35921.6 36221.3 25105.7 26631.3 26688.7 27122.7 27525.6 27132.9 27297.3 27717.6 27938.4 27967.7 31321.2 31578.2 31656.2 31775.1 31835.5 26039.5 26581.9 27230.0 27699.9 27711.0 20680.3 21650.2 21671.5 21900.2 22104.7 07:06:16 INFO - PID 2208 | 07:06:16 INFO - PID 2208 | [#2] jquery.html Cycles:180 Average:24878.60 Median:40424.39 stddev:62507.63 (154.6%) stddev-sans-first:62655.95 07:06:16 INFO - PID 2208 | Values: 395.0 399.1 410.2 425.6 429.3 14536.8 15858.2 17042.7 17755.9 17775.5 18323.9 18336.6 18402.4 18549.5 18651.8 4931.1 5078.9 5108.9 5113.4 5126.4 4728.0 5466.9 5558.8 5589.9 5633.6 5595.6 5597.6 5608.7 5609.3 5617.2 5215.1 5374.3 5398.4 5422.8 5532.0 4853.2 4871.2 4877.6 4888.1 4889.2 21824.3 22201.9 22373.0 22550.2 22683.3 1600.1 1608.8 1652.1 1654.2 1658.4 14493.6 14580.9 14997.2 15020.2 15167.7 1392.3 1394.7 1413.0 1415.6 1427.9 87405.0 89888.0 90616.0 91519.0 92450.0 10859.0 10880.3 11025.8 11194.0 11364.3 15402.7 15471.8 15484.4 15519.6 15523.5 7138.6 7252.9 7307.3 7396.3 7417.1 6395.4 6430.5 6617.1 6637.9 6655.4 6767.6 6981.2 6986.9 6995.0 7093.9 1989.9 2021.9 2029.9 2052.9 2130.6 764.6 814.2 821.9 832.3 840.8 15700.9 16030.5 16145.7 16640.9 16768.7 823.9 825.4 826.7 833.9 851.6 8768.4 8860.9 8964.0 9101.6 9119.0 370837.0 375895.0 376395.0 376788.0 377108.0 71985.0 74608.0 75303.2 76653.1 78677.0 1036.2 1038.4 1047.8 1053.9 1062.2 16193.5 16767.6 17047.5 17992.1 18079.4 38848.6 38954.8 39737.0 40181.4 40667.4 48547.3 49631.5 49951.5 49991.3 49993.8 7461.7 7757.7 7957.2 8002.4 8237.0 11266.6 11338.7 11850.8 12373.8 12784.6 9704.3 10036.6 10133.9 10317.2 10569.9 7837.1 9040.1 9640.6 10067.6 10113.4 9993.8 10201.4 10682.1 10731.2 11053.8 8050.0 8169.2 8175.4 8255.8 8281.2 10326.5 10408.5 10536.2 10608.6 10784.2 07:06:16 INFO - PID 2208 | 07:06:16 INFO - PID 2208 | [#3] mootools.html Cycles:180 Average:6491.26 Median:3303.75 stddev:4270.14 (129.3%) stddev-sans-first:4264.09 07:06:16 INFO - PID 2208 | Values: 1269.2 1303.6 1329.8 1329.9 1331.4 10190.0 10522.7 10530.2 10951.7 11187.3 10978.7 11199.2 11219.0 11262.9 11326.9 2100.4 2118.0 2125.0 2133.4 2145.1 2229.9 2262.6 2266.0 2267.3 2272.6 2157.6 2188.2 2191.9 2192.2 2206.1 2154.7 2160.7 2167.1 2169.8 2171.1 1808.5 1860.8 1939.1 2038.8 2041.4 10654.6 10670.7 10725.7 10736.9 10756.3 5588.6 5796.9 5808.2 5810.1 5812.7 3152.2 3292.9 3314.6 3323.7 3336.5 1090.0 1095.7 1135.9 1137.5 1182.9 15122.8 15199.8 15438.8 15444.6 15445.1 4541.3 4707.6 4852.8 4853.5 4921.7 10549.6 10570.2 10571.9 10584.3 10622.8 5485.3 5537.4 5575.4 5580.1 5601.0 5169.9 5186.7 5207.5 5214.9 5287.3 4281.7 4282.8 4400.6 4429.0 4437.2 1247.3 1305.8 1323.8 1333.7 1339.8 667.7 685.7 688.5 693.4 712.8 5554.8 5704.8 5709.3 5759.7 5794.5 538.6 558.3 558.5 562.9 565.5 3473.5 3803.4 3854.8 3878.2 3976.5 13693.3 13843.4 13944.6 14003.4 14062.9 13323.5 13991.7 14018.4 14023.7 14295.1 7570.5 7592.6 7615.3 7621.7 7624.3 5829.5 5975.6 5984.3 6004.4 6197.8 12700.2 12865.3 12908.2 13014.5 13132.5 12617.1 12882.5 13083.6 13160.7 13290.8 8315.5 8470.4 8491.7 8504.9 8526.5 9964.0 10002.9 10039.8 10072.3 10076.5 8277.5 8368.0 8582.0 8586.5 8844.2 8279.7 8303.6 8336.1 8482.9 8581.8 7708.2 7831.5 7851.8 7864.5 7867.7 4519.5 5271.6 5333.1 5364.3 5576.5 5099.9 5128.1 5192.4 5322.3 5398.2 07:06:16 INFO - PID 2208 | 07:06:16 INFO - PID 2208 | [#4] prototype.html Cycles:180 Average:4753.63 Median:5397.01 stddev:1415.45 (26.2%) stddev-sans-first:1380.29 07:06:16 INFO - PID 2208 | Values: 350.2 369.3 373.6 377.5 383.3 5376.7 5523.3 5553.6 5596.6 5605.3 5324.7 5388.8 5405.3 5410.8 5414.4 4093.8 4119.3 4126.1 4128.2 4133.9 4093.5 4112.4 4131.0 4136.4 4143.9 4058.0 4071.7 4080.7 4081.2 4094.7 4049.4 4074.0 4077.1 4083.4 4091.7 3555.4 3566.0 3569.3 3574.7 3576.7 5174.4 5262.3 5278.7 5297.7 5319.5 4794.6 4813.6 4813.7 4817.6 4822.3 5486.8 5668.8 5672.7 5719.7 5722.7 3982.4 4012.8 4019.4 4020.9 4032.9 5921.4 6097.3 6130.9 6148.9 6155.0 4086.0 4111.4 4112.5 4121.1 4124.2 4168.0 4174.4 4177.2 4181.1 4184.7 4665.3 4787.3 4817.2 4833.3 4835.8 5803.0 5822.0 5825.3 5826.7 5831.0 1408.3 1410.8 1420.8 1422.9 1436.7 939.9 969.6 970.0 1118.9 1129.0 4959.0 4963.4 4988.8 4989.5 5013.0 5940.6 5941.2 5947.5 5978.2 6001.2 4813.0 4967.7 4968.0 4973.7 4997.5 3164.0 3170.9 3183.5 3183.7 3201.9 5440.3 5565.5 5577.7 5585.3 5589.6 6096.7 6175.2 6214.9 6226.9 6236.7 5562.8 5566.6 5605.2 5615.0 5621.4 5855.4 5939.4 5984.5 6011.3 6024.6 5896.3 5908.1 5911.7 5929.9 5931.0 5337.5 5505.9 5533.6 5561.7 5578.1 4033.6 4065.4 4066.3 4067.5 4083.2 5885.3 5943.4 5948.6 5994.4 6025.8 5824.1 5829.3 5838.2 5838.9 5839.9 5767.7 5773.2 5816.6 5818.2 5822.3 5655.6 5692.6 5742.2 5742.4 5750.9 5847.8 5878.4 5884.6 5891.2 5899.6 5584.3 5605.9 5662.2 5699.8 5722.3 07:06:16 INFO - PID 2208 | 07:06:16 INFO - PID 2208 | [#5] yui.html Cycles:180 Average:17057.64 Median:22278.71 stddev:22824.33 (102.4%) stddev-sans-first:22855.43 07:06:16 INFO - PID 2208 | Values: 729.6 734.8 746.9 759.8 762.6 11334.8 11844.8 13268.3 13973.7 14157.2 14697.5 15317.2 15348.3 15374.3 15384.2 878.0 894.1 896.5 897.4 898.3 900.7 901.7 902.3 903.3 903.9 931.7 937.6 939.2 940.4 943.6 897.6 925.2 932.6 933.3 941.9 671.4 677.5 678.0 678.3 678.6 13441.7 13493.7 13608.5 13719.6 13918.1 15736.3 16391.6 16722.2 16770.1 16905.3 12494.3 12535.2 12800.2 13215.8 13221.7 3096.9 3107.8 3108.5 3119.4 3120.0 74846.0 75708.2 76815.2 77301.2 78839.2 12391.8 12413.2 12597.5 12643.1 12749.7 23165.9 23220.9 23283.1 23639.5 23918.5 6080.5 6117.4 6122.9 6126.5 6175.9 2908.9 2956.4 2985.9 2988.2 2993.2 3575.3 3692.8 3782.9 3825.3 3825.5 653.0 654.9 661.8 713.7 754.9 548.0 564.7 581.0 587.9 597.0 10195.6 10416.8 10661.0 10876.7 10897.9 581.4 589.6 593.7 601.8 609.9 4501.4 4649.0 4700.6 4740.1 4866.1 84729.2 84822.0 86215.0 86813.1 88204.6 74137.6 74144.0 74297.0 74941.6 75762.0 67756.7 68452.7 68562.3 68864.7 69687.0 9091.2 9310.1 9445.2 9462.7 9766.6 29275.7 29848.1 30007.4 31301.8 31460.5 39346.8 39418.2 39645.4 39646.6 40056.0 11872.2 12107.2 12143.3 12163.3 12319.8 13159.6 13165.7 13296.3 13328.7 13523.3 12957.1 13157.5 13257.3 13259.1 13369.7 12629.7 12669.1 12724.3 12842.9 12977.5 12062.3 12134.0 12319.5 12377.4 12519.5 9371.7 9391.8 9693.2 9715.3 9718.8 9790.2 9793.7 9878.7 9914.8 10165.9 07:06:16 INFO - PID 2208 | -------- Summary: end -------- 07:06:16 INFO - PID 2208 | 07:06:17 INFO - TEST-INFO | 2208: exit 0 07:06:17 INFO - TEST-OK | dromaeo_css | took 1146545ms 07:06:17 INFO - TEST-START | kraken 07:06:17 INFO - operating with platform_type : linux_ 07:06:17 INFO - Initialising browser for kraken test... 07:06:17 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:37101/getInfo.html -profile /tmp/tmpidYNWr/profile 07:06:17 INFO - TEST-INFO | started process 2761 (/builds/slave/test/build/application/firefox/firefox http://localhost:37101/getInfo.html) 07:06:51 INFO - TEST-INFO | 2761: killed by SIGTERM 07:06:51 INFO - Browser initialized. 07:06:51 INFO - Running cycle 1/1 for kraken test... 07:06:51 INFO - TEST-INFO | started process 3048 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpidYNWr/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:07:03 INFO - PID 3048 | RSS: Main: 177655808 07:07:03 INFO - PID 3048 | 07:07:06 INFO - PID 3048 | Cycle 1(1): loaded http://localhost:37101/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37101/tests/kraken/driver.html?testName=audio-beat-detection) 07:07:07 INFO - PID 3048 | RSS: Main: 182054912 07:07:07 INFO - PID 3048 | 07:07:09 INFO - PID 3048 | Cycle 1(1): loaded http://localhost:37101/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37101/tests/kraken/driver.html?testName=audio-dft) 07:07:10 INFO - PID 3048 | RSS: Main: 181284864 07:07:10 INFO - PID 3048 | 07:07:13 INFO - PID 3048 | Cycle 1(1): loaded http://localhost:37101/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37101/tests/kraken/driver.html?testName=audio-fft) 07:07:14 INFO - PID 3048 | RSS: Main: 178819072 07:07:14 INFO - PID 3048 | 07:07:16 INFO - PID 3048 | Cycle 1(1): loaded http://localhost:37101/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37101/tests/kraken/driver.html?testName=audio-oscillator) 07:07:16 INFO - PID 3048 | RSS: Main: 179027968 07:07:16 INFO - PID 3048 | 07:07:19 INFO - PID 3048 | Cycle 1(1): loaded http://localhost:37101/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37101/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:07:19 INFO - PID 3048 | RSS: Main: 179920896 07:07:19 INFO - PID 3048 | 07:07:22 INFO - PID 3048 | Cycle 1(1): loaded http://localhost:37101/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37101/tests/kraken/driver.html?testName=imaging-darkroom) 07:07:23 INFO - PID 3048 | RSS: Main: 180604928 07:07:23 INFO - PID 3048 | 07:07:27 INFO - PID 3048 | Cycle 1(1): loaded http://localhost:37101/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37101/tests/kraken/driver.html?testName=imaging-desaturate) 07:07:27 INFO - PID 3048 | RSS: Main: 179408896 07:07:27 INFO - PID 3048 | 07:07:30 INFO - PID 3048 | Cycle 1(1): loaded http://localhost:37101/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37101/tests/kraken/driver.html?testName=json-parse-financial) 07:07:31 INFO - PID 3048 | RSS: Main: 180047872 07:07:31 INFO - PID 3048 | 07:07:32 INFO - PID 3048 | Cycle 1(1): loaded http://localhost:37101/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37101/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:07:33 INFO - PID 3048 | RSS: Main: 180154368 07:07:33 INFO - PID 3048 | 07:07:35 INFO - PID 3048 | Cycle 1(1): loaded http://localhost:37101/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37101/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:07:35 INFO - PID 3048 | RSS: Main: 179945472 07:07:35 INFO - PID 3048 | 07:07:38 INFO - PID 3048 | Cycle 1(1): loaded http://localhost:37101/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37101/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:07:38 INFO - PID 3048 | RSS: Main: 180039680 07:07:38 INFO - PID 3048 | 07:07:41 INFO - PID 3048 | Cycle 1(1): loaded http://localhost:37101/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37101/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:07:42 INFO - PID 3048 | RSS: Main: 180690944 07:07:42 INFO - PID 3048 | 07:07:45 INFO - PID 3048 | Cycle 1(1): loaded http://localhost:37101/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37101/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:07:46 INFO - PID 3048 | RSS: Main: 180232192 07:07:46 INFO - PID 3048 | 07:07:48 INFO - PID 3048 | Cycle 1(1): loaded http://localhost:37101/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37101/tests/kraken/driver.html?testName=ai-astar) 07:07:48 INFO - PID 3048 | RSS: Main: 181698560 07:07:48 INFO - PID 3048 | 07:07:48 INFO - PID 3048 | __start_tp_report 07:07:48 INFO - PID 3048 | _x_x_mozilla_page_load 07:07:48 INFO - PID 3048 | _x_x_mozilla_page_load_details 07:07:48 INFO - PID 3048 | |i|pagename|runs| 07:07:48 INFO - PID 3048 | |0;ai-astar;105;114;112;114;113;113;112;114;113;113 07:07:48 INFO - PID 3048 | |1;audio-beat-detection;150;127;124;180;125;132;123;123;156;127 07:07:48 INFO - PID 3048 | |2;audio-dft;166;165;167;176;172;167;166;163;166;163 07:07:48 INFO - PID 3048 | |3;audio-fft;77;75;76;107;75;74;74;78;96;74 07:07:48 INFO - PID 3048 | |4;audio-oscillator;84;85;107;85;85;85;98;84;84;103 07:07:48 INFO - PID 3048 | |5;imaging-gaussian-blur;114;116;116;114;115;113;114;115;115;115 07:07:48 INFO - PID 3048 | |6;imaging-darkroom;151;152;154;152;152;155;152;152;150;152 07:07:48 INFO - PID 3048 | |7;imaging-desaturate;95;97;95;95;95;95;95;95;100;94 07:07:48 INFO - PID 3048 | |8;json-parse-financial;57;58;54;55;57;60;59;57;61;66 07:07:48 INFO - PID 3048 | |9;json-stringify-tinderbox;58;58;56;58;58;56;56;57;57;57 07:07:48 INFO - PID 3048 | |10;stanford-crypto-aes;91;89;87;88;86;86;90;96;116;88 07:07:48 INFO - PID 3048 | |11;stanford-crypto-ccm;147;147;151;136;135;134;147;135;142;135 07:07:48 INFO - PID 3048 | |12;stanford-crypto-pbkdf2;189;190;199;197;202;203;200;209;189;200 07:07:48 INFO - PID 3048 | |13;stanford-crypto-sha256-iterative;78;75;75;76;79;74;73;74;72;74 07:07:48 INFO - PID 3048 | __end_tp_report 07:07:48 INFO - PID 3048 | __start_cc_report 07:07:48 INFO - PID 3048 | _x_x_mozilla_cycle_collect,907 07:07:48 INFO - PID 3048 | __end_cc_report 07:07:48 INFO - PID 3048 | __startTimestamp1495721268374__endTimestamp 07:07:48 INFO - PID 3048 | 07:07:48 INFO - PID 3048 | ------- Summary: start ------- 07:07:48 INFO - PID 3048 | Number of tests: 14 07:07:48 INFO - PID 3048 | 07:07:48 INFO - PID 3048 | [#0] ai-astar Cycles:10 Average:112.30 Median:113.00 stddev:2.67 (2.4%) stddev-sans-first:0.78 07:07:48 INFO - PID 3048 | Values: 105.0 114.0 112.0 114.0 113.0 113.0 112.0 114.0 113.0 113.0 07:07:48 INFO - PID 3048 | 07:07:48 INFO - PID 3048 | [#1] audio-beat-detection Cycles:10 Average:136.70 Median:129.50 stddev:19.17 (14.8%) stddev-sans-first:19.72 07:07:48 INFO - PID 3048 | Values: 150.0 127.0 124.0 180.0 125.0 132.0 123.0 123.0 156.0 127.0 07:07:48 INFO - PID 3048 | 07:07:48 INFO - PID 3048 | [#2] audio-dft Cycles:10 Average:167.10 Median:166.50 stddev:4.01 (2.4%) stddev-sans-first:4.24 07:07:48 INFO - PID 3048 | Values: 166.0 165.0 167.0 176.0 172.0 167.0 166.0 163.0 166.0 163.0 07:07:48 INFO - PID 3048 | 07:07:48 INFO - PID 3048 | [#3] audio-fft Cycles:10 Average:80.60 Median:75.50 stddev:11.39 (15.1%) stddev-sans-first:12.01 07:07:48 INFO - PID 3048 | Values: 77.0 75.0 76.0 107.0 75.0 74.0 74.0 78.0 96.0 74.0 07:07:48 INFO - PID 3048 | 07:07:48 INFO - PID 3048 | [#4] audio-oscillator Cycles:10 Average:90.00 Median:85.00 stddev:9.01 (10.6%) stddev-sans-first:9.29 07:07:48 INFO - PID 3048 | Values: 84.0 85.0 107.0 85.0 85.0 85.0 98.0 84.0 84.0 103.0 07:07:48 INFO - PID 3048 | 07:07:48 INFO - PID 3048 | [#5] imaging-gaussian-blur Cycles:10 Average:114.70 Median:115.00 stddev:0.95 (0.8%) stddev-sans-first:0.97 07:07:48 INFO - PID 3048 | Values: 114.0 116.0 116.0 114.0 115.0 113.0 114.0 115.0 115.0 115.0 07:07:48 INFO - PID 3048 | 07:07:48 INFO - PID 3048 | [#6] imaging-darkroom Cycles:10 Average:152.20 Median:152.00 stddev:1.40 (0.9%) stddev-sans-first:1.41 07:07:48 INFO - PID 3048 | Values: 151.0 152.0 154.0 152.0 152.0 155.0 152.0 152.0 150.0 152.0 07:07:48 INFO - PID 3048 | 07:07:48 INFO - PID 3048 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:95.00 stddev:1.71 (1.8%) stddev-sans-first:1.80 07:07:48 INFO - PID 3048 | Values: 95.0 97.0 95.0 95.0 95.0 95.0 95.0 95.0 100.0 94.0 07:07:48 INFO - PID 3048 | 07:07:48 INFO - PID 3048 | [#8] json-parse-financial Cycles:10 Average:58.40 Median:58.50 stddev:3.41 (5.8%) stddev-sans-first:3.57 07:07:48 INFO - PID 3048 | Values: 57.0 58.0 54.0 55.0 57.0 60.0 59.0 57.0 61.0 66.0 07:07:48 INFO - PID 3048 | 07:07:48 INFO - PID 3048 | [#9] json-stringify-tinderbox Cycles:10 Average:57.10 Median:57.50 stddev:0.88 (1.5%) stddev-sans-first:0.87 07:07:48 INFO - PID 3048 | Values: 58.0 58.0 56.0 58.0 58.0 56.0 56.0 57.0 57.0 57.0 07:07:48 INFO - PID 3048 | 07:07:48 INFO - PID 3048 | [#10] stanford-crypto-aes Cycles:10 Average:91.70 Median:88.50 stddev:9.03 (10.2%) stddev-sans-first:9.58 07:07:48 INFO - PID 3048 | Values: 91.0 89.0 87.0 88.0 86.0 86.0 90.0 96.0 116.0 88.0 07:07:48 INFO - PID 3048 | 07:07:48 INFO - PID 3048 | [#11] stanford-crypto-ccm Cycles:10 Average:140.90 Median:144.50 stddev:6.59 (4.6%) stddev-sans-first:6.61 07:07:48 INFO - PID 3048 | Values: 147.0 147.0 151.0 136.0 135.0 134.0 147.0 135.0 142.0 135.0 07:07:48 INFO - PID 3048 | 07:07:48 INFO - PID 3048 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:197.80 Median:200.00 stddev:6.65 (3.3%) stddev-sans-first:6.24 07:07:48 INFO - PID 3048 | Values: 189.0 190.0 199.0 197.0 202.0 203.0 200.0 209.0 189.0 200.0 07:07:48 INFO - PID 3048 | 07:07:48 INFO - PID 3048 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:75.00 Median:75.00 stddev:2.16 (2.9%) stddev-sans-first:2.00 07:07:48 INFO - PID 3048 | Values: 78.0 75.0 75.0 76.0 79.0 74.0 73.0 74.0 72.0 74.0 07:07:48 INFO - PID 3048 | -------- Summary: end -------- 07:07:48 INFO - PID 3048 | 07:07:49 INFO - TEST-INFO | 3048: exit 0 07:07:49 INFO - TEST-OK | kraken | took 92433ms 07:07:49 INFO - SUITE-END | took 1238s 07:07:49 INFO - Completed test suite (00:20:39) 07:07:49 INFO - javascript benchmark 07:07:49 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6712.490909467558, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2697.3391519077823, 2729.5496243119887, 2730.9726902730968, 2761.3786897947966, 2764.8755805988735, 5143.691378517282, 5302.92045619316, 5313.601479889005, 5316.016536940659, 5395.406505284421, 5311.973440132803, 5363.249145119687, 5378.193271009351, 5466.671999680022, 5474.507294343508, 4721.173794585951, 4741.336212930192, 4756.405449318835, 4787.61699064074, 4831.589314908237, 4792.281157826336, 4830.347903033081, 4833.7824797884, 4839.370881785363, 4871.171900776876, 4701.294805779126, 4757.333973243749, 4799.208130658437, 4800.039992001613, 4848.757562121879, 4744.810207591692, 4758.477287268076, 4776.379070720819, 4785.521447855187, 4789.664723469358, 4687.88280292992, 4698.271767875985, 4702.482726900038, 4713.811447542129, 4762.833300834454, 5239.659422137549, 5256.605754568384, 5291.841244762663, 5294.973525132388, 5376.059189641836, 5711.514521265697, 5785.652860828363, 5795.710214489259, 5848.035074212749, 5868.706564671749, 5740.425957404268, 5747.856303592402, 5750.367459579443, 5773.653580785166, 5804.970975145139, 5340.172273297645, 5342.252084708144, 5350.170723537858, 5352.866178345573, 5371.543418809406, 5900.940990590125, 5915.260592425947, 5952.226210592682, 5962.612430192024, 5983.760649574056, 5726.484616384545, 5759.596828221985, 5762.2509073820975, 5762.596618236767, 5790.189373487715, 5821.417858214145, 5830.7084645767545, 5831.620944638585, 5852.824415267549, 5869.413058694096, 5673.375928647845, 5695.800646977336, 5809.215755872988, 5813.563982701315, 5827.854303642443, 5649.943500565024, 5696.401877802854, 5727.398623144593, 5739.799107031234, 5742.799002034909, 4815.518448155157, 4816.783244753994, 4821.831235906797, 4846.733429661403, 4856.635752318591, 4058.939115913264, 4086.5504794472586, 4100.097978444737, 4146.274401979642, 4155.729877558009, 4728.456227533878, 4855.490173531799, 4859.173940430064, 4877.487863774323, 4887.975560122177, 5794.478496935296, 5805.941940580625, 5851.063829787214, 5894.292684877756, 5897.852553686106, 4771.73755443447, 4772.7136371817805, 4778.665493415497, 4813.03739252151, 4855.223164293696, 5066.316047333637, 5066.594672426197, 5077.416097148801, 5087.084324821568, 5131.332926719577, 5280.260763493191, 5350.866228344167, 5358.544523715528, 5373.382061062872, 5431.049566325956, 5648.661080335193, 5749.9712501437225, 5828.737706803119, 5837.5329973601165, 5903.380145084876, 5304.681719096867, 5308.920366194588, 5319.521243087986, 5324.334458192726, 5459.617826752089, 5666.263385759825, 5672.780352224291, 5732.656040637575, 5755.942440575708, 5756.3380211276235, 5747.8563035924435, 5767.68277744728, 5771.07662773971, 5845.386234445322, 5848.0350742127075, 5535.335759708861, 5565.443455654402, 5614.905093506727, 5646.802361917313, 5652.915206271827, 5585.525230355465, 5674.092145256739, 5679.318481782213, 5712.571557133315, 5731.770729170953, 5528.502434780889, 5583.74873130702, 5594.972025140011, 5595.356533998643, 5600.299962504687, 5595.188697638738, 5669.688167150846, 5698.287714035746, 5703.116017017369, 5714.828555143353, 5396.3524377075, 5439.918401224064, 5454.400015998158, 5491.368492623399, 5502.972485137549], "value": 5226.092106761046, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [623.2085251730302, 673.3165836675773, 675.0684056002716, 1182.8994535464485, 1193.427154965616, 34256.82871585642, 35041.64958350416, 35097.64902350976, 35099.0, 35218.11954701134, 32858.0, 33133.171670708245, 33272.50091248627, 33285.0, 33423.331533369375, 6362.681865906709, 6523.9673801630925, 6674.699638516278, 6682.632455214961, 6682.866342673144, 6688.431483323923, 6768.864622707543, 6792.18493780747, 6813.3527314905, 6825.6587170641515, 6731.798046058626, 6751.898721519181, 6763.763268285611, 6764.086848275469, 6795.286494918037, 6717.59694418334, 6748.156480439945, 6758.121444212221, 6771.645670865846, 6811.284815094443, 6711.664416779142, 6719.832004199885, 6741.3258674132685, 6752.527323087385, 6754.729810807562, 31170.532442013387, 31172.37655246905, 31191.376172476423, 31230.37539249225, 31236.375272494424, 2972.3758010817537, 2976.255936015996, 2999.6700362960055, 3010.3678227572236, 3025.6066711327385, 24379.390515237083, 24482.877585611957, 24568.0, 24617.753822461724, 24658.506829863483, 2931.2818359502057, 2935.0461100142325, 2954.6454425468864, 2968.5250359942306, 2971.821690698565, 132947.0, 133008.0, 133273.0, 154774.0, 158113.0, 39389.40915886264, 39514.209715805526, 39781.80109099494, 39800.40299395511, 39908.80045599753, 40980.59019409768, 41369.0, 41389.586104139176, 41428.0, 41527.37708934308, 11762.0, 11957.402129893471, 11970.102242331859, 12043.578474753342, 12067.094967877445, 9420.764480887896, 9491.572879220452, 9495.477748723748, 9508.334416590773, 9546.284028697875, 11921.761564768656, 11990.580329688419, 11999.520139159546, 12078.577249796215, 12269.0, 5348.9836930983765, 5414.8917021659345, 5469.288992431038, 5493.587980901369, 5498.120300751941, 852.624845068168, 901.121406628532, 910.9590068446936, 913.1097180249204, 931.1991687149047, 20892.791072089083, 21444.24945126913, 21644.35066947994, 21709.56580868374, 21750.782492174876, 965.1844191658038, 977.5747549815853, 993.4039576254335, 995.6564985080136, 1000.7498125468633, 11100.448815985406, 11144.219904606762, 11419.714507137222, 11480.712982175512, 11489.195756297146, 176469.0, 176719.0, 177240.0, 178414.0, 178760.0, 40408.0, 40840.795796021426, 40902.0, 41013.384799228035, 41052.0, 1196.9940150299367, 1229.5081967213187, 1236.5795629486017, 1238.448890243833, 1243.1173866554848, 19806.70289945623, 20296.0, 20715.68926466074, 20870.478238044172, 21228.363149105553, 28992.710072899845, 29170.270743231587, 29264.56103158412, 29348.266293342836, 29390.559141612466, 146689.0, 146721.0, 146861.0, 147024.0, 147320.21438284699, 28448.43103137967, 28471.43057138887, 28485.0, 28992.13023609295, 29008.41983160367, 35498.82250588731, 35756.28487430289, 35820.0, 35921.64078359288, 36221.27557448889, 25105.74894251034, 26631.33421664474, 26688.733112668626, 27122.72877271281, 27525.587116193674, 27132.864335678983, 27297.31756706098, 27717.58423623607, 27938.441231175668, 27967.72032279651, 31321.216969575944, 31578.210544736565, 31656.20859478439, 31775.121602503612, 31835.522467163475, 26039.479210416066, 26581.867090664422, 27230.046948357503, 27699.86150069237, 27711.030113945915, 20680.276190333265, 21650.24224152147, 21671.45821354479, 21900.23349182771, 22104.66842997324], "value": 14300.047478723423, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [394.98685870741565, 399.07613873881945, 410.24514892597614, 425.5616714783772, 429.3066697283887, 14536.781948270784, 15858.20708964553, 17042.659146817055, 17755.934643921373, 17775.466735997925, 18323.908380458113, 18336.633267334677, 18402.447926562225, 18549.53626159347, 18651.813481865178, 4931.087748766472, 5078.898422031557, 5108.923366149511, 5113.437521872591, 5126.410462796789, 4728.0, 5466.945330546703, 5558.777648894039, 5589.944100559003, 5633.60564760467, 5595.552355811526, 5597.63615365002, 5608.747606357723, 5609.3268807743125, 5617.157426386034, 5215.113430716769, 5374.301340825707, 5398.379186393576, 5422.810201642943, 5531.9723401382935, 4853.174960256765, 4871.196252618313, 4877.609791216694, 4888.144574699449, 4889.217725163957, 21824.345269641937, 22201.888990554944, 22373.0, 22550.210742624095, 22683.319500415015, 1600.0719582642039, 1608.7747715319865, 1652.1408867389011, 1654.2225154177518, 1658.4029749290246, 14493.565193044225, 14580.927095364561, 14997.17515536645, 15020.248987550687, 15167.696646067017, 1392.296890070518, 1394.7419727350473, 1412.9858701412957, 1415.6248594122567, 1427.9286035698174, 87405.0, 89887.99999999935, 90616.0, 91519.0, 92450.0, 10859.0, 10880.347179169275, 11025.779484410266, 11194.041042817475, 11364.261323013978, 15402.691946161238, 15471.845281547041, 15484.380624775109, 15519.594462858275, 15523.45667901618, 7138.64306784669, 7252.927470725331, 7307.3058059484265, 7396.297351751575, 7417.109946806418, 6395.392437718409, 6430.5177111715875, 6617.073609694647, 6637.933620663828, 6655.401013908771, 6767.560108592926, 6981.197162326397, 6986.860262794818, 6994.971458277145, 7093.89359159613, 1989.8806071635747, 2021.8887961161984, 2029.8579099462895, 2052.8563000589816, 2130.62714025045, 764.6296480909137, 814.2386868278179, 821.9095899451056, 832.3382910586099, 840.8234270803077, 15700.92149539245, 16030.519084427486, 16145.677086458205, 16640.916795415946, 16768.6646267074, 823.9340852731767, 825.3892119831281, 826.6569373709963, 833.8665813469937, 851.586980314547, 8768.386212965032, 8860.8670869937, 8964.0, 9101.635934562675, 9119.0, 370837.0, 375895.0, 376395.0, 376788.0, 377108.0, 71985.0, 74608.0, 75303.24696753072, 76653.12153675682, 78677.0, 1036.2435422141727, 1038.4236748604446, 1047.7956798424234, 1053.8735351757684, 1062.219268837404, 16193.514194574182, 16767.580810479834, 17047.48857534276, 17992.100394979938, 18079.36722214716, 38848.61151388563, 38954.80522597369, 39737.0, 40181.39727904142, 40667.3899891496, 48547.27179092387, 49631.503684962685, 49951.500484994685, 49991.25013124733, 49993.75003124961, 7461.701531938662, 7757.681194196887, 7957.204279571996, 8002.359811215205, 8236.958815205886, 11266.605668801552, 11338.716532086764, 11850.822237666614, 12373.814392783936, 12784.552540661032, 9704.320697551104, 10036.598536058767, 10133.949330253596, 10317.17462603005, 10569.943005699675, 7837.098733645704, 9040.141186587263, 9640.566174522304, 10067.590537324633, 10113.443760593238, 9993.750156246151, 10201.38791672502, 10682.145428365557, 10731.195160362848, 11053.83419248728, 8050.0, 8169.223923727236, 8175.427720059539, 8255.752327430188, 8281.17188281167, 10326.535305911402, 10408.481943049013, 10536.15710743154, 10608.575656973944, 10784.19118566095], "value": 8533.207267062173, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1269.206745783885, 1303.6414985878882, 1329.807177959196, 1329.9268540230285, 1331.407523651975, 10190.0, 10522.684319470418, 10530.210234232425, 10951.671449856518, 11187.272827266223, 10978.670639880796, 11199.160062995288, 11219.0, 11262.887371126286, 11326.943365283183, 2100.401385605103, 2118.0, 2125.043730321354, 2133.434639820449, 2145.0561752828785, 2229.888505574723, 2262.6153553895797, 2266.036934302923, 2267.285804971437, 2272.6363781794917, 2157.611629906616, 2188.157559339658, 2191.923282685106, 2192.199847055821, 2206.095500844654, 2154.709114269569, 2160.6975023496725, 2167.1114842914485, 2169.750478694939, 2171.0772921508374, 1808.4574627611664, 1860.7953125156223, 1939.0983192815268, 2038.7961203879643, 2041.428400047989, 10654.62708805188, 10670.733231669194, 10725.731856703567, 10736.892631073668, 10756.300840445425, 5588.580856435743, 5796.942030579682, 5808.215890854765, 5810.070388737824, 5812.738426770806, 3152.180433087391, 3292.9176770580925, 3314.585676790401, 3323.667633236681, 3336.5328853960464, 1090.0080926356977, 1095.6822521468764, 1135.903448206895, 1137.454022069403, 1182.8639706433698, 15122.773158402742, 15199.848001519953, 15438.845611543853, 15444.613884652861, 15445.0732956023, 4541.3188021797, 4707.599854012379, 4852.781624826891, 4853.538913803183, 4921.729304888194, 10549.630762923261, 10570.15438764897, 10571.94714026425, 10584.312019718695, 10622.787544249071, 5485.314335708036, 5537.446255374431, 5575.358833734173, 5580.051391263495, 5601.0, 5169.922451163236, 5186.740662966837, 5207.453217412193, 5214.921776173361, 5287.312649355559, 4281.721688090264, 4282.843632219284, 4400.647948164139, 4428.977855110704, 4437.156940181355, 1247.2703468470866, 1305.8432988041495, 1323.8279023726855, 1333.673250053743, 1339.82582264305, 667.6695035957232, 685.6708779785631, 688.5352387138762, 693.3759616345329, 712.7861641507527, 5554.805581804618, 5704.80033198836, 5709.314882214161, 5759.740811663485, 5794.536437085023, 538.6498775795764, 558.2686680448626, 558.5447859994092, 562.9240052592929, 565.5108331293402, 3473.5310733050715, 3803.353429916921, 3854.807259637007, 3878.243742470191, 3976.5029371328583, 13693.315334233248, 13843.446262149602, 13944.58166255014, 14003.369848356848, 14062.859371406155, 13323.467061317438, 13991.720165596835, 14018.369173387222, 14023.719525609635, 14295.07082039664, 7570.485902819458, 7592.582407967504, 7615.314621683964, 7621.69513219465, 7624.313811756858, 5829.5336373090895, 5975.551833612583, 5984.311804142405, 6004.369541198286, 6197.845053873689, 12700.237985720887, 12865.292408917225, 12908.16096953695, 13014.544490942772, 13132.474701012236, 12617.116801824151, 12882.549110781078, 13083.607491775261, 13160.670983225496, 13290.800637990631, 8315.542645154575, 8470.407071504935, 8491.702790402307, 8504.872426913478, 8526.531040792815, 9964.0, 10002.899971000197, 10039.849402259119, 10072.345297555636, 10076.546555404877, 8277.54473503939, 8367.95816020916, 8581.95709021451, 8586.484810911365, 8844.248238899765, 8279.710210142615, 8303.629052276274, 8336.12470690593, 8482.915170848459, 8581.785455363666, 7708.152103268524, 7831.530108193527, 7851.764447066597, 7864.4888082274465, 7867.685292588232, 4519.525449827721, 5271.551918087006, 5333.093374126331, 5364.30264065669, 5576.498115169654, 5099.923501147411, 5128.128218202989, 5192.402873669576, 5322.254884316276, 5398.217258497574], "value": 4796.668706092852, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [350.24871650310087, 369.2596344329619, 373.6133102239183, 377.47907887115775, 383.26987089594326, 5376.677399356041, 5523.337199536057, 5553.555715542757, 5596.608237423382, 5605.271314729084, 5324.733763311829, 5388.757505912234, 5405.27028851105, 5410.756515956781, 5414.40441551429, 4093.836246550142, 4119.2997190477545, 4126.133511962492, 4128.153728485653, 4133.896652583694, 4093.488313960755, 4112.3625837995005, 4131.0, 4136.400221967813, 4143.917121657565, 4057.9594204057876, 4071.694622903279, 4080.6939479539005, 4081.1837632473475, 4094.651954583864, 4049.4128351389177, 4074.0, 4077.103037331782, 4083.3874918762126, 4091.713580049398, 3555.377808883461, 3566.0, 3569.3218288525095, 3574.696150827183, 3576.695980841632, 5174.379074511083, 5262.2632831403635, 5278.709670968095, 5297.655652382583, 5319.494648008433, 4794.592459640935, 4813.628115986962, 4813.687110337817, 4817.590504807061, 4822.252550854623, 5486.835394938158, 5668.801591944303, 5672.659640421588, 5719.7140142992685, 5722.738039317591, 3982.38273067675, 4012.799360031987, 4019.41718450823, 4020.8994775130564, 4032.919341613151, 5921.407859214087, 6097.298810636789, 6130.938690613081, 6148.907766383508, 6154.984427569446, 4085.9785053736564, 4111.362738775435, 4112.547619761824, 4121.1345617420075, 4124.154548317588, 4167.99968007682, 4174.3947127666315, 4177.164567086595, 4181.1010632713505, 4184.66522678185, 4665.323528088408, 4787.305840653085, 4817.205161148441, 4833.275008748716, 4835.758212089452, 5803.0, 5821.970890145522, 5825.330087040044, 5826.679532625746, 5831.0, 1408.2817762940974, 1410.7883817427469, 1420.7868819676924, 1422.8648278413534, 1436.676747731752, 939.9436033837992, 969.5540051576213, 970.0493516353872, 1118.9440527973568, 1129.0064743026085, 4958.975205123951, 4963.404391472975, 4988.825391111293, 4989.525995030466, 5013.0, 5940.6435613863305, 5941.22764040672, 5947.524198064145, 5978.222831032025, 6001.2498437695285, 4812.951870481321, 4967.726775027409, 4968.0, 4973.706836222608, 4997.525235102659, 3164.0, 3170.937735858467, 3183.4906414973957, 3183.6657150999276, 3201.9039428817173, 5440.347158341025, 5565.525135839006, 5577.657383898772, 5585.273914391103, 5589.552835773128, 6096.69516524172, 6175.202250615839, 6214.906776398358, 6226.906596401058, 6236.656983865931, 5562.777488900399, 5566.582506312043, 5605.243292155588, 5614.9719251403485, 5621.409751976065, 5855.36049906027, 5939.406059394199, 5984.521238301013, 6011.308699499614, 6024.578279520391, 5896.292444906639, 5908.143319218603, 5911.704414779158, 5929.851753706192, 5931.0, 5337.519623233928, 5505.862353441035, 5533.5849811265125, 5561.6663000220115, 5578.135389014709, 4033.596640335943, 4065.430839682506, 4066.3290557057753, 4067.471228740245, 4083.1629515948566, 5885.293764748258, 5943.435373639497, 5948.643081415129, 5994.430529099728, 6025.849353766015, 5824.097264923944, 5829.300483941955, 5838.211841401527, 5838.883222335615, 5839.941600583939, 5767.711614419179, 5773.191753154646, 5816.563757718103, 5818.214541036906, 5822.3304320003745, 5655.604107712586, 5692.580653222281, 5742.196092546963, 5742.36833948257, 5750.856228594319, 5847.8245652630485, 5878.441548052928, 5884.6469211847425, 5891.204687367322, 5899.557533185114, 5584.274044374205, 5605.862444215902, 5662.235598194191, 5699.774548472098, 5722.284714410699], "value": 4317.735032524962, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [729.5987207036129, 734.8052766017006, 746.8991686122375, 759.8184822600854, 762.5615271219049, 11334.829977550344, 11844.763104737922, 13268.270245136513, 13973.650658733524, 14157.150570965749, 14697.485588004422, 15317.157556334398, 15348.309326080325, 15374.308156132973, 15384.23078846056, 877.9692710755124, 894.1014280647939, 896.5158814240302, 897.3808072430003, 898.3486971945352, 900.6847603338845, 901.7204666553357, 902.309733054214, 903.3315346643502, 903.9457632542036, 931.7018554062669, 937.6015193542751, 939.178219058324, 940.4498368454463, 943.5612440215299, 897.6229983406952, 925.1765928323797, 932.5756780664781, 933.304688007432, 941.8775559177298, 671.378974448633, 677.5358879167736, 677.9898301525432, 678.3318431345122, 678.6097993653669, 13441.731165376637, 13493.730125397535, 13608.523701670394, 13719.588412347646, 13918.09532380392, 15736.291866866019, 16391.59021024472, 16722.16389180536, 16770.07764572948, 16905.323787048503, 12494.312812795293, 12535.24788512692, 12800.231986080866, 13215.801762973562, 13221.735565288736, 3096.8916087936814, 3107.7513798896034, 3108.4870996285586, 3119.4229067622564, 3120.0327898351356, 74846.0, 75708.24291757066, 76815.23184768192, 77301.22698772997, 78839.21160788376, 12391.814122788166, 12413.193142445713, 12597.496100156075, 12643.051771117203, 12749.745005099847, 23165.88417057904, 23220.883895580413, 23283.06867725306, 23639.527209455715, 23918.521629567313, 6080.452759251689, 6117.449429551361, 6122.938770612326, 6126.509879209652, 6175.938240617536, 2908.8691008904652, 2956.438276727415, 2985.9402811944074, 2988.237999310162, 2993.191838203673, 3575.3385623659706, 3692.8153592320814, 3782.924341513154, 3825.3496905526126, 3825.5026846509777, 653.0302500786329, 654.8886689262837, 661.751843058853, 713.6895450478954, 754.8603508350973, 548.0, 564.7232855900579, 580.9890790025325, 587.8500982249499, 597.0089651179022, 10195.615280024502, 10416.791664166674, 10661.0, 10876.728081798019, 10897.891021089847, 581.3924448950856, 589.6226415094343, 593.7387549478216, 601.7653115285042, 609.8841220168154, 4501.41481607389, 4648.953985353269, 4700.600448961808, 4740.146773580788, 4866.126541281561, 84729.15270847213, 84822.0, 86215.0, 86813.1318686805, 88204.55897720471, 74137.62931185309, 74144.0, 74297.0, 74941.62529187319, 75762.0, 67756.6612166936, 68452.65773671199, 68562.3143768566, 68864.65567672129, 69687.0, 9091.181793638605, 9310.068993100636, 9445.197158241352, 9462.668806592012, 9766.56050477716, 29275.7072429273, 29848.104556863327, 30007.399852003273, 31301.84349078331, 31460.52809207818, 39346.75351292501, 39418.21163576655, 39645.40531892081, 39646.60353396429, 40056.0, 11872.168948173545, 12107.213031152947, 12143.271403715806, 12163.2702037878, 12319.75360492803, 13159.60521184366, 13165.736685266433, 13296.268705221306, 13328.666783330495, 13523.256220907944, 12957.093003489665, 13157.53948611794, 13257.270850103338, 13259.138156019828, 13369.732605348034, 12629.74740505203, 12669.113162078565, 12724.300163491096, 12842.935785321013, 12977.480900763863, 12062.336571488653, 12134.0, 12319.507219711111, 12377.443015064164, 12519.499220031461, 9371.671991480265, 9391.765205869635, 9693.22454203648, 9715.271354648288, 9718.805623887623, 9790.167835733757, 9793.657221997197, 9878.654247101316, 9914.752131196488, 10165.898341016495], "value": 6925.477514410918, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1570.1000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 114.0, 112.0, 114.0, 113.0, 113.0, 112.0, 114.0, 113.0, 113.0], "value": 112.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 127.0, 124.0, 180.0, 125.0, 132.0, 123.0, 123.0, 156.0, 127.0], "value": 136.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 165.0, 167.0, 176.0, 172.0, 167.0, 166.0, 163.0, 166.0, 163.0], "value": 167.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 75.0, 76.0, 107.0, 75.0, 74.0, 74.0, 78.0, 96.0, 74.0], "value": 80.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 107.0, 85.0, 85.0, 85.0, 98.0, 84.0, 84.0, 103.0], "value": 90.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 116.0, 116.0, 114.0, 115.0, 113.0, 114.0, 115.0, 115.0, 115.0], "value": 114.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 152.0, 154.0, 152.0, 152.0, 155.0, 152.0, 152.0, 150.0, 152.0], "value": 152.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 97.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 100.0, 94.0], "value": 95.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 58.0, 54.0, 55.0, 57.0, 60.0, 59.0, 57.0, 61.0, 66.0], "value": 58.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 58.0, 56.0, 58.0, 58.0, 56.0, 56.0, 57.0, 57.0, 57.0], "value": 57.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 89.0, 87.0, 88.0, 86.0, 86.0, 90.0, 96.0, 116.0, 88.0], "value": 91.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 151.0, 136.0, 135.0, 134.0, 147.0, 135.0, 142.0, 135.0], "value": 140.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [189.0, 190.0, 199.0, 197.0, 202.0, 203.0, 200.0, 209.0, 189.0, 200.0], "value": 197.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 75.0, 75.0, 76.0, 79.0, 74.0, 73.0, 74.0, 72.0, 74.0], "value": 75.0, "unit": "score"}]}]} 07:07:49 INFO - Return code: 0 07:07:49 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:07:49 INFO - # TBPL SUCCESS # 07:07:49 INFO - Running post-action listener: _resource_record_post_action 07:07:49 INFO - [mozharness: 2017-05-25 14:07:49.649898Z] Finished run-tests step (success) 07:07:49 INFO - Running post-run listener: _resource_record_post_run 07:07:49 INFO - Total resource usage - Wall time: 1255s; CPU: 13.0%; Read bytes: 4096; Write bytes: 411811840; Read time: 12; Write time: 341372 07:07:49 INFO - TinderboxPrint: CPU usage
12.9% 07:07:49 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 07:07:49 INFO - TinderboxPrint: I/O write bytes / time
411,811,840 / 341,372 07:07:49 INFO - TinderboxPrint: CPU idle
8,728.0 (87.1%) 07:07:49 INFO - TinderboxPrint: CPU user
1,233.2 (12.3%) 07:07:49 INFO - TinderboxPrint: Swap in / out
0 / 0 07:07:49 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 104001536; Read time: 0; Write time: 129756 07:07:49 INFO - run-tests - Wall time: 1239s; CPU: 13.0%; Read bytes: 0; Write bytes: 307810304; Read time: 0; Write time: 211616 07:07:50 INFO - Running post-run listener: _upload_blobber_files 07:07:50 INFO - Blob upload gear active. 07:07:50 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:07:50 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 07:07:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:07:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:07:50 INFO - (blobuploader) - INFO - Open directory for files ... 07:07:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 07:07:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:07:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:07:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 07:07:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:07:51 INFO - (blobuploader) - INFO - Done attempting. 07:07:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 07:07:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:07:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:07:52 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 07:07:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:07:52 INFO - (blobuploader) - INFO - Done attempting. 07:07:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:07:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:07:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:07:59 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:07:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:07:59 INFO - (blobuploader) - INFO - Done attempting. 07:07:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 07:07:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:07:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:07:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 07:07:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:07:59 INFO - (blobuploader) - INFO - Done attempting. 07:07:59 INFO - (blobuploader) - INFO - Iteration through files over. 07:07:59 INFO - Return code: 0 07:07:59 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:07:59 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:07:59 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/00428bd41034d6238254a6b001bbaec23662647fdfa3795d46922003be0db2b94cb2e484f876115111bfc3ad440e4299aaffe386517ba59b1f4025a7ef17856f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/af55887adc2a6f3b08deb2c845c38b68f89f177caa33fc2b7f1bdc8c4d25304d2102ad84367122494d22ef2fbcf37effc6777d5f1db364c2085d70ee5cc59fdb", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f975ca82db9b596d10c3460828cb82c8899e02c6649a1104917bc688918283e945b9fb24c1c14db78d82ecf9dbf6a603cc6e7ecb33d690d892a72745fe830ad5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/32376e3706dacfe576f255ab9f3b211e42f6a4fd4a17eeabbae2eb9aea046c6851f2de0fb9e7db0cb9a8a5b53dccf9add1b9729e207a08080840878f5839ac93"} 07:07:59 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:07:59 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:07:59 INFO - Contents: 07:07:59 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/00428bd41034d6238254a6b001bbaec23662647fdfa3795d46922003be0db2b94cb2e484f876115111bfc3ad440e4299aaffe386517ba59b1f4025a7ef17856f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/af55887adc2a6f3b08deb2c845c38b68f89f177caa33fc2b7f1bdc8c4d25304d2102ad84367122494d22ef2fbcf37effc6777d5f1db364c2085d70ee5cc59fdb", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f975ca82db9b596d10c3460828cb82c8899e02c6649a1104917bc688918283e945b9fb24c1c14db78d82ecf9dbf6a603cc6e7ecb33d690d892a72745fe830ad5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/32376e3706dacfe576f255ab9f3b211e42f6a4fd4a17eeabbae2eb9aea046c6851f2de0fb9e7db0cb9a8a5b53dccf9add1b9729e207a08080840878f5839ac93"} 07:07:59 INFO - Running post-run listener: copy_logs_to_upload_dir 07:07:59 INFO - Copying logs to upload dir... 07:07:59 INFO - mkdir: /builds/slave/test/build/upload/logs 07:07:59 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1315.483443 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 55 secs) (at 2017-05-25 07:07:59.766212) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-25 07:07:59.770040) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1495719963.68497-806580313 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/00428bd41034d6238254a6b001bbaec23662647fdfa3795d46922003be0db2b94cb2e484f876115111bfc3ad440e4299aaffe386517ba59b1f4025a7ef17856f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/af55887adc2a6f3b08deb2c845c38b68f89f177caa33fc2b7f1bdc8c4d25304d2102ad84367122494d22ef2fbcf37effc6777d5f1db364c2085d70ee5cc59fdb", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f975ca82db9b596d10c3460828cb82c8899e02c6649a1104917bc688918283e945b9fb24c1c14db78d82ecf9dbf6a603cc6e7ecb33d690d892a72745fe830ad5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/32376e3706dacfe576f255ab9f3b211e42f6a4fd4a17eeabbae2eb9aea046c6851f2de0fb9e7db0cb9a8a5b53dccf9add1b9729e207a08080840878f5839ac93"} build_url:https://queue.taskcluster.net/v1/task/SRns4UVsTaicCBZLhqaQ2w/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011122 build_url: 'https://queue.taskcluster.net/v1/task/SRns4UVsTaicCBZLhqaQ2w/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/00428bd41034d6238254a6b001bbaec23662647fdfa3795d46922003be0db2b94cb2e484f876115111bfc3ad440e4299aaffe386517ba59b1f4025a7ef17856f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/af55887adc2a6f3b08deb2c845c38b68f89f177caa33fc2b7f1bdc8c4d25304d2102ad84367122494d22ef2fbcf37effc6777d5f1db364c2085d70ee5cc59fdb", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f975ca82db9b596d10c3460828cb82c8899e02c6649a1104917bc688918283e945b9fb24c1c14db78d82ecf9dbf6a603cc6e7ecb33d690d892a72745fe830ad5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/32376e3706dacfe576f255ab9f3b211e42f6a4fd4a17eeabbae2eb9aea046c6851f2de0fb9e7db0cb9a8a5b53dccf9add1b9729e207a08080840878f5839ac93"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-25 07:07:59.793841) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-25 07:07:59.794162) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1495719963.68497-806580313 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004501 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-25 07:07:59.877034) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-25 07:07:59.877366) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-25 07:07:59.877685) ========= ========= Total master_lag: 0.16 =========