builder: mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s slave: talos-linux64-ix-026 starttime: 1495554228.88 results: success (0) revision: 6dfa56094f0cc291945dd3c24d0a4c2682d80ec7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-23 08:43:48.877023) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-23 08:43:48.877469) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-23 08:43:48.877776) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-23 08:43:48.941065) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-23 08:43:48.941364) ========= 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-1495553394.737407-1522700916 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-23 08:43: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.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 45.6M=0s 2017-05-23 08:43:49 (45.6 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.146672 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-23 08:43:49.101532) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-23 08:43:49.104936) ========= 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-1495553394.737407-1522700916 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019590 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-23 08:43:49.157946) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-23 08:43:49.158304) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 6dfa56094f0cc291945dd3c24d0a4c2682d80ec7 --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 6dfa56094f0cc291945dd3c24d0a4c2682d80ec7 --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-1495553394.737407-1522700916 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-23 08:43:50,099 truncating revision to first 12 chars 2017-05-23 08:43:50,099 Setting DEBUG logging. 2017-05-23 08:43:50,099 attempt 1/10 2017-05-23 08:43:50,099 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/6dfa56094f0c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-23 08:43:50,534 unpacking tar archive at: mozilla-central-6dfa56094f0c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.829153 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-23 08:43:50.007403) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-23 08:43:50.007766) ========= script_repo_revision: 6dfa56094f0cc291945dd3c24d0a4c2682d80ec7 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-23 08:43:50.008204) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-23 08:43:50.008516) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-23 08:43:50.026667) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 54 secs) (at 2017-05-23 08:43:50.026986) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=41bf3e9aed84707956354da8000001c5-1495553394.737407-1522700916 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:43:51 INFO - MultiFileLogger online at 20170523 08:43:51 in /builds/slave/test 08:43:51 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 08:43:51 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:43:51 INFO - {'append_to_log': False, 08:43:51 INFO - 'base_work_dir': '/builds/slave/test', 08:43:51 INFO - 'blob_upload_branch': 'Firefox', 08:43:51 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:43:51 INFO - 'branch': 'Firefox', 08:43:51 INFO - 'buildbot_json_path': 'buildprops.json', 08:43:51 INFO - 'config_files': ('talos/linux_config.py',), 08:43:51 INFO - 'default_actions': ('clobber', 08:43:51 INFO - 'read-buildbot-config', 08:43:51 INFO - 'download-and-extract', 08:43:51 INFO - 'populate-webroot', 08:43:51 INFO - 'create-virtualenv', 08:43:51 INFO - 'install', 08:43:51 INFO - 'run-tests'), 08:43:51 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:43:51 INFO - 'download_minidump_stackwalk': True, 08:43:51 INFO - 'download_symbols': 'ondemand', 08:43:51 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:43:51 INFO - 'tooltool.py': '/tools/tooltool.py', 08:43:51 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:43:51 INFO - '/tools/misc-python/virtualenv.py')}, 08:43:51 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:43:51 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:43:51 INFO - 'gecko_profile': False, 08:43:51 INFO - 'gecko_profile_interval': 0, 08:43:51 INFO - 'installer_path': 'installer.exe', 08:43:51 INFO - 'log_level': 'info', 08:43:51 INFO - 'log_name': 'talos', 08:43:51 INFO - 'log_to_console': True, 08:43:51 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:43:51 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:43:51 INFO - 'opt_config_files': (), 08:43:51 INFO - 'pip_index': False, 08:43:51 INFO - 'suite': 'dromaeojs-e10s', 08:43:51 INFO - 'system_bits': '32', 08:43:51 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:43:51 INFO - 'title': 'talos-linux64-ix-026', 08:43:51 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:43:51 INFO - 'use_talos_json': True, 08:43:51 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:43:51 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:43:51 INFO - 'work_dir': 'build'} 08:43:51 INFO - [mozharness: 2017-05-23 15:43:51.065096Z] Running clobber step. 08:43:51 INFO - Running pre-action listener: _resource_record_pre_action 08:43:51 INFO - Running main action method: clobber 08:43:51 INFO - rmtree: /builds/slave/test/build 08:43:51 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:43:52 INFO - Running post-action listener: _resource_record_post_action 08:43:52 INFO - [mozharness: 2017-05-23 15:43:52.085175Z] Finished clobber step (success) 08:43:52 INFO - [mozharness: 2017-05-23 15:43:52.085275Z] Running read-buildbot-config step. 08:43:52 INFO - Running pre-action listener: _resource_record_pre_action 08:43:52 INFO - Running main action method: read_buildbot_config 08:43:52 INFO - Using buildbot properties: 08:43:52 INFO - { 08:43:52 INFO - "project": "", 08:43:52 INFO - "product": "firefox", 08:43:52 INFO - "who": "ffxbld@noreply.mozilla.org", 08:43:52 INFO - "installer_path": "public/build/target.tar.bz2", 08:43:52 INFO - "builddir": "mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s", 08:43:52 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 08:43:52 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo mozilla-central talos dromaeojs-e10s", 08:43:52 INFO - "stage_platform": "linux64-stylo", 08:43:52 INFO - "basedir": "/builds/slave/test", 08:43:52 INFO - "buildnumber": 112, 08:43:52 INFO - "platform": "ubuntu64_hw_stylo", 08:43:52 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 08:43:52 INFO - "slavebuilddir": "test", 08:43:52 INFO - "taskId": "e9oJ_WNXTXC26MIqD7pxPQ", 08:43:52 INFO - "branch": "mozilla-central", 08:43:52 INFO - "script_repo_revision": "production", 08:43:52 INFO - "revision": "6dfa56094f0cc291945dd3c24d0a4c2682d80ec7", 08:43:52 INFO - "slavename": "talos-linux64-ix-026", 08:43:52 INFO - "repo_path": "mozilla-central" 08:43:52 INFO - } 08:43:52 INFO - Finding installer, test and symbols from parent task. 08:43:52 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/e9oJ_WNXTXC26MIqD7pxPQ'}, attempt #1 08:43:52 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/e9oJ_WNXTXC26MIqD7pxPQ'}, attempt #1 08:43:53 INFO - Task dependencies: XE0t9r5GTv2aF_bkVa-y1g 08:43:53 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XE0t9r5GTv2aF_bkVa-y1g'}, attempt #1 08:43:53 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/XE0t9r5GTv2aF_bkVa-y1g/artifacts/public/build/target.tar.bz2 08:43:53 INFO - Set test_url: https://queue.taskcluster.net/v1/task/XE0t9r5GTv2aF_bkVa-y1g/artifacts/public/build/test_packages.json 08:43:53 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/XE0t9r5GTv2aF_bkVa-y1g/artifacts/public/build/target.crashreporter-symbols.zip 08:43:53 INFO - Running post-action listener: _resource_record_post_action 08:43:53 INFO - [mozharness: 2017-05-23 15:43:53.473767Z] Finished read-buildbot-config step (success) 08:43:53 INFO - [mozharness: 2017-05-23 15:43:53.473985Z] Running download-and-extract step. 08:43:53 INFO - Running pre-action listener: _resource_record_pre_action 08:43:53 INFO - Running main action method: download_and_extract 08:43:53 INFO - mkdir: /builds/slave/test/build/tests 08:43: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')]} 08:43:53 INFO - trying https://queue.taskcluster.net/v1/task/XE0t9r5GTv2aF_bkVa-y1g/artifacts/public/build/target.test_packages.json 08:43:53 INFO - Downloading https://queue.taskcluster.net/v1/task/XE0t9r5GTv2aF_bkVa-y1g/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 08:43:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XE0t9r5GTv2aF_bkVa-y1g/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 08:43:54 INFO - Downloaded 989 bytes. 08:43:54 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 08:43:54 INFO - Using the following test package requirements: 08:43:54 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 08:43:54 INFO - u'common': [u'target.common.tests.zip'], 08:43:54 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 08:43:54 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 08:43:54 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 08:43:54 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 08:43:54 INFO - u'mozbase': [u'target.common.tests.zip'], 08:43:54 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 08:43:54 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 08:43:54 INFO - u'web-platform': [u'target.common.tests.zip', 08:43:54 INFO - u'target.web-platform.tests.tar.gz'], 08:43:54 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 08:43:54 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 08:43:54 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XE0t9r5GTv2aF_bkVa-y1g/artifacts/public/build/target.common.tests.zip 08:43:54 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XE0t9r5GTv2aF_bkVa-y1g/artifacts/public/build/target.common.tests.zip'}, attempt #1 08:43:54 INFO - Fetch https://queue.taskcluster.net/v1/task/XE0t9r5GTv2aF_bkVa-y1g/artifacts/public/build/target.common.tests.zip into memory 08:44:31 INFO - Content-Length response header: 63522574 08:44:31 INFO - Bytes received: 63522574 08:44:42 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 08:44:42 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XE0t9r5GTv2aF_bkVa-y1g/artifacts/public/build/target.common.tests.zip 08:44:42 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XE0t9r5GTv2aF_bkVa-y1g/artifacts/public/build/target.common.tests.zip'}, attempt #1 08:44:42 INFO - Fetch https://queue.taskcluster.net/v1/task/XE0t9r5GTv2aF_bkVa-y1g/artifacts/public/build/target.common.tests.zip into memory 08:44:44 INFO - Content-Length response header: 63522574 08:44:44 INFO - Bytes received: 63522574 08:44:56 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XE0t9r5GTv2aF_bkVa-y1g/artifacts/public/build/target.talos.tests.zip 08:44:56 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XE0t9r5GTv2aF_bkVa-y1g/artifacts/public/build/target.talos.tests.zip'}, attempt #1 08:44:56 INFO - Fetch https://queue.taskcluster.net/v1/task/XE0t9r5GTv2aF_bkVa-y1g/artifacts/public/build/target.talos.tests.zip into memory 08:45:11 INFO - Content-Length response header: 14410000 08:45:11 INFO - Bytes received: 14410000 08:45:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:45:11 INFO - trying https://queue.taskcluster.net/v1/task/XE0t9r5GTv2aF_bkVa-y1g/artifacts/public/build/target.tar.bz2 08:45:11 INFO - Downloading https://queue.taskcluster.net/v1/task/XE0t9r5GTv2aF_bkVa-y1g/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 08:45:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XE0t9r5GTv2aF_bkVa-y1g/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 08:45:23 INFO - Downloaded 56425918 bytes. 08:45:23 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/XE0t9r5GTv2aF_bkVa-y1g/artifacts/public/build/target.tar.bz2 08:45:23 INFO - mkdir: /builds/slave/test/properties 08:45:23 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:45:23 INFO - Writing to file /builds/slave/test/properties/build_url 08:45:23 INFO - Contents: 08:45:23 INFO - build_url:https://queue.taskcluster.net/v1/task/XE0t9r5GTv2aF_bkVa-y1g/artifacts/public/build/target.tar.bz2 08:45:23 INFO - Running post-action listener: _resource_record_post_action 08:45:23 INFO - Running post-action listener: set_extra_try_arguments 08:45:23 INFO - [mozharness: 2017-05-23 15:45:23.109025Z] Finished download-and-extract step (success) 08:45:23 INFO - [mozharness: 2017-05-23 15:45:23.109252Z] Running populate-webroot step. 08:45:23 INFO - Running pre-action listener: _resource_record_pre_action 08:45:23 INFO - Running main action method: populate_webroot 08:45:23 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:45:23 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:45:23 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:45:23 INFO - '--tppagecycles', 08:45:23 INFO - '7'], 08:45:23 INFO - 'tests': ['tsvgm']}}, 08:45:23 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:45:23 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:45:23 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:45:23 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:45:23 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:45:23 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:45:23 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 08:45:23 INFO - 'talos_options': ['--disable-e10s'], 08:45:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:45:23 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 08:45:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:45:23 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 08:45:23 INFO - 'talos_options': ['--disable-e10s'], 08:45:23 INFO - 'tests': ['damp', 'tps']}, 08:45:23 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 08:45:23 INFO - 'tests': ['damp', 'tps']}, 08:45:23 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:45:23 INFO - 'tests': ['dromaeo_dom']}, 08:45:23 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:45:23 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:45:23 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 08:45:23 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 08:45:23 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 08:45:23 INFO - 'tests': ['ts_paint', 'tp5o']}, 08:45:23 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:45:23 INFO - 'tests': ['a11yr', 08:45:23 INFO - 'ts_paint', 08:45:23 INFO - 'tpaint', 08:45:23 INFO - 'sessionrestore', 08:45:23 INFO - 'sessionrestore_no_auto_restore', 08:45:23 INFO - 'tabpaint']}, 08:45:23 INFO - 'other-e10s': {'tests': ['a11yr', 08:45:23 INFO - 'ts_paint', 08:45:23 INFO - 'tpaint', 08:45:23 INFO - 'sessionrestore', 08:45:23 INFO - 'sessionrestore_no_auto_restore', 08:45:23 INFO - 'tabpaint']}, 08:45:23 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:45:23 INFO - 'ts_paint', 08:45:23 INFO - 'tpaint', 08:45:23 INFO - 'sessionrestore', 08:45:23 INFO - 'sessionrestore_no_auto_restore', 08:45:23 INFO - 'tabpaint']}, 08:45:23 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:45:23 INFO - 'ts_paint', 08:45:23 INFO - 'tpaint', 08:45:23 INFO - 'sessionrestore', 08:45:23 INFO - 'sessionrestore_no_auto_restore', 08:45:23 INFO - 'tabpaint']}, 08:45:23 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:45:23 INFO - 'tests': ['a11yr', 08:45:23 INFO - 'ts_paint', 08:45:23 INFO - 'tpaint', 08:45:23 INFO - 'sessionrestore', 08:45:23 INFO - 'sessionrestore_no_auto_restore', 08:45:23 INFO - 'tabpaint']}, 08:45:23 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:45:23 INFO - 'tests': ['a11yr', 08:45:23 INFO - 'ts_paint', 08:45:23 INFO - 'tpaint', 08:45:23 INFO - 'sessionrestore', 08:45:23 INFO - 'sessionrestore_no_auto_restore', 08:45:23 INFO - 'tabpaint']}, 08:45:23 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 08:45:23 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 08:45:23 INFO - 'bloom_basic_ref']}, 08:45:23 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:45:23 INFO - 'tests': ['tsvgx', 08:45:23 INFO - 'tsvgr_opacity', 08:45:23 INFO - 'tart', 08:45:23 INFO - 'tscrollx', 08:45:23 INFO - 'cart', 08:45:23 INFO - 'tsvg_static']}, 08:45:23 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:45:23 INFO - 'tsvgr_opacity', 08:45:23 INFO - 'tart', 08:45:23 INFO - 'tscrollx', 08:45:23 INFO - 'cart', 08:45:23 INFO - 'tsvg_static']}, 08:45:23 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 08:45:23 INFO - 'talos_options': ['--disable-e10s'], 08:45:23 INFO - 'tests': ['tp5o']}, 08:45:23 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 08:45:23 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 08:45:23 INFO - 'talos_options': ['--disable-e10s', 08:45:23 INFO - '--xperf_path', 08:45:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:45:23 INFO - 'tests': ['tp5n']}, 08:45:23 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 08:45:23 INFO - 'talos_options': ['--xperf_path', 08:45:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:45:23 INFO - 'tests': ['tp5n']}}, 08:45:23 INFO - 'talos.zip': {'path': '', 08:45:23 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:45:23 INFO - Running post-action listener: _resource_record_post_action 08:45:23 INFO - [mozharness: 2017-05-23 15:45:23.125849Z] Finished populate-webroot step (success) 08:45:23 INFO - [mozharness: 2017-05-23 15:45:23.125938Z] Running create-virtualenv step. 08:45:23 INFO - Running pre-action listener: _resource_record_pre_action 08:45:23 INFO - Running main action method: create_virtualenv 08:45:23 INFO - Creating virtualenv /builds/slave/test/build/venv 08:45: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 08:45:23 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:45:23 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:45:23 INFO - Using real prefix '/usr' 08:45:23 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:45:23 INFO - Installing distribute.............................................................................................................................................................................................done. 08:45:25 INFO - Installing pip.................done. 08:45:25 INFO - Return code: 0 08:45:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:45:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:45:25 INFO - Reading from file tmpfile_stdout 08:45:25 INFO - Output received: 08:45: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) 08:45:25 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:45: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')]} 08:45:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:45: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')]} 08:45:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:45: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 0x20151f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21e2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23885c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23857a0>, '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 0x23866a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2386b30>, '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-1495553394.737407-1522700916', '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 08:45: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 08:45: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 08:45:25 INFO - Using env: {'DISPLAY': ':0', 08:45:25 INFO - 'HOME': '/home/cltbld', 08:45:25 INFO - 'LANG': 'en_US.UTF-8', 08:45:25 INFO - 'LANGUAGE': 'en_US:en', 08:45:25 INFO - 'LOGNAME': 'cltbld', 08:45:25 INFO - 'MAIL': '/var/mail/cltbld', 08:45:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:45:25 INFO - 'MOZ_NO_REMOTE': '1', 08:45:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:45:25 INFO - 'NO_EM_RESTART': '1', 08:45:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:45:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:45:25 INFO - 'PWD': '/builds/slave/test', 08:45:25 INFO - 'SHELL': '/bin/bash', 08:45:25 INFO - 'SHLVL': '1', 08:45:25 INFO - 'TERM': 'linux', 08:45:25 INFO - 'TMOUT': '86400', 08:45:25 INFO - 'USER': 'cltbld', 08:45:25 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1495553394.737407-1522700916', 08:45:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:45:25 INFO - '_': '/tools/buildbot/bin/python'} 08:45:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:45: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 08:45:26 INFO - Cleaning up... 08:45:26 INFO - Return code: 0 08:45:26 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:45: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')]} 08:45:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:45: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')]} 08:45:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:45: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 0x20151f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21e2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23885c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23857a0>, '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 0x23866a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2386b30>, '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-1495553394.737407-1522700916', '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 08:45: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 08:45: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 08:45:26 INFO - Using env: {'DISPLAY': ':0', 08:45:26 INFO - 'HOME': '/home/cltbld', 08:45:26 INFO - 'LANG': 'en_US.UTF-8', 08:45:26 INFO - 'LANGUAGE': 'en_US:en', 08:45:26 INFO - 'LOGNAME': 'cltbld', 08:45:26 INFO - 'MAIL': '/var/mail/cltbld', 08:45:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:45:26 INFO - 'MOZ_NO_REMOTE': '1', 08:45:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:45:26 INFO - 'NO_EM_RESTART': '1', 08:45:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:45:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:45:26 INFO - 'PWD': '/builds/slave/test', 08:45:26 INFO - 'SHELL': '/bin/bash', 08:45:26 INFO - 'SHLVL': '1', 08:45:26 INFO - 'TERM': 'linux', 08:45:26 INFO - 'TMOUT': '86400', 08:45:26 INFO - 'USER': 'cltbld', 08:45:26 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1495553394.737407-1522700916', 08:45:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:45:26 INFO - '_': '/tools/buildbot/bin/python'} 08:45:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:45:26 INFO - Downloading/unpacking psutil>=3.1.1 08:45: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 08:45: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 08:45: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 08:45: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 08:45:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:45:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:45:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:45:27 INFO - Installing collected packages: psutil 08:45:27 INFO - Running setup.py install for psutil 08:45:27 INFO - building 'psutil._psutil_linux' extension 08:45: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 08:45: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 08:45:27 INFO - building 'psutil._psutil_posix' extension 08:45: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 08:45: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 08:45:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:45:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:45:28 INFO - Successfully installed psutil 08:45:28 INFO - Cleaning up... 08:45:28 INFO - Return code: 0 08:45:28 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:45: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')]} 08:45:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:45: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')]} 08:45:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:45: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 0x20151f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21e2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23885c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23857a0>, '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 0x23866a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2386b30>, '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-1495553394.737407-1522700916', '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 08:45: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 08:45: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 08:45:28 INFO - Using env: {'DISPLAY': ':0', 08:45:28 INFO - 'HOME': '/home/cltbld', 08:45:28 INFO - 'LANG': 'en_US.UTF-8', 08:45:28 INFO - 'LANGUAGE': 'en_US:en', 08:45:28 INFO - 'LOGNAME': 'cltbld', 08:45:28 INFO - 'MAIL': '/var/mail/cltbld', 08:45:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:45:28 INFO - 'MOZ_NO_REMOTE': '1', 08:45:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:45:28 INFO - 'NO_EM_RESTART': '1', 08:45:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:45:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:45:28 INFO - 'PWD': '/builds/slave/test', 08:45:28 INFO - 'SHELL': '/bin/bash', 08:45:28 INFO - 'SHLVL': '1', 08:45:28 INFO - 'TERM': 'linux', 08:45:28 INFO - 'TMOUT': '86400', 08:45:28 INFO - 'USER': 'cltbld', 08:45:28 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1495553394.737407-1522700916', 08:45:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:45:28 INFO - '_': '/tools/buildbot/bin/python'} 08:45:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:45:28 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:45: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 08:45: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 08:45: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 08:45: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 08:45:29 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:45:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:45:29 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:45:29 INFO - Installing collected packages: mozsystemmonitor 08:45:29 INFO - Running setup.py install for mozsystemmonitor 08:45:29 INFO - Successfully installed mozsystemmonitor 08:45:29 INFO - Cleaning up... 08:45:29 INFO - Return code: 0 08:45:29 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:45: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')]} 08:45:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:45: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')]} 08:45:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:45: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 0x20151f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21e2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23885c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23857a0>, '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 0x23866a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2386b30>, '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-1495553394.737407-1522700916', '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 08:45: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 08:45: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 08:45:29 INFO - Using env: {'DISPLAY': ':0', 08:45:29 INFO - 'HOME': '/home/cltbld', 08:45:29 INFO - 'LANG': 'en_US.UTF-8', 08:45:29 INFO - 'LANGUAGE': 'en_US:en', 08:45:29 INFO - 'LOGNAME': 'cltbld', 08:45:29 INFO - 'MAIL': '/var/mail/cltbld', 08:45:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:45:29 INFO - 'MOZ_NO_REMOTE': '1', 08:45:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:45:29 INFO - 'NO_EM_RESTART': '1', 08:45:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:45:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:45:29 INFO - 'PWD': '/builds/slave/test', 08:45:29 INFO - 'SHELL': '/bin/bash', 08:45:29 INFO - 'SHLVL': '1', 08:45:29 INFO - 'TERM': 'linux', 08:45:29 INFO - 'TMOUT': '86400', 08:45:29 INFO - 'USER': 'cltbld', 08:45:29 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1495553394.737407-1522700916', 08:45:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:45:29 INFO - '_': '/tools/buildbot/bin/python'} 08:45:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:45:29 INFO - Downloading/unpacking jsonschema==2.5.1 08:45: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 08:45: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 08:45: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 08:45: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 08:45:30 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:45:30 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:45: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 08:45: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 08:45: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 08:45: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 08:45:30 INFO - Downloading functools32-3.2.3-2.tar.gz 08:45:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:45:31 INFO - warning: no files found matching '*.txt' 08:45:31 INFO - no previously-included directories found matching 'build' 08:45:31 INFO - no previously-included directories found matching 'dist' 08:45:31 INFO - no previously-included directories found matching '.git*' 08:45:31 INFO - Installing collected packages: jsonschema, functools32 08:45:31 INFO - Running setup.py install for functools32 08:45:31 INFO - warning: no files found matching '*.txt' 08:45:31 INFO - no previously-included directories found matching 'build' 08:45:31 INFO - no previously-included directories found matching 'dist' 08:45:31 INFO - no previously-included directories found matching '.git*' 08:45:31 INFO - Successfully installed jsonschema functools32 08:45:31 INFO - Cleaning up... 08:45:31 INFO - Return code: 0 08:45:31 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:45: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')]} 08:45:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:45: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')]} 08:45:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:45: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 0x20151f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21e2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23885c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23857a0>, '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 0x23866a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2386b30>, '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-1495553394.737407-1522700916', '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 08:45: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 08:45: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 08:45:31 INFO - Using env: {'DISPLAY': ':0', 08:45:31 INFO - 'HOME': '/home/cltbld', 08:45:31 INFO - 'LANG': 'en_US.UTF-8', 08:45:31 INFO - 'LANGUAGE': 'en_US:en', 08:45:31 INFO - 'LOGNAME': 'cltbld', 08:45:31 INFO - 'MAIL': '/var/mail/cltbld', 08:45:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:45:31 INFO - 'MOZ_NO_REMOTE': '1', 08:45:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:45:31 INFO - 'NO_EM_RESTART': '1', 08:45:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:45:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:45:31 INFO - 'PWD': '/builds/slave/test', 08:45:31 INFO - 'SHELL': '/bin/bash', 08:45:31 INFO - 'SHLVL': '1', 08:45:31 INFO - 'TERM': 'linux', 08:45:31 INFO - 'TMOUT': '86400', 08:45:31 INFO - 'USER': 'cltbld', 08:45:31 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1495553394.737407-1522700916', 08:45:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:45:31 INFO - '_': '/tools/buildbot/bin/python'} 08:45:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:45:31 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:45:31 INFO - Cleaning up... 08:45:31 INFO - Return code: 0 08:45:31 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:45: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')]} 08:45:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:45: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')]} 08:45:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:45: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 0x20151f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21e2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23885c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23857a0>, '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 0x23866a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2386b30>, '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-1495553394.737407-1522700916', '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 08:45: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 08:45: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 08:45:31 INFO - Using env: {'DISPLAY': ':0', 08:45:31 INFO - 'HOME': '/home/cltbld', 08:45:31 INFO - 'LANG': 'en_US.UTF-8', 08:45:31 INFO - 'LANGUAGE': 'en_US:en', 08:45:31 INFO - 'LOGNAME': 'cltbld', 08:45:31 INFO - 'MAIL': '/var/mail/cltbld', 08:45:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:45:31 INFO - 'MOZ_NO_REMOTE': '1', 08:45:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:45:31 INFO - 'NO_EM_RESTART': '1', 08:45:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:45:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:45:31 INFO - 'PWD': '/builds/slave/test', 08:45:31 INFO - 'SHELL': '/bin/bash', 08:45:31 INFO - 'SHLVL': '1', 08:45:31 INFO - 'TERM': 'linux', 08:45:31 INFO - 'TMOUT': '86400', 08:45:31 INFO - 'USER': 'cltbld', 08:45:31 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1495553394.737407-1522700916', 08:45:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:45:31 INFO - '_': '/tools/buildbot/bin/python'} 08:45:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:45:31 INFO - Downloading/unpacking blobuploader==1.2.4 08:45: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 08:45: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 08:45: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 08:45: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 08:45:32 INFO - Downloading blobuploader-1.2.4.tar.gz 08:45:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:45:33 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:45: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 08:45: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 08:45: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 08:45: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 08:45:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:45:33 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:45: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 08:45: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 08:45: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 08:45: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 08:45:33 INFO - Downloading docopt-0.6.1.tar.gz 08:45:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:45:33 INFO - Installing collected packages: blobuploader, requests, docopt 08:45:33 INFO - Running setup.py install for blobuploader 08:45:33 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:45:33 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:45:33 INFO - Running setup.py install for requests 08:45:34 INFO - Running setup.py install for docopt 08:45:34 INFO - Successfully installed blobuploader requests docopt 08:45:34 INFO - Cleaning up... 08:45:34 INFO - Return code: 0 08:45:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:45:34 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')]} 08:45:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:45:34 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')]} 08:45:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:45:34 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 0x20151f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21e2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23885c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23857a0>, '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 0x23866a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2386b30>, '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-1495553394.737407-1522700916', '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 08:45:34 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 08:45:34 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 08:45:34 INFO - Using env: {'DISPLAY': ':0', 08:45:34 INFO - 'HOME': '/home/cltbld', 08:45:34 INFO - 'LANG': 'en_US.UTF-8', 08:45:34 INFO - 'LANGUAGE': 'en_US:en', 08:45:34 INFO - 'LOGNAME': 'cltbld', 08:45:34 INFO - 'MAIL': '/var/mail/cltbld', 08:45:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:45:34 INFO - 'MOZ_NO_REMOTE': '1', 08:45:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:45:34 INFO - 'NO_EM_RESTART': '1', 08:45:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:45:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:45:34 INFO - 'PWD': '/builds/slave/test', 08:45:34 INFO - 'SHELL': '/bin/bash', 08:45:34 INFO - 'SHLVL': '1', 08:45:34 INFO - 'TERM': 'linux', 08:45:34 INFO - 'TMOUT': '86400', 08:45:34 INFO - 'USER': 'cltbld', 08:45:34 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1495553394.737407-1522700916', 08:45:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:45:34 INFO - '_': '/tools/buildbot/bin/python'} 08:45:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:45:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:45:34 INFO - Running setup.py (path:/tmp/pip-InXPnx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:45:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:45:34 INFO - Running setup.py (path:/tmp/pip-NWEATO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:45:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:45:34 INFO - Running setup.py (path:/tmp/pip-StkquY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:45:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:45:34 INFO - Running setup.py (path:/tmp/pip-9ROrwW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:45:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:45:34 INFO - Running setup.py (path:/tmp/pip-62_3qa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:45:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:45:34 INFO - Running setup.py (path:/tmp/pip-q8g_Nj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:45:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:45:34 INFO - Running setup.py (path:/tmp/pip-DB61q1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:45:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:45:34 INFO - Running setup.py (path:/tmp/pip-0cBOLP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:45:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:45:34 INFO - Running setup.py (path:/tmp/pip-pk10cQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:45:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:45:34 INFO - Running setup.py (path:/tmp/pip-iQnZcQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:45:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:45:35 INFO - Running setup.py (path:/tmp/pip-uE1aIF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:45:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:45:35 INFO - Running setup.py (path:/tmp/pip-K6h_n9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:45:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:45:35 INFO - Running setup.py (path:/tmp/pip-6X_ADK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:45:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:45:35 INFO - Running setup.py (path:/tmp/pip-0AQMwA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:45:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:45:35 INFO - Running setup.py (path:/tmp/pip-or9mTb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:45:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:45:35 INFO - Running setup.py (path:/tmp/pip-NZOM9e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:45:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:45:35 INFO - Running setup.py (path:/tmp/pip-kj3Uzs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:45:35 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:45:35 INFO - Running setup.py install for manifestparser 08:45:35 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:45:35 INFO - Running setup.py install for mozcrash 08:45:35 INFO - Running setup.py install for mozdebug 08:45:35 INFO - Running setup.py install for mozdevice 08:45:35 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:45:35 INFO - Running setup.py install for mozfile 08:45:36 INFO - Running setup.py install for mozhttpd 08:45:36 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:45:36 INFO - Running setup.py install for mozinfo 08:45:36 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:45:36 INFO - Running setup.py install for mozInstall 08:45:36 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:45:36 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:45:36 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:45:36 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:45:36 INFO - Running setup.py install for mozleak 08:45:36 INFO - Running setup.py install for mozlog 08:45:36 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:45:36 INFO - Running setup.py install for moznetwork 08:45:36 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:45:36 INFO - Running setup.py install for mozprocess 08:45:36 INFO - Running setup.py install for mozprofile 08:45:36 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:45:36 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:45:36 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:45:36 INFO - Running setup.py install for mozrunner 08:45:36 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:45:36 INFO - Running setup.py install for mozscreenshot 08:45:37 INFO - Running setup.py install for moztest 08:45:37 INFO - Running setup.py install for mozversion 08:45:37 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:45:37 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:45:37 INFO - Cleaning up... 08:45:37 INFO - Return code: 0 08:45:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:45: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')]} 08:45:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:45: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')]} 08:45:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:45: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 0x20151f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21e2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23885c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23857a0>, '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 0x23866a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2386b30>, '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-1495553394.737407-1522700916', '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 08:45: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 08:45: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 08:45:37 INFO - Using env: {'DISPLAY': ':0', 08:45:37 INFO - 'HOME': '/home/cltbld', 08:45:37 INFO - 'LANG': 'en_US.UTF-8', 08:45:37 INFO - 'LANGUAGE': 'en_US:en', 08:45:37 INFO - 'LOGNAME': 'cltbld', 08:45:37 INFO - 'MAIL': '/var/mail/cltbld', 08:45:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:45:37 INFO - 'MOZ_NO_REMOTE': '1', 08:45:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:45:37 INFO - 'NO_EM_RESTART': '1', 08:45:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:45:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:45:37 INFO - 'PWD': '/builds/slave/test', 08:45:37 INFO - 'SHELL': '/bin/bash', 08:45:37 INFO - 'SHLVL': '1', 08:45:37 INFO - 'TERM': 'linux', 08:45:37 INFO - 'TMOUT': '86400', 08:45:37 INFO - 'USER': 'cltbld', 08:45:37 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1495553394.737407-1522700916', 08:45:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:45:37 INFO - '_': '/tools/buildbot/bin/python'} 08:45:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:45:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:45:37 INFO - Running setup.py (path:/tmp/pip-HhP4lW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:45: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)) 08:45:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:45:37 INFO - Running setup.py (path:/tmp/pip-uapfWk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:45: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)) 08:45:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:45:37 INFO - Running setup.py (path:/tmp/pip-_UH3E7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:45: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)) 08:45:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:45:37 INFO - Running setup.py (path:/tmp/pip-Xq564s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:45: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)) 08:45:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:45:37 INFO - Running setup.py (path:/tmp/pip-mPPyLa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:45: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)) 08:45:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:45:37 INFO - Running setup.py (path:/tmp/pip-hT8hlx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:45: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)) 08:45:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:45:37 INFO - Running setup.py (path:/tmp/pip-SoJkQM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:45:38 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)) 08:45:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:45:38 INFO - Running setup.py (path:/tmp/pip-mnupjN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:45:38 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)) 08:45:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:45:38 INFO - Running setup.py (path:/tmp/pip-3NacSF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:45: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)) 08:45:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:45:38 INFO - Running setup.py (path:/tmp/pip-AXbSjL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:45: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)) 08:45:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:45:38 INFO - Running setup.py (path:/tmp/pip-RTHZpN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:45: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)) 08:45:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:45:38 INFO - Running setup.py (path:/tmp/pip-cFvaQu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:45: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)) 08:45:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:45:38 INFO - Running setup.py (path:/tmp/pip-5v2RZA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:45: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)) 08:45:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:45:38 INFO - Running setup.py (path:/tmp/pip-5xDk8t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:45: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)) 08:45:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:45:38 INFO - Running setup.py (path:/tmp/pip-Pqu89V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:45: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)) 08:45:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:45:38 INFO - Running setup.py (path:/tmp/pip-aS9ouP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:45: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)) 08:45:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:45:38 INFO - Running setup.py (path:/tmp/pip-UXpNqc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:45: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)) 08:45: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)) 08:45: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)) 08:45: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)) 08:45: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)) 08:45: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)) 08:45:38 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:45: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 08:45: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 08:45: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 08:45: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 08:45:39 INFO - Downloading blessings-1.6.tar.gz 08:45:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:45:39 INFO - Installing collected packages: blessings 08:45:39 INFO - Running setup.py install for blessings 08:45:40 INFO - Successfully installed blessings 08:45:40 INFO - Cleaning up... 08:45:40 INFO - Return code: 0 08:45:40 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:45:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:45:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:45:40 INFO - Reading from file tmpfile_stdout 08:45:40 INFO - Current package versions: 08:45:40 INFO - argparse == 1.2.1 08:45:40 INFO - blessings == 1.6 08:45:40 INFO - blobuploader == 1.2.4 08:45:40 INFO - docopt == 0.6.1 08:45:40 INFO - functools32 == 3.2.3-2 08:45:40 INFO - jsonschema == 2.5.1 08:45:40 INFO - manifestparser == 1.1 08:45:40 INFO - mozInstall == 1.12 08:45:40 INFO - mozcrash == 1.0 08:45:40 INFO - mozdebug == 0.1 08:45:40 INFO - mozdevice == 0.50 08:45:40 INFO - mozfile == 1.2 08:45:40 INFO - mozhttpd == 0.7 08:45:40 INFO - mozinfo == 0.9 08:45:40 INFO - mozleak == 0.1 08:45:40 INFO - mozlog == 3.4 08:45:40 INFO - moznetwork == 0.27 08:45:40 INFO - mozprocess == 0.25 08:45:40 INFO - mozprofile == 0.28 08:45:40 INFO - mozrunner == 6.13 08:45:40 INFO - mozscreenshot == 0.1 08:45:40 INFO - mozsystemmonitor == 0.3 08:45:40 INFO - moztest == 0.8 08:45:40 INFO - mozversion == 1.4 08:45:40 INFO - psutil == 3.1.1 08:45:40 INFO - requests == 1.2.3 08:45:40 INFO - wsgiref == 0.1.2 08:45:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:45: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')]} 08:45:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:45: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')]} 08:45:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:45: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 0x20151f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21e2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23885c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23857a0>, '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 0x23866a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2386b30>, '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-1495553394.737407-1522700916', '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 08:45: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 08:45: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 08:45:40 INFO - Using env: {'DISPLAY': ':0', 08:45:40 INFO - 'HOME': '/home/cltbld', 08:45:40 INFO - 'LANG': 'en_US.UTF-8', 08:45:40 INFO - 'LANGUAGE': 'en_US:en', 08:45:40 INFO - 'LOGNAME': 'cltbld', 08:45:40 INFO - 'MAIL': '/var/mail/cltbld', 08:45:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:45:40 INFO - 'MOZ_NO_REMOTE': '1', 08:45:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:45:40 INFO - 'NO_EM_RESTART': '1', 08:45:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:45:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:45:40 INFO - 'PWD': '/builds/slave/test', 08:45:40 INFO - 'SHELL': '/bin/bash', 08:45:40 INFO - 'SHLVL': '1', 08:45:40 INFO - 'TERM': 'linux', 08:45:40 INFO - 'TMOUT': '86400', 08:45:40 INFO - 'USER': 'cltbld', 08:45:40 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1495553394.737407-1522700916', 08:45:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:45:40 INFO - '_': '/tools/buildbot/bin/python'} 08:45:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:45: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)) 08:45: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)) 08:45: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)) 08:45: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)) 08:45: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)) 08:45: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)) 08:45: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)) 08:45: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)) 08:45: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)) 08:45: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)) 08:45: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)) 08:45:40 INFO - Cleaning up... 08:45:40 INFO - Return code: 0 08:45:40 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:45: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')]} 08:45:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:45: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')]} 08:45:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:45: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 0x20151f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21e2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23885c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23857a0>, '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 0x23866a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2386b30>, '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-1495553394.737407-1522700916', '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 08:45: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 08:45: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 08:45:40 INFO - Using env: {'DISPLAY': ':0', 08:45:40 INFO - 'HOME': '/home/cltbld', 08:45:40 INFO - 'LANG': 'en_US.UTF-8', 08:45:40 INFO - 'LANGUAGE': 'en_US:en', 08:45:40 INFO - 'LOGNAME': 'cltbld', 08:45:40 INFO - 'MAIL': '/var/mail/cltbld', 08:45:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:45:40 INFO - 'MOZ_NO_REMOTE': '1', 08:45:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:45:40 INFO - 'NO_EM_RESTART': '1', 08:45:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:45:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:45:40 INFO - 'PWD': '/builds/slave/test', 08:45:40 INFO - 'SHELL': '/bin/bash', 08:45:40 INFO - 'SHLVL': '1', 08:45:40 INFO - 'TERM': 'linux', 08:45:40 INFO - 'TMOUT': '86400', 08:45:40 INFO - 'USER': 'cltbld', 08:45:40 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1495553394.737407-1522700916', 08:45:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:45:40 INFO - '_': '/tools/buildbot/bin/python'} 08:45:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:45:40 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:45:40 INFO - Cleaning up... 08:45:40 INFO - Return code: 0 08:45:40 INFO - Running post-action listener: _resource_record_post_action 08:45:40 INFO - Running post-action listener: _start_resource_monitoring 08:45:40 INFO - Starting resource monitoring. 08:45:40 INFO - [mozharness: 2017-05-23 15:45:40.804474Z] Finished create-virtualenv step (success) 08:45:40 INFO - [mozharness: 2017-05-23 15:45:40.804929Z] Running install step. 08:45:40 INFO - Running pre-action listener: _resource_record_pre_action 08:45:40 INFO - Running main action method: install 08:45:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:45:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:45:41 INFO - Reading from file tmpfile_stdout 08:45:41 INFO - Detecting whether we're running mozinstall >=1.0... 08:45:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:45:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:45:41 INFO - Reading from file tmpfile_stdout 08:45:41 INFO - Output received: 08:45:41 INFO - Usage: mozinstall [options] installer 08:45:41 INFO - Options: 08:45:41 INFO - -h, --help show this help message and exit 08:45:41 INFO - -d DEST, --destination=DEST 08:45:41 INFO - Directory to install application into. [default: 08:45:41 INFO - "/builds/slave/test"] 08:45:41 INFO - --app=APP Application being installed. [default: firefox] 08:45:41 INFO - mkdir: /builds/slave/test/build/application 08:45:41 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'] 08:45:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 08:45:57 INFO - Reading from file tmpfile_stdout 08:45:57 INFO - Output received: 08:45:57 INFO - /builds/slave/test/build/application/firefox/firefox 08:45:57 INFO - Running post-action listener: _resource_record_post_action 08:45:57 INFO - [mozharness: 2017-05-23 15:45:57.248137Z] Finished install step (success) 08:45:57 INFO - [mozharness: 2017-05-23 15:45:57.248415Z] Running run-tests step. 08:45:57 INFO - Running pre-action listener: _resource_record_pre_action 08:45:57 INFO - Running main action method: run_tests 08:45:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:45:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:45:57 INFO - Python 2.7.3 08:45:57 INFO - Return code: 0 08:45:57 INFO - grabbing minidump binary from tooltool 08:45: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')]} 08:45: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 0x23857a0>, '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 0x23866a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2386b30>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:45: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 08:45: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 08:45: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 08:45:57 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:45:57 INFO - Return code: 0 08:45:57 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:45:57 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:45:57 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:45:57 INFO - ENV: RUST_BACKTRACE is now 1 08:45:57 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:45:57 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:45:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XE0t9r5GTv2aF_bkVa-y1g/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 08:45:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/XE0t9r5GTv2aF_bkVa-y1g/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 08:45:57 INFO - Using env: {'DISPLAY': ':0', 08:45:57 INFO - 'HOME': '/home/cltbld', 08:45:57 INFO - 'LANG': 'en_US.UTF-8', 08:45:57 INFO - 'LANGUAGE': 'en_US:en', 08:45:57 INFO - 'LOGNAME': 'cltbld', 08:45:57 INFO - 'MAIL': '/var/mail/cltbld', 08:45:57 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:45:57 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:45:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:45:57 INFO - 'MOZ_NO_REMOTE': '1', 08:45:57 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:45:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:45:57 INFO - 'NO_EM_RESTART': '1', 08:45:57 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:45:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:45:57 INFO - 'PWD': '/builds/slave/test', 08:45:57 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:45:57 INFO - 'RUST_BACKTRACE': '1', 08:45:57 INFO - 'SHELL': '/bin/bash', 08:45:57 INFO - 'SHLVL': '1', 08:45:57 INFO - 'TERM': 'linux', 08:45:57 INFO - 'TMOUT': '86400', 08:45:57 INFO - 'USER': 'cltbld', 08:45:57 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1495553394.737407-1522700916', 08:45:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:45:57 INFO - '_': '/tools/buildbot/bin/python'} 08:45:57 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XE0t9r5GTv2aF_bkVa-y1g/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 08:45:57 INFO - mozversion application_buildid: 20170523150804 08:45:57 INFO - mozversion application_changeset: 6dfa56094f0cc291945dd3c24d0a4c2682d80ec7 08:45:57 INFO - mozversion application_display_name: Nightly 08:45:57 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:45:57 INFO - mozversion application_name: Firefox 08:45:57 INFO - mozversion application_remotingname: firefox 08:45:57 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 08:45:57 INFO - mozversion application_vendor: Mozilla 08:45:57 INFO - mozversion application_version: 55.0a1 08:45:57 INFO - mozversion platform_buildid: 20170523150804 08:45:57 INFO - mozversion platform_changeset: 6dfa56094f0cc291945dd3c24d0a4c2682d80ec7 08:45:57 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 08:45:57 INFO - mozversion platform_version: 55.0a1 08:45:57 INFO - using testdate: 1495554357 08:45:57 INFO - actual date: 1495554357 08:45:57 INFO - starting webserver on 'localhost:47851' 08:45:57 INFO - SUITE-START | Running 2 tests 08:45:57 INFO - TEST-START | dromaeo_css 08:45:57 INFO - operating with platform_type : linux_ 08:45:57 INFO - Initialising browser for dromaeo_css test... 08:45:57 INFO - TEST-INFO | started process 26219 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeQozDO/profile http://localhost:47851/getInfo.html) 08:45:58 INFO - PID 26219 | JavaScript warning: resource://gre/modules/addons/XPIProvider.jsm, line 2978: String.localeCompare is deprecated; use String.prototype.localeCompare instead 08:46:01 INFO - PID 26219 | __metrics Screen width/height:1600/1200 08:46:01 INFO - PID 26219 | colorDepth:24 08:46:01 INFO - PID 26219 | Browser inner width/height: 1024/695 08:46:01 INFO - PID 26219 | __metrics 08:46:03 INFO - TEST-INFO | 26219: exit 0 08:46:03 INFO - Browser initialized. 08:46:03 INFO - Running cycle 1/1 for dromaeo_css test... 08:46:03 INFO - TEST-INFO | started process 26399 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeQozDO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:46:15 INFO - PID 26399 | RSS: Main: 170033152 08:46:15 INFO - PID 26399 | 08:49:19 INFO - PID 26399 | Cycle 1(1): loaded http://localhost:47851/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47851/tests/dromaeo/cssquery-ext.html) 08:49:21 INFO - PID 26399 | RSS: Main: 175951872 08:49:21 INFO - PID 26399 | 08:52:23 INFO - PID 26399 | Cycle 1(1): loaded http://localhost:47851/tests/dromaeo/cssquery-ext.html (next: http://localhost:47851/tests/dromaeo/cssquery-jquery.html) 08:52:23 INFO - PID 26399 | RSS: Main: 173932544 08:52:23 INFO - PID 26399 | 08:55:25 INFO - PID 26399 | Cycle 1(1): loaded http://localhost:47851/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47851/tests/dromaeo/cssquery-mootools.html) 08:55:26 INFO - PID 26399 | RSS: Main: 176984064 08:55:26 INFO - PID 26399 | 08:58:28 INFO - PID 26399 | Cycle 1(1): loaded http://localhost:47851/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47851/tests/dromaeo/cssquery-prototype.html) 08:58:29 INFO - PID 26399 | RSS: Main: 175804416 08:58:29 INFO - PID 26399 | 09:01:31 INFO - PID 26399 | Cycle 1(1): loaded http://localhost:47851/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47851/tests/dromaeo/cssquery-yui.html) 09:01:32 INFO - PID 26399 | RSS: Main: 175083520 09:01:32 INFO - PID 26399 | 09:04:34 INFO - PID 26399 | Cycle 1(1): loaded http://localhost:47851/tests/dromaeo/cssquery-yui.html (next: http://localhost:47851/tests/dromaeo/cssquery-dojo.html) 09:04:34 INFO - PID 26399 | RSS: Main: 181899264 09:04:34 INFO - PID 26399 | 09:04:34 INFO - PID 26399 | __start_tp_report 09:04:34 INFO - PID 26399 | _x_x_mozilla_page_load 09:04:34 INFO - PID 26399 | _x_x_mozilla_page_load_details 09:04:34 INFO - PID 26399 | |i|pagename|runs| 09:04:34 INFO - PID 26399 | |0;dojo.html;2688.556388195948;2697.689765676947;2703.243091934258;2718.347596576822;2731.440054788768;5157.3811142662835;5214.973925130374;5227.242049902762;5230.895382092365;5242.580593552516;5113.284140220372;5178.093833579118;5189.766460509277;5198.350206224222;5224.503672151149;4442.324261438048;4610.377599024139;4691.390119284488;4695.953040469586;4714.740689262089;4688.929666054994;4733.148033353995;4741.359916411275;4761.85714428566;4766.833160839371;4587.266037434028;4626.768661566908;4632.837850675244;4667.88330291742;4697.788599512996;4661.044485880387;4676.134915040694;4680.297955306697;4690.859274221779;4721.787519561593;4587.082583483317;4595.747233902134;4621.3299071634765;4625.421822272216;4629.606483448911;5067.49325067494;5154.484551544815;5206.817761378334;5208.609354298443;5251.894962100737;5601.971990140064;5654.434556544313;5657.830265092054;5703.258576385043;5704.543636509111;5596.804111856106;5599.048161812501;5609.691466969315;5615.775368985236;5631.887362252732;5173.456787037382;5235.921461178085;5240.711760853113;5256.81601143962;5291.3385826771655;5698.629589076697;5731.197632331477;5804.071348584206;5858.765649373977;5888.381719919346;5549.084401073777;5553.222548843165;5566.025945459609;5572.554195664337;5574.916376254359;5458.2904222450825;5474;5486.643368181135;5633.492985631313;5693.601447898607;5591.30108736408;5597.552195824324;5612.466815652507;5638.633488823213;5647.604667673223;5603.131514615241;5607.803726869622;5610.887782244332;5615.9157612635845;5622.353429355595;4618.307253911873;4677.111348843709;4679.883002924954;4693.507181745936;4739.123262196505;4057.756534607874;4061.817218225187;4112.91774164515;4147.294959856771;4151.543330233671;4752.263399173134;4774.21225497789;4774.7135171889795;4775.044991001813;4778.37881075458;5491.752871120809;5634.352049514358;5636.8308950730725;5663.348714897757;5715.342735585461;4685.461171965268;4714.528547145326;4760.214564596872;4784.354112194878;4803.303520989507;5002.274670172805;5017.071841709296;5031.547160755549;5039.899202015939;5069.619778516626;5242.97378513105;5252.606054546;5261.105612045885;5267.868303292448;5268.078086334876;5545.029619816435;5612.354579223442;5619.634723743107;5624.128260119688;5627.099664053731;5161.174212126042;5208.895822083613;5209.973950130225;5215.217717342429;5222.791088356423;5594.916076258778;5595.804146854841;5614.24207731951;5624.268845050117;5646;5555.972220138873;5661.377248502744;5661.943380566142;5682.6306290091015;5685.687287199244;5358.598105142208;5413.323334583177;5454.3454785426;5471.151971444432;5478.945210547843;5361.329833770778;5436;5523.226748255167;5534.889302214014;5541.279633647761;5284.471552844685;5299.6290259681455;5449.23710680513;5452.127659574449;5456.099743542271;5422.783088676409;5550.38945715979;5552.944470555242;5555.30558680165;5559.52744016747;5219.451957544555;5359.946400535945;5390.164524498709;5400.702961337164;5451.318585176853 09:04:34 INFO - PID 26399 | |1;ext.html;660.6531570925264;692.5879101934349;713.443514059034;1155.8208477685962;1204.5663561118001;35635.109122271926;36364.63635363646;36467.4529882052;36470.81764591177;36541.08647283816;33997;34380.65619343806;34388.1402964926;34470.31059378811;34474.8276258619;6498.740050397979;6613.867722645568;6849.178098628172;7017.82455438613;7055.929440705604;6999.370056694896;7092.4326053915565;7093.04243927071;7116.110486189226;7137.143542774875;7061.717531298767;7106.289371062904;7131.179914309843;7141.750038748645;7144.571325720447;7055.788326350218;7090.787276381717;7094.858102837914;7096.432285417154;7114.075170227889;6939.6877140528795;6986.93013069873;6995.26549712283;7008.299170083002;7016.087908571904;32361.352772944643;32545;32602.184945376317;32652.836735816407;32672.346553069045;2921.328094538268;2965.7330840224267;2972.895948641809;2985.567092771558;2989.3124581346196;25213.49573008548;25227.369315767068;25263.242102736946;25426.36434089144;25430.745692543023;3087.3516561522106;3106.782525223235;3120.2199450137464;3120.7971481853606;3133.2166958260436;144188.27905860508;144941;145296;148818;154244.22877885652;39733.40399894004;40062.59937400647;40117.398239026435;40136;40227.59772402297;41723.58276417258;41780.164396711894;41801.581984180375;46243;47595.286070708964;11370.431478426046;11520;11629.59296424638;11687.123465740104;11819.822702659467;8960.641574337084;9097.363184577016;9200.125988031126;9247.075292470834;9274.30442716799;13224.801627975588;13357.866421335857;13375.933120334335;13418.865811341957;13540.322983850965;4757.381540399795;4773.947202702801;4776.928346074812;4786.664933454625;4804.975975120102;868.5874209750318;892.2415946445599;901.3510272603714;905.6422713028317;920.0753242990752;21367;21572.56854862894;21807;21919.123235070736;22310.442238943833;948.966786162481;959.9808003840024;960.3469640644429;961.1109723505868;988.1650005745134;10802.297850639683;11204.439778011067;11304.265222760494;11347.319300734944;11414.486348114355;181420;182755;182988;183243;183854.0807295955;42096.15807683829;42096.579034209266;42375.152496949886;42436.363454548205;42447.151056978684;1185.967366196973;1235.8640549539723;1235.9382030898598;1236.2644226685288;1238.1518659717942;19337.8066219336;19929.601407972048;20043.398698039084;20697.27559535409;21085.789142108384;30107.795688172228;38407.42388864113;39362.60637393704;39419.605803941595;39630;163348;163537;164031.1798441048;164491;164777.17611411866;30503.237419064702;30624.693753063075;30729;30961.845190773904;30994.69005309918;35948.10129746777;36237;37053.81473092617;37079;37080.62919370772;28275;28300.71699282981;28793.7120628791;28949.7105028947;29547.40905181927;27641;27851.58222626622;28284.292892677848;28321.43357132887;29173.7082629171;30602.234944125685;31389.8430507846;31400.528992065596;31542.842285789342;31593.52609710902;27764.44471110526;28054;28443.28891777722;28807.711922880502;29010.12969610915;21190.364289071353;23118.57254988202;23171.88414057919;23377.41556461102;23777.881110594335 09:04:34 INFO - PID 26399 | |2;jquery.html;387.2313457786292;407.2913131151795;417.2447869356464;428.7791787229576;433.75492846541704;16937.576560585992;17054.573635659115;17590.120493975315;17604.119794010297;17702.468925932244;17015.91492042541;17103.74344384835;17125.571860703487;17778.64442711145;18156.092195390243;5253.921191182136;5345.4387289334645;5523.392426833045;5525.861853453655;5530;5294.100002999499;5356.705381204032;5364;5364.953834002371;5367.624266301361;5130.281760553526;5328.813491527797;5343.465653434664;5346.224797404374;5371.248025276445;5381.058314794915;5417.51242388185;5424.83725488232;5429.321334833146;5440.6735595864375;4683;4816.7350795706225;4818.734969576672;4845.079434907357;4858.514148585148;21956.670649940264;22023.559528809496;22098.33704988853;22144.22495212676;22355.10579576815;1668.215938508899;1689.358043943306;1701.5490894912857;1701.7362308842148;1702.3701230544655;14390.208538530376;14952.551423457313;15153.242337883172;15174.24128793556;15217.771733424008;2052.10733331;2069.3481553310808;2104.5685634444903;2114.1543382647064;2122.61792877282;88647;90484.19031619397;90751.54624226836;90850;91181.54409227977;10173.33873298248;10281.53733082013;10286.428392901775;10543.89456105429;10661.253712240068;13870.237136957565;13928;14011.579652610439;14040.85959140416;14094.224817635128;6738.764143254963;6903.792886213421;6949.235584085746;7084.964575177091;7127.82180445493;6073.119397687399;6130.601510901777;6286.842828929313;6356.68216589178;6368.522360822957;6476.805695829133;6666.600003999775;6679.165104361955;6763.613459240843;6806.863862722717;1892.4417296897448;1900.6863867461714;1908.5419499320062;1910.293191519119;2099.992003838166;839.2195258409738;849.7026040885764;862.5816479007676;867.7873920889423;890.3856339125982;16935.745963810554;17119.22963466647;17124.74312885308;17277.222524986406;17889.19498622565;859.0807835615956;862.8403745307138;865.9653613855501;868.5830801215452;886.3662481325754;8952.731418057469;9058.909410905939;9241.907580924239;9465.574049167804;9580.408423739585;356427;361669;366293;366968;367846;72318.63840680763;72631.63684181651;75000.62499687467;75103.24896751072;75157.24842751611;1011.5245834457646;1014.5079636376499;1037.7094413564214;1038.1383451735041;1041.1150522056191;14571.635709106933;14700.632484187981;14766.48317308932;14807.925960370128;15449.459268925533;38742.61257387503;38958.220835582564;39919.80040099781;40321.39517907175;40690.1861962765;48939.308338040326;49262.753686232776;49403.50596494133;49498;49749.502504975935;7875.464284464474;8223.95888020556;8263.462874913352;8312.127226641358;8316.6673333066;13792.379342929391;13980.790288145889;14082.929585352007;14103.788443173566;14167.858321417067;11014.339139651647;11235.4382280884;11517.366544840113;11678.474468648761;11885.504044150824;10688.83966740484;10777.62278320255;10836.620718274822;10847.783044339227;10937.83593246118;11537.134714896583;11538.307701537935;11582.6525204244;11658.358790266617;11871.465784039912;7933.682652694059;8114.229148230908;8144.8778268327205;8238.83522329538;8396.412251142361;11094.445277736242;11186.161037922351;11272.549098035986;11355.261907975955;11442.370669612917 09:04:34 INFO - PID 26399 | |3;mootools.html;1239.32456811038;1294.4110429754462;1316.8288122544068;1319.4392383237127;1326.6351753267852;9653.131218190361;9763.316567840255;9993.200543956484;10056.446895420759;10109.090181883628;9953.153981911546;10042.046005629454;10099.899001009988;10100.848487272697;10149.441780702058;2247.7752224777514;2280.7491175970713;2286.8284878634086;2287.965680514785;2290.1869836208157;2163.1023125403017;2231.2190733243315;2241.0363543676212;2248.303026061918;2253.8422310438277;2257.849827656419;2275.7382900966354;2302.942426439344;2314.6412306092498;2323.7908588227056;2188.485705859122;2188.7592364839857;2225.9888700556476;2229.7658745831695;2237.0268933014027;2101.13853320138;2195.637719776235;2250.954980900373;2255.639097744353;2256.2328808205125;9539.284553658434;9548.331616786827;9579.61681532738;9619.326647134703;9638.614455421775;5535.197396377503;5728.140778883201;5733.426657334233;5761.107028410603;5779.739911703983;3103.7361824244967;3253.4957081652383;3300.5379246905454;3318;3344.2141096842224;1007.2244371833647;1016.5628779624758;1030.9896901031043;1045.9320144190604;1048.7378155461136;13951.302434878215;14007.299635018207;14028.368723407471;14117.576472705836;14145.575632730932;4607.470140933769;4678.742669153161;4777.163996300634;4784;4804.711717296904;10097.545610447547;10153;10169;10188.694339169688;10196.4391958443;5367.1680889462195;5392.865178370494;5399.973000134974;5400.973814975142;5411.702356370437;4913.533214344631;4983.90032199354;5058.595312375001;5063.822766203165;5150.356205474316;3488.354654388946;3588.1567831559564;3588.964110358863;3660.066682995819;3710.257948410329;1069.5721711315537;1072.6567498400436;1076.7200527862656;1092.229977865603;1094.0864378244096;624.5190756323361;632.0456111272013;643.112504743451;646.5926466326184;654.2410803467955;5506.669599824023;5514.503694667499;5538.086215774432;5606.85982850432;5785.103308987113;794.8211652378169;818.1695578987333;825.6037102190982;826.8470332988417;844.5101840932244;3345;3371.477420999749;3433.210361616842;3438.157651375379;3530.3468858261303;12467.251964882136;12925.418356173996;13017.674558135934;13157.53948611794;13195.67010824737;13087.607371778862;13129.212247265195;13134.671633209055;13149.60551183466;13196.14225075367;6854.554453960476;7167.068281123525;7263.854722905618;7264.128304603481;7294.671739771723;5564.805231816867;5611.438856114356;5859.355470898283;5917.1715959766525;6025.548083893813;11252;11627.127965402799;11761.764764704829;11915.82126268124;11922;11481.94259028733;11962.401879906143;12166.209196402206;12174.086943479097;12175.817362739388;8081.111077781322;8209.343252539664;8209.384296177692;8212;8215.424920255524;8929.330300227639;9060.637574496946;9065.048169942062;9217;9320.254379649476;7567.697292108474;7661.272179142972;7763.378929685498;7769.951056607286;7785.416093792875;7456.552606843607;7543.358814500829;7546.735864244725;7611.505252158592;7635.770926872203;7074.186468556182;7233.674484648309;7236.855262894818;7243;7244.166920804175;4911.754412279443;4925.261210818406;4958.801647934042;5019.67372120811;5120.564751996122;4983.75081245929;5012.398512178562;5120.6686261573;5197.740112994259;5210.244514545294 09:04:34 INFO - PID 26399 | |4;prototype.html;355.0945090020449;364.26418634358595;371.6246590943147;371.8438255932508;374.17867780222423;5453.918191227135;5573.637713548622;5592.356878958921;5614.831555053344;5635.436456354368;5330.493603107699;5402.864928376793;5418.160185171295;5441;5449.291592093033;4077.571854955224;4077.5718549552316;4089.6114869087387;4093.140440507497;4097.44684467596;3930.6069393060607;4056.4118202860714;4077.245709543744;4078.6737061035196;4093.385992101179;4053.391991201314;4055.087605288801;4065.4714887064642;4067.864371205126;4069.552349241581;4044.979775101135;4068.572799856032;4068.755874647501;4071.87784366468;4097.180563887205;3541.8229088545727;3551.520544726455;3551.7978853110976;3553.4136867416846;3554.5023696682483;5210.322658054467;5293.947060529384;5309.964556911404;5326.467353264643;5336.651873175791;4736.7631618418945;4759.333693282943;4765.451973023078;4784.808607655689;4785.712857228543;5602.215689803431;5746.706990927049;5769.163471296639;5776.624519406268;5789.565782566325;3914.4911161548816;3950.407438884162;3960.841566337343;3963.900902477461;3970.563238043813;5966.761329546813;6085.3914608539235;6135.9079613805825;6147.047207682861;6187.597806142587;3971.4439978403047;3998.3602623580086;4001.6198461146146;4012.7792971386853;4016.5581786003518;4046.7976601169826;4052.858149964737;4057.1885622875543;4058.837646494107;4072.0227145485464;4663.603593694574;4732.384789977281;4736.8105275788585;4742.857714268508;4756.881077973078;5824.155497452845;5844.26946631671;5860.120981852671;5868.589198756132;5873.823785286363;1397.1337770582304;1418.1491105336922;1419.1697856753708;1419.5031738891305;1420.9644758880904;889.3818795936762;909.3316412436853;927.9164875161268;936.7517607833929;939.0797018921495;4976.726280054631;4984.177610694267;5003.649744517922;5012.298278241049;5029.17018691919;6012.488938440194;6059.424354686298;6062.272527296753;6069.757209711651;6087.691146403545;4833.347498087714;4975.975120124376;4980.551750342486;5000.6249531284575;5006.299118123466;3150.7321877640197;3155.7475401967786;3157.921051973673;3170.1916011416943;3173.7622327292374;5456.399796022434;5546.417626149197;5555.972220138954;5577.637453565505;5586.91619625706;6166.599171053867;6171.938280617226;6195.938040619536;6210.347913469021;6219.191505104398;5534.889302213933;5545.584081194007;5548.167774833726;5567.8886422272135;5568.136938774496;5884.735186916513;5984.251968503937;5986.191864098291;6029.78895738647;6030.90953635687;5893.410658934073;5896.909071821727;5916.230889984275;5946.137810017437;5957.582969192115;5411.702356370437;5539.279893613804;5541.5289700375915;5560.499555040065;5562.499375056264;4003.319435695997;4028.4762980812307;4039.8788036358956;4040.9797951010055;4065.3088974874936;5919.674417906885;5996.520278377807;6061.696915154136;6065.636061836304;6086.452219300284;5814.418558144321;5823.679697616672;5827.970860145672;5832.883342333044;5858.912116318344;5801.680907550125;5823.301203855564;5834.358220595816;5847.356790752929;5858.2677165354335;5652.660840349592;5705.971470142623;5746.885062298814;5760.798372056958;5778;5851.678157701367;5861.413858614104;5868.823935281948;5870.207521984477;5895;5599.80400685974;5610.9158362623775;5615.691136987341;5668.688222147656;5687.658740475585 09:04:34 INFO - PID 26399 | |5;yui.html;741.8701727197739;745.6979923131132;765.3609236287696;773.3272053313615;777.9844403111938;11913;12415.068869834753;12622.810657840128;13328.600141995743;13341.466341346335;14617.415303387852;14728.263586820669;15193;15229.543113706579;15300.846991530081;767.7312940470832;812.7196117339508;819.3772732723144;823.2919689067397;826.0954255090666;875.0287181228831;875.0724232313736;876.5310558851016;882.0297672560165;882.8896387951506;909.5497728624307;912.8813254276935;916.2532535983186;918.8392031394512;918.9954050229773;910.2308549275851;911.4759013567159;912.63494602159;914.1498406481969;916.702071826659;674.0193019157115;674.1101745695684;674.2482132422314;674.5379415100623;675.7398401615413;13374.063815532916;13397;13412.46350145993;13899.722005559832;13955.232462214573;15560.22198890051;15599.1420471874;15749.291281892229;16013.519594412186;16069.678606427806;12517.624471265877;12521.436535355931;12575.622731317984;12598.748025039447;12691.175073620278;2897.1453421240785;2923.2253452835016;2923.429931163424;2927.8536073196256;2930.106317573139;65443.3455665442;66085;66821.66589167072;67689;69079;10725;10843.132549396028;11040.282381645167;11375.658730238107;11443.828342574869;21512.78487215139;21726.565468690536;22176.223832165797;22360.440988975406;22593.4351641207;5856.472917437451;5913.201717768132;6048.879022419527;6097.634141951408;6102.206713127265;2899.492588796952;2945.0575815739185;2954.3648115655237;2957.5711521829217;2980.0612806965737;3344.7491438142238;3408.522806807049;3423.5891692997;3441.346144232588;3526.347625689256;688.9896651550231;689.055993289187;689.5793565924782;691.1602403080282;694.6804469943781;575.8790653962631;588.9587728859025;591.2432086928652;594.174098003775;605.6154341992866;9236.603133419765;9685.515724213901;9723.902760972442;9743.853842192373;10127;576.8846230753866;581.1892410087904;581.8632621333983;582.6766144789682;582.6882617799541;4382.824687012484;4545.159145558082;4565.931511027337;4567.314902764612;4599.33309670096;62264.688676556325;62266.377336226054;62780.686096569225;62927;65005;54643;56256.718716406154;58533.41466585365;58608.41391586115;59704.70147649234;46538;47336.289955650696;47822.28266576004;49096.75451622719;49229.261561076615;9457.38526995743;9921.454320012468;10102.242331824995;10346.586136554453;10389.636362727268;24646;24796.50406991814;24956.875215623804;25208.36979075538;26136.60795088113;29749.702502974695;41209;41981.79009105057;42302;43209.13581728285;12642.87357126417;12680.175788573713;12814.55149069778;12929.935350323189;12949.482020719066;15851.603709906884;16388.590285242964;16390.836091638932;16631.251593678557;17118.229679664695;14732.263386830402;15021.24893755286;15361.001534900195;15636.374545018527;15899.04605723614;14250.14499130014;14443;14731.484398046017;15252.923735381251;15333.310001049756;14176.929115354356;14180.645483862985;14673;15893.125878076355;16023.679526409172;9864.654737084167;10128.139108175594;10128.84806727885;10143.949280253551;10240.48797560134;11283.605073822377;11698.122640802145;11794.46924888365;11911.463984120908;12005.699857503283 09:04:34 INFO - PID 26399 | __end_tp_report 09:04:34 INFO - PID 26399 | __start_cc_report 09:04:34 INFO - PID 26399 | _x_x_mozilla_cycle_collect,283 09:04:34 INFO - PID 26399 | __end_cc_report 09:04:34 INFO - PID 26399 | __startTimestamp1495555474777__endTimestamp 09:04:34 INFO - PID 26399 | 09:04:34 INFO - PID 26399 | ------- Summary: start ------- 09:04:34 INFO - PID 26399 | Number of tests: 6 09:04:34 INFO - PID 26399 | 09:04:34 INFO - PID 26399 | [#0] dojo.html Cycles:165 Average:5143.64 Median:5261.11 stddev:602.04 (11.4%) stddev-sans-first:572.26 09:04:34 INFO - PID 26399 | Values: 2688.6 2697.7 2703.2 2718.3 2731.4 5157.4 5215.0 5227.2 5230.9 5242.6 5113.3 5178.1 5189.8 5198.4 5224.5 4442.3 4610.4 4691.4 4696.0 4714.7 4688.9 4733.1 4741.4 4761.9 4766.8 4587.3 4626.8 4632.8 4667.9 4697.8 4661.0 4676.1 4680.3 4690.9 4721.8 4587.1 4595.7 4621.3 4625.4 4629.6 5067.5 5154.5 5206.8 5208.6 5251.9 5602.0 5654.4 5657.8 5703.3 5704.5 5596.8 5599.0 5609.7 5615.8 5631.9 5173.5 5235.9 5240.7 5256.8 5291.3 5698.6 5731.2 5804.1 5858.8 5888.4 5549.1 5553.2 5566.0 5572.6 5574.9 5458.3 5474.0 5486.6 5633.5 5693.6 5591.3 5597.6 5612.5 5638.6 5647.6 5603.1 5607.8 5610.9 5615.9 5622.4 4618.3 4677.1 4679.9 4693.5 4739.1 4057.8 4061.8 4112.9 4147.3 4151.5 4752.3 4774.2 4774.7 4775.0 4778.4 5491.8 5634.4 5636.8 5663.3 5715.3 4685.5 4714.5 4760.2 4784.4 4803.3 5002.3 5017.1 5031.5 5039.9 5069.6 5243.0 5252.6 5261.1 5267.9 5268.1 5545.0 5612.4 5619.6 5624.1 5627.1 5161.2 5208.9 5210.0 5215.2 5222.8 5594.9 5595.8 5614.2 5624.3 5646.0 5556.0 5661.4 5661.9 5682.6 5685.7 5358.6 5413.3 5454.3 5471.2 5478.9 5361.3 5436.0 5523.2 5534.9 5541.3 5284.5 5299.6 5449.2 5452.1 5456.1 5422.8 5550.4 5552.9 5555.3 5559.5 5219.5 5359.9 5390.2 5400.7 5451.3 09:04:34 INFO - PID 26399 | 09:04:34 INFO - PID 26399 | [#1] ext.html Cycles:180 Average:31413.36 Median:31471.69 stddev:42757.94 (135.9%) stddev-sans-first:42815.53 09:04:34 INFO - PID 26399 | Values: 660.7 692.6 713.4 1155.8 1204.6 35635.1 36364.6 36467.5 36470.8 36541.1 33997.0 34380.7 34388.1 34470.3 34474.8 6498.7 6613.9 6849.2 7017.8 7055.9 6999.4 7092.4 7093.0 7116.1 7137.1 7061.7 7106.3 7131.2 7141.8 7144.6 7055.8 7090.8 7094.9 7096.4 7114.1 6939.7 6986.9 6995.3 7008.3 7016.1 32361.4 32545.0 32602.2 32652.8 32672.3 2921.3 2965.7 2972.9 2985.6 2989.3 25213.5 25227.4 25263.2 25426.4 25430.7 3087.4 3106.8 3120.2 3120.8 3133.2 144188.3 144941.0 145296.0 148818.0 154244.2 39733.4 40062.6 40117.4 40136.0 40227.6 41723.6 41780.2 41801.6 46243.0 47595.3 11370.4 11520.0 11629.6 11687.1 11819.8 8960.6 9097.4 9200.1 9247.1 9274.3 13224.8 13357.9 13375.9 13418.9 13540.3 4757.4 4773.9 4776.9 4786.7 4805.0 868.6 892.2 901.4 905.6 920.1 21367.0 21572.6 21807.0 21919.1 22310.4 949.0 960.0 960.3 961.1 988.2 10802.3 11204.4 11304.3 11347.3 11414.5 181420.0 182755.0 182988.0 183243.0 183854.1 42096.2 42096.6 42375.2 42436.4 42447.2 1186.0 1235.9 1235.9 1236.3 1238.2 19337.8 19929.6 20043.4 20697.3 21085.8 30107.8 38407.4 39362.6 39419.6 39630.0 163348.0 163537.0 164031.2 164491.0 164777.2 30503.2 30624.7 30729.0 30961.8 30994.7 35948.1 36237.0 37053.8 37079.0 37080.6 28275.0 28300.7 28793.7 28949.7 29547.4 27641.0 27851.6 28284.3 28321.4 29173.7 30602.2 31389.8 31400.5 31542.8 31593.5 27764.4 28054.0 28443.3 28807.7 29010.1 21190.4 23118.6 23171.9 23377.4 23777.9 09:04:34 INFO - PID 26399 | 09:04:34 INFO - PID 26399 | [#2] jquery.html Cycles:180 Average:24603.17 Median:19564.92 stddev:60637.18 (309.9%) stddev-sans-first:60780.03 09:04:34 INFO - PID 26399 | Values: 387.2 407.3 417.2 428.8 433.8 16937.6 17054.6 17590.1 17604.1 17702.5 17015.9 17103.7 17125.6 17778.6 18156.1 5253.9 5345.4 5523.4 5525.9 5530.0 5294.1 5356.7 5364.0 5365.0 5367.6 5130.3 5328.8 5343.5 5346.2 5371.2 5381.1 5417.5 5424.8 5429.3 5440.7 4683.0 4816.7 4818.7 4845.1 4858.5 21956.7 22023.6 22098.3 22144.2 22355.1 1668.2 1689.4 1701.5 1701.7 1702.4 14390.2 14952.6 15153.2 15174.2 15217.8 2052.1 2069.3 2104.6 2114.2 2122.6 88647.0 90484.2 90751.5 90850.0 91181.5 10173.3 10281.5 10286.4 10543.9 10661.3 13870.2 13928.0 14011.6 14040.9 14094.2 6738.8 6903.8 6949.2 7085.0 7127.8 6073.1 6130.6 6286.8 6356.7 6368.5 6476.8 6666.6 6679.2 6763.6 6806.9 1892.4 1900.7 1908.5 1910.3 2100.0 839.2 849.7 862.6 867.8 890.4 16935.7 17119.2 17124.7 17277.2 17889.2 859.1 862.8 866.0 868.6 886.4 8952.7 9058.9 9241.9 9465.6 9580.4 356427.0 361669.0 366293.0 366968.0 367846.0 72318.6 72631.6 75000.6 75103.2 75157.2 1011.5 1014.5 1037.7 1038.1 1041.1 14571.6 14700.6 14766.5 14807.9 15449.5 38742.6 38958.2 39919.8 40321.4 40690.2 48939.3 49262.8 49403.5 49498.0 49749.5 7875.5 8224.0 8263.5 8312.1 8316.7 13792.4 13980.8 14082.9 14103.8 14167.9 11014.3 11235.4 11517.4 11678.5 11885.5 10688.8 10777.6 10836.6 10847.8 10937.8 11537.1 11538.3 11582.7 11658.4 11871.5 7933.7 8114.2 8144.9 8238.8 8396.4 11094.4 11186.2 11272.5 11355.3 11442.4 09:04:34 INFO - PID 26399 | 09:04:34 INFO - PID 26399 | [#3] mootools.html Cycles:180 Average:6090.18 Median:4158.86 stddev:3880.95 (93.3%) stddev-sans-first:3874.72 09:04:34 INFO - PID 26399 | Values: 1239.3 1294.4 1316.8 1319.4 1326.6 9653.1 9763.3 9993.2 10056.4 10109.1 9953.2 10042.0 10099.9 10100.8 10149.4 2247.8 2280.7 2286.8 2288.0 2290.2 2163.1 2231.2 2241.0 2248.3 2253.8 2257.8 2275.7 2302.9 2314.6 2323.8 2188.5 2188.8 2226.0 2229.8 2237.0 2101.1 2195.6 2251.0 2255.6 2256.2 9539.3 9548.3 9579.6 9619.3 9638.6 5535.2 5728.1 5733.4 5761.1 5779.7 3103.7 3253.5 3300.5 3318.0 3344.2 1007.2 1016.6 1031.0 1045.9 1048.7 13951.3 14007.3 14028.4 14117.6 14145.6 4607.5 4678.7 4777.2 4784.0 4804.7 10097.5 10153.0 10169.0 10188.7 10196.4 5367.2 5392.9 5400.0 5401.0 5411.7 4913.5 4983.9 5058.6 5063.8 5150.4 3488.4 3588.2 3589.0 3660.1 3710.3 1069.6 1072.7 1076.7 1092.2 1094.1 624.5 632.0 643.1 646.6 654.2 5506.7 5514.5 5538.1 5606.9 5785.1 794.8 818.2 825.6 826.8 844.5 3345.0 3371.5 3433.2 3438.2 3530.3 12467.3 12925.4 13017.7 13157.5 13195.7 13087.6 13129.2 13134.7 13149.6 13196.1 6854.6 7167.1 7263.9 7264.1 7294.7 5564.8 5611.4 5859.4 5917.2 6025.5 11252.0 11627.1 11761.8 11915.8 11922.0 11481.9 11962.4 12166.2 12174.1 12175.8 8081.1 8209.3 8209.4 8212.0 8215.4 8929.3 9060.6 9065.0 9217.0 9320.3 7567.7 7661.3 7763.4 7770.0 7785.4 7456.6 7543.4 7546.7 7611.5 7635.8 7074.2 7233.7 7236.9 7243.0 7244.2 4911.8 4925.3 4958.8 5019.7 5120.6 4983.8 5012.4 5120.7 5197.7 5210.2 09:04:34 INFO - PID 26399 | 09:04:34 INFO - PID 26399 | [#4] prototype.html Cycles:180 Average:4746.02 Median:5451.60 stddev:1439.04 (26.4%) stddev-sans-first:1404.83 09:04:34 INFO - PID 26399 | Values: 355.1 364.3 371.6 371.8 374.2 5453.9 5573.6 5592.4 5614.8 5635.4 5330.5 5402.9 5418.2 5441.0 5449.3 4077.6 4077.6 4089.6 4093.1 4097.4 3930.6 4056.4 4077.2 4078.7 4093.4 4053.4 4055.1 4065.5 4067.9 4069.6 4045.0 4068.6 4068.8 4071.9 4097.2 3541.8 3551.5 3551.8 3553.4 3554.5 5210.3 5293.9 5310.0 5326.5 5336.7 4736.8 4759.3 4765.5 4784.8 4785.7 5602.2 5746.7 5769.2 5776.6 5789.6 3914.5 3950.4 3960.8 3963.9 3970.6 5966.8 6085.4 6135.9 6147.0 6187.6 3971.4 3998.4 4001.6 4012.8 4016.6 4046.8 4052.9 4057.2 4058.8 4072.0 4663.6 4732.4 4736.8 4742.9 4756.9 5824.2 5844.3 5860.1 5868.6 5873.8 1397.1 1418.1 1419.2 1419.5 1421.0 889.4 909.3 927.9 936.8 939.1 4976.7 4984.2 5003.6 5012.3 5029.2 6012.5 6059.4 6062.3 6069.8 6087.7 4833.3 4976.0 4980.6 5000.6 5006.3 3150.7 3155.7 3157.9 3170.2 3173.8 5456.4 5546.4 5556.0 5577.6 5586.9 6166.6 6171.9 6195.9 6210.3 6219.2 5534.9 5545.6 5548.2 5567.9 5568.1 5884.7 5984.3 5986.2 6029.8 6030.9 5893.4 5896.9 5916.2 5946.1 5957.6 5411.7 5539.3 5541.5 5560.5 5562.5 4003.3 4028.5 4039.9 4041.0 4065.3 5919.7 5996.5 6061.7 6065.6 6086.5 5814.4 5823.7 5828.0 5832.9 5858.9 5801.7 5823.3 5834.4 5847.4 5858.3 5652.7 5706.0 5746.9 5760.8 5778.0 5851.7 5861.4 5868.8 5870.2 5895.0 5599.8 5610.9 5615.7 5668.7 5687.7 09:04:34 INFO - PID 26399 | 09:04:34 INFO - PID 26399 | [#5] yui.html Cycles:180 Average:15166.24 Median:3416.06 stddev:17747.47 (519.5%) stddev-sans-first:17764.20 09:04:34 INFO - PID 26399 | Values: 741.9 745.7 765.4 773.3 778.0 11913.0 12415.1 12622.8 13328.6 13341.5 14617.4 14728.3 15193.0 15229.5 15300.8 767.7 812.7 819.4 823.3 826.1 875.0 875.1 876.5 882.0 882.9 909.5 912.9 916.3 918.8 919.0 910.2 911.5 912.6 914.1 916.7 674.0 674.1 674.2 674.5 675.7 13374.1 13397.0 13412.5 13899.7 13955.2 15560.2 15599.1 15749.3 16013.5 16069.7 12517.6 12521.4 12575.6 12598.7 12691.2 2897.1 2923.2 2923.4 2927.9 2930.1 65443.3 66085.0 66821.7 67689.0 69079.0 10725.0 10843.1 11040.3 11375.7 11443.8 21512.8 21726.6 22176.2 22360.4 22593.4 5856.5 5913.2 6048.9 6097.6 6102.2 2899.5 2945.1 2954.4 2957.6 2980.1 3344.7 3408.5 3423.6 3441.3 3526.3 689.0 689.1 689.6 691.2 694.7 575.9 589.0 591.2 594.2 605.6 9236.6 9685.5 9723.9 9743.9 10127.0 576.9 581.2 581.9 582.7 582.7 4382.8 4545.2 4565.9 4567.3 4599.3 62264.7 62266.4 62780.7 62927.0 65005.0 54643.0 56256.7 58533.4 58608.4 59704.7 46538.0 47336.3 47822.3 49096.8 49229.3 9457.4 9921.5 10102.2 10346.6 10389.6 24646.0 24796.5 24956.9 25208.4 26136.6 29749.7 41209.0 41981.8 42302.0 43209.1 12642.9 12680.2 12814.6 12929.9 12949.5 15851.6 16388.6 16390.8 16631.3 17118.2 14732.3 15021.2 15361.0 15636.4 15899.0 14250.1 14443.0 14731.5 15252.9 15333.3 14176.9 14180.6 14673.0 15893.1 16023.7 9864.7 10128.1 10128.8 10143.9 10240.5 11283.6 11698.1 11794.5 11911.5 12005.7 09:04:34 INFO - PID 26399 | -------- Summary: end -------- 09:04:34 INFO - PID 26399 | 09:04:35 INFO - TEST-INFO | 26399: exit 0 09:04:35 INFO - TEST-OK | dromaeo_css | took 1118110ms 09:04:35 INFO - TEST-START | kraken 09:04:35 INFO - operating with platform_type : linux_ 09:04:35 INFO - Initialising browser for kraken test... 09:04:35 INFO - TEST-INFO | started process 26819 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpu_XuW3/profile http://localhost:47851/getInfo.html) 09:04:36 INFO - PID 26819 | JavaScript warning: resource://gre/modules/addons/XPIProvider.jsm, line 2978: String.localeCompare is deprecated; use String.prototype.localeCompare instead 09:04:39 INFO - PID 26819 | __metrics Screen width/height:1600/1200 09:04:39 INFO - PID 26819 | colorDepth:24 09:04:39 INFO - PID 26819 | Browser inner width/height: 1024/695 09:04:39 INFO - PID 26819 | __metrics 09:04:41 INFO - TEST-INFO | 26819: exit 0 09:04:41 INFO - Browser initialized. 09:04:41 INFO - Running cycle 1/1 for kraken test... 09:04:41 INFO - TEST-INFO | started process 26997 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpu_XuW3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:04:53 INFO - PID 26997 | RSS: Main: 170360832 09:04:53 INFO - PID 26997 | 09:04:55 INFO - PID 26997 | Cycle 1(1): loaded http://localhost:47851/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47851/tests/kraken/driver.html?testName=audio-beat-detection) 09:04:56 INFO - PID 26997 | RSS: Main: 174555136 09:04:56 INFO - PID 26997 | 09:04:59 INFO - PID 26997 | Cycle 1(1): loaded http://localhost:47851/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47851/tests/kraken/driver.html?testName=audio-dft) 09:05:00 INFO - PID 26997 | RSS: Main: 174272512 09:05:00 INFO - PID 26997 | 09:05:03 INFO - PID 26997 | Cycle 1(1): loaded http://localhost:47851/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47851/tests/kraken/driver.html?testName=audio-fft) 09:05:03 INFO - PID 26997 | RSS: Main: 169418752 09:05:03 INFO - PID 26997 | 09:05:06 INFO - PID 26997 | Cycle 1(1): loaded http://localhost:47851/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47851/tests/kraken/driver.html?testName=audio-oscillator) 09:05:06 INFO - PID 26997 | RSS: Main: 170045440 09:05:06 INFO - PID 26997 | 09:05:08 INFO - PID 26997 | Cycle 1(1): loaded http://localhost:47851/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47851/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:05:09 INFO - PID 26997 | RSS: Main: 170569728 09:05:09 INFO - PID 26997 | 09:05:12 INFO - PID 26997 | Cycle 1(1): loaded http://localhost:47851/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47851/tests/kraken/driver.html?testName=imaging-darkroom) 09:05:13 INFO - PID 26997 | RSS: Main: 174575616 09:05:13 INFO - PID 26997 | 09:05:16 INFO - PID 26997 | Cycle 1(1): loaded http://localhost:47851/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47851/tests/kraken/driver.html?testName=imaging-desaturate) 09:05:17 INFO - PID 26997 | RSS: Main: 172122112 09:05:17 INFO - PID 26997 | 09:05:20 INFO - PID 26997 | Cycle 1(1): loaded http://localhost:47851/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47851/tests/kraken/driver.html?testName=json-parse-financial) 09:05:20 INFO - PID 26997 | RSS: Main: 172937216 09:05:20 INFO - PID 26997 | 09:05:22 INFO - PID 26997 | Cycle 1(1): loaded http://localhost:47851/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47851/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:05:23 INFO - PID 26997 | RSS: Main: 173068288 09:05:23 INFO - PID 26997 | 09:05:24 INFO - PID 26997 | Cycle 1(1): loaded http://localhost:47851/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47851/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:05:25 INFO - PID 26997 | RSS: Main: 173031424 09:05:25 INFO - PID 26997 | 09:05:27 INFO - PID 26997 | Cycle 1(1): loaded http://localhost:47851/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47851/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:05:28 INFO - PID 26997 | RSS: Main: 173248512 09:05:28 INFO - PID 26997 | 09:05:31 INFO - PID 26997 | Cycle 1(1): loaded http://localhost:47851/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47851/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:05:31 INFO - PID 26997 | RSS: Main: 173928448 09:05:31 INFO - PID 26997 | 09:05:35 INFO - PID 26997 | Cycle 1(1): loaded http://localhost:47851/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47851/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:05:35 INFO - PID 26997 | RSS: Main: 173744128 09:05:35 INFO - PID 26997 | 09:05:37 INFO - PID 26997 | Cycle 1(1): loaded http://localhost:47851/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47851/tests/kraken/driver.html?testName=ai-astar) 09:05:37 INFO - PID 26997 | RSS: Main: 175173632 09:05:37 INFO - PID 26997 | 09:05:37 INFO - PID 26997 | __start_tp_report 09:05:37 INFO - PID 26997 | _x_x_mozilla_page_load 09:05:37 INFO - PID 26997 | _x_x_mozilla_page_load_details 09:05:37 INFO - PID 26997 | |i|pagename|runs| 09:05:37 INFO - PID 26997 | |0;ai-astar;104;111;112;114;113;114;114;114;112;113 09:05:37 INFO - PID 26997 | |1;audio-beat-detection;157;125;128;173;127;126;124;128;146;126 09:05:37 INFO - PID 26997 | |2;audio-dft;164;165;164;164;165;167;174;165;165;162 09:05:37 INFO - PID 26997 | |3;audio-fft;76;74;78;104;79;76;75;76;101;76 09:05:37 INFO - PID 26997 | |4;audio-oscillator;85;83;111;83;85;84;97;85;85;106 09:05:37 INFO - PID 26997 | |5;imaging-gaussian-blur;114;120;114;115;114;114;115;114;118;114 09:05:37 INFO - PID 26997 | |6;imaging-darkroom;150;151;151;152;150;152;151;151;151;152 09:05:37 INFO - PID 26997 | |7;imaging-desaturate;95;94;95;100;95;94;99;102;95;95 09:05:37 INFO - PID 26997 | |8;json-parse-financial;58;54;58;56;56;59;60;56;56;57 09:05:37 INFO - PID 26997 | |9;json-stringify-tinderbox;56;57;59;58;59;56;58;57;56;56 09:05:37 INFO - PID 26997 | |10;stanford-crypto-aes;83;84;81;83;86;84;83;83;83;82 09:05:37 INFO - PID 26997 | |11;stanford-crypto-ccm;137;134;133;133;133;134;136;130;186;135 09:05:37 INFO - PID 26997 | |12;stanford-crypto-pbkdf2;189;195;204;193;193;194;197;196;186;188 09:05:37 INFO - PID 26997 | |13;stanford-crypto-sha256-iterative;74;71;71;71;74;72;72;75;71;74 09:05:37 INFO - PID 26997 | __end_tp_report 09:05:37 INFO - PID 26997 | __start_cc_report 09:05:37 INFO - PID 26997 | _x_x_mozilla_cycle_collect,762 09:05:37 INFO - PID 26997 | __end_cc_report 09:05:37 INFO - PID 26997 | __startTimestamp1495555537746__endTimestamp 09:05:37 INFO - PID 26997 | 09:05:37 INFO - PID 26997 | ------- Summary: start ------- 09:05:37 INFO - PID 26997 | Number of tests: 14 09:05:37 INFO - PID 26997 | 09:05:37 INFO - PID 26997 | [#0] ai-astar Cycles:10 Average:112.10 Median:113.50 stddev:3.03 (2.7%) stddev-sans-first:1.12 09:05:37 INFO - PID 26997 | Values: 104.0 111.0 112.0 114.0 113.0 114.0 114.0 114.0 112.0 113.0 09:05:37 INFO - PID 26997 | 09:05:37 INFO - PID 26997 | [#1] audio-beat-detection Cycles:10 Average:136.00 Median:128.00 stddev:16.94 (13.2%) stddev-sans-first:16.18 09:05:37 INFO - PID 26997 | Values: 157.0 125.0 128.0 173.0 127.0 126.0 124.0 128.0 146.0 126.0 09:05:37 INFO - PID 26997 | 09:05:37 INFO - PID 26997 | [#2] audio-dft Cycles:10 Average:165.50 Median:165.00 stddev:3.24 (2.0%) stddev-sans-first:3.39 09:05:37 INFO - PID 26997 | Values: 164.0 165.0 164.0 164.0 165.0 167.0 174.0 165.0 165.0 162.0 09:05:37 INFO - PID 26997 | 09:05:37 INFO - PID 26997 | [#3] audio-fft Cycles:10 Average:81.50 Median:76.00 stddev:11.18 (14.7%) stddev-sans-first:11.68 09:05:37 INFO - PID 26997 | Values: 76.0 74.0 78.0 104.0 79.0 76.0 75.0 76.0 101.0 76.0 09:05:37 INFO - PID 26997 | 09:05:37 INFO - PID 26997 | [#4] audio-oscillator Cycles:10 Average:90.40 Median:85.00 stddev:10.43 (12.3%) stddev-sans-first:10.87 09:05:37 INFO - PID 26997 | Values: 85.0 83.0 111.0 83.0 85.0 84.0 97.0 85.0 85.0 106.0 09:05:37 INFO - PID 26997 | 09:05:37 INFO - PID 26997 | [#5] imaging-gaussian-blur Cycles:10 Average:115.20 Median:114.50 stddev:2.10 (1.8%) stddev-sans-first:2.18 09:05:37 INFO - PID 26997 | Values: 114.0 120.0 114.0 115.0 114.0 114.0 115.0 114.0 118.0 114.0 09:05:37 INFO - PID 26997 | 09:05:37 INFO - PID 26997 | [#6] imaging-darkroom Cycles:10 Average:151.10 Median:151.00 stddev:0.74 (0.5%) stddev-sans-first:0.67 09:05:37 INFO - PID 26997 | Values: 150.0 151.0 151.0 152.0 150.0 152.0 151.0 151.0 151.0 152.0 09:05:37 INFO - PID 26997 | 09:05:37 INFO - PID 26997 | [#7] imaging-desaturate Cycles:10 Average:96.40 Median:95.00 stddev:2.84 (3.0%) stddev-sans-first:2.96 09:05:37 INFO - PID 26997 | Values: 95.0 94.0 95.0 100.0 95.0 94.0 99.0 102.0 95.0 95.0 09:05:37 INFO - PID 26997 | 09:05:37 INFO - PID 26997 | [#8] json-parse-financial Cycles:10 Average:57.00 Median:57.50 stddev:1.76 (3.1%) stddev-sans-first:1.83 09:05:37 INFO - PID 26997 | Values: 58.0 54.0 58.0 56.0 56.0 59.0 60.0 56.0 56.0 57.0 09:05:37 INFO - PID 26997 | 09:05:37 INFO - PID 26997 | [#9] json-stringify-tinderbox Cycles:10 Average:57.20 Median:57.50 stddev:1.23 (2.1%) stddev-sans-first:1.22 09:05:37 INFO - PID 26997 | Values: 56.0 57.0 59.0 58.0 59.0 56.0 58.0 57.0 56.0 56.0 09:05:37 INFO - PID 26997 | 09:05:37 INFO - PID 26997 | [#10] stanford-crypto-aes Cycles:10 Average:83.20 Median:83.00 stddev:1.32 (1.6%) stddev-sans-first:1.39 09:05:37 INFO - PID 26997 | Values: 83.0 84.0 81.0 83.0 86.0 84.0 83.0 83.0 83.0 82.0 09:05:37 INFO - PID 26997 | 09:05:37 INFO - PID 26997 | [#11] stanford-crypto-ccm Cycles:10 Average:139.10 Median:134.50 stddev:16.59 (12.3%) stddev-sans-first:17.58 09:05:37 INFO - PID 26997 | Values: 137.0 134.0 133.0 133.0 133.0 134.0 136.0 130.0 186.0 135.0 09:05:37 INFO - PID 26997 | 09:05:37 INFO - PID 26997 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:193.50 Median:194.50 stddev:5.15 (2.6%) stddev-sans-first:5.20 09:05:37 INFO - PID 26997 | Values: 189.0 195.0 204.0 193.0 193.0 194.0 197.0 196.0 186.0 188.0 09:05:37 INFO - PID 26997 | 09:05:37 INFO - PID 26997 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.50 Median:73.00 stddev:1.58 (2.2%) stddev-sans-first:1.58 09:05:37 INFO - PID 26997 | Values: 74.0 71.0 71.0 71.0 74.0 72.0 72.0 75.0 71.0 74.0 09:05:37 INFO - PID 26997 | -------- Summary: end -------- 09:05:37 INFO - PID 26997 | 09:05:38 INFO - TEST-INFO | 26997: exit 0 09:05:38 INFO - TEST-OK | kraken | took 63200ms 09:05:38 INFO - SUITE-END | took 1181s 09:05:38 INFO - Completed test suite (00:19:41) 09:05:38 INFO - javascript benchmark 09:05:38 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6661.530656955571, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2688.556388195948, 2697.689765676947, 2703.243091934258, 2718.347596576822, 2731.440054788768, 5157.3811142662835, 5214.973925130374, 5227.242049902762, 5230.895382092365, 5242.580593552516, 5113.284140220372, 5178.093833579118, 5189.766460509277, 5198.350206224222, 5224.503672151149, 4442.324261438048, 4610.377599024139, 4691.390119284488, 4695.953040469586, 4714.740689262089, 4688.929666054994, 4733.148033353995, 4741.359916411275, 4761.85714428566, 4766.833160839371, 4587.266037434028, 4626.768661566908, 4632.837850675244, 4667.88330291742, 4697.788599512996, 4661.044485880387, 4676.134915040694, 4680.297955306697, 4690.859274221779, 4721.787519561593, 4587.082583483317, 4595.747233902134, 4621.3299071634765, 4625.421822272216, 4629.606483448911, 5067.49325067494, 5154.484551544815, 5206.817761378334, 5208.609354298443, 5251.894962100737, 5601.971990140064, 5654.434556544313, 5657.830265092054, 5703.258576385043, 5704.543636509111, 5596.804111856106, 5599.048161812501, 5609.691466969315, 5615.775368985236, 5631.887362252732, 5173.456787037382, 5235.921461178085, 5240.711760853113, 5256.81601143962, 5291.3385826771655, 5698.629589076697, 5731.197632331477, 5804.071348584206, 5858.765649373977, 5888.381719919346, 5549.084401073777, 5553.222548843165, 5566.025945459609, 5572.554195664337, 5574.916376254359, 5458.2904222450825, 5474.0, 5486.643368181135, 5633.492985631313, 5693.601447898607, 5591.30108736408, 5597.552195824324, 5612.466815652507, 5638.633488823213, 5647.604667673223, 5603.131514615241, 5607.803726869622, 5610.887782244332, 5615.9157612635845, 5622.353429355595, 4618.307253911873, 4677.111348843709, 4679.883002924954, 4693.507181745936, 4739.123262196505, 4057.756534607874, 4061.817218225187, 4112.91774164515, 4147.294959856771, 4151.543330233671, 4752.263399173134, 4774.21225497789, 4774.7135171889795, 4775.044991001813, 4778.37881075458, 5491.752871120809, 5634.352049514358, 5636.8308950730725, 5663.348714897757, 5715.342735585461, 4685.461171965268, 4714.528547145326, 4760.214564596872, 4784.354112194878, 4803.303520989507, 5002.274670172805, 5017.071841709296, 5031.547160755549, 5039.899202015939, 5069.619778516626, 5242.97378513105, 5252.606054546, 5261.105612045885, 5267.868303292448, 5268.078086334876, 5545.029619816435, 5612.354579223442, 5619.634723743107, 5624.128260119688, 5627.099664053731, 5161.174212126042, 5208.895822083613, 5209.973950130225, 5215.217717342429, 5222.791088356423, 5594.916076258778, 5595.804146854841, 5614.24207731951, 5624.268845050117, 5646.0, 5555.972220138873, 5661.377248502744, 5661.943380566142, 5682.6306290091015, 5685.687287199244, 5358.598105142208, 5413.323334583177, 5454.3454785426, 5471.151971444432, 5478.945210547843, 5361.329833770778, 5436.0, 5523.226748255167, 5534.889302214014, 5541.279633647761, 5284.471552844685, 5299.6290259681455, 5449.23710680513, 5452.127659574449, 5456.099743542271, 5422.783088676409, 5550.38945715979, 5552.944470555242, 5555.30558680165, 5559.52744016747, 5219.451957544555, 5359.946400535945, 5390.164524498709, 5400.702961337164, 5451.318585176853], "value": 5100.021114235501, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [660.6531570925264, 692.5879101934349, 713.443514059034, 1155.8208477685962, 1204.5663561118001, 35635.109122271926, 36364.63635363646, 36467.4529882052, 36470.81764591177, 36541.08647283816, 33997.0, 34380.65619343806, 34388.1402964926, 34470.31059378811, 34474.8276258619, 6498.740050397979, 6613.867722645568, 6849.178098628172, 7017.82455438613, 7055.929440705604, 6999.370056694896, 7092.4326053915565, 7093.04243927071, 7116.110486189226, 7137.143542774875, 7061.717531298767, 7106.289371062904, 7131.179914309843, 7141.750038748645, 7144.571325720447, 7055.788326350218, 7090.787276381717, 7094.858102837914, 7096.432285417154, 7114.075170227889, 6939.6877140528795, 6986.93013069873, 6995.26549712283, 7008.299170083002, 7016.087908571904, 32361.352772944643, 32545.0, 32602.184945376317, 32652.836735816407, 32672.346553069045, 2921.328094538268, 2965.7330840224267, 2972.895948641809, 2985.567092771558, 2989.3124581346196, 25213.49573008548, 25227.369315767068, 25263.242102736946, 25426.36434089144, 25430.745692543023, 3087.3516561522106, 3106.782525223235, 3120.2199450137464, 3120.7971481853606, 3133.2166958260436, 144188.27905860508, 144941.0, 145296.0, 148818.0, 154244.22877885652, 39733.40399894004, 40062.59937400647, 40117.398239026435, 40136.0, 40227.59772402297, 41723.58276417258, 41780.164396711894, 41801.581984180375, 46243.0, 47595.286070708964, 11370.431478426046, 11520.0, 11629.59296424638, 11687.123465740104, 11819.822702659467, 8960.641574337084, 9097.363184577016, 9200.125988031126, 9247.075292470834, 9274.30442716799, 13224.801627975588, 13357.866421335857, 13375.933120334335, 13418.865811341957, 13540.322983850965, 4757.381540399795, 4773.947202702801, 4776.928346074812, 4786.664933454625, 4804.975975120102, 868.5874209750318, 892.2415946445599, 901.3510272603714, 905.6422713028317, 920.0753242990752, 21367.0, 21572.56854862894, 21807.0, 21919.123235070736, 22310.442238943833, 948.966786162481, 959.9808003840024, 960.3469640644429, 961.1109723505868, 988.1650005745134, 10802.297850639683, 11204.439778011067, 11304.265222760494, 11347.319300734944, 11414.486348114355, 181420.0, 182755.0, 182988.0, 183243.0, 183854.0807295955, 42096.15807683829, 42096.579034209266, 42375.152496949886, 42436.363454548205, 42447.151056978684, 1185.967366196973, 1235.8640549539723, 1235.9382030898598, 1236.2644226685288, 1238.1518659717942, 19337.8066219336, 19929.601407972048, 20043.398698039084, 20697.27559535409, 21085.789142108384, 30107.795688172228, 38407.42388864113, 39362.60637393704, 39419.605803941595, 39630.0, 163348.0, 163537.0, 164031.1798441048, 164491.0, 164777.17611411866, 30503.237419064702, 30624.693753063075, 30729.0, 30961.845190773904, 30994.69005309918, 35948.10129746777, 36237.0, 37053.81473092617, 37079.0, 37080.62919370772, 28275.0, 28300.71699282981, 28793.7120628791, 28949.7105028947, 29547.40905181927, 27641.0, 27851.58222626622, 28284.292892677848, 28321.43357132887, 29173.7082629171, 30602.234944125685, 31389.8430507846, 31400.528992065596, 31542.842285789342, 31593.52609710902, 27764.44471110526, 28054.0, 28443.28891777722, 28807.711922880502, 29010.12969610915, 21190.364289071353, 23118.57254988202, 23171.88414057919, 23377.41556461102, 23777.881110594335], "value": 14744.21323052554, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [387.2313457786292, 407.2913131151795, 417.2447869356464, 428.7791787229576, 433.75492846541704, 16937.576560585992, 17054.573635659115, 17590.120493975315, 17604.119794010297, 17702.468925932244, 17015.91492042541, 17103.74344384835, 17125.571860703487, 17778.64442711145, 18156.092195390243, 5253.921191182136, 5345.4387289334645, 5523.392426833045, 5525.861853453655, 5530.0, 5294.100002999499, 5356.705381204032, 5364.0, 5364.953834002371, 5367.624266301361, 5130.281760553526, 5328.813491527797, 5343.465653434664, 5346.224797404374, 5371.248025276445, 5381.058314794915, 5417.51242388185, 5424.83725488232, 5429.321334833146, 5440.6735595864375, 4683.0, 4816.7350795706225, 4818.734969576672, 4845.079434907357, 4858.514148585148, 21956.670649940264, 22023.559528809496, 22098.33704988853, 22144.22495212676, 22355.10579576815, 1668.215938508899, 1689.358043943306, 1701.5490894912857, 1701.7362308842148, 1702.3701230544655, 14390.208538530376, 14952.551423457313, 15153.242337883172, 15174.24128793556, 15217.771733424008, 2052.10733331, 2069.3481553310808, 2104.5685634444903, 2114.1543382647064, 2122.61792877282, 88647.0, 90484.19031619397, 90751.54624226836, 90850.0, 91181.54409227977, 10173.33873298248, 10281.53733082013, 10286.428392901775, 10543.89456105429, 10661.253712240068, 13870.237136957565, 13928.0, 14011.579652610439, 14040.85959140416, 14094.224817635128, 6738.764143254963, 6903.792886213421, 6949.235584085746, 7084.964575177091, 7127.82180445493, 6073.119397687399, 6130.601510901777, 6286.842828929313, 6356.68216589178, 6368.522360822957, 6476.805695829133, 6666.600003999775, 6679.165104361955, 6763.613459240843, 6806.863862722717, 1892.4417296897448, 1900.6863867461714, 1908.5419499320062, 1910.293191519119, 2099.992003838166, 839.2195258409738, 849.7026040885764, 862.5816479007676, 867.7873920889423, 890.3856339125982, 16935.745963810554, 17119.22963466647, 17124.74312885308, 17277.222524986406, 17889.19498622565, 859.0807835615956, 862.8403745307138, 865.9653613855501, 868.5830801215452, 886.3662481325754, 8952.731418057469, 9058.909410905939, 9241.907580924239, 9465.574049167804, 9580.408423739585, 356427.0, 361669.0, 366293.0, 366968.0, 367846.0, 72318.63840680763, 72631.63684181651, 75000.62499687467, 75103.24896751072, 75157.24842751611, 1011.5245834457646, 1014.5079636376499, 1037.7094413564214, 1038.1383451735041, 1041.1150522056191, 14571.635709106933, 14700.632484187981, 14766.48317308932, 14807.925960370128, 15449.459268925533, 38742.61257387503, 38958.220835582564, 39919.80040099781, 40321.39517907175, 40690.1861962765, 48939.308338040326, 49262.753686232776, 49403.50596494133, 49498.0, 49749.502504975935, 7875.464284464474, 8223.95888020556, 8263.462874913352, 8312.127226641358, 8316.6673333066, 13792.379342929391, 13980.790288145889, 14082.929585352007, 14103.788443173566, 14167.858321417067, 11014.339139651647, 11235.4382280884, 11517.366544840113, 11678.474468648761, 11885.504044150824, 10688.83966740484, 10777.62278320255, 10836.620718274822, 10847.783044339227, 10937.83593246118, 11537.134714896583, 11538.307701537935, 11582.6525204244, 11658.358790266617, 11871.465784039912, 7933.682652694059, 8114.229148230908, 8144.8778268327205, 8238.83522329538, 8396.412251142361, 11094.445277736242, 11186.161037922351, 11272.549098035986, 11355.261907975955, 11442.370669612917], "value": 8695.093903953728, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1239.32456811038, 1294.4110429754462, 1316.8288122544068, 1319.4392383237127, 1326.6351753267852, 9653.131218190361, 9763.316567840255, 9993.200543956484, 10056.446895420759, 10109.090181883628, 9953.153981911546, 10042.046005629454, 10099.899001009988, 10100.848487272697, 10149.441780702058, 2247.7752224777514, 2280.7491175970713, 2286.8284878634086, 2287.965680514785, 2290.1869836208157, 2163.1023125403017, 2231.2190733243315, 2241.0363543676212, 2248.303026061918, 2253.8422310438277, 2257.849827656419, 2275.7382900966354, 2302.942426439344, 2314.6412306092498, 2323.7908588227056, 2188.485705859122, 2188.7592364839857, 2225.9888700556476, 2229.7658745831695, 2237.0268933014027, 2101.13853320138, 2195.637719776235, 2250.954980900373, 2255.639097744353, 2256.2328808205125, 9539.284553658434, 9548.331616786827, 9579.61681532738, 9619.326647134703, 9638.614455421775, 5535.197396377503, 5728.140778883201, 5733.426657334233, 5761.107028410603, 5779.739911703983, 3103.7361824244967, 3253.4957081652383, 3300.5379246905454, 3318.0, 3344.2141096842224, 1007.2244371833647, 1016.5628779624758, 1030.9896901031043, 1045.9320144190604, 1048.7378155461136, 13951.302434878215, 14007.299635018207, 14028.368723407471, 14117.576472705836, 14145.575632730932, 4607.470140933769, 4678.742669153161, 4777.163996300634, 4784.0, 4804.711717296904, 10097.545610447547, 10153.0, 10169.0, 10188.694339169688, 10196.4391958443, 5367.1680889462195, 5392.865178370494, 5399.973000134974, 5400.973814975142, 5411.702356370437, 4913.533214344631, 4983.90032199354, 5058.595312375001, 5063.822766203165, 5150.356205474316, 3488.354654388946, 3588.1567831559564, 3588.964110358863, 3660.066682995819, 3710.257948410329, 1069.5721711315537, 1072.6567498400436, 1076.7200527862656, 1092.229977865603, 1094.0864378244096, 624.5190756323361, 632.0456111272013, 643.112504743451, 646.5926466326184, 654.2410803467955, 5506.669599824023, 5514.503694667499, 5538.086215774432, 5606.85982850432, 5785.103308987113, 794.8211652378169, 818.1695578987333, 825.6037102190982, 826.8470332988417, 844.5101840932244, 3345.0, 3371.477420999749, 3433.210361616842, 3438.157651375379, 3530.3468858261303, 12467.251964882136, 12925.418356173996, 13017.674558135934, 13157.53948611794, 13195.67010824737, 13087.607371778862, 13129.212247265195, 13134.671633209055, 13149.60551183466, 13196.14225075367, 6854.554453960476, 7167.068281123525, 7263.854722905618, 7264.128304603481, 7294.671739771723, 5564.805231816867, 5611.438856114356, 5859.355470898283, 5917.1715959766525, 6025.548083893813, 11252.0, 11627.127965402799, 11761.764764704829, 11915.82126268124, 11922.0, 11481.94259028733, 11962.401879906143, 12166.209196402206, 12174.086943479097, 12175.817362739388, 8081.111077781322, 8209.343252539664, 8209.384296177692, 8212.0, 8215.424920255524, 8929.330300227639, 9060.637574496946, 9065.048169942062, 9217.0, 9320.254379649476, 7567.697292108474, 7661.272179142972, 7763.378929685498, 7769.951056607286, 7785.416093792875, 7456.552606843607, 7543.358814500829, 7546.735864244725, 7611.505252158592, 7635.770926872203, 7074.186468556182, 7233.674484648309, 7236.855262894818, 7243.0, 7244.166920804175, 4911.754412279443, 4925.261210818406, 4958.801647934042, 5019.67372120811, 5120.564751996122, 4983.75081245929, 5012.398512178562, 5120.6686261573, 5197.740112994259, 5210.244514545294], "value": 4609.439425977445, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [355.0945090020449, 364.26418634358595, 371.6246590943147, 371.8438255932508, 374.17867780222423, 5453.918191227135, 5573.637713548622, 5592.356878958921, 5614.831555053344, 5635.436456354368, 5330.493603107699, 5402.864928376793, 5418.160185171295, 5441.0, 5449.291592093033, 4077.571854955224, 4077.5718549552316, 4089.6114869087387, 4093.140440507497, 4097.44684467596, 3930.6069393060607, 4056.4118202860714, 4077.245709543744, 4078.6737061035196, 4093.385992101179, 4053.391991201314, 4055.087605288801, 4065.4714887064642, 4067.864371205126, 4069.552349241581, 4044.979775101135, 4068.572799856032, 4068.755874647501, 4071.87784366468, 4097.180563887205, 3541.8229088545727, 3551.520544726455, 3551.7978853110976, 3553.4136867416846, 3554.5023696682483, 5210.322658054467, 5293.947060529384, 5309.964556911404, 5326.467353264643, 5336.651873175791, 4736.7631618418945, 4759.333693282943, 4765.451973023078, 4784.808607655689, 4785.712857228543, 5602.215689803431, 5746.706990927049, 5769.163471296639, 5776.624519406268, 5789.565782566325, 3914.4911161548816, 3950.407438884162, 3960.841566337343, 3963.900902477461, 3970.563238043813, 5966.761329546813, 6085.3914608539235, 6135.9079613805825, 6147.047207682861, 6187.597806142587, 3971.4439978403047, 3998.3602623580086, 4001.6198461146146, 4012.7792971386853, 4016.5581786003518, 4046.7976601169826, 4052.858149964737, 4057.1885622875543, 4058.837646494107, 4072.0227145485464, 4663.603593694574, 4732.384789977281, 4736.8105275788585, 4742.857714268508, 4756.881077973078, 5824.155497452845, 5844.26946631671, 5860.120981852671, 5868.589198756132, 5873.823785286363, 1397.1337770582304, 1418.1491105336922, 1419.1697856753708, 1419.5031738891305, 1420.9644758880904, 889.3818795936762, 909.3316412436853, 927.9164875161268, 936.7517607833929, 939.0797018921495, 4976.726280054631, 4984.177610694267, 5003.649744517922, 5012.298278241049, 5029.17018691919, 6012.488938440194, 6059.424354686298, 6062.272527296753, 6069.757209711651, 6087.691146403545, 4833.347498087714, 4975.975120124376, 4980.551750342486, 5000.6249531284575, 5006.299118123466, 3150.7321877640197, 3155.7475401967786, 3157.921051973673, 3170.1916011416943, 3173.7622327292374, 5456.399796022434, 5546.417626149197, 5555.972220138954, 5577.637453565505, 5586.91619625706, 6166.599171053867, 6171.938280617226, 6195.938040619536, 6210.347913469021, 6219.191505104398, 5534.889302213933, 5545.584081194007, 5548.167774833726, 5567.8886422272135, 5568.136938774496, 5884.735186916513, 5984.251968503937, 5986.191864098291, 6029.78895738647, 6030.90953635687, 5893.410658934073, 5896.909071821727, 5916.230889984275, 5946.137810017437, 5957.582969192115, 5411.702356370437, 5539.279893613804, 5541.5289700375915, 5560.499555040065, 5562.499375056264, 4003.319435695997, 4028.4762980812307, 4039.8788036358956, 4040.9797951010055, 4065.3088974874936, 5919.674417906885, 5996.520278377807, 6061.696915154136, 6065.636061836304, 6086.452219300284, 5814.418558144321, 5823.679697616672, 5827.970860145672, 5832.883342333044, 5858.912116318344, 5801.680907550125, 5823.301203855564, 5834.358220595816, 5847.356790752929, 5858.2677165354335, 5652.660840349592, 5705.971470142623, 5746.885062298814, 5760.798372056958, 5778.0, 5851.678157701367, 5861.413858614104, 5868.823935281948, 5870.207521984477, 5895.0, 5599.80400685974, 5610.9158362623775, 5615.691136987341, 5668.688222147656, 5687.658740475585], "value": 4295.136186065898, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [741.8701727197739, 745.6979923131132, 765.3609236287696, 773.3272053313615, 777.9844403111938, 11913.0, 12415.068869834753, 12622.810657840128, 13328.600141995743, 13341.466341346335, 14617.415303387852, 14728.263586820669, 15193.0, 15229.543113706579, 15300.846991530081, 767.7312940470832, 812.7196117339508, 819.3772732723144, 823.2919689067397, 826.0954255090666, 875.0287181228831, 875.0724232313736, 876.5310558851016, 882.0297672560165, 882.8896387951506, 909.5497728624307, 912.8813254276935, 916.2532535983186, 918.8392031394512, 918.9954050229773, 910.2308549275851, 911.4759013567159, 912.63494602159, 914.1498406481969, 916.702071826659, 674.0193019157115, 674.1101745695684, 674.2482132422314, 674.5379415100623, 675.7398401615413, 13374.063815532916, 13397.0, 13412.46350145993, 13899.722005559832, 13955.232462214573, 15560.22198890051, 15599.1420471874, 15749.291281892229, 16013.519594412186, 16069.678606427806, 12517.624471265877, 12521.436535355931, 12575.622731317984, 12598.748025039447, 12691.175073620278, 2897.1453421240785, 2923.2253452835016, 2923.429931163424, 2927.8536073196256, 2930.106317573139, 65443.3455665442, 66085.0, 66821.66589167072, 67689.0, 69079.0, 10725.0, 10843.132549396028, 11040.282381645167, 11375.658730238107, 11443.828342574869, 21512.78487215139, 21726.565468690536, 22176.223832165797, 22360.440988975406, 22593.4351641207, 5856.472917437451, 5913.201717768132, 6048.879022419527, 6097.634141951408, 6102.206713127265, 2899.492588796952, 2945.0575815739185, 2954.3648115655237, 2957.5711521829217, 2980.0612806965737, 3344.7491438142238, 3408.522806807049, 3423.5891692997, 3441.346144232588, 3526.347625689256, 688.9896651550231, 689.055993289187, 689.5793565924782, 691.1602403080282, 694.6804469943781, 575.8790653962631, 588.9587728859025, 591.2432086928652, 594.174098003775, 605.6154341992866, 9236.603133419765, 9685.515724213901, 9723.902760972442, 9743.853842192373, 10127.0, 576.8846230753866, 581.1892410087904, 581.8632621333983, 582.6766144789682, 582.6882617799541, 4382.824687012484, 4545.159145558082, 4565.931511027337, 4567.314902764612, 4599.33309670096, 62264.688676556325, 62266.377336226054, 62780.686096569225, 62927.0, 65005.0, 54643.0, 56256.718716406154, 58533.41466585365, 58608.41391586115, 59704.70147649234, 46538.0, 47336.289955650696, 47822.28266576004, 49096.75451622719, 49229.261561076615, 9457.38526995743, 9921.454320012468, 10102.242331824995, 10346.586136554453, 10389.636362727268, 24646.0, 24796.50406991814, 24956.875215623804, 25208.36979075538, 26136.60795088113, 29749.702502974695, 41209.0, 41981.79009105057, 42302.0, 43209.13581728285, 12642.87357126417, 12680.175788573713, 12814.55149069778, 12929.935350323189, 12949.482020719066, 15851.603709906884, 16388.590285242964, 16390.836091638932, 16631.251593678557, 17118.229679664695, 14732.263386830402, 15021.24893755286, 15361.001534900195, 15636.374545018527, 15899.04605723614, 14250.14499130014, 14443.0, 14731.484398046017, 15252.923735381251, 15333.310001049756, 14176.929115354356, 14180.645483862985, 14673.0, 15893.125878076355, 16023.679526409172, 9864.654737084167, 10128.139108175594, 10128.84806727885, 10143.949280253551, 10240.48797560134, 11283.605073822377, 11698.122640802145, 11794.46924888365, 11911.463984120908, 12005.699857503283], "value": 6750.224700758593, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1550.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 111.0, 112.0, 114.0, 113.0, 114.0, 114.0, 114.0, 112.0, 113.0], "value": 112.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 125.0, 128.0, 173.0, 127.0, 126.0, 124.0, 128.0, 146.0, 126.0], "value": 136.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 165.0, 164.0, 164.0, 165.0, 167.0, 174.0, 165.0, 165.0, 162.0], "value": 165.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 74.0, 78.0, 104.0, 79.0, 76.0, 75.0, 76.0, 101.0, 76.0], "value": 81.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 83.0, 111.0, 83.0, 85.0, 84.0, 97.0, 85.0, 85.0, 106.0], "value": 90.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 120.0, 114.0, 115.0, 114.0, 114.0, 115.0, 114.0, 118.0, 114.0], "value": 115.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 151.0, 151.0, 152.0, 150.0, 152.0, 151.0, 151.0, 151.0, 152.0], "value": 151.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 100.0, 95.0, 94.0, 99.0, 102.0, 95.0, 95.0], "value": 96.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 54.0, 58.0, 56.0, 56.0, 59.0, 60.0, 56.0, 56.0, 57.0], "value": 57.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 57.0, 59.0, 58.0, 59.0, 56.0, 58.0, 57.0, 56.0, 56.0], "value": 57.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 81.0, 83.0, 86.0, 84.0, 83.0, 83.0, 83.0, 82.0], "value": 83.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 134.0, 133.0, 133.0, 133.0, 134.0, 136.0, 130.0, 186.0, 135.0], "value": 139.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [189.0, 195.0, 204.0, 193.0, 193.0, 194.0, 197.0, 196.0, 186.0, 188.0], "value": 193.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 71.0, 71.0, 71.0, 74.0, 72.0, 72.0, 75.0, 71.0, 74.0], "value": 72.5, "unit": "score"}]}]} 09:05:38 INFO - Return code: 0 09:05:39 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:05:39 INFO - # TBPL SUCCESS # 09:05:39 INFO - Running post-action listener: _resource_record_post_action 09:05:39 INFO - [mozharness: 2017-05-23 16:05:39.044527Z] Finished run-tests step (success) 09:05:39 INFO - Running post-run listener: _resource_record_post_run 09:05:39 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 4096; Write bytes: 407261184; Read time: 12; Write time: 209940 09:05:39 INFO - TinderboxPrint: CPU usage
13.3% 09:05:39 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 09:05:39 INFO - TinderboxPrint: I/O write bytes / time
407,261,184 / 209,940 09:05:39 INFO - TinderboxPrint: CPU idle
8,286.7 (86.7%) 09:05:39 INFO - TinderboxPrint: CPU user
1,220.3 (12.8%) 09:05:39 INFO - TinderboxPrint: Swap in / out
0 / 0 09:05:39 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 100016128; Read time: 0; Write time: 65140 09:05:39 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 0; Write bytes: 307245056; Read time: 0; Write time: 144800 09:05:39 INFO - Running post-run listener: _upload_blobber_files 09:05:39 INFO - Blob upload gear active. 09:05:39 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:05: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:05: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', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:05: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 -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:05:40 INFO - (blobuploader) - INFO - Open directory for files ... 09:05:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:05:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:05:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:05:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:05:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:05:41 INFO - (blobuploader) - INFO - Done attempting. 09:05:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:05:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:05:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:05:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:05:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:05:41 INFO - (blobuploader) - INFO - Done attempting. 09:05:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:05:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:05:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:05:44 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:05:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:05:44 INFO - (blobuploader) - INFO - Done attempting. 09:05:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 09:05:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:05:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:05:45 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 09:05:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:05:45 INFO - (blobuploader) - INFO - Done attempting. 09:05:45 INFO - (blobuploader) - INFO - Iteration through files over. 09:05:45 INFO - Return code: 0 09:05:45 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:05:45 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:05:45 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/874715166e1ec91cabc515a8c28b077cf498b925a0a83f8f3dd051b85fe5c8375ace4d5c49952a778b05ce72a005724c90f23a4a6dcaccad53937233ec6f2f0b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c51477c6d6c6449a0ee17ec7c0fa04ee81923a775f9685971592dc5acc9e40f8470f66a7705397f0702bfd4bcd472675e0d9827b4cbea46891483ef79d2deea9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ca59dd071b5777b3467bd9dda25c392d34f73311610c25f12da38997df0042f70926fac401d7794253180da66e41db9060fe628832df1d4e0cd45ed288073754", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4c3da0b240456ca65b9252f4671d107faa86585c4fdaed16873d2a82e044168436733fc68afaaee7a81514e02e3544bdfc7c614744e1957ae4e4cbd6a2afc257"} 09:05:45 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:05:45 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:05:45 INFO - Contents: 09:05:45 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/874715166e1ec91cabc515a8c28b077cf498b925a0a83f8f3dd051b85fe5c8375ace4d5c49952a778b05ce72a005724c90f23a4a6dcaccad53937233ec6f2f0b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c51477c6d6c6449a0ee17ec7c0fa04ee81923a775f9685971592dc5acc9e40f8470f66a7705397f0702bfd4bcd472675e0d9827b4cbea46891483ef79d2deea9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ca59dd071b5777b3467bd9dda25c392d34f73311610c25f12da38997df0042f70926fac401d7794253180da66e41db9060fe628832df1d4e0cd45ed288073754", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4c3da0b240456ca65b9252f4671d107faa86585c4fdaed16873d2a82e044168436733fc68afaaee7a81514e02e3544bdfc7c614744e1957ae4e4cbd6a2afc257"} 09:05:45 INFO - Running post-run listener: copy_logs_to_upload_dir 09:05:45 INFO - Copying logs to upload dir... 09:05:45 INFO - mkdir: /builds/slave/test/build/upload/logs 09:05:45 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1314.817561 ========= master_lag: -0.08 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 54 secs) (at 2017-05-23 09:05:44.762947) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-23 09:05:44.767388) ========= 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-1495553394.737407-1522700916 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/874715166e1ec91cabc515a8c28b077cf498b925a0a83f8f3dd051b85fe5c8375ace4d5c49952a778b05ce72a005724c90f23a4a6dcaccad53937233ec6f2f0b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c51477c6d6c6449a0ee17ec7c0fa04ee81923a775f9685971592dc5acc9e40f8470f66a7705397f0702bfd4bcd472675e0d9827b4cbea46891483ef79d2deea9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ca59dd071b5777b3467bd9dda25c392d34f73311610c25f12da38997df0042f70926fac401d7794253180da66e41db9060fe628832df1d4e0cd45ed288073754", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4c3da0b240456ca65b9252f4671d107faa86585c4fdaed16873d2a82e044168436733fc68afaaee7a81514e02e3544bdfc7c614744e1957ae4e4cbd6a2afc257"} build_url:https://queue.taskcluster.net/v1/task/XE0t9r5GTv2aF_bkVa-y1g/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011372 build_url: 'https://queue.taskcluster.net/v1/task/XE0t9r5GTv2aF_bkVa-y1g/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/874715166e1ec91cabc515a8c28b077cf498b925a0a83f8f3dd051b85fe5c8375ace4d5c49952a778b05ce72a005724c90f23a4a6dcaccad53937233ec6f2f0b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c51477c6d6c6449a0ee17ec7c0fa04ee81923a775f9685971592dc5acc9e40f8470f66a7705397f0702bfd4bcd472675e0d9827b4cbea46891483ef79d2deea9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ca59dd071b5777b3467bd9dda25c392d34f73311610c25f12da38997df0042f70926fac401d7794253180da66e41db9060fe628832df1d4e0cd45ed288073754", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4c3da0b240456ca65b9252f4671d107faa86585c4fdaed16873d2a82e044168436733fc68afaaee7a81514e02e3544bdfc7c614744e1957ae4e4cbd6a2afc257"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-23 09:05:44.795086) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-23 09:05:44.795501) ========= 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-1495553394.737407-1522700916 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004440 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-23 09:05:44.875891) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-23 09:05:44.876240) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-23 09:05:44.876565) ========= ========= Total master_lag: 0.08 =========