builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-026 starttime: 1495210549.21 results: success (0) revision: c800b6dfca673f8cb0f3cf41e4f495755d04bbb3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-19 09:15:49.210008) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-19 09:15:49.210574) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-19 09:15:49.210937) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-19 09:15:49.225685) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-19 09:15:49.226049) ========= 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=41bf3e9aed84707956354da8000001c5-1495210548.714939-469727514 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-19 09:15:49-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 223M=0s 2017-05-19 09:15:49 (223 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.086245 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-19 09:15:49.331884) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-19 09:15:49.332255) ========= 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=41bf3e9aed84707956354da8000001c5-1495210548.714939-469727514 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018612 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-19 09:15:49.407443) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-19 09:15:49.407923) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev c800b6dfca673f8cb0f3cf41e4f495755d04bbb3 --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 c800b6dfca673f8cb0f3cf41e4f495755d04bbb3 --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=41bf3e9aed84707956354da8000001c5-1495210548.714939-469727514 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-19 09:15:49,653 truncating revision to first 12 chars 2017-05-19 09:15:49,653 Setting DEBUG logging. 2017-05-19 09:15:49,654 attempt 1/10 2017-05-19 09:15:49,654 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/c800b6dfca67?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-19 09:15:50,568 unpacking tar archive at: mozilla-central-c800b6dfca67/testing/mozharness/ program finished with exit code 0 elapsedTime=1.227528 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-19 09:15:50.655850) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-19 09:15:50.656268) ========= script_repo_revision: c800b6dfca673f8cb0f3cf41e4f495755d04bbb3 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-19 09:15:50.656741) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-19 09:15:50.657071) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-19 09:15:50.666504) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2017-05-19 09:15:50.666837) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 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-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] 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=41bf3e9aed84707956354da8000001c5-1495210548.714939-469727514 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:15:51 INFO - MultiFileLogger online at 20170519 09:15:51 in /builds/slave/test 09:15:51 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 09:15:51 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:15:51 INFO - {'append_to_log': False, 09:15:51 INFO - 'base_work_dir': '/builds/slave/test', 09:15:51 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 09:15:51 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:15:51 INFO - 'branch': 'Firefox-Non-PGO', 09:15:51 INFO - 'buildbot_json_path': 'buildprops.json', 09:15:51 INFO - 'config_files': ('talos/linux_config.py',), 09:15:51 INFO - 'default_actions': ('clobber', 09:15:51 INFO - 'read-buildbot-config', 09:15:51 INFO - 'download-and-extract', 09:15:51 INFO - 'populate-webroot', 09:15:51 INFO - 'create-virtualenv', 09:15:51 INFO - 'install', 09:15:51 INFO - 'run-tests'), 09:15:51 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:15:51 INFO - 'download_minidump_stackwalk': True, 09:15:51 INFO - 'download_symbols': 'ondemand', 09:15:51 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:15:51 INFO - 'tooltool.py': '/tools/tooltool.py', 09:15:51 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:15:51 INFO - '/tools/misc-python/virtualenv.py')}, 09:15:51 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:15:51 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:15:51 INFO - 'gecko_profile': False, 09:15:51 INFO - 'gecko_profile_interval': 0, 09:15:51 INFO - 'installer_path': 'installer.exe', 09:15:51 INFO - 'log_level': 'info', 09:15:51 INFO - 'log_name': 'talos', 09:15:51 INFO - 'log_to_console': True, 09:15:51 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:15:51 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:15:51 INFO - 'opt_config_files': (), 09:15:51 INFO - 'pip_index': False, 09:15:51 INFO - 'suite': 'dromaeojs-e10s', 09:15:51 INFO - 'system_bits': '32', 09:15:51 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:15:51 INFO - 'title': 'talos-linux64-ix-026', 09:15:51 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:15:51 INFO - 'use_talos_json': True, 09:15:51 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:15:51 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:15:51 INFO - 'work_dir': 'build'} 09:15:51 INFO - [mozharness: 2017-05-19 16:15:51.012497Z] Running clobber step. 09:15:51 INFO - Running pre-action listener: _resource_record_pre_action 09:15:51 INFO - Running main action method: clobber 09:15:51 INFO - rmtree: /builds/slave/test/build 09:15:51 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:15:52 INFO - Running post-action listener: _resource_record_post_action 09:15:52 INFO - [mozharness: 2017-05-19 16:15:52.440186Z] Finished clobber step (success) 09:15:52 INFO - [mozharness: 2017-05-19 16:15:52.440284Z] Running read-buildbot-config step. 09:15:52 INFO - Running pre-action listener: _resource_record_pre_action 09:15:52 INFO - Running main action method: read_buildbot_config 09:15:52 INFO - Using buildbot properties: 09:15:52 INFO - { 09:15:52 INFO - "project": "", 09:15:52 INFO - "product": "firefox", 09:15:52 INFO - "who": "ryanvm@gmail.com", 09:15:52 INFO - "installer_path": "public/build/target.tar.bz2", 09:15:52 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 09:15:52 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 09:15:52 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 09:15:52 INFO - "stage_platform": "linux64", 09:15:52 INFO - "basedir": "/builds/slave/test", 09:15:52 INFO - "buildnumber": 841, 09:15:52 INFO - "platform": "ubuntu64_hw", 09:15:52 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 09:15:52 INFO - "slavebuilddir": "test", 09:15:52 INFO - "taskId": "R0CUaqJYRzmJkpMSYTWpZw", 09:15:52 INFO - "branch": "mozilla-central", 09:15:52 INFO - "script_repo_revision": "production", 09:15:52 INFO - "revision": "c800b6dfca673f8cb0f3cf41e4f495755d04bbb3", 09:15:52 INFO - "slavename": "talos-linux64-ix-026", 09:15:52 INFO - "repo_path": "mozilla-central" 09:15:52 INFO - } 09:15:52 INFO - Finding installer, test and symbols from parent task. 09:15:52 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/R0CUaqJYRzmJkpMSYTWpZw'}, attempt #1 09:15:52 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/R0CUaqJYRzmJkpMSYTWpZw'}, attempt #1 09:15:53 INFO - Task dependencies: Nb4DyC1NQSWAXleixBvs-w 09:15:53 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Nb4DyC1NQSWAXleixBvs-w'}, attempt #1 09:15:53 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/Nb4DyC1NQSWAXleixBvs-w/artifacts/public/build/target.tar.bz2 09:15:53 INFO - Set test_url: https://queue.taskcluster.net/v1/task/Nb4DyC1NQSWAXleixBvs-w/artifacts/public/build/test_packages.json 09:15:53 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/Nb4DyC1NQSWAXleixBvs-w/artifacts/public/build/target.crashreporter-symbols.zip 09:15:53 INFO - Running post-action listener: _resource_record_post_action 09:15:53 INFO - [mozharness: 2017-05-19 16:15:53.827157Z] Finished read-buildbot-config step (success) 09:15:53 INFO - [mozharness: 2017-05-19 16:15:53.827379Z] Running download-and-extract step. 09:15:53 INFO - Running pre-action listener: _resource_record_pre_action 09:15:53 INFO - Running main action method: download_and_extract 09:15:53 INFO - mkdir: /builds/slave/test/build/tests 09:15: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')]} 09:15:53 INFO - trying https://queue.taskcluster.net/v1/task/Nb4DyC1NQSWAXleixBvs-w/artifacts/public/build/target.test_packages.json 09:15:53 INFO - Downloading https://queue.taskcluster.net/v1/task/Nb4DyC1NQSWAXleixBvs-w/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 09:15:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Nb4DyC1NQSWAXleixBvs-w/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 09:15:54 INFO - Downloaded 986 bytes. 09:15:54 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 09:15:54 INFO - Using the following test package requirements: 09:15:54 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 09:15:54 INFO - u'common': [u'target.common.tests.zip'], 09:15:54 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 09:15:54 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 09:15:54 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 09:15:54 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 09:15:54 INFO - u'mozbase': [u'target.common.tests.zip'], 09:15:54 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 09:15:54 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 09:15:54 INFO - u'web-platform': [u'target.common.tests.zip', 09:15:54 INFO - u'target.web-platform.tests.zip'], 09:15:54 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 09:15:54 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 09:15:54 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Nb4DyC1NQSWAXleixBvs-w/artifacts/public/build/target.common.tests.zip 09:15:54 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Nb4DyC1NQSWAXleixBvs-w/artifacts/public/build/target.common.tests.zip'}, attempt #1 09:15:54 INFO - Fetch https://queue.taskcluster.net/v1/task/Nb4DyC1NQSWAXleixBvs-w/artifacts/public/build/target.common.tests.zip into memory 09:15:56 INFO - Content-Length response header: 63521042 09:15:56 INFO - Bytes received: 63521042 09:16:07 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 09:16:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Nb4DyC1NQSWAXleixBvs-w/artifacts/public/build/target.common.tests.zip 09:16:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Nb4DyC1NQSWAXleixBvs-w/artifacts/public/build/target.common.tests.zip'}, attempt #1 09:16:07 INFO - Fetch https://queue.taskcluster.net/v1/task/Nb4DyC1NQSWAXleixBvs-w/artifacts/public/build/target.common.tests.zip into memory 09:16:08 INFO - Content-Length response header: 63521042 09:16:08 INFO - Bytes received: 63521042 09:16:20 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Nb4DyC1NQSWAXleixBvs-w/artifacts/public/build/target.talos.tests.zip 09:16:20 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Nb4DyC1NQSWAXleixBvs-w/artifacts/public/build/target.talos.tests.zip'}, attempt #1 09:16:20 INFO - Fetch https://queue.taskcluster.net/v1/task/Nb4DyC1NQSWAXleixBvs-w/artifacts/public/build/target.talos.tests.zip into memory 09:16:21 INFO - Content-Length response header: 14410008 09:16:21 INFO - Bytes received: 14410008 09:16:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:16:21 INFO - trying https://queue.taskcluster.net/v1/task/Nb4DyC1NQSWAXleixBvs-w/artifacts/public/build/target.tar.bz2 09:16:21 INFO - Downloading https://queue.taskcluster.net/v1/task/Nb4DyC1NQSWAXleixBvs-w/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 09:16:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Nb4DyC1NQSWAXleixBvs-w/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 09:16:23 INFO - Downloaded 58136550 bytes. 09:16:23 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Nb4DyC1NQSWAXleixBvs-w/artifacts/public/build/target.tar.bz2 09:16:23 INFO - mkdir: /builds/slave/test/properties 09:16:23 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:16:23 INFO - Writing to file /builds/slave/test/properties/build_url 09:16:23 INFO - Contents: 09:16:23 INFO - build_url:https://queue.taskcluster.net/v1/task/Nb4DyC1NQSWAXleixBvs-w/artifacts/public/build/target.tar.bz2 09:16:23 INFO - Running post-action listener: _resource_record_post_action 09:16:23 INFO - Running post-action listener: set_extra_try_arguments 09:16:23 INFO - [mozharness: 2017-05-19 16:16:23.046179Z] Finished download-and-extract step (success) 09:16:23 INFO - [mozharness: 2017-05-19 16:16:23.046331Z] Running populate-webroot step. 09:16:23 INFO - Running pre-action listener: _resource_record_pre_action 09:16:23 INFO - Running main action method: populate_webroot 09:16:23 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:16:23 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:16:23 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:16:23 INFO - '--tppagecycles', 09:16:23 INFO - '7'], 09:16:23 INFO - 'tests': ['tsvgm']}}, 09:16:23 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:16:23 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:16:23 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:16:23 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:16:23 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:16:23 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:16:23 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 09:16:23 INFO - 'talos_options': ['--disable-e10s'], 09:16:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:16:23 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 09:16:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:16:23 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 09:16:23 INFO - 'talos_options': ['--disable-e10s'], 09:16:23 INFO - 'tests': ['damp', 'tps']}, 09:16:23 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 09:16:23 INFO - 'tests': ['damp', 'tps']}, 09:16:23 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:16:23 INFO - 'tests': ['dromaeo_dom']}, 09:16:23 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:16:23 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:16:23 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 09:16:23 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 09:16:23 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 09:16:23 INFO - 'tests': ['ts_paint', 'tp5o']}, 09:16:23 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:16:23 INFO - 'tests': ['a11yr', 09:16:23 INFO - 'ts_paint', 09:16:23 INFO - 'tpaint', 09:16:23 INFO - 'sessionrestore', 09:16:23 INFO - 'sessionrestore_no_auto_restore', 09:16:23 INFO - 'tabpaint']}, 09:16:23 INFO - 'other-e10s': {'tests': ['a11yr', 09:16:23 INFO - 'ts_paint', 09:16:23 INFO - 'tpaint', 09:16:23 INFO - 'sessionrestore', 09:16:23 INFO - 'sessionrestore_no_auto_restore', 09:16:23 INFO - 'tabpaint']}, 09:16:23 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:16:23 INFO - 'ts_paint', 09:16:23 INFO - 'tpaint', 09:16:23 INFO - 'sessionrestore', 09:16:23 INFO - 'sessionrestore_no_auto_restore', 09:16:23 INFO - 'tabpaint']}, 09:16:23 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:16:23 INFO - 'ts_paint', 09:16:23 INFO - 'tpaint', 09:16:23 INFO - 'sessionrestore', 09:16:23 INFO - 'sessionrestore_no_auto_restore', 09:16:23 INFO - 'tabpaint']}, 09:16:23 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:16:23 INFO - 'tests': ['a11yr', 09:16:23 INFO - 'ts_paint', 09:16:23 INFO - 'tpaint', 09:16:23 INFO - 'sessionrestore', 09:16:23 INFO - 'sessionrestore_no_auto_restore', 09:16:23 INFO - 'tabpaint']}, 09:16:23 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:16:23 INFO - 'tests': ['a11yr', 09:16:23 INFO - 'ts_paint', 09:16:23 INFO - 'tpaint', 09:16:23 INFO - 'sessionrestore', 09:16:23 INFO - 'sessionrestore_no_auto_restore', 09:16:23 INFO - 'tabpaint']}, 09:16:23 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 09:16:23 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 09:16:23 INFO - 'bloom_basic_ref']}, 09:16:23 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:16:23 INFO - 'tests': ['tsvgx', 09:16:23 INFO - 'tsvgr_opacity', 09:16:23 INFO - 'tart', 09:16:23 INFO - 'tscrollx', 09:16:23 INFO - 'cart', 09:16:23 INFO - 'tsvg_static']}, 09:16:23 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:16:23 INFO - 'tsvgr_opacity', 09:16:23 INFO - 'tart', 09:16:23 INFO - 'tscrollx', 09:16:23 INFO - 'cart', 09:16:23 INFO - 'tsvg_static']}, 09:16:23 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 09:16:23 INFO - 'talos_options': ['--disable-e10s'], 09:16:23 INFO - 'tests': ['tp5o']}, 09:16:23 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 09:16:23 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 09:16:23 INFO - 'talos_options': ['--disable-e10s', 09:16:23 INFO - '--xperf_path', 09:16:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:16:23 INFO - 'tests': ['tp5n']}, 09:16:23 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 09:16:23 INFO - 'talos_options': ['--xperf_path', 09:16:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:16:23 INFO - 'tests': ['tp5n']}}, 09:16:23 INFO - 'talos.zip': {'path': '', 09:16:23 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:16:23 INFO - Running post-action listener: _resource_record_post_action 09:16:23 INFO - [mozharness: 2017-05-19 16:16:23.067420Z] Finished populate-webroot step (success) 09:16:23 INFO - [mozharness: 2017-05-19 16:16:23.067509Z] Running create-virtualenv step. 09:16:23 INFO - Running pre-action listener: _resource_record_pre_action 09:16:23 INFO - Running main action method: create_virtualenv 09:16:23 INFO - Creating virtualenv /builds/slave/test/build/venv 09:16:23 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 09:16:23 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:16:23 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:16:23 INFO - Using real prefix '/usr' 09:16:23 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:16:23 INFO - Installing distribute.............................................................................................................................................................................................done. 09:16:25 INFO - Installing pip.................done. 09:16:25 INFO - Return code: 0 09:16:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:16:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:16:25 INFO - Reading from file tmpfile_stdout 09:16:25 INFO - Output received: 09:16:25 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) 09:16:25 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:16:25 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')]} 09:16:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:16:25 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')]} 09:16:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:16:25 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 0x12131f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13e0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15865c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15837a0>, '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 0x15846a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1584b30>, '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': '41bf3e9aed84707956354da8000001c5-1495210548.714939-469727514', '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 09:16:25 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 09:16:25 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 09:16:25 INFO - Using env: {'DISPLAY': ':0', 09:16:25 INFO - 'HOME': '/home/cltbld', 09:16:25 INFO - 'LANG': 'en_US.UTF-8', 09:16:25 INFO - 'LANGUAGE': 'en_US:en', 09:16:25 INFO - 'LOGNAME': 'cltbld', 09:16:25 INFO - 'MAIL': '/var/mail/cltbld', 09:16:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:16:25 INFO - 'MOZ_NO_REMOTE': '1', 09:16:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:16:25 INFO - 'NO_EM_RESTART': '1', 09:16:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:16:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:16:25 INFO - 'PWD': '/builds/slave/test', 09:16:25 INFO - 'SHELL': '/bin/bash', 09:16:25 INFO - 'SHLVL': '1', 09:16:25 INFO - 'TERM': 'linux', 09:16:25 INFO - 'TMOUT': '86400', 09:16:25 INFO - 'USER': 'cltbld', 09:16:25 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1495210548.714939-469727514', 09:16:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:16:25 INFO - '_': '/tools/buildbot/bin/python'} 09:16:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:16:26 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 09:16:26 INFO - Cleaning up... 09:16:26 INFO - Return code: 0 09:16:26 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:16:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:16:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:16:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:16:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:16:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x12131f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13e0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15865c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15837a0>, '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 0x15846a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1584b30>, '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': '41bf3e9aed84707956354da8000001c5-1495210548.714939-469727514', '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 09:16:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 09:16:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 09:16:26 INFO - Using env: {'DISPLAY': ':0', 09:16:26 INFO - 'HOME': '/home/cltbld', 09:16:26 INFO - 'LANG': 'en_US.UTF-8', 09:16:26 INFO - 'LANGUAGE': 'en_US:en', 09:16:26 INFO - 'LOGNAME': 'cltbld', 09:16:26 INFO - 'MAIL': '/var/mail/cltbld', 09:16:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:16:26 INFO - 'MOZ_NO_REMOTE': '1', 09:16:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:16:26 INFO - 'NO_EM_RESTART': '1', 09:16:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:16:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:16:26 INFO - 'PWD': '/builds/slave/test', 09:16:26 INFO - 'SHELL': '/bin/bash', 09:16:26 INFO - 'SHLVL': '1', 09:16:26 INFO - 'TERM': 'linux', 09:16:26 INFO - 'TMOUT': '86400', 09:16:26 INFO - 'USER': 'cltbld', 09:16:26 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1495210548.714939-469727514', 09:16:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:16:26 INFO - '_': '/tools/buildbot/bin/python'} 09:16:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:16:26 INFO - Downloading/unpacking psutil>=3.1.1 09:16:26 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 09:16:26 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 09:16:26 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 09:16:26 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 09:16:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:16:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:16:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:16:27 INFO - Installing collected packages: psutil 09:16:27 INFO - Running setup.py install for psutil 09:16:27 INFO - building 'psutil._psutil_linux' extension 09:16:27 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 09:16:27 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 09:16:27 INFO - building 'psutil._psutil_posix' extension 09:16:27 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 09:16:27 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 09:16:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:16:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:16:28 INFO - Successfully installed psutil 09:16:28 INFO - Cleaning up... 09:16:28 INFO - Return code: 0 09:16:28 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:16:28 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')]} 09:16:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:16:28 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')]} 09:16:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:16:28 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 0x12131f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13e0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15865c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15837a0>, '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 0x15846a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1584b30>, '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': '41bf3e9aed84707956354da8000001c5-1495210548.714939-469727514', '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 09:16:28 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 09:16:28 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 09:16:28 INFO - Using env: {'DISPLAY': ':0', 09:16:28 INFO - 'HOME': '/home/cltbld', 09:16:28 INFO - 'LANG': 'en_US.UTF-8', 09:16:28 INFO - 'LANGUAGE': 'en_US:en', 09:16:28 INFO - 'LOGNAME': 'cltbld', 09:16:28 INFO - 'MAIL': '/var/mail/cltbld', 09:16:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:16:28 INFO - 'MOZ_NO_REMOTE': '1', 09:16:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:16:28 INFO - 'NO_EM_RESTART': '1', 09:16:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:16:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:16:28 INFO - 'PWD': '/builds/slave/test', 09:16:28 INFO - 'SHELL': '/bin/bash', 09:16:28 INFO - 'SHLVL': '1', 09:16:28 INFO - 'TERM': 'linux', 09:16:28 INFO - 'TMOUT': '86400', 09:16:28 INFO - 'USER': 'cltbld', 09:16:28 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1495210548.714939-469727514', 09:16:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:16:28 INFO - '_': '/tools/buildbot/bin/python'} 09:16:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:16:28 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:16:28 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 09:16:28 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 09:16:28 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 09:16:28 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 09:16:29 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:16:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:16:29 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:16:29 INFO - Installing collected packages: mozsystemmonitor 09:16:29 INFO - Running setup.py install for mozsystemmonitor 09:16:29 INFO - Successfully installed mozsystemmonitor 09:16:29 INFO - Cleaning up... 09:16:29 INFO - Return code: 0 09:16:29 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:16:29 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')]} 09:16:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:16:29 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')]} 09:16:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:16:29 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 0x12131f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13e0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15865c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15837a0>, '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 0x15846a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1584b30>, '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': '41bf3e9aed84707956354da8000001c5-1495210548.714939-469727514', '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 09:16:29 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 09:16:29 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 09:16:29 INFO - Using env: {'DISPLAY': ':0', 09:16:29 INFO - 'HOME': '/home/cltbld', 09:16:29 INFO - 'LANG': 'en_US.UTF-8', 09:16:29 INFO - 'LANGUAGE': 'en_US:en', 09:16:29 INFO - 'LOGNAME': 'cltbld', 09:16:29 INFO - 'MAIL': '/var/mail/cltbld', 09:16:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:16:29 INFO - 'MOZ_NO_REMOTE': '1', 09:16:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:16:29 INFO - 'NO_EM_RESTART': '1', 09:16:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:16:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:16:29 INFO - 'PWD': '/builds/slave/test', 09:16:29 INFO - 'SHELL': '/bin/bash', 09:16:29 INFO - 'SHLVL': '1', 09:16:29 INFO - 'TERM': 'linux', 09:16:29 INFO - 'TMOUT': '86400', 09:16:29 INFO - 'USER': 'cltbld', 09:16:29 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1495210548.714939-469727514', 09:16:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:16:29 INFO - '_': '/tools/buildbot/bin/python'} 09:16:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:16:29 INFO - Downloading/unpacking jsonschema==2.5.1 09:16:29 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 09:16:29 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 09:16:29 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 09:16:29 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 09:16:30 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:16:30 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:16:30 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 09:16:30 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 09:16:30 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 09:16:30 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 09:16:30 INFO - Downloading functools32-3.2.3-2.tar.gz 09:16:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:16:31 INFO - warning: no files found matching '*.txt' 09:16:31 INFO - no previously-included directories found matching 'build' 09:16:31 INFO - no previously-included directories found matching 'dist' 09:16:31 INFO - no previously-included directories found matching '.git*' 09:16:31 INFO - Installing collected packages: jsonschema, functools32 09:16:31 INFO - Running setup.py install for functools32 09:16:31 INFO - warning: no files found matching '*.txt' 09:16:31 INFO - no previously-included directories found matching 'build' 09:16:31 INFO - no previously-included directories found matching 'dist' 09:16:31 INFO - no previously-included directories found matching '.git*' 09:16:31 INFO - Successfully installed jsonschema functools32 09:16:31 INFO - Cleaning up... 09:16:31 INFO - Return code: 0 09:16:31 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:16:31 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')]} 09:16:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:16:31 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')]} 09:16:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:16:31 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 0x12131f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13e0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15865c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15837a0>, '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 0x15846a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1584b30>, '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': '41bf3e9aed84707956354da8000001c5-1495210548.714939-469727514', '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 09:16:31 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 09:16:31 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 09:16:31 INFO - Using env: {'DISPLAY': ':0', 09:16:31 INFO - 'HOME': '/home/cltbld', 09:16:31 INFO - 'LANG': 'en_US.UTF-8', 09:16:31 INFO - 'LANGUAGE': 'en_US:en', 09:16:31 INFO - 'LOGNAME': 'cltbld', 09:16:31 INFO - 'MAIL': '/var/mail/cltbld', 09:16:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:16:31 INFO - 'MOZ_NO_REMOTE': '1', 09:16:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:16:31 INFO - 'NO_EM_RESTART': '1', 09:16:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:16:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:16:31 INFO - 'PWD': '/builds/slave/test', 09:16:31 INFO - 'SHELL': '/bin/bash', 09:16:31 INFO - 'SHLVL': '1', 09:16:31 INFO - 'TERM': 'linux', 09:16:31 INFO - 'TMOUT': '86400', 09:16:31 INFO - 'USER': 'cltbld', 09:16:31 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1495210548.714939-469727514', 09:16:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:16:31 INFO - '_': '/tools/buildbot/bin/python'} 09:16:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:16:31 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:16:31 INFO - Cleaning up... 09:16:31 INFO - Return code: 0 09:16:31 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:16:31 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')]} 09:16:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:16:31 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')]} 09:16:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:16:31 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 0x12131f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13e0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15865c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15837a0>, '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 0x15846a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1584b30>, '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': '41bf3e9aed84707956354da8000001c5-1495210548.714939-469727514', '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 09:16:31 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 09:16:31 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 09:16:31 INFO - Using env: {'DISPLAY': ':0', 09:16:31 INFO - 'HOME': '/home/cltbld', 09:16:31 INFO - 'LANG': 'en_US.UTF-8', 09:16:31 INFO - 'LANGUAGE': 'en_US:en', 09:16:31 INFO - 'LOGNAME': 'cltbld', 09:16:31 INFO - 'MAIL': '/var/mail/cltbld', 09:16:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:16:31 INFO - 'MOZ_NO_REMOTE': '1', 09:16:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:16:31 INFO - 'NO_EM_RESTART': '1', 09:16:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:16:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:16:31 INFO - 'PWD': '/builds/slave/test', 09:16:31 INFO - 'SHELL': '/bin/bash', 09:16:31 INFO - 'SHLVL': '1', 09:16:31 INFO - 'TERM': 'linux', 09:16:31 INFO - 'TMOUT': '86400', 09:16:31 INFO - 'USER': 'cltbld', 09:16:31 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1495210548.714939-469727514', 09:16:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:16:31 INFO - '_': '/tools/buildbot/bin/python'} 09:16:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:16:31 INFO - Downloading/unpacking blobuploader==1.2.4 09:16:31 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 09:16:31 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 09:16:31 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 09:16:31 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 09:16:32 INFO - Downloading blobuploader-1.2.4.tar.gz 09:16:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:16:32 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:16:32 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 09:16:32 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 09:16:32 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 09:16:32 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 09:16:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:16:33 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:16:33 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 09:16:33 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 09:16:33 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 09:16:33 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 09:16:33 INFO - Downloading docopt-0.6.1.tar.gz 09:16:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:16:33 INFO - Installing collected packages: blobuploader, requests, docopt 09:16:33 INFO - Running setup.py install for blobuploader 09:16:33 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:16:33 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:16:33 INFO - Running setup.py install for requests 09:16:33 INFO - Running setup.py install for docopt 09:16:33 INFO - Successfully installed blobuploader requests docopt 09:16:33 INFO - Cleaning up... 09:16:33 INFO - Return code: 0 09:16:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:16: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')]} 09:16:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:16: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')]} 09:16:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:16:33 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 0x12131f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13e0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15865c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15837a0>, '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 0x15846a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1584b30>, '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': '41bf3e9aed84707956354da8000001c5-1495210548.714939-469727514', '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 09:16:33 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 09:16:33 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 09:16:33 INFO - Using env: {'DISPLAY': ':0', 09:16:33 INFO - 'HOME': '/home/cltbld', 09:16:33 INFO - 'LANG': 'en_US.UTF-8', 09:16:33 INFO - 'LANGUAGE': 'en_US:en', 09:16:33 INFO - 'LOGNAME': 'cltbld', 09:16:33 INFO - 'MAIL': '/var/mail/cltbld', 09:16:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:16:33 INFO - 'MOZ_NO_REMOTE': '1', 09:16:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:16:33 INFO - 'NO_EM_RESTART': '1', 09:16:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:16:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:16:33 INFO - 'PWD': '/builds/slave/test', 09:16:33 INFO - 'SHELL': '/bin/bash', 09:16:33 INFO - 'SHLVL': '1', 09:16:33 INFO - 'TERM': 'linux', 09:16:33 INFO - 'TMOUT': '86400', 09:16:33 INFO - 'USER': 'cltbld', 09:16:33 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1495210548.714939-469727514', 09:16:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:16:33 INFO - '_': '/tools/buildbot/bin/python'} 09:16:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:16:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:16:34 INFO - Running setup.py (path:/tmp/pip-k6IzPZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:16:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:16:34 INFO - Running setup.py (path:/tmp/pip-XUkQk6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:16:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:16:34 INFO - Running setup.py (path:/tmp/pip-mWaaXL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:16:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:16:34 INFO - Running setup.py (path:/tmp/pip-bB0jVI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:16:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:16:34 INFO - Running setup.py (path:/tmp/pip-bDTc4L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:16:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:16:34 INFO - Running setup.py (path:/tmp/pip-pPlJH6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:16:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:16:34 INFO - Running setup.py (path:/tmp/pip-9JzziL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:16:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:16:34 INFO - Running setup.py (path:/tmp/pip-59j1iT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:16:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:16:34 INFO - Running setup.py (path:/tmp/pip-vjIPAR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:16:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:16:34 INFO - Running setup.py (path:/tmp/pip-SdKSeJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:16:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:16:34 INFO - Running setup.py (path:/tmp/pip-SmDyZg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:16:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:16:34 INFO - Running setup.py (path:/tmp/pip-E4iLnh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:16:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:16:35 INFO - Running setup.py (path:/tmp/pip-kGRx7g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:16:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:16:35 INFO - Running setup.py (path:/tmp/pip-FzUSgK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:16:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:16:35 INFO - Running setup.py (path:/tmp/pip-FG5t0U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:16:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:16:35 INFO - Running setup.py (path:/tmp/pip-m3kWXV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:16:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:16:35 INFO - Running setup.py (path:/tmp/pip-UKeRjf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:16:35 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:16:35 INFO - Running setup.py install for manifestparser 09:16:35 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:16:35 INFO - Running setup.py install for mozcrash 09:16:35 INFO - Running setup.py install for mozdebug 09:16:35 INFO - Running setup.py install for mozdevice 09:16:35 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:16:35 INFO - Running setup.py install for mozfile 09:16:35 INFO - Running setup.py install for mozhttpd 09:16:35 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:16:35 INFO - Running setup.py install for mozinfo 09:16:36 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:16:36 INFO - Running setup.py install for mozInstall 09:16:36 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:16:36 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:16:36 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:16:36 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:16:36 INFO - Running setup.py install for mozleak 09:16:36 INFO - Running setup.py install for mozlog 09:16:36 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:16:36 INFO - Running setup.py install for moznetwork 09:16:36 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:16:36 INFO - Running setup.py install for mozprocess 09:16:36 INFO - Running setup.py install for mozprofile 09:16:36 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:16:36 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:16:36 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:16:36 INFO - Running setup.py install for mozrunner 09:16:36 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:16:36 INFO - Running setup.py install for mozscreenshot 09:16:36 INFO - Running setup.py install for moztest 09:16:37 INFO - Running setup.py install for mozversion 09:16:37 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:16:37 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:16:37 INFO - Cleaning up... 09:16:37 INFO - Return code: 0 09:16:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:16: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')]} 09:16:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:16: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')]} 09:16:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:16:37 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 0x12131f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13e0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15865c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15837a0>, '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 0x15846a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1584b30>, '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': '41bf3e9aed84707956354da8000001c5-1495210548.714939-469727514', '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 09:16:37 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 09:16:37 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 09:16:37 INFO - Using env: {'DISPLAY': ':0', 09:16:37 INFO - 'HOME': '/home/cltbld', 09:16:37 INFO - 'LANG': 'en_US.UTF-8', 09:16:37 INFO - 'LANGUAGE': 'en_US:en', 09:16:37 INFO - 'LOGNAME': 'cltbld', 09:16:37 INFO - 'MAIL': '/var/mail/cltbld', 09:16:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:16:37 INFO - 'MOZ_NO_REMOTE': '1', 09:16:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:16:37 INFO - 'NO_EM_RESTART': '1', 09:16:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:16:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:16:37 INFO - 'PWD': '/builds/slave/test', 09:16:37 INFO - 'SHELL': '/bin/bash', 09:16:37 INFO - 'SHLVL': '1', 09:16:37 INFO - 'TERM': 'linux', 09:16:37 INFO - 'TMOUT': '86400', 09:16:37 INFO - 'USER': 'cltbld', 09:16:37 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1495210548.714939-469727514', 09:16:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:16:37 INFO - '_': '/tools/buildbot/bin/python'} 09:16:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:16:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:16:37 INFO - Running setup.py (path:/tmp/pip-mCFZ6L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:16:37 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)) 09:16:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:16:37 INFO - Running setup.py (path:/tmp/pip-cEfaFC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:16:37 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)) 09:16:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:16:37 INFO - Running setup.py (path:/tmp/pip-mXDCXa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:16:37 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)) 09:16:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:16:37 INFO - Running setup.py (path:/tmp/pip-aOgUDj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:16:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.50 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)) 09:16:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:16:37 INFO - Running setup.py (path:/tmp/pip-0TMGzq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:16:37 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)) 09:16:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:16:37 INFO - Running setup.py (path:/tmp/pip-06bNtm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:16:37 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)) 09:16:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:16:37 INFO - Running setup.py (path:/tmp/pip-5q95dd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:16:37 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)) 09:16:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:16:37 INFO - Running setup.py (path:/tmp/pip-sA0v02-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:16:37 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)) 09:16:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:16:37 INFO - Running setup.py (path:/tmp/pip-UrNoWn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:16:38 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)) 09:16:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:16:38 INFO - Running setup.py (path:/tmp/pip-AJMt6A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:16:38 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)) 09:16:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:16:38 INFO - Running setup.py (path:/tmp/pip-ZxfuNV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:16:38 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)) 09:16:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:16:38 INFO - Running setup.py (path:/tmp/pip-sZCFVJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:16:38 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)) 09:16:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:16:38 INFO - Running setup.py (path:/tmp/pip-9JHirX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:16:38 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)) 09:16:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:16:38 INFO - Running setup.py (path:/tmp/pip-j_Sb4J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:16:38 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)) 09:16:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:16:38 INFO - Running setup.py (path:/tmp/pip-eZbSJK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:16:38 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)) 09:16:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:16:38 INFO - Running setup.py (path:/tmp/pip-jRfUo7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:16:38 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)) 09:16:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:16:38 INFO - Running setup.py (path:/tmp/pip-yZHa88-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:16:38 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)) 09:16:38 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)) 09:16:38 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)) 09:16:38 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)) 09:16:38 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:16:38 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:16:38 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:16: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 09:16: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 09:16: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 09:16: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 09:16:39 INFO - Downloading blessings-1.6.tar.gz 09:16:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:16:39 INFO - Installing collected packages: blessings 09:16:39 INFO - Running setup.py install for blessings 09:16:39 INFO - Successfully installed blessings 09:16:39 INFO - Cleaning up... 09:16:39 INFO - Return code: 0 09:16:39 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:16:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:16:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:16:40 INFO - Reading from file tmpfile_stdout 09:16:40 INFO - Current package versions: 09:16:40 INFO - argparse == 1.2.1 09:16:40 INFO - blessings == 1.6 09:16:40 INFO - blobuploader == 1.2.4 09:16:40 INFO - docopt == 0.6.1 09:16:40 INFO - functools32 == 3.2.3-2 09:16:40 INFO - jsonschema == 2.5.1 09:16:40 INFO - manifestparser == 1.1 09:16:40 INFO - mozInstall == 1.12 09:16:40 INFO - mozcrash == 1.0 09:16:40 INFO - mozdebug == 0.1 09:16:40 INFO - mozdevice == 0.50 09:16:40 INFO - mozfile == 1.2 09:16:40 INFO - mozhttpd == 0.7 09:16:40 INFO - mozinfo == 0.9 09:16:40 INFO - mozleak == 0.1 09:16:40 INFO - mozlog == 3.4 09:16:40 INFO - moznetwork == 0.27 09:16:40 INFO - mozprocess == 0.25 09:16:40 INFO - mozprofile == 0.28 09:16:40 INFO - mozrunner == 6.13 09:16:40 INFO - mozscreenshot == 0.1 09:16:40 INFO - mozsystemmonitor == 0.3 09:16:40 INFO - moztest == 0.8 09:16:40 INFO - mozversion == 1.4 09:16:40 INFO - psutil == 3.1.1 09:16:40 INFO - requests == 1.2.3 09:16:40 INFO - wsgiref == 0.1.2 09:16:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:16:40 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')]} 09:16:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:16:40 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')]} 09:16:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:16:40 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 0x12131f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13e0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15865c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15837a0>, '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 0x15846a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1584b30>, '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': '41bf3e9aed84707956354da8000001c5-1495210548.714939-469727514', '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 09:16:40 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 09:16:40 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 09:16:40 INFO - Using env: {'DISPLAY': ':0', 09:16:40 INFO - 'HOME': '/home/cltbld', 09:16:40 INFO - 'LANG': 'en_US.UTF-8', 09:16:40 INFO - 'LANGUAGE': 'en_US:en', 09:16:40 INFO - 'LOGNAME': 'cltbld', 09:16:40 INFO - 'MAIL': '/var/mail/cltbld', 09:16:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:16:40 INFO - 'MOZ_NO_REMOTE': '1', 09:16:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:16:40 INFO - 'NO_EM_RESTART': '1', 09:16:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:16:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:16:40 INFO - 'PWD': '/builds/slave/test', 09:16:40 INFO - 'SHELL': '/bin/bash', 09:16:40 INFO - 'SHLVL': '1', 09:16:40 INFO - 'TERM': 'linux', 09:16:40 INFO - 'TMOUT': '86400', 09:16:40 INFO - 'USER': 'cltbld', 09:16:40 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1495210548.714939-469727514', 09:16:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:16:40 INFO - '_': '/tools/buildbot/bin/python'} 09:16:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:16:40 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)) 09:16:40 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)) 09:16:40 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)) 09:16:40 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)) 09:16:40 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)) 09:16:40 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)) 09:16:40 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)) 09:16:40 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)) 09:16:40 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)) 09:16:40 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)) 09:16:40 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)) 09:16:40 INFO - Cleaning up... 09:16:40 INFO - Return code: 0 09:16:40 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:16:40 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')]} 09:16:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:16:40 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')]} 09:16:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:16:40 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 0x12131f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13e0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15865c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15837a0>, '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 0x15846a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1584b30>, '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': '41bf3e9aed84707956354da8000001c5-1495210548.714939-469727514', '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 09:16:40 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 09:16:40 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 09:16:40 INFO - Using env: {'DISPLAY': ':0', 09:16:40 INFO - 'HOME': '/home/cltbld', 09:16:40 INFO - 'LANG': 'en_US.UTF-8', 09:16:40 INFO - 'LANGUAGE': 'en_US:en', 09:16:40 INFO - 'LOGNAME': 'cltbld', 09:16:40 INFO - 'MAIL': '/var/mail/cltbld', 09:16:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:16:40 INFO - 'MOZ_NO_REMOTE': '1', 09:16:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:16:40 INFO - 'NO_EM_RESTART': '1', 09:16:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:16:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:16:40 INFO - 'PWD': '/builds/slave/test', 09:16:40 INFO - 'SHELL': '/bin/bash', 09:16:40 INFO - 'SHLVL': '1', 09:16:40 INFO - 'TERM': 'linux', 09:16:40 INFO - 'TMOUT': '86400', 09:16:40 INFO - 'USER': 'cltbld', 09:16:40 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1495210548.714939-469727514', 09:16:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:16:40 INFO - '_': '/tools/buildbot/bin/python'} 09:16:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:16:40 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:16:40 INFO - Cleaning up... 09:16:40 INFO - Return code: 0 09:16:40 INFO - Running post-action listener: _resource_record_post_action 09:16:40 INFO - Running post-action listener: _start_resource_monitoring 09:16:40 INFO - Starting resource monitoring. 09:16:40 INFO - [mozharness: 2017-05-19 16:16:40.634563Z] Finished create-virtualenv step (success) 09:16:40 INFO - [mozharness: 2017-05-19 16:16:40.635022Z] Running install step. 09:16:40 INFO - Running pre-action listener: _resource_record_pre_action 09:16:40 INFO - Running main action method: install 09:16:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:16:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:16:40 INFO - Reading from file tmpfile_stdout 09:16:40 INFO - Detecting whether we're running mozinstall >=1.0... 09:16:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:16:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:16:40 INFO - Reading from file tmpfile_stdout 09:16:40 INFO - Output received: 09:16:40 INFO - Usage: mozinstall [options] installer 09:16:40 INFO - Options: 09:16:40 INFO - -h, --help show this help message and exit 09:16:40 INFO - -d DEST, --destination=DEST 09:16:40 INFO - Directory to install application into. [default: 09:16:40 INFO - "/builds/slave/test"] 09:16:40 INFO - --app=APP Application being installed. [default: firefox] 09:16:40 INFO - mkdir: /builds/slave/test/build/application 09:16:40 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'] 09:16:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 09:16:57 INFO - Reading from file tmpfile_stdout 09:16:57 INFO - Output received: 09:16:57 INFO - /builds/slave/test/build/application/firefox/firefox 09:16:57 INFO - Running post-action listener: _resource_record_post_action 09:16:57 INFO - [mozharness: 2017-05-19 16:16:57.853474Z] Finished install step (success) 09:16:57 INFO - [mozharness: 2017-05-19 16:16:57.853748Z] Running run-tests step. 09:16:57 INFO - Running pre-action listener: _resource_record_pre_action 09:16:57 INFO - Running main action method: run_tests 09:16:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:16:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:16:57 INFO - Python 2.7.3 09:16:57 INFO - Return code: 0 09:16:57 INFO - grabbing minidump binary from tooltool 09:16:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:16:57 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 0x15837a0>, '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 0x15846a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1584b30>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:16:57 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 09:16:57 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 09:16:57 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 09:16:57 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:16:57 INFO - Return code: 0 09:16:57 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:16:57 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:16:57 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:16:57 INFO - ENV: RUST_BACKTRACE is now 1 09:16:57 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:16:57 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:16:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Nb4DyC1NQSWAXleixBvs-w/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--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 09:16:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Nb4DyC1NQSWAXleixBvs-w/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-026 --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 09:16:57 INFO - Using env: {'DISPLAY': ':0', 09:16:57 INFO - 'HOME': '/home/cltbld', 09:16:57 INFO - 'LANG': 'en_US.UTF-8', 09:16:57 INFO - 'LANGUAGE': 'en_US:en', 09:16:57 INFO - 'LOGNAME': 'cltbld', 09:16:57 INFO - 'MAIL': '/var/mail/cltbld', 09:16:57 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:16:57 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:16:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:16:57 INFO - 'MOZ_NO_REMOTE': '1', 09:16:57 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:16:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:16:57 INFO - 'NO_EM_RESTART': '1', 09:16:57 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:16:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:16:57 INFO - 'PWD': '/builds/slave/test', 09:16:57 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:16:57 INFO - 'RUST_BACKTRACE': '1', 09:16:57 INFO - 'SHELL': '/bin/bash', 09:16:57 INFO - 'SHLVL': '1', 09:16:57 INFO - 'TERM': 'linux', 09:16:57 INFO - 'TMOUT': '86400', 09:16:57 INFO - 'USER': 'cltbld', 09:16:57 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1495210548.714939-469727514', 09:16:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:16:57 INFO - '_': '/tools/buildbot/bin/python'} 09:16:57 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Nb4DyC1NQSWAXleixBvs-w/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--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 09:16:58 INFO - mozversion application_buildid: 20170519154716 09:16:58 INFO - mozversion application_changeset: c800b6dfca673f8cb0f3cf41e4f495755d04bbb3 09:16:58 INFO - mozversion application_display_name: Nightly 09:16:58 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:16:58 INFO - mozversion application_name: Firefox 09:16:58 INFO - mozversion application_remotingname: firefox 09:16:58 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 09:16:58 INFO - mozversion application_vendor: Mozilla 09:16:58 INFO - mozversion application_version: 55.0a1 09:16:58 INFO - mozversion platform_buildid: 20170519154716 09:16:58 INFO - mozversion platform_changeset: c800b6dfca673f8cb0f3cf41e4f495755d04bbb3 09:16:58 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 09:16:58 INFO - mozversion platform_version: 55.0a1 09:16:58 INFO - using testdate: 1495210618 09:16:58 INFO - actual date: 1495210618 09:16:58 INFO - starting webserver on 'localhost:39671' 09:16:58 INFO - SUITE-START | Running 2 tests 09:16:58 INFO - TEST-START | dromaeo_css 09:16:58 INFO - operating with platform_type : linux_ 09:16:58 INFO - Initialising browser for dromaeo_css test... 09:16:58 INFO - TEST-INFO | started process 26732 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5S91Yp/profile http://localhost:39671/getInfo.html) 09:16:58 INFO - PID 26732 | JavaScript warning: resource://gre/modules/addons/XPIProvider.jsm, line 2963: String.localeCompare is deprecated; use String.prototype.localeCompare instead 09:17:02 INFO - PID 26732 | __metrics Screen width/height:1600/1200 09:17:02 INFO - PID 26732 | colorDepth:24 09:17:02 INFO - PID 26732 | Browser inner width/height: 1024/695 09:17:02 INFO - PID 26732 | __metrics 09:17:04 INFO - TEST-INFO | 26732: exit 0 09:17:04 INFO - Browser initialized. 09:17:04 INFO - Running cycle 1/1 for dromaeo_css test... 09:17:04 INFO - TEST-INFO | started process 26896 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5S91Yp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:17:15 INFO - PID 26896 | RSS: Main: 166584320 09:17:15 INFO - PID 26896 | 09:20:20 INFO - PID 26896 | Cycle 1(1): loaded http://localhost:39671/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39671/tests/dromaeo/cssquery-ext.html) 09:20:21 INFO - PID 26896 | RSS: Main: 171544576 09:20:21 INFO - PID 26896 | 09:23:23 INFO - PID 26896 | Cycle 1(1): loaded http://localhost:39671/tests/dromaeo/cssquery-ext.html (next: http://localhost:39671/tests/dromaeo/cssquery-jquery.html) 09:23:24 INFO - PID 26896 | RSS: Main: 171212800 09:23:24 INFO - PID 26896 | 09:26:26 INFO - PID 26896 | Cycle 1(1): loaded http://localhost:39671/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39671/tests/dromaeo/cssquery-mootools.html) 09:26:27 INFO - PID 26896 | RSS: Main: 172556288 09:26:27 INFO - PID 26896 | 09:29:28 INFO - PID 26896 | Cycle 1(1): loaded http://localhost:39671/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39671/tests/dromaeo/cssquery-prototype.html) 09:29:29 INFO - PID 26896 | RSS: Main: 170786816 09:29:29 INFO - PID 26896 | 09:32:32 INFO - PID 26896 | Cycle 1(1): loaded http://localhost:39671/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39671/tests/dromaeo/cssquery-yui.html) 09:32:32 INFO - PID 26896 | RSS: Main: 172457984 09:32:32 INFO - PID 26896 | 09:35:34 INFO - PID 26896 | Cycle 1(1): loaded http://localhost:39671/tests/dromaeo/cssquery-yui.html (next: http://localhost:39671/tests/dromaeo/cssquery-dojo.html) 09:35:34 INFO - PID 26896 | RSS: Main: 173867008 09:35:34 INFO - PID 26896 | 09:35:34 INFO - PID 26896 | __start_tp_report 09:35:34 INFO - PID 26896 | _x_x_mozilla_page_load 09:35:34 INFO - PID 26896 | _x_x_mozilla_page_load_details 09:35:34 INFO - PID 26896 | |i|pagename|runs| 09:35:34 INFO - PID 26896 | |0;dojo.html;2675.6521652185215;2709.6883858356296;2735.452909418117;2751;2766.9308267293327;5229.790808367661;5345.037893179231;5345.278387417708;5358.785648574058;5380.300560927079;5318.76065577049;5324.201369794523;5412.83761487156;5423.620346575742;5439.864003399917;4692.648051396141;4692.976535117328;4711.505291944348;4773.188557945157;4799.064182484417;4742.573168414842;4784.162771514988;4829.51704829516;4842;4881.536254055877;4693.413323334583;4767.76161191939;4826.1795494765975;4843.733594652293;4850.854474365775;4695.990362072171;4744.335792988984;4777.5222477752295;4797.472278049447;4816.301636262722;4638.46657634373;4733.715977041354;4739.12326219647;4750.928736068961;4792.161371759963;5261.053010458116;5266.526012658879;5269.499397557226;5305.469453054702;5309.867253318659;5578.079616863212;5672.064109421982;5672.801451949162;5674.858128546778;5742.6841523716175;5751.884962300731;5752.539796816244;5760.452756988079;5768.509676677488;5812.941870581325;5349.384820745586;5353.491418315254;5357.43746906577;5361.463853614608;5375.596830237748;5750.741216645261;5788.5369170466265;5849.88300233993;5892.94107058924;5983.252093488314;5592.916106258409;5613.607047506635;5623.437656234344;5651.943480565142;5670.00774864397;5596.832095037155;5660.660360378391;5684.573656975744;5685.60200785941;5724.856878577985;5547.306586676666;5670.121131224667;5683.9715801420725;5687.146927960839;5715.428457154251;5603.691796951207;5639.238702775155;5658.886822263532;5663.886722265532;5690.687012214368;4782.569568738831;4822.324874517571;4824.49342818999;4852.733099679552;4870.391201099863;4101.753894766323;4103.835846566164;4111.8972025698995;4147.419361289422;4153.335466325373;4701.177293973609;4744.264638980963;4744.715317080986;4782.760861956958;4783.330333753277;5726.312842458931;5803.738831752581;5822.272215973004;5832.9708351457975;5842.2405087338375;4738.265568836836;4747.928781068286;4756.120117778222;4780.713157210509;4790.760461976887;5026.974865125651;5065.366829146356;5065.696058236591;5110.029094472038;5110.310108135429;5275.551578115749;5285.68285902847;5341.038613049688;5365;5369.677819330853;5779.653220806765;5780.393058728773;5785.450382213683;5821.534277257894;5835.358110607915;5337.519623233928;5345.41200467956;5345.65253258537;5349.304590403378;5356.035913535601;5543.3902270751;5612.242347283228;5638.295213098363;5677.489025987681;5738.139279108167;5733.226014487991;5778.219940308005;5790.855228619318;5843.29880414353;5858.326292476249;5472.452754724496;5566.24855644499;5576.163575463713;5579.721013949205;5590.748416321194;5429.538489228302;5607.5513958884;5610.943890561042;5622.353429355513;5630.8029218977135;5361.303030605996;5414.675119492843;5448.700321482356;5464.972675136599;5525.557955363481;5555.916661250004;5626.465485778845;5632.633878797865;5697.7436015380235;5714.885702286014;5410.621256512007;5486.506214440719;5486.561075113901;5490.258815059916;5492.5331346835965 09:35:34 INFO - PID 26896 | |1;ext.html;640.5132099604302;692.2558249881378;707.2503146664536;1167.2646232873294;1198.6284251881912;34470.31059378811;34737.82631086848;34889.30221395571;34890;34942.47586286205;32811.67188328116;32883;33042;33226.501602475924;33250.33499330012;6627.73489060437;6732.0575119483065;7029.08621879155;7151.284871512833;7166.283371662818;7091.751788687397;7116.537425067354;7155.892661610054;7197.496175267734;7211.990321355014;7143.249958754334;7213.098362704662;7220.422366210717;7222.891656625155;7239.167495737978;7180.353768160839;7180.676869540883;7185.065941427607;7187.245339239409;7206.567605943607;7046.5067445278855;7069.151701795766;7070.151581810164;7115.750948716822;7151.749688760869;31048.844755776077;31119.844400777853;31163;31210.53184202239;31386.68613313883;2953.8523073846436;2959.511680572703;2970.4207679502506;2982.970170298291;2984.104768569442;24972.250832475056;24976.12583559585;25062.624060639104;25070.4985900281;25127;2794.9580756288674;2823.8305701657964;2836.120802551195;2841.9147425577266;2842.5167721487396;148826.25586872105;149326;149622;155625.22187389105;159802;39345;39358.803205983786;39614.60385396167;39639;39768.40347394792;41292.1741565167;41854.37218441726;41863.581364186575;41980.37029444561;47025.5297447028;10476.68569942903;10499.475026248658;10595;10627.256092073636;10659.614250147431;7819.335356494648;7887.132415434297;7900.565468899151;7903.525788452711;7929.801754956172;13255.403506842214;13319.467221311039;13340.5330813423;13347.599572012856;13496.122752021087;5574.414686457944;5636.60543761941;5637.548996080303;5647;5652.943470565324;881.5768431152954;919.1222382624577;921.8801555797837;927.5455027036838;951.4671783801093;21055.263065792624;21836.344909652737;22049.559008819735;22135;22157.335279941628;969.6266937229218;976.1702552830037;993.8211121997965;1012.0233974214918;1017.353980222564;11359.772804543863;11609;11610.825837612443;11680.182387232811;11817.940910295394;171861;172899;173758;173809;173976;40567;40653;41066;41088.79455602703;41278.79360603238;1192.6165647848454;1233.808759642257;1235.246499635204;1238.9008879289636;1248.4382028087398;20071.498212544804;20233;20589.58820823605;20891.895540522808;21237.256696015564;29522.704772951995;37517.06207344838;37901;37974.8101259503;38034.42948355832;159458;161634;161860;162005;162157.18921405319;30187.547186791777;30284.24289392783;30514;30561.694383055885;30942.69057309398;35786.64213357833;36084.63915360813;36337.818310908275;36423.635763643084;36698.26603467969;27548.724512754616;27806.721932781224;28063;28246.43507129805;29104.854475727487;26897.86551067232;27501.31246718848;27538.17385478439;27608.723912760615;28591.42817143604;31279.21801954878;31320.37359252848;31421.214469638442;31451;31544.36911261716;26696.866515667298;26721.7327826727;27303.86348068247;27308.726912730617;28026;21478.355649330544;22060.558788824455;22218.222362217246;22377.32868013962;22450.214242501435 09:35:34 INFO - PID 26896 | |2;jquery.html;409.1367215175976;413.88825017245347;418.5667833792024;433.7072476078647;441.6488891331391;14411.927940360283;14657.706845863104;16670.249838757256;17428.56428589286;17469.825301746994;18699.53251168718;18930.905345473253;19011.524711882208;19204.615907681837;19485.22059117637;5473.808416705416;5524.364698059724;5568.58001209691;5570.303712035996;5712.6286791358425;5493.066178749622;5549.472800084006;5596.58025648076;5608.327000759915;5611.158326251054;5330.040592693314;5503.559715222773;5511.366192887829;5520.723963801814;5545.556355491572;5188.6509507527935;5506.724663766816;5519.806806761784;5548.250986116883;5549.1676248562835;4874.585660218886;4900.583450406684;4912.452577438131;4916.53292937174;4918.286848406961;21926.671099933516;22087;22506.212282570195;22610.66084008741;22795.544089118124;1624.374615772924;1662.1356894414957;1668.099226417745;1674.4055860169708;1674.5143908266589;14621.853781462156;14866.479673211494;15201.467948621856;15256.160911149882;15359.308831102628;2043.5402034542258;2102.7686954435;2125.3092744857827;2128.244473212003;2141.8714877107423;89607.55196224042;91801.65586753044;91803;92909.53545232298;93871;10924.672259832218;11043.116550675926;11054.281471704313;11098.112151027899;11381;15261.694766104838;15508.689826203412;15608.765868511982;15657.217139143226;15672.138032408098;6632.43624291931;6874.106366172366;6943.375096241362;7008.614526201108;7042.92957070433;5950;5976;6144.139820425144;6154.78458253959;6173.135760993465;6962.895556566555;7035.964820175969;7074.787756367317;7183.480094753638;7244.673989670478;2064.5870825834895;2076.709260703503;2093.2008404745643;2116.5978464091772;2259.435141214696;840.9075001749802;860.4880096342666;862.2498426368974;871.3856731004627;896.8878890138733;16990;17151.571210719583;17263.827361726475;17338.91330543339;18041;852.0840096895862;857.9742607721778;858.356232825381;869.8390797702446;884.2925659472396;9162;9362.812743745088;9715.27135464843;9750.171235444925;9795.902040979641;341142;341284;341652;346275;349850;71335;72453.637731811;74549;74611;75543;1010.525053224983;1031.3657100883054;1050.779336339362;1056.4084112896649;1063.2610335816687;14743.705125897637;14768.852311476749;14909.179995100374;15014.174220417983;15709;38489.42265865958;38867;38873.611263886996;38884.02789930161;39242.87949765348;47083.29375059308;47111.293330600754;47161.29258061063;47719.76140119277;48252;8220.876686849822;8232.382571307297;8445.366597505088;8504.44721093127;8634.78413039679;12507.187032842836;13108.344582770633;13230.470781168646;13342.466301347837;13345;11143;11161.107111430903;11236.325820450798;11310;11571.421428928688;10462.843057353994;10703.357798532114;10727.839082413926;10807.297525660806;10867.673969780919;11529.020033296929;11544.365059921785;11658;11855.229410088317;12043.397830108635;8190.83618327642;8241.464304820167;8390.202930721573;8506.702265420681;8544;10727.785444291227;10787.244892857425;10841.512131953923;10883.67348979532;11181.944090279496 09:35:34 INFO - PID 26896 | |3;mootools.html;1267.8415198100238;1305.229914350533;1327.1638867513466;1332.533613235367;1336.5322137251958;10060.144887684546;10068.395896246231;10453.895461045387;10518.842217366737;10544.367337959728;10500;10629.096526795232;10685.30545514541;10697.732556686087;10699.78600427991;2271.205078222621;2297.7357603875603;2305.930822075332;2311.3066080175963;2316.444053427182;2216.2575537195057;2262.264763951714;2265.0486795545826;2274.0676322707695;2279.6922415473946;2225.643896976484;2240.0815665577115;2263.807576356012;2269.1604106480545;2283.4177284792354;2155.321073861744;2175.0755928730305;2242.7981481666566;2245.5396643688086;2246.4833088389682;2025.4936265933516;2151.655735082379;2165.058199683143;2210.9668354974688;2214.6345852934246;10121.291509594332;10349.430781307025;10354.068133867913;10358.378497290187;10367.89632103677;5589.74846131925;5764.221830052931;5772.018756811311;5777.7977770777825;5791.841631673682;3091.474449343617;3322.8670853165845;3435.4675025371107;3437.604675462329;3461.0655123116617;957.3920560444099;987.3532835992437;987.9259055570789;989.6091044037637;1011.6105299459688;15174;15346;15362;15363.846361536353;15365.001274917206;4586.243269860435;4749.64377671676;4913.950860491421;4991.326170966946;5007.39911210657;10785.13718902486;10794.73013174677;10800.675979720621;10804.13566914645;10807.891921080689;5502.0371434998715;5514.91727624086;5545.61180717354;5554.472325129106;5557.249771280906;4914.0908931847725;5146.330976972969;5148.819791307361;5162.277281180638;5174.7153906535505;3831.885043448701;3927.273454410943;3942.7634341939574;3958.9208215835524;3964.306246406867;1105.4086063955745;1112.7273817914502;1115.453427820362;1131.338167172197;1138.9316641001567;677.6103740349319;698.9405900498515;704.3484776581641;708.4544900426642;722.819295176206;5502.284702988586;5730.71346432685;5770.740316685759;5827.8052999135925;5958.493528050078;486.7420267258359;520.9166533354721;523.4582207415307;528.4477720781792;534.0280689145795;3245.237369218232;3666.7249956253386;3703.9629603704157;3716.3310604090984;3742.8877133686033;12061.276323420623;12873.420696068699;12879.162854414433;12881;12885.226886386847;12454.128211025323;12706.618801435972;12711;12725.809112863315;12819;7230.493865429369;7289.562626242442;7344.926550734424;7346.742863999842;7389.593572353572;5626.831195064155;6285.182926219745;6294.402031806971;6326;6583.144191255106;11679.240849344766;11813.704657383634;11850.703732406759;11931.940340298243;12050.819237711266;12255;12275.2021118627;12277.263364198177;12429.875701242872;12489.250644961332;7998.600069996361;8054.5569993650915;8087.393445491494;8273.214044665747;8361.289290410139;9914.900850991686;9927.652532161339;9986.950065249628;10025.298229123891;10041.447720375449;7751.806204844924;7895.881561776463;7956.801079973047;8013.6794528218215;8104.068032176139;7932.524048557105;8136.430449868452;8172.18278172178;8190.549519776231;8338.207870252316;7330.853382932418;7502.099748030053;7517.436192285491;7529.284717951786;7530.246975302426;5219.739013049409;5275.419703832652;5345.064613692666;5414.079606466831;5538.196961440488;5319.946800531945;5359.383670877899;5422.240886275846;5462.9180562292395;5569.443055694398 09:35:34 INFO - PID 26896 | |4;prototype.html;359.3567514149672;374.8406927056001;382.2488809489354;385.3891581842779;391.27809192040684;5629.268195134627;5646;5657.830265092043;5709.229254050697;5740.5120564752;5569.301363084268;5573.247611572437;5581.972090139554;5586.13414920687;5592.0773072443;4287.292596721552;4321.805518751648;4348.30427131659;4367.301231802912;4374.49693285273;4355.934660980088;4367.192069467159;4372.3878656988045;4373.540778218289;4383.890402739925;4346.500152482474;4354.390385346054;4357.172137293904;4376.912461750763;4380.605745482906;4228.534861165269;4314.784260786948;4372.234858899696;4372.6064654180955;4378.693491455615;3881.1849511602595;3895.474110995008;3898.3567711327596;3903.8633647822476;3906.374980003214;5492.423295553949;5499.7250137492965;5501.394846566875;5520.66875987442;5523.337199536041;4688.531146885284;4824.469308376111;4886.096072226649;5181.792728290864;5198.480151984809;5809.419058094199;5816.651000939914;5837.124431335291;5845.707714614252;5876.735546900357;4032.959670403288;4049.6355328020327;4049.9392509112386;4050.9189816203807;4053.2906741320444;6113.23584551931;6216.036514340284;6241.34465881085;6255.249370075575;6275.2783429905685;4133.726450452239;4147.6267135957905;4154.480689913761;4157.625813676784;4162.625363717219;4196.51740049892;4202.789860506962;4207.726497777635;4210.873673789792;4219.599138081878;4762.904741905142;4828.806847726051;4873.707577545359;4877.756112194447;4881.267809828483;5861.765529378862;5871.9706401468575;5883.61756485827;5884.47039766423;5898.764049437975;1430.5279257844886;1434.956951291463;1436.8563143685758;1437.6190309567974;1438.841727409984;914.7484441778564;950.3442624589012;954.8663187153804;956.8277710012264;967.6274634265718;4926.8768280793265;4945.876353091202;4953.885375790491;5000.399952005782;5007.924881126786;5922.73347699346;5951;5998.580099393001;6042;6101.115338276014;4756.7145971241835;4930.482299358588;4956.231784073474;4984.6261530384645;5006.6495345325475;3182.7110020441296;3208.181913612014;3208.1982850321974;3209.277912469676;3237.417264892342;5493.368262649767;5616.354119276336;5653.378128405872;5679.772809087673;5680.4319568042865;6103.389661033861;6268.843278918063;6277.108192920418;6279.466245369194;6306.905396419057;5625.493705566519;5659.434056594308;5659.43405659439;5697.829065128053;5702.087665973508;6036.486898613667;6123.295820980644;6142.293636231711;6149.446549810538;6164.489700023523;5971.7611295547695;5990.131430942576;6004.789832355847;6016.578839481369;6021.518278537794;5671.829845104653;5672;5672.347680016851;5687;5692.800751973661;4063.4717486726536;4083.5099788025627;4113.4858142732155;4147.502299724052;4162.875113746592;6091.604045737013;6097.847553811191;6113.23584551931;6113.877722445615;6124.601900876429;5872.735726892385;5878.353381127987;5921.348651648229;5932.49573786233;5935.910961335497;5756.971215143897;5846.824595262149;5885.352611212848;5892.351841297368;5892.6759028253855;5808.970955145197;5814.069748840166;5815.371695925148;5828.358880523054;5848.239728835224;5822.94177058224;5932.288125424977;5969.701514924323;5983;5991.580589358703;5772.19189313488;5786.594938354275;5789.478946894631;5798.362180160263;5804.1874137619925 09:35:34 INFO - PID 26896 | |5;yui.html;623.5416968528134;629.8519847835761;708.4084789201017;742.3170682971665;747.4879707400432;13713.177209367444;14167.858321416796;14292.499762508302;14631.12213267202;15773.763393549107;15588.376464941417;15640.765388519181;15889.2849821758;15896.761548576751;16344.427945021927;914.5427286356821;914.7255823253031;922.9723108306762;925.2967744514184;926.6756635177701;874.3791907745476;878.5212059427595;916.2212119698237;921.0927236671873;923.2014307623924;941.0542404883083;953.3755390219383;953.6757502449166;956.7990721948399;963.1909196275127;938.7746940734208;957.0907637744136;957.2007373842849;958.3818437108026;959.2517836087862;693.466031156012;698.807827847341;701.9996504980382;702.6170736948325;702.7048639571341;13065.150765200231;13301.933490332583;14535.200563968978;14686.412543498247;14861.256937153206;15406.22968851553;15648.608784780357;15784.368625254976;15906.125163116025;15908.204589770465;10578.418186999712;10813.67558973232;10951.616693415772;10957.83563246552;10966.06788422985;2796.5385711357603;2800.355918138819;2821.1677555121287;2828.6464191976;2843.616111824898;70446.29553704448;72047.63976180137;72131.27868721298;72741.27258727398;73271.63364183198;11593.420328983517;11670.533178672928;11865.5847045353;11937.104717146076;11977.700557486132;19793.505162371057;20047.599048018958;21095.367138985854;21288.467788305108;21329.146834126463;5940.198073260141;6023.608465449732;6131.110988906673;6135.110408990671;6213.378662133841;3000.7599392048583;3028.7425568826457;3034.4082903833983;3045.8781648734243;3048.9542656860167;3351.0952042948265;3395.694387505087;3397.43942249531;3408.0968543336035;3410.4543273076188;683.5454422808776;696.6098984568657;699.5697645947807;701.4528667639249;704.651197657163;576.8183022347947;588.3322429043067;600.3786081405812;601.3655593348972;620.0915658560141;9224.354295199406;9885.752856178653;10320.587176512856;10352.637657681946;10445.425501597334;599.5263741644139;606.8664893723374;608.4767100293744;618.3692633513791;619.4672581579838;4178.558288004294;4244.72409293395;4287.406119297842;4375.1031038637;4397.890052748707;57579;57704.13443798346;58941.70529147413;59358.40641593615;59615.40384596185;51539.74230128901;51895.74052129715;52696.73651631794;52866;53603.19595206075;45224.773876130406;45563.31655025177;45871.541284587394;46103.53896460992;46134;9644.614215431584;9760.121589057018;10020.899791002288;10096;10309.175265978554;24352.634710479004;24551.263462096165;25037.248882533553;25060;25207.24378268655;39967;40451;40941.59058409497;41479.7926010368;41728.3740743883;12534.749305013665;12661.303628300164;12742.554010609954;12780.169288996185;13215.273159976294;13713.108647937852;14305.785413219019;14591.343389547283;14738.336774844944;15170.544883653509;13021.869781302066;13144.737105257651;13166.854717253133;13261.66845828862;13283.335833208494;12027.699307517381;12099.092568057255;12150;12236.694082648006;12357.75284494323;12980.415881285553;13637.318134093453;13734.313284335944;13771.862281377458;13787.586372408843;9708.5145742714;9931.106200441995;10128.24038197153;10292.022257885788;10304.793904122025;10141.49292535385;10373.740656483647;10558.736031599272;10768.623098191525;10946.288491248044 09:35:34 INFO - PID 26896 | __end_tp_report 09:35:34 INFO - PID 26896 | __start_cc_report 09:35:34 INFO - PID 26896 | _x_x_mozilla_cycle_collect,278 09:35:34 INFO - PID 26896 | __end_cc_report 09:35:34 INFO - PID 26896 | __startTimestamp1495211734892__endTimestamp 09:35:34 INFO - PID 26896 | 09:35:34 INFO - PID 26896 | ------- Summary: start ------- 09:35:34 INFO - PID 26896 | Number of tests: 6 09:35:34 INFO - PID 26896 | 09:35:34 INFO - PID 26896 | [#0] dojo.html Cycles:165 Average:5236.31 Median:5380.30 stddev:619.13 (11.5%) stddev-sans-first:587.54 09:35:34 INFO - PID 26896 | Values: 2675.7 2709.7 2735.5 2751.0 2766.9 5229.8 5345.0 5345.3 5358.8 5380.3 5318.8 5324.2 5412.8 5423.6 5439.9 4692.6 4693.0 4711.5 4773.2 4799.1 4742.6 4784.2 4829.5 4842.0 4881.5 4693.4 4767.8 4826.2 4843.7 4850.9 4696.0 4744.3 4777.5 4797.5 4816.3 4638.5 4733.7 4739.1 4750.9 4792.2 5261.1 5266.5 5269.5 5305.5 5309.9 5578.1 5672.1 5672.8 5674.9 5742.7 5751.9 5752.5 5760.5 5768.5 5812.9 5349.4 5353.5 5357.4 5361.5 5375.6 5750.7 5788.5 5849.9 5892.9 5983.3 5592.9 5613.6 5623.4 5651.9 5670.0 5596.8 5660.7 5684.6 5685.6 5724.9 5547.3 5670.1 5684.0 5687.1 5715.4 5603.7 5639.2 5658.9 5663.9 5690.7 4782.6 4822.3 4824.5 4852.7 4870.4 4101.8 4103.8 4111.9 4147.4 4153.3 4701.2 4744.3 4744.7 4782.8 4783.3 5726.3 5803.7 5822.3 5833.0 5842.2 4738.3 4747.9 4756.1 4780.7 4790.8 5027.0 5065.4 5065.7 5110.0 5110.3 5275.6 5285.7 5341.0 5365.0 5369.7 5779.7 5780.4 5785.5 5821.5 5835.4 5337.5 5345.4 5345.7 5349.3 5356.0 5543.4 5612.2 5638.3 5677.5 5738.1 5733.2 5778.2 5790.9 5843.3 5858.3 5472.5 5566.2 5576.2 5579.7 5590.7 5429.5 5607.6 5610.9 5622.4 5630.8 5361.3 5414.7 5448.7 5465.0 5525.6 5555.9 5626.5 5632.6 5697.7 5714.9 5410.6 5486.5 5486.6 5490.3 5492.5 09:35:34 INFO - PID 26896 | 09:35:34 INFO - PID 26896 | [#1] ext.html Cycles:180 Average:30862.22 Median:31084.34 stddev:41989.29 (135.1%) stddev-sans-first:42045.76 09:35:34 INFO - PID 26896 | Values: 640.5 692.3 707.3 1167.3 1198.6 34470.3 34737.8 34889.3 34890.0 34942.5 32811.7 32883.0 33042.0 33226.5 33250.3 6627.7 6732.1 7029.1 7151.3 7166.3 7091.8 7116.5 7155.9 7197.5 7212.0 7143.2 7213.1 7220.4 7222.9 7239.2 7180.4 7180.7 7185.1 7187.2 7206.6 7046.5 7069.2 7070.2 7115.8 7151.7 31048.8 31119.8 31163.0 31210.5 31386.7 2953.9 2959.5 2970.4 2983.0 2984.1 24972.3 24976.1 25062.6 25070.5 25127.0 2795.0 2823.8 2836.1 2841.9 2842.5 148826.3 149326.0 149622.0 155625.2 159802.0 39345.0 39358.8 39614.6 39639.0 39768.4 41292.2 41854.4 41863.6 41980.4 47025.5 10476.7 10499.5 10595.0 10627.3 10659.6 7819.3 7887.1 7900.6 7903.5 7929.8 13255.4 13319.5 13340.5 13347.6 13496.1 5574.4 5636.6 5637.5 5647.0 5652.9 881.6 919.1 921.9 927.5 951.5 21055.3 21836.3 22049.6 22135.0 22157.3 969.6 976.2 993.8 1012.0 1017.4 11359.8 11609.0 11610.8 11680.2 11817.9 171861.0 172899.0 173758.0 173809.0 173976.0 40567.0 40653.0 41066.0 41088.8 41278.8 1192.6 1233.8 1235.2 1238.9 1248.4 20071.5 20233.0 20589.6 20891.9 21237.3 29522.7 37517.1 37901.0 37974.8 38034.4 159458.0 161634.0 161860.0 162005.0 162157.2 30187.5 30284.2 30514.0 30561.7 30942.7 35786.6 36084.6 36337.8 36423.6 36698.3 27548.7 27806.7 28063.0 28246.4 29104.9 26897.9 27501.3 27538.2 27608.7 28591.4 31279.2 31320.4 31421.2 31451.0 31544.4 26696.9 26721.7 27303.9 27308.7 28026.0 21478.4 22060.6 22218.2 22377.3 22450.2 09:35:34 INFO - PID 26896 | 09:35:34 INFO - PID 26896 | [#2] jquery.html Cycles:180 Average:24109.90 Median:38678.21 stddev:57546.98 (148.8%) stddev-sans-first:57680.90 09:35:34 INFO - PID 26896 | Values: 409.1 413.9 418.6 433.7 441.6 14411.9 14657.7 16670.2 17428.6 17469.8 18699.5 18930.9 19011.5 19204.6 19485.2 5473.8 5524.4 5568.6 5570.3 5712.6 5493.1 5549.5 5596.6 5608.3 5611.2 5330.0 5503.6 5511.4 5520.7 5545.6 5188.7 5506.7 5519.8 5548.3 5549.2 4874.6 4900.6 4912.5 4916.5 4918.3 21926.7 22087.0 22506.2 22610.7 22795.5 1624.4 1662.1 1668.1 1674.4 1674.5 14621.9 14866.5 15201.5 15256.2 15359.3 2043.5 2102.8 2125.3 2128.2 2141.9 89607.6 91801.7 91803.0 92909.5 93871.0 10924.7 11043.1 11054.3 11098.1 11381.0 15261.7 15508.7 15608.8 15657.2 15672.1 6632.4 6874.1 6943.4 7008.6 7042.9 5950.0 5976.0 6144.1 6154.8 6173.1 6962.9 7036.0 7074.8 7183.5 7244.7 2064.6 2076.7 2093.2 2116.6 2259.4 840.9 860.5 862.2 871.4 896.9 16990.0 17151.6 17263.8 17338.9 18041.0 852.1 858.0 858.4 869.8 884.3 9162.0 9362.8 9715.3 9750.2 9795.9 341142.0 341284.0 341652.0 346275.0 349850.0 71335.0 72453.6 74549.0 74611.0 75543.0 1010.5 1031.4 1050.8 1056.4 1063.3 14743.7 14768.9 14909.2 15014.2 15709.0 38489.4 38867.0 38873.6 38884.0 39242.9 47083.3 47111.3 47161.3 47719.8 48252.0 8220.9 8232.4 8445.4 8504.4 8634.8 12507.2 13108.3 13230.5 13342.5 13345.0 11143.0 11161.1 11236.3 11310.0 11571.4 10462.8 10703.4 10727.8 10807.3 10867.7 11529.0 11544.4 11658.0 11855.2 12043.4 8190.8 8241.5 8390.2 8506.7 8544.0 10727.8 10787.2 10841.5 10883.7 11181.9 09:35:34 INFO - PID 26896 | 09:35:34 INFO - PID 26896 | [#3] mootools.html Cycles:180 Average:6298.94 Median:3710.15 stddev:4037.14 (108.8%) stddev-sans-first:4030.76 09:35:34 INFO - PID 26896 | Values: 1267.8 1305.2 1327.2 1332.5 1336.5 10060.1 10068.4 10453.9 10518.8 10544.4 10500.0 10629.1 10685.3 10697.7 10699.8 2271.2 2297.7 2305.9 2311.3 2316.4 2216.3 2262.3 2265.0 2274.1 2279.7 2225.6 2240.1 2263.8 2269.2 2283.4 2155.3 2175.1 2242.8 2245.5 2246.5 2025.5 2151.7 2165.1 2211.0 2214.6 10121.3 10349.4 10354.1 10358.4 10367.9 5589.7 5764.2 5772.0 5777.8 5791.8 3091.5 3322.9 3435.5 3437.6 3461.1 957.4 987.4 987.9 989.6 1011.6 15174.0 15346.0 15362.0 15363.8 15365.0 4586.2 4749.6 4914.0 4991.3 5007.4 10785.1 10794.7 10800.7 10804.1 10807.9 5502.0 5514.9 5545.6 5554.5 5557.2 4914.1 5146.3 5148.8 5162.3 5174.7 3831.9 3927.3 3942.8 3958.9 3964.3 1105.4 1112.7 1115.5 1131.3 1138.9 677.6 698.9 704.3 708.5 722.8 5502.3 5730.7 5770.7 5827.8 5958.5 486.7 520.9 523.5 528.4 534.0 3245.2 3666.7 3704.0 3716.3 3742.9 12061.3 12873.4 12879.2 12881.0 12885.2 12454.1 12706.6 12711.0 12725.8 12819.0 7230.5 7289.6 7344.9 7346.7 7389.6 5626.8 6285.2 6294.4 6326.0 6583.1 11679.2 11813.7 11850.7 11931.9 12050.8 12255.0 12275.2 12277.3 12429.9 12489.3 7998.6 8054.6 8087.4 8273.2 8361.3 9914.9 9927.7 9987.0 10025.3 10041.4 7751.8 7895.9 7956.8 8013.7 8104.1 7932.5 8136.4 8172.2 8190.5 8338.2 7330.9 7502.1 7517.4 7529.3 7530.2 5219.7 5275.4 5345.1 5414.1 5538.2 5319.9 5359.4 5422.2 5462.9 5569.4 09:35:34 INFO - PID 26896 | 09:35:34 INFO - PID 26896 | [#4] prototype.html Cycles:180 Average:4860.13 Median:5604.22 stddev:1439.14 (25.7%) stddev-sans-first:1402.97 09:35:34 INFO - PID 26896 | Values: 359.4 374.8 382.2 385.4 391.3 5629.3 5646.0 5657.8 5709.2 5740.5 5569.3 5573.2 5582.0 5586.1 5592.1 4287.3 4321.8 4348.3 4367.3 4374.5 4355.9 4367.2 4372.4 4373.5 4383.9 4346.5 4354.4 4357.2 4376.9 4380.6 4228.5 4314.8 4372.2 4372.6 4378.7 3881.2 3895.5 3898.4 3903.9 3906.4 5492.4 5499.7 5501.4 5520.7 5523.3 4688.5 4824.5 4886.1 5181.8 5198.5 5809.4 5816.7 5837.1 5845.7 5876.7 4033.0 4049.6 4049.9 4050.9 4053.3 6113.2 6216.0 6241.3 6255.2 6275.3 4133.7 4147.6 4154.5 4157.6 4162.6 4196.5 4202.8 4207.7 4210.9 4219.6 4762.9 4828.8 4873.7 4877.8 4881.3 5861.8 5872.0 5883.6 5884.5 5898.8 1430.5 1435.0 1436.9 1437.6 1438.8 914.7 950.3 954.9 956.8 967.6 4926.9 4945.9 4953.9 5000.4 5007.9 5922.7 5951.0 5998.6 6042.0 6101.1 4756.7 4930.5 4956.2 4984.6 5006.6 3182.7 3208.2 3208.2 3209.3 3237.4 5493.4 5616.4 5653.4 5679.8 5680.4 6103.4 6268.8 6277.1 6279.5 6306.9 5625.5 5659.4 5659.4 5697.8 5702.1 6036.5 6123.3 6142.3 6149.4 6164.5 5971.8 5990.1 6004.8 6016.6 6021.5 5671.8 5672.0 5672.3 5687.0 5692.8 4063.5 4083.5 4113.5 4147.5 4162.9 6091.6 6097.8 6113.2 6113.9 6124.6 5872.7 5878.4 5921.3 5932.5 5935.9 5757.0 5846.8 5885.4 5892.4 5892.7 5809.0 5814.1 5815.4 5828.4 5848.2 5822.9 5932.3 5969.7 5983.0 5991.6 5772.2 5786.6 5789.5 5798.4 5804.2 09:35:34 INFO - PID 26896 | 09:35:34 INFO - PID 26896 | [#5] yui.html Cycles:180 Average:14775.66 Median:3396.57 stddev:17456.93 (514.0%) stddev-sans-first:17473.55 09:35:34 INFO - PID 26896 | Values: 623.5 629.9 708.4 742.3 747.5 13713.2 14167.9 14292.5 14631.1 15773.8 15588.4 15640.8 15889.3 15896.8 16344.4 914.5 914.7 923.0 925.3 926.7 874.4 878.5 916.2 921.1 923.2 941.1 953.4 953.7 956.8 963.2 938.8 957.1 957.2 958.4 959.3 693.5 698.8 702.0 702.6 702.7 13065.2 13301.9 14535.2 14686.4 14861.3 15406.2 15648.6 15784.4 15906.1 15908.2 10578.4 10813.7 10951.6 10957.8 10966.1 2796.5 2800.4 2821.2 2828.6 2843.6 70446.3 72047.6 72131.3 72741.3 73271.6 11593.4 11670.5 11865.6 11937.1 11977.7 19793.5 20047.6 21095.4 21288.5 21329.1 5940.2 6023.6 6131.1 6135.1 6213.4 3000.8 3028.7 3034.4 3045.9 3049.0 3351.1 3395.7 3397.4 3408.1 3410.5 683.5 696.6 699.6 701.5 704.7 576.8 588.3 600.4 601.4 620.1 9224.4 9885.8 10320.6 10352.6 10445.4 599.5 606.9 608.5 618.4 619.5 4178.6 4244.7 4287.4 4375.1 4397.9 57579.0 57704.1 58941.7 59358.4 59615.4 51539.7 51895.7 52696.7 52866.0 53603.2 45224.8 45563.3 45871.5 46103.5 46134.0 9644.6 9760.1 10020.9 10096.0 10309.2 24352.6 24551.3 25037.2 25060.0 25207.2 39967.0 40451.0 40941.6 41479.8 41728.4 12534.7 12661.3 12742.6 12780.2 13215.3 13713.1 14305.8 14591.3 14738.3 15170.5 13021.9 13144.7 13166.9 13261.7 13283.3 12027.7 12099.1 12150.0 12236.7 12357.8 12980.4 13637.3 13734.3 13771.9 13787.6 9708.5 9931.1 10128.2 10292.0 10304.8 10141.5 10373.7 10558.7 10768.6 10946.3 09:35:34 INFO - PID 26896 | -------- Summary: end -------- 09:35:34 INFO - PID 26896 | 09:35:35 INFO - TEST-INFO | 26896: exit 0 09:35:35 INFO - TEST-OK | dromaeo_css | took 1117629ms 09:35:35 INFO - TEST-START | kraken 09:35:35 INFO - operating with platform_type : linux_ 09:35:35 INFO - Initialising browser for kraken test... 09:35:35 INFO - TEST-INFO | started process 27299 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyM2qoU/profile http://localhost:39671/getInfo.html) 09:35:36 INFO - PID 27299 | JavaScript warning: resource://gre/modules/addons/XPIProvider.jsm, line 2963: String.localeCompare is deprecated; use String.prototype.localeCompare instead 09:35:39 INFO - PID 27299 | __metrics Screen width/height:1600/1200 09:35:39 INFO - PID 27299 | colorDepth:24 09:35:39 INFO - PID 27299 | Browser inner width/height: 1024/695 09:35:39 INFO - PID 27299 | __metrics 09:35:41 INFO - TEST-INFO | 27299: exit 0 09:35:41 INFO - Browser initialized. 09:35:41 INFO - Running cycle 1/1 for kraken test... 09:35:41 INFO - TEST-INFO | started process 27463 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyM2qoU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:35:53 INFO - PID 27463 | RSS: Main: 165638144 09:35:53 INFO - PID 27463 | 09:35:55 INFO - PID 27463 | Cycle 1(1): loaded http://localhost:39671/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39671/tests/kraken/driver.html?testName=audio-beat-detection) 09:35:56 INFO - PID 27463 | RSS: Main: 169660416 09:35:56 INFO - PID 27463 | 09:35:59 INFO - PID 27463 | Cycle 1(1): loaded http://localhost:39671/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39671/tests/kraken/driver.html?testName=audio-dft) 09:35:59 INFO - PID 27463 | RSS: Main: 169324544 09:35:59 INFO - PID 27463 | 09:36:02 INFO - PID 27463 | Cycle 1(1): loaded http://localhost:39671/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39671/tests/kraken/driver.html?testName=audio-fft) 09:36:03 INFO - PID 27463 | RSS: Main: 166113280 09:36:03 INFO - PID 27463 | 09:36:05 INFO - PID 27463 | Cycle 1(1): loaded http://localhost:39671/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39671/tests/kraken/driver.html?testName=audio-oscillator) 09:36:06 INFO - PID 27463 | RSS: Main: 166674432 09:36:06 INFO - PID 27463 | 09:36:08 INFO - PID 27463 | Cycle 1(1): loaded http://localhost:39671/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39671/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:36:09 INFO - PID 27463 | RSS: Main: 166551552 09:36:09 INFO - PID 27463 | 09:36:12 INFO - PID 27463 | Cycle 1(1): loaded http://localhost:39671/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39671/tests/kraken/driver.html?testName=imaging-darkroom) 09:36:12 INFO - PID 27463 | RSS: Main: 170733568 09:36:12 INFO - PID 27463 | 09:36:16 INFO - PID 27463 | Cycle 1(1): loaded http://localhost:39671/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39671/tests/kraken/driver.html?testName=imaging-desaturate) 09:36:16 INFO - PID 27463 | RSS: Main: 168316928 09:36:16 INFO - PID 27463 | 09:36:19 INFO - PID 27463 | Cycle 1(1): loaded http://localhost:39671/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39671/tests/kraken/driver.html?testName=json-parse-financial) 09:36:20 INFO - PID 27463 | RSS: Main: 169123840 09:36:20 INFO - PID 27463 | 09:36:22 INFO - PID 27463 | Cycle 1(1): loaded http://localhost:39671/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39671/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:36:22 INFO - PID 27463 | RSS: Main: 169517056 09:36:22 INFO - PID 27463 | 09:36:24 INFO - PID 27463 | Cycle 1(1): loaded http://localhost:39671/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39671/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:36:25 INFO - PID 27463 | RSS: Main: 169025536 09:36:25 INFO - PID 27463 | 09:36:27 INFO - PID 27463 | Cycle 1(1): loaded http://localhost:39671/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39671/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:36:27 INFO - PID 27463 | RSS: Main: 169295872 09:36:27 INFO - PID 27463 | 09:36:30 INFO - PID 27463 | Cycle 1(1): loaded http://localhost:39671/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39671/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:36:31 INFO - PID 27463 | RSS: Main: 169693184 09:36:31 INFO - PID 27463 | 09:36:34 INFO - PID 27463 | Cycle 1(1): loaded http://localhost:39671/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39671/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:36:35 INFO - PID 27463 | RSS: Main: 169394176 09:36:35 INFO - PID 27463 | 09:36:36 INFO - PID 27463 | Cycle 1(1): loaded http://localhost:39671/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39671/tests/kraken/driver.html?testName=ai-astar) 09:36:37 INFO - PID 27463 | RSS: Main: 170455040 09:36:37 INFO - PID 27463 | 09:36:37 INFO - PID 27463 | __start_tp_report 09:36:37 INFO - PID 27463 | _x_x_mozilla_page_load 09:36:37 INFO - PID 27463 | _x_x_mozilla_page_load_details 09:36:37 INFO - PID 27463 | |i|pagename|runs| 09:36:37 INFO - PID 27463 | |0;ai-astar;104;113;113;114;112;113;113;113;113;115 09:36:37 INFO - PID 27463 | |1;audio-beat-detection;151;124;123;162;125;123;123;125;153;129 09:36:37 INFO - PID 27463 | |2;audio-dft;165;165;174;164;164;165;164;172;164;163 09:36:37 INFO - PID 27463 | |3;audio-fft;75;77;76;116;76;75;78;74;99;77 09:36:37 INFO - PID 27463 | |4;audio-oscillator;84;83;107;86;85;84;96;84;84;102 09:36:37 INFO - PID 27463 | |5;imaging-gaussian-blur;114;115;114;114;114;114;114;113;115;117 09:36:37 INFO - PID 27463 | |6;imaging-darkroom;151;151;150;151;151;152;151;151;152;153 09:36:37 INFO - PID 27463 | |7;imaging-desaturate;95;95;95;95;95;94;96;95;94;95 09:36:37 INFO - PID 27463 | |8;json-parse-financial;53;53;54;54;54;54;57;54;54;55 09:36:37 INFO - PID 27463 | |9;json-stringify-tinderbox;57;56;57;57;57;57;57;57;57;57 09:36:37 INFO - PID 27463 | |10;stanford-crypto-aes;84;84;82;83;82;87;83;82;88;83 09:36:37 INFO - PID 27463 | |11;stanford-crypto-ccm;141;132;132;132;134;137;132;134;181;139 09:36:37 INFO - PID 27463 | |12;stanford-crypto-pbkdf2;188;196;195;196;202;197;198;199;198;193 09:36:37 INFO - PID 27463 | |13;stanford-crypto-sha256-iterative;76;77;74;78;76;74;75;80;78;74 09:36:37 INFO - PID 27463 | __end_tp_report 09:36:37 INFO - PID 27463 | __start_cc_report 09:36:37 INFO - PID 27463 | _x_x_mozilla_cycle_collect,762 09:36:37 INFO - PID 27463 | __end_cc_report 09:36:37 INFO - PID 27463 | __startTimestamp1495211797189__endTimestamp 09:36:37 INFO - PID 27463 | 09:36:37 INFO - PID 27463 | ------- Summary: start ------- 09:36:37 INFO - PID 27463 | Number of tests: 14 09:36:37 INFO - PID 27463 | 09:36:37 INFO - PID 27463 | [#0] ai-astar Cycles:10 Average:112.30 Median:113.00 stddev:3.02 (2.7%) stddev-sans-first:0.83 09:36:37 INFO - PID 27463 | Values: 104.0 113.0 113.0 114.0 112.0 113.0 113.0 113.0 113.0 115.0 09:36:37 INFO - PID 27463 | 09:36:37 INFO - PID 27463 | [#1] audio-beat-detection Cycles:10 Average:133.80 Median:127.00 stddev:15.22 (12.0%) stddev-sans-first:14.81 09:36:37 INFO - PID 27463 | Values: 151.0 124.0 123.0 162.0 125.0 123.0 123.0 125.0 153.0 129.0 09:36:37 INFO - PID 27463 | 09:36:37 INFO - PID 27463 | [#2] audio-dft Cycles:10 Average:166.00 Median:165.00 stddev:3.77 (2.3%) stddev-sans-first:3.98 09:36:37 INFO - PID 27463 | Values: 165.0 165.0 174.0 164.0 164.0 165.0 164.0 172.0 164.0 163.0 09:36:37 INFO - PID 27463 | 09:36:37 INFO - PID 27463 | [#3] audio-fft Cycles:10 Average:82.30 Median:76.50 stddev:13.92 (18.2%) stddev-sans-first:14.51 09:36:37 INFO - PID 27463 | Values: 75.0 77.0 76.0 116.0 76.0 75.0 78.0 74.0 99.0 77.0 09:36:37 INFO - PID 27463 | 09:36:37 INFO - PID 27463 | [#4] audio-oscillator Cycles:10 Average:89.50 Median:84.00 stddev:8.82 (10.5%) stddev-sans-first:9.13 09:36:37 INFO - PID 27463 | Values: 84.0 83.0 107.0 86.0 85.0 84.0 96.0 84.0 84.0 102.0 09:36:37 INFO - PID 27463 | 09:36:37 INFO - PID 27463 | [#5] imaging-gaussian-blur Cycles:10 Average:114.40 Median:114.00 stddev:1.07 (0.9%) stddev-sans-first:1.13 09:36:37 INFO - PID 27463 | Values: 114.0 115.0 114.0 114.0 114.0 114.0 114.0 113.0 115.0 117.0 09:36:37 INFO - PID 27463 | 09:36:37 INFO - PID 27463 | [#6] imaging-darkroom Cycles:10 Average:151.30 Median:151.00 stddev:0.82 (0.5%) stddev-sans-first:0.87 09:36:37 INFO - PID 27463 | Values: 151.0 151.0 150.0 151.0 151.0 152.0 151.0 151.0 152.0 153.0 09:36:37 INFO - PID 27463 | 09:36:37 INFO - PID 27463 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 09:36:37 INFO - PID 27463 | Values: 95.0 95.0 95.0 95.0 95.0 94.0 96.0 95.0 94.0 95.0 09:36:37 INFO - PID 27463 | 09:36:37 INFO - PID 27463 | [#8] json-parse-financial Cycles:10 Average:54.20 Median:54.00 stddev:1.14 (2.1%) stddev-sans-first:1.12 09:36:37 INFO - PID 27463 | Values: 53.0 53.0 54.0 54.0 54.0 54.0 57.0 54.0 54.0 55.0 09:36:37 INFO - PID 27463 | 09:36:37 INFO - PID 27463 | [#9] json-stringify-tinderbox Cycles:10 Average:56.90 Median:57.00 stddev:0.32 (0.6%) stddev-sans-first:0.33 09:36:37 INFO - PID 27463 | Values: 57.0 56.0 57.0 57.0 57.0 57.0 57.0 57.0 57.0 57.0 09:36:37 INFO - PID 27463 | 09:36:37 INFO - PID 27463 | [#10] stanford-crypto-aes Cycles:10 Average:83.80 Median:83.50 stddev:2.10 (2.5%) stddev-sans-first:2.22 09:36:37 INFO - PID 27463 | Values: 84.0 84.0 82.0 83.0 82.0 87.0 83.0 82.0 88.0 83.0 09:36:37 INFO - PID 27463 | 09:36:37 INFO - PID 27463 | [#11] stanford-crypto-ccm Cycles:10 Average:139.40 Median:135.50 stddev:14.97 (11.0%) stddev-sans-first:15.86 09:36:37 INFO - PID 27463 | Values: 141.0 132.0 132.0 132.0 134.0 137.0 132.0 134.0 181.0 139.0 09:36:37 INFO - PID 27463 | 09:36:37 INFO - PID 27463 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:196.20 Median:197.50 stddev:3.77 (1.9%) stddev-sans-first:2.57 09:36:37 INFO - PID 27463 | Values: 188.0 196.0 195.0 196.0 202.0 197.0 198.0 199.0 198.0 193.0 09:36:37 INFO - PID 27463 | 09:36:37 INFO - PID 27463 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:76.20 Median:76.50 stddev:2.04 (2.7%) stddev-sans-first:2.17 09:36:37 INFO - PID 27463 | Values: 76.0 77.0 74.0 78.0 76.0 74.0 75.0 80.0 78.0 74.0 09:36:37 INFO - PID 27463 | -------- Summary: end -------- 09:36:37 INFO - PID 27463 | 09:36:38 INFO - TEST-INFO | 27463: exit 0 09:36:38 INFO - TEST-OK | kraken | took 62495ms 09:36:38 INFO - SUITE-END | took 1180s 09:36:38 INFO - Completed test suite (00:19:40) 09:36:38 INFO - javascript benchmark 09:36:38 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6711.9883336507555, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2675.6521652185215, 2709.6883858356296, 2735.452909418117, 2751.0, 2766.9308267293327, 5229.790808367661, 5345.037893179231, 5345.278387417708, 5358.785648574058, 5380.300560927079, 5318.76065577049, 5324.201369794523, 5412.83761487156, 5423.620346575742, 5439.864003399917, 4692.648051396141, 4692.976535117328, 4711.505291944348, 4773.188557945157, 4799.064182484417, 4742.573168414842, 4784.162771514988, 4829.51704829516, 4842.0, 4881.536254055877, 4693.413323334583, 4767.76161191939, 4826.1795494765975, 4843.733594652293, 4850.854474365775, 4695.990362072171, 4744.335792988984, 4777.5222477752295, 4797.472278049447, 4816.301636262722, 4638.46657634373, 4733.715977041354, 4739.12326219647, 4750.928736068961, 4792.161371759963, 5261.053010458116, 5266.526012658879, 5269.499397557226, 5305.469453054702, 5309.867253318659, 5578.079616863212, 5672.064109421982, 5672.801451949162, 5674.858128546778, 5742.6841523716175, 5751.884962300731, 5752.539796816244, 5760.452756988079, 5768.509676677488, 5812.941870581325, 5349.384820745586, 5353.491418315254, 5357.43746906577, 5361.463853614608, 5375.596830237748, 5750.741216645261, 5788.5369170466265, 5849.88300233993, 5892.94107058924, 5983.252093488314, 5592.916106258409, 5613.607047506635, 5623.437656234344, 5651.943480565142, 5670.00774864397, 5596.832095037155, 5660.660360378391, 5684.573656975744, 5685.60200785941, 5724.856878577985, 5547.306586676666, 5670.121131224667, 5683.9715801420725, 5687.146927960839, 5715.428457154251, 5603.691796951207, 5639.238702775155, 5658.886822263532, 5663.886722265532, 5690.687012214368, 4782.569568738831, 4822.324874517571, 4824.49342818999, 4852.733099679552, 4870.391201099863, 4101.753894766323, 4103.835846566164, 4111.8972025698995, 4147.419361289422, 4153.335466325373, 4701.177293973609, 4744.264638980963, 4744.715317080986, 4782.760861956958, 4783.330333753277, 5726.312842458931, 5803.738831752581, 5822.272215973004, 5832.9708351457975, 5842.2405087338375, 4738.265568836836, 4747.928781068286, 4756.120117778222, 4780.713157210509, 4790.760461976887, 5026.974865125651, 5065.366829146356, 5065.696058236591, 5110.029094472038, 5110.310108135429, 5275.551578115749, 5285.68285902847, 5341.038613049688, 5365.0, 5369.677819330853, 5779.653220806765, 5780.393058728773, 5785.450382213683, 5821.534277257894, 5835.358110607915, 5337.519623233928, 5345.41200467956, 5345.65253258537, 5349.304590403378, 5356.035913535601, 5543.3902270751, 5612.242347283228, 5638.295213098363, 5677.489025987681, 5738.139279108167, 5733.226014487991, 5778.219940308005, 5790.855228619318, 5843.29880414353, 5858.326292476249, 5472.452754724496, 5566.24855644499, 5576.163575463713, 5579.721013949205, 5590.748416321194, 5429.538489228302, 5607.5513958884, 5610.943890561042, 5622.353429355513, 5630.8029218977135, 5361.303030605996, 5414.675119492843, 5448.700321482356, 5464.972675136599, 5525.557955363481, 5555.916661250004, 5626.465485778845, 5632.633878797865, 5697.7436015380235, 5714.885702286014, 5410.621256512007, 5486.506214440719, 5486.561075113901, 5490.258815059916, 5492.5331346835965], "value": 5190.673779745527, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [640.5132099604302, 692.2558249881378, 707.2503146664536, 1167.2646232873294, 1198.6284251881912, 34470.31059378811, 34737.82631086848, 34889.30221395571, 34890.0, 34942.47586286205, 32811.67188328116, 32883.0, 33042.0, 33226.501602475924, 33250.33499330012, 6627.73489060437, 6732.0575119483065, 7029.08621879155, 7151.284871512833, 7166.283371662818, 7091.751788687397, 7116.537425067354, 7155.892661610054, 7197.496175267734, 7211.990321355014, 7143.249958754334, 7213.098362704662, 7220.422366210717, 7222.891656625155, 7239.167495737978, 7180.353768160839, 7180.676869540883, 7185.065941427607, 7187.245339239409, 7206.567605943607, 7046.5067445278855, 7069.151701795766, 7070.151581810164, 7115.750948716822, 7151.749688760869, 31048.844755776077, 31119.844400777853, 31163.0, 31210.53184202239, 31386.68613313883, 2953.8523073846436, 2959.511680572703, 2970.4207679502506, 2982.970170298291, 2984.104768569442, 24972.250832475056, 24976.12583559585, 25062.624060639104, 25070.4985900281, 25127.0, 2794.9580756288674, 2823.8305701657964, 2836.120802551195, 2841.9147425577266, 2842.5167721487396, 148826.25586872105, 149326.0, 149622.0, 155625.22187389105, 159802.0, 39345.0, 39358.803205983786, 39614.60385396167, 39639.0, 39768.40347394792, 41292.1741565167, 41854.37218441726, 41863.581364186575, 41980.37029444561, 47025.5297447028, 10476.68569942903, 10499.475026248658, 10595.0, 10627.256092073636, 10659.614250147431, 7819.335356494648, 7887.132415434297, 7900.565468899151, 7903.525788452711, 7929.801754956172, 13255.403506842214, 13319.467221311039, 13340.5330813423, 13347.599572012856, 13496.122752021087, 5574.414686457944, 5636.60543761941, 5637.548996080303, 5647.0, 5652.943470565324, 881.5768431152954, 919.1222382624577, 921.8801555797837, 927.5455027036838, 951.4671783801093, 21055.263065792624, 21836.344909652737, 22049.559008819735, 22135.0, 22157.335279941628, 969.6266937229218, 976.1702552830037, 993.8211121997965, 1012.0233974214918, 1017.353980222564, 11359.772804543863, 11609.0, 11610.825837612443, 11680.182387232811, 11817.940910295394, 171861.0, 172899.0, 173758.0, 173809.0, 173976.0, 40567.0, 40653.0, 41066.0, 41088.79455602703, 41278.79360603238, 1192.6165647848454, 1233.808759642257, 1235.246499635204, 1238.9008879289636, 1248.4382028087398, 20071.498212544804, 20233.0, 20589.58820823605, 20891.895540522808, 21237.256696015564, 29522.704772951995, 37517.06207344838, 37901.0, 37974.8101259503, 38034.42948355832, 159458.0, 161634.0, 161860.0, 162005.0, 162157.18921405319, 30187.547186791777, 30284.24289392783, 30514.0, 30561.694383055885, 30942.69057309398, 35786.64213357833, 36084.63915360813, 36337.818310908275, 36423.635763643084, 36698.26603467969, 27548.724512754616, 27806.721932781224, 28063.0, 28246.43507129805, 29104.854475727487, 26897.86551067232, 27501.31246718848, 27538.17385478439, 27608.723912760615, 28591.42817143604, 31279.21801954878, 31320.37359252848, 31421.214469638442, 31451.0, 31544.36911261716, 26696.866515667298, 26721.7327826727, 27303.86348068247, 27308.726912730617, 28026.0, 21478.355649330544, 22060.558788824455, 22218.222362217246, 22377.32868013962, 22450.214242501435], "value": 14577.480345964905, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [409.1367215175976, 413.88825017245347, 418.5667833792024, 433.7072476078647, 441.6488891331391, 14411.927940360283, 14657.706845863104, 16670.249838757256, 17428.56428589286, 17469.825301746994, 18699.53251168718, 18930.905345473253, 19011.524711882208, 19204.615907681837, 19485.22059117637, 5473.808416705416, 5524.364698059724, 5568.58001209691, 5570.303712035996, 5712.6286791358425, 5493.066178749622, 5549.472800084006, 5596.58025648076, 5608.327000759915, 5611.158326251054, 5330.040592693314, 5503.559715222773, 5511.366192887829, 5520.723963801814, 5545.556355491572, 5188.6509507527935, 5506.724663766816, 5519.806806761784, 5548.250986116883, 5549.1676248562835, 4874.585660218886, 4900.583450406684, 4912.452577438131, 4916.53292937174, 4918.286848406961, 21926.671099933516, 22087.0, 22506.212282570195, 22610.66084008741, 22795.544089118124, 1624.374615772924, 1662.1356894414957, 1668.099226417745, 1674.4055860169708, 1674.5143908266589, 14621.853781462156, 14866.479673211494, 15201.467948621856, 15256.160911149882, 15359.308831102628, 2043.5402034542258, 2102.7686954435, 2125.3092744857827, 2128.244473212003, 2141.8714877107423, 89607.55196224042, 91801.65586753044, 91803.0, 92909.53545232298, 93871.0, 10924.672259832218, 11043.116550675926, 11054.281471704313, 11098.112151027899, 11381.0, 15261.694766104838, 15508.689826203412, 15608.765868511982, 15657.217139143226, 15672.138032408098, 6632.43624291931, 6874.106366172366, 6943.375096241362, 7008.614526201108, 7042.92957070433, 5950.0, 5976.0, 6144.139820425144, 6154.78458253959, 6173.135760993465, 6962.895556566555, 7035.964820175969, 7074.787756367317, 7183.480094753638, 7244.673989670478, 2064.5870825834895, 2076.709260703503, 2093.2008404745643, 2116.5978464091772, 2259.435141214696, 840.9075001749802, 860.4880096342666, 862.2498426368974, 871.3856731004627, 896.8878890138733, 16990.0, 17151.571210719583, 17263.827361726475, 17338.91330543339, 18041.0, 852.0840096895862, 857.9742607721778, 858.356232825381, 869.8390797702446, 884.2925659472396, 9162.0, 9362.812743745088, 9715.27135464843, 9750.171235444925, 9795.902040979641, 341142.0, 341284.0, 341652.0, 346275.0, 349850.0, 71335.0, 72453.637731811, 74549.0, 74611.0, 75543.0, 1010.525053224983, 1031.3657100883054, 1050.779336339362, 1056.4084112896649, 1063.2610335816687, 14743.705125897637, 14768.852311476749, 14909.179995100374, 15014.174220417983, 15709.0, 38489.42265865958, 38867.0, 38873.611263886996, 38884.02789930161, 39242.87949765348, 47083.29375059308, 47111.293330600754, 47161.29258061063, 47719.76140119277, 48252.0, 8220.876686849822, 8232.382571307297, 8445.366597505088, 8504.44721093127, 8634.78413039679, 12507.187032842836, 13108.344582770633, 13230.470781168646, 13342.466301347837, 13345.0, 11143.0, 11161.107111430903, 11236.325820450798, 11310.0, 11571.421428928688, 10462.843057353994, 10703.357798532114, 10727.839082413926, 10807.297525660806, 10867.673969780919, 11529.020033296929, 11544.365059921785, 11658.0, 11855.229410088317, 12043.397830108635, 8190.83618327642, 8241.464304820167, 8390.202930721573, 8506.702265420681, 8544.0, 10727.785444291227, 10787.244892857425, 10841.512131953923, 10883.67348979532, 11181.944090279496], "value": 8777.979434519617, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1267.8415198100238, 1305.229914350533, 1327.1638867513466, 1332.533613235367, 1336.5322137251958, 10060.144887684546, 10068.395896246231, 10453.895461045387, 10518.842217366737, 10544.367337959728, 10500.0, 10629.096526795232, 10685.30545514541, 10697.732556686087, 10699.78600427991, 2271.205078222621, 2297.7357603875603, 2305.930822075332, 2311.3066080175963, 2316.444053427182, 2216.2575537195057, 2262.264763951714, 2265.0486795545826, 2274.0676322707695, 2279.6922415473946, 2225.643896976484, 2240.0815665577115, 2263.807576356012, 2269.1604106480545, 2283.4177284792354, 2155.321073861744, 2175.0755928730305, 2242.7981481666566, 2245.5396643688086, 2246.4833088389682, 2025.4936265933516, 2151.655735082379, 2165.058199683143, 2210.9668354974688, 2214.6345852934246, 10121.291509594332, 10349.430781307025, 10354.068133867913, 10358.378497290187, 10367.89632103677, 5589.74846131925, 5764.221830052931, 5772.018756811311, 5777.7977770777825, 5791.841631673682, 3091.474449343617, 3322.8670853165845, 3435.4675025371107, 3437.604675462329, 3461.0655123116617, 957.3920560444099, 987.3532835992437, 987.9259055570789, 989.6091044037637, 1011.6105299459688, 15174.0, 15346.0, 15362.0, 15363.846361536353, 15365.001274917206, 4586.243269860435, 4749.64377671676, 4913.950860491421, 4991.326170966946, 5007.39911210657, 10785.13718902486, 10794.73013174677, 10800.675979720621, 10804.13566914645, 10807.891921080689, 5502.0371434998715, 5514.91727624086, 5545.61180717354, 5554.472325129106, 5557.249771280906, 4914.0908931847725, 5146.330976972969, 5148.819791307361, 5162.277281180638, 5174.7153906535505, 3831.885043448701, 3927.273454410943, 3942.7634341939574, 3958.9208215835524, 3964.306246406867, 1105.4086063955745, 1112.7273817914502, 1115.453427820362, 1131.338167172197, 1138.9316641001567, 677.6103740349319, 698.9405900498515, 704.3484776581641, 708.4544900426642, 722.819295176206, 5502.284702988586, 5730.71346432685, 5770.740316685759, 5827.8052999135925, 5958.493528050078, 486.7420267258359, 520.9166533354721, 523.4582207415307, 528.4477720781792, 534.0280689145795, 3245.237369218232, 3666.7249956253386, 3703.9629603704157, 3716.3310604090984, 3742.8877133686033, 12061.276323420623, 12873.420696068699, 12879.162854414433, 12881.0, 12885.226886386847, 12454.128211025323, 12706.618801435972, 12711.0, 12725.809112863315, 12819.0, 7230.493865429369, 7289.562626242442, 7344.926550734424, 7346.742863999842, 7389.593572353572, 5626.831195064155, 6285.182926219745, 6294.402031806971, 6326.0, 6583.144191255106, 11679.240849344766, 11813.704657383634, 11850.703732406759, 11931.940340298243, 12050.819237711266, 12255.0, 12275.2021118627, 12277.263364198177, 12429.875701242872, 12489.250644961332, 7998.600069996361, 8054.5569993650915, 8087.393445491494, 8273.214044665747, 8361.289290410139, 9914.900850991686, 9927.652532161339, 9986.950065249628, 10025.298229123891, 10041.447720375449, 7751.806204844924, 7895.881561776463, 7956.801079973047, 8013.6794528218215, 8104.068032176139, 7932.524048557105, 8136.430449868452, 8172.18278172178, 8190.549519776231, 8338.207870252316, 7330.853382932418, 7502.099748030053, 7517.436192285491, 7529.284717951786, 7530.246975302426, 5219.739013049409, 5275.419703832652, 5345.064613692666, 5414.079606466831, 5538.196961440488, 5319.946800531945, 5359.383670877899, 5422.240886275846, 5462.9180562292395, 5569.443055694398], "value": 4692.602486913652, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [359.3567514149672, 374.8406927056001, 382.2488809489354, 385.3891581842779, 391.27809192040684, 5629.268195134627, 5646.0, 5657.830265092043, 5709.229254050697, 5740.5120564752, 5569.301363084268, 5573.247611572437, 5581.972090139554, 5586.13414920687, 5592.0773072443, 4287.292596721552, 4321.805518751648, 4348.30427131659, 4367.301231802912, 4374.49693285273, 4355.934660980088, 4367.192069467159, 4372.3878656988045, 4373.540778218289, 4383.890402739925, 4346.500152482474, 4354.390385346054, 4357.172137293904, 4376.912461750763, 4380.605745482906, 4228.534861165269, 4314.784260786948, 4372.234858899696, 4372.6064654180955, 4378.693491455615, 3881.1849511602595, 3895.474110995008, 3898.3567711327596, 3903.8633647822476, 3906.374980003214, 5492.423295553949, 5499.7250137492965, 5501.394846566875, 5520.66875987442, 5523.337199536041, 4688.531146885284, 4824.469308376111, 4886.096072226649, 5181.792728290864, 5198.480151984809, 5809.419058094199, 5816.651000939914, 5837.124431335291, 5845.707714614252, 5876.735546900357, 4032.959670403288, 4049.6355328020327, 4049.9392509112386, 4050.9189816203807, 4053.2906741320444, 6113.23584551931, 6216.036514340284, 6241.34465881085, 6255.249370075575, 6275.2783429905685, 4133.726450452239, 4147.6267135957905, 4154.480689913761, 4157.625813676784, 4162.625363717219, 4196.51740049892, 4202.789860506962, 4207.726497777635, 4210.873673789792, 4219.599138081878, 4762.904741905142, 4828.806847726051, 4873.707577545359, 4877.756112194447, 4881.267809828483, 5861.765529378862, 5871.9706401468575, 5883.61756485827, 5884.47039766423, 5898.764049437975, 1430.5279257844886, 1434.956951291463, 1436.8563143685758, 1437.6190309567974, 1438.841727409984, 914.7484441778564, 950.3442624589012, 954.8663187153804, 956.8277710012264, 967.6274634265718, 4926.8768280793265, 4945.876353091202, 4953.885375790491, 5000.399952005782, 5007.924881126786, 5922.73347699346, 5951.0, 5998.580099393001, 6042.0, 6101.115338276014, 4756.7145971241835, 4930.482299358588, 4956.231784073474, 4984.6261530384645, 5006.6495345325475, 3182.7110020441296, 3208.181913612014, 3208.1982850321974, 3209.277912469676, 3237.417264892342, 5493.368262649767, 5616.354119276336, 5653.378128405872, 5679.772809087673, 5680.4319568042865, 6103.389661033861, 6268.843278918063, 6277.108192920418, 6279.466245369194, 6306.905396419057, 5625.493705566519, 5659.434056594308, 5659.43405659439, 5697.829065128053, 5702.087665973508, 6036.486898613667, 6123.295820980644, 6142.293636231711, 6149.446549810538, 6164.489700023523, 5971.7611295547695, 5990.131430942576, 6004.789832355847, 6016.578839481369, 6021.518278537794, 5671.829845104653, 5672.0, 5672.347680016851, 5687.0, 5692.800751973661, 4063.4717486726536, 4083.5099788025627, 4113.4858142732155, 4147.502299724052, 4162.875113746592, 6091.604045737013, 6097.847553811191, 6113.23584551931, 6113.877722445615, 6124.601900876429, 5872.735726892385, 5878.353381127987, 5921.348651648229, 5932.49573786233, 5935.910961335497, 5756.971215143897, 5846.824595262149, 5885.352611212848, 5892.351841297368, 5892.6759028253855, 5808.970955145197, 5814.069748840166, 5815.371695925148, 5828.358880523054, 5848.239728835224, 5822.94177058224, 5932.288125424977, 5969.701514924323, 5983.0, 5991.580589358703, 5772.19189313488, 5786.594938354275, 5789.478946894631, 5798.362180160263, 5804.1874137619925], "value": 4408.063326382785, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [623.5416968528134, 629.8519847835761, 708.4084789201017, 742.3170682971665, 747.4879707400432, 13713.177209367444, 14167.858321416796, 14292.499762508302, 14631.12213267202, 15773.763393549107, 15588.376464941417, 15640.765388519181, 15889.2849821758, 15896.761548576751, 16344.427945021927, 914.5427286356821, 914.7255823253031, 922.9723108306762, 925.2967744514184, 926.6756635177701, 874.3791907745476, 878.5212059427595, 916.2212119698237, 921.0927236671873, 923.2014307623924, 941.0542404883083, 953.3755390219383, 953.6757502449166, 956.7990721948399, 963.1909196275127, 938.7746940734208, 957.0907637744136, 957.2007373842849, 958.3818437108026, 959.2517836087862, 693.466031156012, 698.807827847341, 701.9996504980382, 702.6170736948325, 702.7048639571341, 13065.150765200231, 13301.933490332583, 14535.200563968978, 14686.412543498247, 14861.256937153206, 15406.22968851553, 15648.608784780357, 15784.368625254976, 15906.125163116025, 15908.204589770465, 10578.418186999712, 10813.67558973232, 10951.616693415772, 10957.83563246552, 10966.06788422985, 2796.5385711357603, 2800.355918138819, 2821.1677555121287, 2828.6464191976, 2843.616111824898, 70446.29553704448, 72047.63976180137, 72131.27868721298, 72741.27258727398, 73271.63364183198, 11593.420328983517, 11670.533178672928, 11865.5847045353, 11937.104717146076, 11977.700557486132, 19793.505162371057, 20047.599048018958, 21095.367138985854, 21288.467788305108, 21329.146834126463, 5940.198073260141, 6023.608465449732, 6131.110988906673, 6135.110408990671, 6213.378662133841, 3000.7599392048583, 3028.7425568826457, 3034.4082903833983, 3045.8781648734243, 3048.9542656860167, 3351.0952042948265, 3395.694387505087, 3397.43942249531, 3408.0968543336035, 3410.4543273076188, 683.5454422808776, 696.6098984568657, 699.5697645947807, 701.4528667639249, 704.651197657163, 576.8183022347947, 588.3322429043067, 600.3786081405812, 601.3655593348972, 620.0915658560141, 9224.354295199406, 9885.752856178653, 10320.587176512856, 10352.637657681946, 10445.425501597334, 599.5263741644139, 606.8664893723374, 608.4767100293744, 618.3692633513791, 619.4672581579838, 4178.558288004294, 4244.72409293395, 4287.406119297842, 4375.1031038637, 4397.890052748707, 57579.0, 57704.13443798346, 58941.70529147413, 59358.40641593615, 59615.40384596185, 51539.74230128901, 51895.74052129715, 52696.73651631794, 52866.0, 53603.19595206075, 45224.773876130406, 45563.31655025177, 45871.541284587394, 46103.53896460992, 46134.0, 9644.614215431584, 9760.121589057018, 10020.899791002288, 10096.0, 10309.175265978554, 24352.634710479004, 24551.263462096165, 25037.248882533553, 25060.0, 25207.24378268655, 39967.0, 40451.0, 40941.59058409497, 41479.7926010368, 41728.3740743883, 12534.749305013665, 12661.303628300164, 12742.554010609954, 12780.169288996185, 13215.273159976294, 13713.108647937852, 14305.785413219019, 14591.343389547283, 14738.336774844944, 15170.544883653509, 13021.869781302066, 13144.737105257651, 13166.854717253133, 13261.66845828862, 13283.335833208494, 12027.699307517381, 12099.092568057255, 12150.0, 12236.694082648006, 12357.75284494323, 12980.415881285553, 13637.318134093453, 13734.313284335944, 13771.862281377458, 13787.586372408843, 9708.5145742714, 9931.106200441995, 10128.24038197153, 10292.022257885788, 10304.793904122025, 10141.49292535385, 10373.740656483647, 10558.736031599272, 10768.623098191525, 10946.288491248044], "value": 6654.474591376902, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1551.2000000000003, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 113.0, 113.0, 114.0, 112.0, 113.0, 113.0, 113.0, 113.0, 115.0], "value": 112.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 124.0, 123.0, 162.0, 125.0, 123.0, 123.0, 125.0, 153.0, 129.0], "value": 133.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 165.0, 174.0, 164.0, 164.0, 165.0, 164.0, 172.0, 164.0, 163.0], "value": 166.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 76.0, 116.0, 76.0, 75.0, 78.0, 74.0, 99.0, 77.0], "value": 82.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 107.0, 86.0, 85.0, 84.0, 96.0, 84.0, 84.0, 102.0], "value": 89.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 115.0, 114.0, 114.0, 114.0, 114.0, 114.0, 113.0, 115.0, 117.0], "value": 114.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 151.0, 150.0, 151.0, 151.0, 152.0, 151.0, 151.0, 152.0, 153.0], "value": 151.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 96.0, 95.0, 94.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 53.0, 54.0, 54.0, 54.0, 54.0, 57.0, 54.0, 54.0, 55.0], "value": 54.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 56.0, 57.0, 57.0, 57.0, 57.0, 57.0, 57.0, 57.0, 57.0], "value": 56.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 82.0, 83.0, 82.0, 87.0, 83.0, 82.0, 88.0, 83.0], "value": 83.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 132.0, 132.0, 132.0, 134.0, 137.0, 132.0, 134.0, 181.0, 139.0], "value": 139.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [188.0, 196.0, 195.0, 196.0, 202.0, 197.0, 198.0, 199.0, 198.0, 193.0], "value": 196.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 74.0, 78.0, 76.0, 74.0, 75.0, 80.0, 78.0, 74.0], "value": 76.2, "unit": "score"}]}]} 09:36:38 INFO - Return code: 0 09:36:38 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:36:38 INFO - # TBPL SUCCESS # 09:36:38 INFO - Running post-action listener: _resource_record_post_action 09:36:38 INFO - [mozharness: 2017-05-19 16:36:38.496191Z] Finished run-tests step (success) 09:36:38 INFO - Running post-run listener: _resource_record_post_run 09:36:38 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 16384; Write bytes: 417456128; Read time: 324; Write time: 234996 09:36:38 INFO - TinderboxPrint: CPU usage
13.3% 09:36:38 INFO - TinderboxPrint: I/O read bytes / time
16,384 / 324 09:36:38 INFO - TinderboxPrint: I/O write bytes / time
417,456,128 / 234,996 09:36:38 INFO - TinderboxPrint: CPU idle
8,284.5 (86.7%) 09:36:38 INFO - TinderboxPrint: CPU user
1,214.5 (12.7%) 09:36:38 INFO - TinderboxPrint: Swap in / out
0 / 0 09:36:38 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 4096; Write bytes: 101621760; Read time: 64; Write time: 88728 09:36:38 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 8192; Write bytes: 315834368; Read time: 248; Write time: 146268 09:36:39 INFO - Running post-run listener: _upload_blobber_files 09:36:39 INFO - Blob upload gear active. 09:36:39 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:36:39 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 09:36:39 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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:36:39 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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:36:39 INFO - (blobuploader) - INFO - Open directory for files ... 09:36:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:36:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:36:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:36:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:36:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:36:40 INFO - (blobuploader) - INFO - Done attempting. 09:36:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:36:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:36:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:36:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:36:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:36:41 INFO - (blobuploader) - INFO - Done attempting. 09:36:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:36:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:36:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:36:44 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:36:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:36:44 INFO - (blobuploader) - INFO - Done attempting. 09:36:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 09:36:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:36:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:36:45 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 09:36:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:36:45 INFO - (blobuploader) - INFO - Done attempting. 09:36:45 INFO - (blobuploader) - INFO - Iteration through files over. 09:36:45 INFO - Return code: 0 09:36:45 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:36:45 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:36:45 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/46d9ddba91262f4a32500901096de878c8a66c7dadb86f80146623c881fa023e51566cf6e62ec5b1e23489d816a11315b006e43307d7308a645e92161c34f143", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/67c1faf67d5ca4b0aeb7476bf9aa8c6e727c181ce3abf40ef85501d1792ac4b3fd89966c97edb55b3b1ba141edd5bd3b74d39e2c6b8c64f99fc038640f26570e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c7d6cc980111c41b2c1292808db71c8d4f1be0e69ff1200dbbf342b853036357394261cfb208be136ca3d4ff7917587666e3514c210bbf00dff9ddbe0a053872", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1b7c772177fff45210141d8484fd2a1d429207f1bb23fc1fe1da3f0c2327e3bddb3eb01b2c4689b17e9558fa0658a94298f9442b895134516439d46b28cfae15"} 09:36:45 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:36:45 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:36:45 INFO - Contents: 09:36:45 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/46d9ddba91262f4a32500901096de878c8a66c7dadb86f80146623c881fa023e51566cf6e62ec5b1e23489d816a11315b006e43307d7308a645e92161c34f143", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/67c1faf67d5ca4b0aeb7476bf9aa8c6e727c181ce3abf40ef85501d1792ac4b3fd89966c97edb55b3b1ba141edd5bd3b74d39e2c6b8c64f99fc038640f26570e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c7d6cc980111c41b2c1292808db71c8d4f1be0e69ff1200dbbf342b853036357394261cfb208be136ca3d4ff7917587666e3514c210bbf00dff9ddbe0a053872", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1b7c772177fff45210141d8484fd2a1d429207f1bb23fc1fe1da3f0c2327e3bddb3eb01b2c4689b17e9558fa0658a94298f9442b895134516439d46b28cfae15"} 09:36:45 INFO - Running post-run listener: copy_logs_to_upload_dir 09:36:45 INFO - Copying logs to upload dir... 09:36:45 INFO - mkdir: /builds/slave/test/build/upload/logs 09:36:45 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1254.254512 ========= master_lag: -0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2017-05-19 09:36:44.866918) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-19 09:36:44.871550) ========= 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=41bf3e9aed84707956354da8000001c5-1495210548.714939-469727514 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/46d9ddba91262f4a32500901096de878c8a66c7dadb86f80146623c881fa023e51566cf6e62ec5b1e23489d816a11315b006e43307d7308a645e92161c34f143", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/67c1faf67d5ca4b0aeb7476bf9aa8c6e727c181ce3abf40ef85501d1792ac4b3fd89966c97edb55b3b1ba141edd5bd3b74d39e2c6b8c64f99fc038640f26570e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c7d6cc980111c41b2c1292808db71c8d4f1be0e69ff1200dbbf342b853036357394261cfb208be136ca3d4ff7917587666e3514c210bbf00dff9ddbe0a053872", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1b7c772177fff45210141d8484fd2a1d429207f1bb23fc1fe1da3f0c2327e3bddb3eb01b2c4689b17e9558fa0658a94298f9442b895134516439d46b28cfae15"} build_url:https://queue.taskcluster.net/v1/task/Nb4DyC1NQSWAXleixBvs-w/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011345 build_url: 'https://queue.taskcluster.net/v1/task/Nb4DyC1NQSWAXleixBvs-w/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/46d9ddba91262f4a32500901096de878c8a66c7dadb86f80146623c881fa023e51566cf6e62ec5b1e23489d816a11315b006e43307d7308a645e92161c34f143", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/67c1faf67d5ca4b0aeb7476bf9aa8c6e727c181ce3abf40ef85501d1792ac4b3fd89966c97edb55b3b1ba141edd5bd3b74d39e2c6b8c64f99fc038640f26570e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c7d6cc980111c41b2c1292808db71c8d4f1be0e69ff1200dbbf342b853036357394261cfb208be136ca3d4ff7917587666e3514c210bbf00dff9ddbe0a053872", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1b7c772177fff45210141d8484fd2a1d429207f1bb23fc1fe1da3f0c2327e3bddb3eb01b2c4689b17e9558fa0658a94298f9442b895134516439d46b28cfae15"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-19 09:36:44.898608) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-19 09:36:44.898946) ========= 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=41bf3e9aed84707956354da8000001c5-1495210548.714939-469727514 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004508 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-19 09:36:44.980910) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-19 09:36:44.984244) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-19 09:36:44.984529) ========= ========= Total master_lag: 0.14 =========