builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-068 starttime: 1494586330.32 results: success (0) revision: 8a7d0b15595f9916123848ca906f29c62d4914c9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-12 03:52:10.317615) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-12 03:52:10.318049) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-12 03:52:10.318322) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-12 03:52:10.358259) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-12 03:52:10.358520) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1494585323.378922-522741995 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-12 03:52:10-- 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% 216M=0s 2017-05-12 03:52:10 (216 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.105214 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-12 03:52:10.482830) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-12 03:52:10.483351) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1494585323.378922-522741995 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022846 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-12 03:52:10.534811) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-12 03:52:10.535202) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 8a7d0b15595f9916123848ca906f29c62d4914c9 --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 8a7d0b15595f9916123848ca906f29c62d4914c9 --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=97facb8ba2ac28944cc45e6b000001d4-1494585323.378922-522741995 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-12 03:52:10,580 truncating revision to first 12 chars 2017-05-12 03:52:10,580 Setting DEBUG logging. 2017-05-12 03:52:10,580 attempt 1/10 2017-05-12 03:52:10,580 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/8a7d0b15595f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-12 03:52:10,944 unpacking tar archive at: mozilla-central-8a7d0b15595f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.695859 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-12 03:52:11.245410) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-12 03:52:11.245724) ========= script_repo_revision: 8a7d0b15595f9916123848ca906f29c62d4914c9 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-12 03:52:11.246529) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-12 03:52:11.246803) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-12 03:52:11.265014) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2017-05-12 03:52:11.265286) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=97facb8ba2ac28944cc45e6b000001d4-1494585323.378922-522741995 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:52:11 INFO - MultiFileLogger online at 20170512 03:52:11 in /builds/slave/test 03:52:11 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 03:52:11 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:52:11 INFO - {'append_to_log': False, 03:52:11 INFO - 'base_work_dir': '/builds/slave/test', 03:52:11 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 03:52:11 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:52:11 INFO - 'branch': 'Firefox-Non-PGO', 03:52:11 INFO - 'buildbot_json_path': 'buildprops.json', 03:52:11 INFO - 'config_files': ('talos/linux_config.py',), 03:52:11 INFO - 'default_actions': ('clobber', 03:52:11 INFO - 'read-buildbot-config', 03:52:11 INFO - 'download-and-extract', 03:52:11 INFO - 'populate-webroot', 03:52:11 INFO - 'create-virtualenv', 03:52:11 INFO - 'install', 03:52:11 INFO - 'run-tests'), 03:52:11 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:52:11 INFO - 'download_minidump_stackwalk': True, 03:52:11 INFO - 'download_symbols': 'ondemand', 03:52:11 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:52:11 INFO - 'tooltool.py': '/tools/tooltool.py', 03:52:11 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:52:11 INFO - '/tools/misc-python/virtualenv.py')}, 03:52:11 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:52:11 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:52:11 INFO - 'gecko_profile': False, 03:52:11 INFO - 'gecko_profile_interval': 0, 03:52:11 INFO - 'installer_path': 'installer.exe', 03:52:11 INFO - 'log_level': 'info', 03:52:11 INFO - 'log_name': 'talos', 03:52:11 INFO - 'log_to_console': True, 03:52:11 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:52:11 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:52:11 INFO - 'opt_config_files': (), 03:52:11 INFO - 'pip_index': False, 03:52:11 INFO - 'suite': 'dromaeojs-e10s', 03:52:11 INFO - 'system_bits': '32', 03:52:11 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:52:11 INFO - 'title': 'talos-linux64-ix-068', 03:52:11 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:52:11 INFO - 'use_talos_json': True, 03:52:11 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:52:11 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:52:11 INFO - 'work_dir': 'build'} 03:52:11 INFO - [mozharness: 2017-05-12 10:52:11.405997Z] Running clobber step. 03:52:11 INFO - Running pre-action listener: _resource_record_pre_action 03:52:11 INFO - Running main action method: clobber 03:52:11 INFO - rmtree: /builds/slave/test/build 03:52:11 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:52:12 INFO - Running post-action listener: _resource_record_post_action 03:52:12 INFO - [mozharness: 2017-05-12 10:52:12.401395Z] Finished clobber step (success) 03:52:12 INFO - [mozharness: 2017-05-12 10:52:12.401494Z] Running read-buildbot-config step. 03:52:12 INFO - Running pre-action listener: _resource_record_pre_action 03:52:12 INFO - Running main action method: read_buildbot_config 03:52:12 INFO - Using buildbot properties: 03:52:12 INFO - { 03:52:12 INFO - "project": "", 03:52:12 INFO - "product": "firefox", 03:52:12 INFO - "who": "nobody@mozilla.org", 03:52:12 INFO - "installer_path": "public/build/target.tar.bz2", 03:52:12 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 03:52:12 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 03:52:12 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 03:52:12 INFO - "stage_platform": "linux64", 03:52:12 INFO - "basedir": "/builds/slave/test", 03:52:12 INFO - "buildnumber": 872, 03:52:12 INFO - "platform": "ubuntu64_hw", 03:52:12 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 03:52:12 INFO - "slavebuilddir": "test", 03:52:12 INFO - "taskId": "Cp2I1WUsQXusat18xK6LEQ", 03:52:12 INFO - "branch": "mozilla-central", 03:52:12 INFO - "script_repo_revision": "production", 03:52:12 INFO - "revision": "8a7d0b15595f9916123848ca906f29c62d4914c9", 03:52:12 INFO - "slavename": "talos-linux64-ix-068", 03:52:12 INFO - "repo_path": "mozilla-central" 03:52:12 INFO - } 03:52:12 INFO - Finding installer, test and symbols from parent task. 03:52:12 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Cp2I1WUsQXusat18xK6LEQ'}, attempt #1 03:52:12 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Cp2I1WUsQXusat18xK6LEQ'}, attempt #1 03:52:13 INFO - Task dependencies: Jt9B3QZUS5CaIvbQegJIuA 03:52:13 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Jt9B3QZUS5CaIvbQegJIuA'}, attempt #1 03:52:13 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/Jt9B3QZUS5CaIvbQegJIuA/artifacts/public/build/target.tar.bz2 03:52:13 INFO - Set test_url: https://queue.taskcluster.net/v1/task/Jt9B3QZUS5CaIvbQegJIuA/artifacts/public/build/test_packages.json 03:52:13 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/Jt9B3QZUS5CaIvbQegJIuA/artifacts/public/build/target.crashreporter-symbols.zip 03:52:13 INFO - Running post-action listener: _resource_record_post_action 03:52:13 INFO - [mozharness: 2017-05-12 10:52:13.761883Z] Finished read-buildbot-config step (success) 03:52:13 INFO - [mozharness: 2017-05-12 10:52:13.762100Z] Running download-and-extract step. 03:52:13 INFO - Running pre-action listener: _resource_record_pre_action 03:52:13 INFO - Running main action method: download_and_extract 03:52:13 INFO - mkdir: /builds/slave/test/build/tests 03:52:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:52:13 INFO - trying https://queue.taskcluster.net/v1/task/Jt9B3QZUS5CaIvbQegJIuA/artifacts/public/build/target.test_packages.json 03:52:13 INFO - Downloading https://queue.taskcluster.net/v1/task/Jt9B3QZUS5CaIvbQegJIuA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 03:52:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Jt9B3QZUS5CaIvbQegJIuA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 03:52:14 INFO - Downloaded 986 bytes. 03:52:14 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 03:52:14 INFO - Using the following test package requirements: 03:52:14 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 03:52:14 INFO - u'common': [u'target.common.tests.zip'], 03:52:14 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 03:52:14 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 03:52:14 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 03:52:14 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 03:52:14 INFO - u'mozbase': [u'target.common.tests.zip'], 03:52:14 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 03:52:14 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 03:52:14 INFO - u'web-platform': [u'target.common.tests.zip', 03:52:14 INFO - u'target.web-platform.tests.zip'], 03:52:14 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 03:52:14 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 03:52:14 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Jt9B3QZUS5CaIvbQegJIuA/artifacts/public/build/target.common.tests.zip 03:52:14 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Jt9B3QZUS5CaIvbQegJIuA/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:52:14 INFO - Fetch https://queue.taskcluster.net/v1/task/Jt9B3QZUS5CaIvbQegJIuA/artifacts/public/build/target.common.tests.zip into memory 03:52:16 INFO - Content-Length response header: 60743182 03:52:16 INFO - Bytes received: 60743182 03:52:26 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 03:52:26 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Jt9B3QZUS5CaIvbQegJIuA/artifacts/public/build/target.common.tests.zip 03:52:26 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Jt9B3QZUS5CaIvbQegJIuA/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:52:26 INFO - Fetch https://queue.taskcluster.net/v1/task/Jt9B3QZUS5CaIvbQegJIuA/artifacts/public/build/target.common.tests.zip into memory 03:52:28 INFO - Content-Length response header: 60743182 03:52:28 INFO - Bytes received: 60743182 03:52:39 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Jt9B3QZUS5CaIvbQegJIuA/artifacts/public/build/target.talos.tests.zip 03:52:39 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Jt9B3QZUS5CaIvbQegJIuA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 03:52:39 INFO - Fetch https://queue.taskcluster.net/v1/task/Jt9B3QZUS5CaIvbQegJIuA/artifacts/public/build/target.talos.tests.zip into memory 03:52:40 INFO - Content-Length response header: 14409411 03:52:40 INFO - Bytes received: 14409411 03:52: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')]} 03:52:40 INFO - trying https://queue.taskcluster.net/v1/task/Jt9B3QZUS5CaIvbQegJIuA/artifacts/public/build/target.tar.bz2 03:52:40 INFO - Downloading https://queue.taskcluster.net/v1/task/Jt9B3QZUS5CaIvbQegJIuA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 03:52:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Jt9B3QZUS5CaIvbQegJIuA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 03:52:42 INFO - Downloaded 68949041 bytes. 03:52:42 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Jt9B3QZUS5CaIvbQegJIuA/artifacts/public/build/target.tar.bz2 03:52:42 INFO - mkdir: /builds/slave/test/properties 03:52:42 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:52:42 INFO - Writing to file /builds/slave/test/properties/build_url 03:52:42 INFO - Contents: 03:52:42 INFO - build_url:https://queue.taskcluster.net/v1/task/Jt9B3QZUS5CaIvbQegJIuA/artifacts/public/build/target.tar.bz2 03:52:42 INFO - Running post-action listener: _resource_record_post_action 03:52:42 INFO - Running post-action listener: set_extra_try_arguments 03:52:42 INFO - [mozharness: 2017-05-12 10:52:42.600225Z] Finished download-and-extract step (success) 03:52:42 INFO - [mozharness: 2017-05-12 10:52:42.600398Z] Running populate-webroot step. 03:52:42 INFO - Running pre-action listener: _resource_record_pre_action 03:52:42 INFO - Running main action method: populate_webroot 03:52:42 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:52:42 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:52:42 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:52:42 INFO - '--tppagecycles', 03:52:42 INFO - '7'], 03:52:42 INFO - 'tests': ['tsvgm']}}, 03:52:42 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:52:42 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:52:42 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:52:42 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:52:42 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:52:42 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:52:42 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 03:52:42 INFO - 'talos_options': ['--disable-e10s'], 03:52:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:52:42 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 03:52:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:52:42 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 03:52:42 INFO - 'talos_options': ['--disable-e10s'], 03:52:42 INFO - 'tests': ['damp', 'tps']}, 03:52:42 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 03:52:42 INFO - 'tests': ['damp', 'tps']}, 03:52:42 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:52:42 INFO - 'tests': ['dromaeo_dom']}, 03:52:42 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:52:42 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:52:42 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 03:52:42 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 03:52:42 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:52:42 INFO - 'tests': ['a11yr', 03:52:42 INFO - 'ts_paint', 03:52:42 INFO - 'tpaint', 03:52:42 INFO - 'sessionrestore', 03:52:42 INFO - 'sessionrestore_no_auto_restore', 03:52:42 INFO - 'tabpaint']}, 03:52:42 INFO - 'other-e10s': {'tests': ['a11yr', 03:52:42 INFO - 'ts_paint', 03:52:42 INFO - 'tpaint', 03:52:42 INFO - 'sessionrestore', 03:52:42 INFO - 'sessionrestore_no_auto_restore', 03:52:42 INFO - 'tabpaint']}, 03:52:42 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:52:42 INFO - 'ts_paint', 03:52:42 INFO - 'tpaint', 03:52:42 INFO - 'sessionrestore', 03:52:42 INFO - 'sessionrestore_no_auto_restore', 03:52:42 INFO - 'tabpaint']}, 03:52:42 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:52:42 INFO - 'ts_paint', 03:52:42 INFO - 'tpaint', 03:52:42 INFO - 'sessionrestore', 03:52:42 INFO - 'sessionrestore_no_auto_restore', 03:52:42 INFO - 'tabpaint']}, 03:52:42 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:52:42 INFO - 'tests': ['a11yr', 03:52:42 INFO - 'ts_paint', 03:52:42 INFO - 'tpaint', 03:52:42 INFO - 'sessionrestore', 03:52:42 INFO - 'sessionrestore_no_auto_restore', 03:52:42 INFO - 'tabpaint']}, 03:52:42 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:52:42 INFO - 'tests': ['a11yr', 03:52:42 INFO - 'ts_paint', 03:52:42 INFO - 'tpaint', 03:52:42 INFO - 'sessionrestore', 03:52:42 INFO - 'sessionrestore_no_auto_restore', 03:52:42 INFO - 'tabpaint']}, 03:52:42 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 03:52:42 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 03:52:42 INFO - 'bloom_basic_ref']}, 03:52:42 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:52:42 INFO - 'tests': ['tsvgx', 03:52:42 INFO - 'tsvgr_opacity', 03:52:42 INFO - 'tart', 03:52:42 INFO - 'tscrollx', 03:52:42 INFO - 'cart', 03:52:42 INFO - 'tsvg_static']}, 03:52:42 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:52:42 INFO - 'tsvgr_opacity', 03:52:42 INFO - 'tart', 03:52:42 INFO - 'tscrollx', 03:52:42 INFO - 'cart', 03:52:42 INFO - 'tsvg_static']}, 03:52:42 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 03:52:42 INFO - 'talos_options': ['--disable-e10s'], 03:52:42 INFO - 'tests': ['tp5o']}, 03:52:42 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 03:52:42 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 03:52:42 INFO - 'talos_options': ['--disable-e10s', 03:52:42 INFO - '--xperf_path', 03:52:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:52:42 INFO - 'tests': ['tp5n']}, 03:52:42 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 03:52:42 INFO - 'talos_options': ['--xperf_path', 03:52:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:52:42 INFO - 'tests': ['tp5n']}}, 03:52:42 INFO - 'talos.zip': {'path': '', 03:52:42 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:52:42 INFO - Running post-action listener: _resource_record_post_action 03:52:42 INFO - [mozharness: 2017-05-12 10:52:42.621417Z] Finished populate-webroot step (success) 03:52:42 INFO - [mozharness: 2017-05-12 10:52:42.621505Z] Running create-virtualenv step. 03:52:42 INFO - Running pre-action listener: _resource_record_pre_action 03:52:42 INFO - Running main action method: create_virtualenv 03:52:42 INFO - Creating virtualenv /builds/slave/test/build/venv 03:52:42 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 03:52:42 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:52:42 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:52:42 INFO - Using real prefix '/usr' 03:52:42 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:52:43 INFO - Installing distribute.............................................................................................................................................................................................done. 03:52:45 INFO - Installing pip.................done. 03:52:45 INFO - Return code: 0 03:52:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:52:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:52:45 INFO - Reading from file tmpfile_stdout 03:52:45 INFO - Output received: 03:52:45 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 03:52:45 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:52:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:52:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:52:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:52:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:52:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26861f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2852a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29f8770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29f5a30>, '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 0x29f67f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29f6ca0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1494585323.378922-522741995', '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 03:52:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:52:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:52:45 INFO - Using env: {'DISPLAY': ':0', 03:52:45 INFO - 'HOME': '/home/cltbld', 03:52:45 INFO - 'LANG': 'en_US.UTF-8', 03:52:45 INFO - 'LANGUAGE': 'en_US:en', 03:52:45 INFO - 'LOGNAME': 'cltbld', 03:52:45 INFO - 'MAIL': '/var/mail/cltbld', 03:52:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:52:45 INFO - 'MOZ_NO_REMOTE': '1', 03:52:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:52:45 INFO - 'NO_EM_RESTART': '1', 03:52:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:52:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:52:45 INFO - 'PWD': '/builds/slave/test', 03:52:45 INFO - 'SHELL': '/bin/bash', 03:52:45 INFO - 'SHLVL': '1', 03:52:45 INFO - 'TERM': 'linux', 03:52:45 INFO - 'TMOUT': '86400', 03:52:45 INFO - 'USER': 'cltbld', 03:52:45 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1494585323.378922-522741995', 03:52:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:52:45 INFO - '_': '/tools/buildbot/bin/python'} 03:52:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:52:45 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 03:52:45 INFO - Cleaning up... 03:52:45 INFO - Return code: 0 03:52:45 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:52:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:52:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:52:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:52:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:52:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26861f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2852a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29f8770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29f5a30>, '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 0x29f67f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29f6ca0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1494585323.378922-522741995', '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 03:52:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 03:52:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 03:52:45 INFO - Using env: {'DISPLAY': ':0', 03:52:45 INFO - 'HOME': '/home/cltbld', 03:52:45 INFO - 'LANG': 'en_US.UTF-8', 03:52:45 INFO - 'LANGUAGE': 'en_US:en', 03:52:45 INFO - 'LOGNAME': 'cltbld', 03:52:45 INFO - 'MAIL': '/var/mail/cltbld', 03:52:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:52:45 INFO - 'MOZ_NO_REMOTE': '1', 03:52:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:52:45 INFO - 'NO_EM_RESTART': '1', 03:52:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:52:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:52:45 INFO - 'PWD': '/builds/slave/test', 03:52:45 INFO - 'SHELL': '/bin/bash', 03:52:45 INFO - 'SHLVL': '1', 03:52:45 INFO - 'TERM': 'linux', 03:52:45 INFO - 'TMOUT': '86400', 03:52:45 INFO - 'USER': 'cltbld', 03:52:45 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1494585323.378922-522741995', 03:52:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:52:45 INFO - '_': '/tools/buildbot/bin/python'} 03:52:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:52:45 INFO - Downloading/unpacking psutil>=3.1.1 03:52:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:52:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:52:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:52:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:52:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:52:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:52:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:52:47 INFO - Installing collected packages: psutil 03:52:47 INFO - Running setup.py install for psutil 03:52:47 INFO - building 'psutil._psutil_linux' extension 03:52:47 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 03:52:47 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 03:52:47 INFO - building 'psutil._psutil_posix' extension 03:52:47 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 03:52:47 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 03:52:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:52:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:52:47 INFO - Successfully installed psutil 03:52:47 INFO - Cleaning up... 03:52:47 INFO - Return code: 0 03:52:47 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:52:47 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')]} 03:52:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:52:47 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')]} 03:52:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:52:47 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 0x26861f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2852a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29f8770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29f5a30>, '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 0x29f67f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29f6ca0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1494585323.378922-522741995', '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 03:52:47 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 03:52:47 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 03:52:47 INFO - Using env: {'DISPLAY': ':0', 03:52:47 INFO - 'HOME': '/home/cltbld', 03:52:47 INFO - 'LANG': 'en_US.UTF-8', 03:52:47 INFO - 'LANGUAGE': 'en_US:en', 03:52:47 INFO - 'LOGNAME': 'cltbld', 03:52:47 INFO - 'MAIL': '/var/mail/cltbld', 03:52:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:52:47 INFO - 'MOZ_NO_REMOTE': '1', 03:52:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:52:47 INFO - 'NO_EM_RESTART': '1', 03:52:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:52:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:52:47 INFO - 'PWD': '/builds/slave/test', 03:52:47 INFO - 'SHELL': '/bin/bash', 03:52:47 INFO - 'SHLVL': '1', 03:52:47 INFO - 'TERM': 'linux', 03:52:47 INFO - 'TMOUT': '86400', 03:52:47 INFO - 'USER': 'cltbld', 03:52:47 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1494585323.378922-522741995', 03:52:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:52:47 INFO - '_': '/tools/buildbot/bin/python'} 03:52:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:52:47 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:52:47 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 03:52:47 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 03:52:47 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 03:52:47 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 03:52:48 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:52:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:52:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:52:48 INFO - Installing collected packages: mozsystemmonitor 03:52:48 INFO - Running setup.py install for mozsystemmonitor 03:52:49 INFO - Successfully installed mozsystemmonitor 03:52:49 INFO - Cleaning up... 03:52:49 INFO - Return code: 0 03:52:49 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:52:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:52:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:52:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:52:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:52:49 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 0x26861f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2852a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29f8770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29f5a30>, '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 0x29f67f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29f6ca0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1494585323.378922-522741995', '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 03:52:49 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 03:52:49 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 03:52:49 INFO - Using env: {'DISPLAY': ':0', 03:52:49 INFO - 'HOME': '/home/cltbld', 03:52:49 INFO - 'LANG': 'en_US.UTF-8', 03:52:49 INFO - 'LANGUAGE': 'en_US:en', 03:52:49 INFO - 'LOGNAME': 'cltbld', 03:52:49 INFO - 'MAIL': '/var/mail/cltbld', 03:52:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:52:49 INFO - 'MOZ_NO_REMOTE': '1', 03:52:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:52:49 INFO - 'NO_EM_RESTART': '1', 03:52:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:52:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:52:49 INFO - 'PWD': '/builds/slave/test', 03:52:49 INFO - 'SHELL': '/bin/bash', 03:52:49 INFO - 'SHLVL': '1', 03:52:49 INFO - 'TERM': 'linux', 03:52:49 INFO - 'TMOUT': '86400', 03:52:49 INFO - 'USER': 'cltbld', 03:52:49 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1494585323.378922-522741995', 03:52:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:52:49 INFO - '_': '/tools/buildbot/bin/python'} 03:52:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:52:49 INFO - Downloading/unpacking jsonschema==2.5.1 03:52:49 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 03:52:49 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 03:52:49 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 03:52:49 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 03:52:50 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:52:50 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:52:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:52:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:52:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:52:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:52:50 INFO - Downloading functools32-3.2.3-2.tar.gz 03:52:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:52:50 INFO - warning: no files found matching '*.txt' 03:52:50 INFO - no previously-included directories found matching 'build' 03:52:50 INFO - no previously-included directories found matching 'dist' 03:52:50 INFO - no previously-included directories found matching '.git*' 03:52:50 INFO - Installing collected packages: jsonschema, functools32 03:52:50 INFO - Running setup.py install for functools32 03:52:50 INFO - warning: no files found matching '*.txt' 03:52:50 INFO - no previously-included directories found matching 'build' 03:52:50 INFO - no previously-included directories found matching 'dist' 03:52:50 INFO - no previously-included directories found matching '.git*' 03:52:50 INFO - Successfully installed jsonschema functools32 03:52:50 INFO - Cleaning up... 03:52:50 INFO - Return code: 0 03:52:50 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:52:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:52:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:52:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:52:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:52:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x26861f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2852a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29f8770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29f5a30>, '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 0x29f67f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29f6ca0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1494585323.378922-522741995', '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 03:52:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 03:52:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 03:52:50 INFO - Using env: {'DISPLAY': ':0', 03:52:50 INFO - 'HOME': '/home/cltbld', 03:52:50 INFO - 'LANG': 'en_US.UTF-8', 03:52:50 INFO - 'LANGUAGE': 'en_US:en', 03:52:50 INFO - 'LOGNAME': 'cltbld', 03:52:50 INFO - 'MAIL': '/var/mail/cltbld', 03:52:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:52:50 INFO - 'MOZ_NO_REMOTE': '1', 03:52:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:52:50 INFO - 'NO_EM_RESTART': '1', 03:52:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:52:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:52:50 INFO - 'PWD': '/builds/slave/test', 03:52:50 INFO - 'SHELL': '/bin/bash', 03:52:50 INFO - 'SHLVL': '1', 03:52:50 INFO - 'TERM': 'linux', 03:52:50 INFO - 'TMOUT': '86400', 03:52:50 INFO - 'USER': 'cltbld', 03:52:50 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1494585323.378922-522741995', 03:52:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:52:50 INFO - '_': '/tools/buildbot/bin/python'} 03:52:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:52:50 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:52:50 INFO - Cleaning up... 03:52:50 INFO - Return code: 0 03:52:50 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:52:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:52:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:52:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:52:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:52:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x26861f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2852a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29f8770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29f5a30>, '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 0x29f67f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29f6ca0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1494585323.378922-522741995', '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 03:52:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:52:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:52:50 INFO - Using env: {'DISPLAY': ':0', 03:52:50 INFO - 'HOME': '/home/cltbld', 03:52:50 INFO - 'LANG': 'en_US.UTF-8', 03:52:50 INFO - 'LANGUAGE': 'en_US:en', 03:52:50 INFO - 'LOGNAME': 'cltbld', 03:52:50 INFO - 'MAIL': '/var/mail/cltbld', 03:52:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:52:50 INFO - 'MOZ_NO_REMOTE': '1', 03:52:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:52:50 INFO - 'NO_EM_RESTART': '1', 03:52:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:52:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:52:50 INFO - 'PWD': '/builds/slave/test', 03:52:50 INFO - 'SHELL': '/bin/bash', 03:52:50 INFO - 'SHLVL': '1', 03:52:50 INFO - 'TERM': 'linux', 03:52:50 INFO - 'TMOUT': '86400', 03:52:50 INFO - 'USER': 'cltbld', 03:52:50 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1494585323.378922-522741995', 03:52:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:52:50 INFO - '_': '/tools/buildbot/bin/python'} 03:52:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:52:51 INFO - Downloading/unpacking blobuploader==1.2.4 03:52:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:52:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:52:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:52:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:52:52 INFO - Downloading blobuploader-1.2.4.tar.gz 03:52:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:52:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:52:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:52:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:52:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:52:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:52:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:52:52 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:52:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:52:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:52:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:52:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:52:52 INFO - Downloading docopt-0.6.1.tar.gz 03:52:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:52:52 INFO - Installing collected packages: blobuploader, requests, docopt 03:52:52 INFO - Running setup.py install for blobuploader 03:52:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:52:53 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:52:53 INFO - Running setup.py install for requests 03:52:53 INFO - Running setup.py install for docopt 03:52:53 INFO - Successfully installed blobuploader requests docopt 03:52:53 INFO - Cleaning up... 03:52:53 INFO - Return code: 0 03:52:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:52: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')]} 03:52:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:52: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')]} 03:52:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:52:53 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 0x26861f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2852a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29f8770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29f5a30>, '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 0x29f67f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29f6ca0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1494585323.378922-522741995', '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 03:52:53 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 03:52:53 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 03:52:53 INFO - Using env: {'DISPLAY': ':0', 03:52:53 INFO - 'HOME': '/home/cltbld', 03:52:53 INFO - 'LANG': 'en_US.UTF-8', 03:52:53 INFO - 'LANGUAGE': 'en_US:en', 03:52:53 INFO - 'LOGNAME': 'cltbld', 03:52:53 INFO - 'MAIL': '/var/mail/cltbld', 03:52:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:52:53 INFO - 'MOZ_NO_REMOTE': '1', 03:52:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:52:53 INFO - 'NO_EM_RESTART': '1', 03:52:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:52:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:52:53 INFO - 'PWD': '/builds/slave/test', 03:52:53 INFO - 'SHELL': '/bin/bash', 03:52:53 INFO - 'SHLVL': '1', 03:52:53 INFO - 'TERM': 'linux', 03:52:53 INFO - 'TMOUT': '86400', 03:52:53 INFO - 'USER': 'cltbld', 03:52:53 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1494585323.378922-522741995', 03:52:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:52:53 INFO - '_': '/tools/buildbot/bin/python'} 03:52:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:52:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:52:53 INFO - Running setup.py (path:/tmp/pip-lRvOxB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:52:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:52:53 INFO - Running setup.py (path:/tmp/pip-KgEkGD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:52:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:52:53 INFO - Running setup.py (path:/tmp/pip-_utCAZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:52:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:52:53 INFO - Running setup.py (path:/tmp/pip-U_0XrX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:52:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:52:54 INFO - Running setup.py (path:/tmp/pip-vQV6yk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:52:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:52:54 INFO - Running setup.py (path:/tmp/pip-IsfUlB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:52:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:52:54 INFO - Running setup.py (path:/tmp/pip-ThalUa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:52:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:52:54 INFO - Running setup.py (path:/tmp/pip-FfBBV2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:52:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:52:54 INFO - Running setup.py (path:/tmp/pip-WEimFW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:52:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:52:54 INFO - Running setup.py (path:/tmp/pip-Zkaj4R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:52:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:52:54 INFO - Running setup.py (path:/tmp/pip-HxOmp4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:52:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:52:54 INFO - Running setup.py (path:/tmp/pip-AXTtGm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:52:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:52:54 INFO - Running setup.py (path:/tmp/pip-e_zVgZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:52:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:52:54 INFO - Running setup.py (path:/tmp/pip-3lJ9z6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:52:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:52:54 INFO - Running setup.py (path:/tmp/pip-QQBCE3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:52:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:52:54 INFO - Running setup.py (path:/tmp/pip-Iwc1HU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:52:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:52:54 INFO - Running setup.py (path:/tmp/pip-_lTQ9S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:52:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:52:54 INFO - Running setup.py install for manifestparser 03:52:55 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:52:55 INFO - Running setup.py install for mozcrash 03:52:55 INFO - Running setup.py install for mozdebug 03:52:55 INFO - Running setup.py install for mozdevice 03:52:55 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:52:55 INFO - Running setup.py install for mozfile 03:52:55 INFO - Running setup.py install for mozhttpd 03:52:55 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:52:55 INFO - Running setup.py install for mozinfo 03:52:55 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:52:55 INFO - Running setup.py install for mozInstall 03:52:55 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:52:55 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:52:55 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:52:55 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:52:55 INFO - Running setup.py install for mozleak 03:52:55 INFO - Running setup.py install for mozlog 03:52:55 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:52:56 INFO - Running setup.py install for moznetwork 03:52:56 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:52:56 INFO - Running setup.py install for mozprocess 03:52:56 INFO - Running setup.py install for mozprofile 03:52:56 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:52:56 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:52:56 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:52:56 INFO - Running setup.py install for mozrunner 03:52:56 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:52:56 INFO - Running setup.py install for mozscreenshot 03:52:56 INFO - Running setup.py install for moztest 03:52:56 INFO - Running setup.py install for mozversion 03:52:56 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:52:56 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:52:56 INFO - Cleaning up... 03:52:56 INFO - Return code: 0 03:52:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:52:56 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')]} 03:52:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:52:56 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')]} 03:52:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:52:56 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 0x26861f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2852a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29f8770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29f5a30>, '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 0x29f67f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29f6ca0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1494585323.378922-522741995', '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 03:52:56 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 03:52:56 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 03:52:56 INFO - Using env: {'DISPLAY': ':0', 03:52:56 INFO - 'HOME': '/home/cltbld', 03:52:56 INFO - 'LANG': 'en_US.UTF-8', 03:52:56 INFO - 'LANGUAGE': 'en_US:en', 03:52:56 INFO - 'LOGNAME': 'cltbld', 03:52:56 INFO - 'MAIL': '/var/mail/cltbld', 03:52:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:52:56 INFO - 'MOZ_NO_REMOTE': '1', 03:52:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:52:56 INFO - 'NO_EM_RESTART': '1', 03:52:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:52:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:52:56 INFO - 'PWD': '/builds/slave/test', 03:52:56 INFO - 'SHELL': '/bin/bash', 03:52:56 INFO - 'SHLVL': '1', 03:52:56 INFO - 'TERM': 'linux', 03:52:56 INFO - 'TMOUT': '86400', 03:52:56 INFO - 'USER': 'cltbld', 03:52:56 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1494585323.378922-522741995', 03:52:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:52:56 INFO - '_': '/tools/buildbot/bin/python'} 03:52:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:52:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:52:56 INFO - Running setup.py (path:/tmp/pip-hvAMVX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:52:57 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)) 03:52:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:52:57 INFO - Running setup.py (path:/tmp/pip-r8x4jj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:52:57 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)) 03:52:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:52:57 INFO - Running setup.py (path:/tmp/pip-YHULse-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:52:57 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)) 03:52:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:52:57 INFO - Running setup.py (path:/tmp/pip-DQNm1i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:52:57 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)) 03:52:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:52:57 INFO - Running setup.py (path:/tmp/pip-eKOhdl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:52:57 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)) 03:52:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:52:57 INFO - Running setup.py (path:/tmp/pip-KJjacE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:52:57 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)) 03:52:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:52:57 INFO - Running setup.py (path:/tmp/pip-s3iInG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:52:57 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)) 03:52:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:52:57 INFO - Running setup.py (path:/tmp/pip-EFiK9y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:52:57 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)) 03:52:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:52:57 INFO - Running setup.py (path:/tmp/pip-hsNzkh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:52:57 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)) 03:52:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:52:57 INFO - Running setup.py (path:/tmp/pip-Fwcg2W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:52:57 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)) 03:52:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:52:57 INFO - Running setup.py (path:/tmp/pip-C1c0Nw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:52:57 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)) 03:52:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:52:57 INFO - Running setup.py (path:/tmp/pip-u0jgw4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:52:57 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)) 03:52:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:52:57 INFO - Running setup.py (path:/tmp/pip-YIZyHl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:52:57 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)) 03:52:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:52:57 INFO - Running setup.py (path:/tmp/pip-M5bHsP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:52:58 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)) 03:52:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:52:58 INFO - Running setup.py (path:/tmp/pip-hFNcAW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:52:58 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)) 03:52:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:52:58 INFO - Running setup.py (path:/tmp/pip-HIRZWt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:52:58 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)) 03:52:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:52:58 INFO - Running setup.py (path:/tmp/pip-FZI12_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:52:58 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)) 03:52:58 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)) 03:52:58 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)) 03:52:58 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)) 03:52:58 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)) 03:52:58 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)) 03:52:58 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:52:58 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 03:52:58 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 03:52:58 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 03:52:58 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 03:52:59 INFO - Downloading blessings-1.6.tar.gz 03:52:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:52:59 INFO - Installing collected packages: blessings 03:52:59 INFO - Running setup.py install for blessings 03:52:59 INFO - Successfully installed blessings 03:52:59 INFO - Cleaning up... 03:52:59 INFO - Return code: 0 03:52:59 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:52:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:52:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:52:59 INFO - Reading from file tmpfile_stdout 03:52:59 INFO - Current package versions: 03:52:59 INFO - argparse == 1.2.1 03:52:59 INFO - blessings == 1.6 03:52:59 INFO - blobuploader == 1.2.4 03:52:59 INFO - docopt == 0.6.1 03:52:59 INFO - functools32 == 3.2.3-2 03:52:59 INFO - jsonschema == 2.5.1 03:52:59 INFO - manifestparser == 1.1 03:52:59 INFO - mozInstall == 1.12 03:52:59 INFO - mozcrash == 1.0 03:52:59 INFO - mozdebug == 0.1 03:52:59 INFO - mozdevice == 0.50 03:52:59 INFO - mozfile == 1.2 03:52:59 INFO - mozhttpd == 0.7 03:52:59 INFO - mozinfo == 0.9 03:52:59 INFO - mozleak == 0.1 03:52:59 INFO - mozlog == 3.4 03:52:59 INFO - moznetwork == 0.27 03:52:59 INFO - mozprocess == 0.25 03:52:59 INFO - mozprofile == 0.28 03:52:59 INFO - mozrunner == 6.13 03:52:59 INFO - mozscreenshot == 0.1 03:52:59 INFO - mozsystemmonitor == 0.3 03:52:59 INFO - moztest == 0.8 03:52:59 INFO - mozversion == 1.4 03:52:59 INFO - psutil == 3.1.1 03:52:59 INFO - requests == 1.2.3 03:52:59 INFO - wsgiref == 0.1.2 03:52:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:52:59 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')]} 03:52:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:52:59 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')]} 03:52:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:52:59 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 0x26861f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2852a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29f8770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29f5a30>, '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 0x29f67f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29f6ca0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1494585323.378922-522741995', '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 03:52:59 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 03:52:59 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 03:52:59 INFO - Using env: {'DISPLAY': ':0', 03:52:59 INFO - 'HOME': '/home/cltbld', 03:52:59 INFO - 'LANG': 'en_US.UTF-8', 03:52:59 INFO - 'LANGUAGE': 'en_US:en', 03:52:59 INFO - 'LOGNAME': 'cltbld', 03:52:59 INFO - 'MAIL': '/var/mail/cltbld', 03:52:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:52:59 INFO - 'MOZ_NO_REMOTE': '1', 03:52:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:52:59 INFO - 'NO_EM_RESTART': '1', 03:52:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:52:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:52:59 INFO - 'PWD': '/builds/slave/test', 03:52:59 INFO - 'SHELL': '/bin/bash', 03:52:59 INFO - 'SHLVL': '1', 03:52:59 INFO - 'TERM': 'linux', 03:52:59 INFO - 'TMOUT': '86400', 03:52:59 INFO - 'USER': 'cltbld', 03:52:59 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1494585323.378922-522741995', 03:52:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:52:59 INFO - '_': '/tools/buildbot/bin/python'} 03:52:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:52:59 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)) 03:52:59 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)) 03:52:59 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)) 03:52:59 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)) 03:52:59 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)) 03:52:59 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)) 03:52:59 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)) 03:52:59 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)) 03:52:59 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)) 03:52:59 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)) 03:52:59 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)) 03:52:59 INFO - Cleaning up... 03:52:59 INFO - Return code: 0 03:52:59 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:52:59 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')]} 03:52:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:52:59 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')]} 03:52:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:52:59 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 0x26861f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2852a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x29f8770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29f5a30>, '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 0x29f67f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29f6ca0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1494585323.378922-522741995', '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 03:52:59 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 03:52:59 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 03:53:00 INFO - Using env: {'DISPLAY': ':0', 03:53:00 INFO - 'HOME': '/home/cltbld', 03:53:00 INFO - 'LANG': 'en_US.UTF-8', 03:53:00 INFO - 'LANGUAGE': 'en_US:en', 03:53:00 INFO - 'LOGNAME': 'cltbld', 03:53:00 INFO - 'MAIL': '/var/mail/cltbld', 03:53:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:53:00 INFO - 'MOZ_NO_REMOTE': '1', 03:53:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:53:00 INFO - 'NO_EM_RESTART': '1', 03:53:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:53:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:53:00 INFO - 'PWD': '/builds/slave/test', 03:53:00 INFO - 'SHELL': '/bin/bash', 03:53:00 INFO - 'SHLVL': '1', 03:53:00 INFO - 'TERM': 'linux', 03:53:00 INFO - 'TMOUT': '86400', 03:53:00 INFO - 'USER': 'cltbld', 03:53:00 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1494585323.378922-522741995', 03:53:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:53:00 INFO - '_': '/tools/buildbot/bin/python'} 03:53:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:53:00 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:53:00 INFO - Cleaning up... 03:53:00 INFO - Return code: 0 03:53:00 INFO - Running post-action listener: _resource_record_post_action 03:53:00 INFO - Running post-action listener: _start_resource_monitoring 03:53:00 INFO - Starting resource monitoring. 03:53:00 INFO - [mozharness: 2017-05-12 10:53:00.256922Z] Finished create-virtualenv step (success) 03:53:00 INFO - [mozharness: 2017-05-12 10:53:00.257454Z] Running install step. 03:53:00 INFO - Running pre-action listener: _resource_record_pre_action 03:53:00 INFO - Running main action method: install 03:53:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:53:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:53:00 INFO - Reading from file tmpfile_stdout 03:53:00 INFO - Detecting whether we're running mozinstall >=1.0... 03:53:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:53:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:53:00 INFO - Reading from file tmpfile_stdout 03:53:00 INFO - Output received: 03:53:00 INFO - Usage: mozinstall [options] installer 03:53:00 INFO - Options: 03:53:00 INFO - -h, --help show this help message and exit 03:53:00 INFO - -d DEST, --destination=DEST 03:53:00 INFO - Directory to install application into. [default: 03:53:00 INFO - "/builds/slave/test"] 03:53:00 INFO - --app=APP Application being installed. [default: firefox] 03:53:00 INFO - mkdir: /builds/slave/test/build/application 03:53:00 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'] 03:53:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 03:53:17 INFO - Reading from file tmpfile_stdout 03:53:17 INFO - Output received: 03:53:17 INFO - /builds/slave/test/build/application/firefox/firefox 03:53:17 INFO - Running post-action listener: _resource_record_post_action 03:53:17 INFO - [mozharness: 2017-05-12 10:53:17.769574Z] Finished install step (success) 03:53:17 INFO - [mozharness: 2017-05-12 10:53:17.769822Z] Running run-tests step. 03:53:17 INFO - Running pre-action listener: _resource_record_pre_action 03:53:17 INFO - Running main action method: run_tests 03:53:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:53:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:53:17 INFO - Python 2.7.3 03:53:17 INFO - Return code: 0 03:53:17 INFO - grabbing minidump binary from tooltool 03:53:17 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')]} 03:53:17 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 0x29f5a30>, '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 0x29f67f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29f6ca0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:53:17 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 03:53:17 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 03:53:17 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 03:53:17 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:53:17 INFO - Return code: 0 03:53:17 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:53:17 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:53:17 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:53:17 INFO - ENV: RUST_BACKTRACE is now 1 03:53:17 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:53:17 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:53:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Jt9B3QZUS5CaIvbQegJIuA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--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 03:53:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Jt9B3QZUS5CaIvbQegJIuA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-068 --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 03:53:17 INFO - Using env: {'DISPLAY': ':0', 03:53:17 INFO - 'HOME': '/home/cltbld', 03:53:17 INFO - 'LANG': 'en_US.UTF-8', 03:53:17 INFO - 'LANGUAGE': 'en_US:en', 03:53:17 INFO - 'LOGNAME': 'cltbld', 03:53:17 INFO - 'MAIL': '/var/mail/cltbld', 03:53:17 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:53:17 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:53:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:53:17 INFO - 'MOZ_NO_REMOTE': '1', 03:53:17 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:53:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:53:17 INFO - 'NO_EM_RESTART': '1', 03:53:17 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:53:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:53:17 INFO - 'PWD': '/builds/slave/test', 03:53:17 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:53:17 INFO - 'RUST_BACKTRACE': '1', 03:53:17 INFO - 'SHELL': '/bin/bash', 03:53:17 INFO - 'SHLVL': '1', 03:53:17 INFO - 'TERM': 'linux', 03:53:17 INFO - 'TMOUT': '86400', 03:53:17 INFO - 'USER': 'cltbld', 03:53:17 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1494585323.378922-522741995', 03:53:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:53:17 INFO - '_': '/tools/buildbot/bin/python'} 03:53:17 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Jt9B3QZUS5CaIvbQegJIuA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--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 03:53:18 INFO - mozversion application_buildid: 20170512100218 03:53:18 INFO - mozversion application_changeset: 8a7d0b15595f9916123848ca906f29c62d4914c9 03:53:18 INFO - mozversion application_display_name: Nightly 03:53:18 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:53:18 INFO - mozversion application_name: Firefox 03:53:18 INFO - mozversion application_remotingname: firefox 03:53:18 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:53:18 INFO - mozversion application_vendor: Mozilla 03:53:18 INFO - mozversion application_version: 55.0a1 03:53:18 INFO - mozversion platform_buildid: 20170512100218 03:53:18 INFO - mozversion platform_changeset: 8a7d0b15595f9916123848ca906f29c62d4914c9 03:53:18 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:53:18 INFO - mozversion platform_version: 55.0a1 03:53:18 INFO - using testdate: 1494586398 03:53:18 INFO - actual date: 1494586398 03:53:18 INFO - starting webserver on 'localhost:44286' 03:53:18 INFO - SUITE-START | Running 2 tests 03:53:18 INFO - TEST-START | dromaeo_css 03:53:18 INFO - operating with platform_type : linux_ 03:53:18 INFO - Initialising browser for dromaeo_css test... 03:53:18 INFO - TEST-INFO | started process 5948 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgwA_b3/profile http://localhost:44286/getInfo.html) 03:53:22 INFO - PID 5948 | __metrics Screen width/height:1600/1200 03:53:22 INFO - PID 5948 | colorDepth:24 03:53:22 INFO - PID 5948 | Browser inner width/height: 1024/695 03:53:22 INFO - PID 5948 | __metrics 03:53:24 INFO - TEST-INFO | 5948: exit 0 03:53:24 INFO - Browser initialized. 03:53:24 INFO - Running cycle 1/1 for dromaeo_css test... 03:53:24 INFO - TEST-INFO | started process 6123 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgwA_b3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:53:35 INFO - PID 6123 | RSS: Main: 151326720 03:53:35 INFO - PID 6123 | 03:56:37 INFO - PID 6123 | Cycle 1(1): loaded http://localhost:44286/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44286/tests/dromaeo/cssquery-ext.html) 03:56:38 INFO - PID 6123 | RSS: Main: 162988032 03:56:38 INFO - PID 6123 | 03:59:40 INFO - PID 6123 | Cycle 1(1): loaded http://localhost:44286/tests/dromaeo/cssquery-ext.html (next: http://localhost:44286/tests/dromaeo/cssquery-jquery.html) 03:59:41 INFO - PID 6123 | RSS: Main: 160407552 03:59:41 INFO - PID 6123 | 04:02:43 INFO - PID 6123 | Cycle 1(1): loaded http://localhost:44286/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44286/tests/dromaeo/cssquery-mootools.html) 04:02:43 INFO - PID 6123 | RSS: Main: 166699008 04:02:43 INFO - PID 6123 | 04:05:45 INFO - PID 6123 | Cycle 1(1): loaded http://localhost:44286/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44286/tests/dromaeo/cssquery-prototype.html) 04:05:45 INFO - PID 6123 | RSS: Main: 161132544 04:05:45 INFO - PID 6123 | 04:08:48 INFO - PID 6123 | Cycle 1(1): loaded http://localhost:44286/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44286/tests/dromaeo/cssquery-yui.html) 04:08:49 INFO - PID 6123 | RSS: Main: 163569664 04:08:49 INFO - PID 6123 | 04:11:50 INFO - PID 6123 | Cycle 1(1): loaded http://localhost:44286/tests/dromaeo/cssquery-yui.html (next: http://localhost:44286/tests/dromaeo/cssquery-dojo.html) 04:11:50 INFO - PID 6123 | RSS: Main: 164974592 04:11:50 INFO - PID 6123 | 04:11:50 INFO - PID 6123 | __start_tp_report 04:11:50 INFO - PID 6123 | _x_x_mozilla_page_load 04:11:50 INFO - PID 6123 | _x_x_mozilla_page_load_details 04:11:50 INFO - PID 6123 | |i|pagename|runs| 04:11:50 INFO - PID 6123 | |0;dojo.html;3363.630000699923;3366.9831650841757;3389.5932488101425;3393.440082386405;3399.898003059906;5820.825375238739;5957.642541447511;5971.761129554818;5973.253343332083;6048.969755151218;5972.134040564116;5991.790287339944;6017.308009578889;6057.151998720183;6100.23747031621;5290.39160496544;5301.098813201765;5312.150055991042;5342.091844386454;5360.2763626910255;5359.517643412092;5368.32895888014;5374.086405311087;5413.079776438015;5427.864303392407;5243.449437809013;5317.255584218213;5324.41431442541;5329.413764485904;5423.918641220384;5301.469853014706;5312.73436328182;5320.787168513293;5327.094393953037;5331.866703332447;5068.391792984866;5149.871253218662;5152.948470515322;5172.172452407597;5175.663581867167;5966.820995370146;5982.760689572412;5997.790077347272;6021.668808215546;6074.9392506075255;6451.163923588122;6467.256265529477;6522.510811689142;6533.346665333476;6542.4438922691625;6390.520710946651;6473.514486413538;6614.0740296358545;6615.834604134887;6650;5968.31364393096;6038.40449147401;6086.847828804315;6107.541934354941;6114.633122012693;6629.5359324846795;6629.9337006630285;6674.899876501856;6683.899741503881;6695.966520167368;6181.443670069715;6264.498840092781;6347.492200624031;6352.14246076783;6377.74489020434;6407.231132264158;6538.869222615616;6541.28045914949;6542.509311801634;6546.574472659262;6508.284088750233;6515.771947981798;6517.934820651828;6520.836979075466;6529.183852018497;6331.651759153291;6473.158489396348;6542.836429089216;6543;6555.246146693096;4836.854894353175;4875.488073752276;4884.462709101996;4923.040007198562;4932.679375840559;4367.344898265222;4382.342648602735;4424.955750442518;4449.822007119744;4489.551044895549;6161.322254551996;6178.073289006595;6187.16473276111;6187.721552530147;6193.659348735772;6330.493560515148;6426.646534440651;6498.285188629247;6551.312112228243;6554.3117972613145;6078.969605152034;6111.318268824403;6141.271221159682;6154.753809847556;6168.1056246843955;5632.267805185382;5634;5636.210930469738;5637.661740295595;5676.176954341598;6721.966390168018;6831.521793474509;6834.419074378733;6835;6849.452043836382;6352.269489008823;6397.552171347961;6405.295417504164;6526.379993900572;6531.085648009377;6739.764108256188;6755.42578880781;6767.424768894699;6768.424683901727;6783.728650853911;6343.238811342669;6374.936250637435;6381.617102973836;6386.521010924106;6420.101185833893;6360.141380913703;6366.9044964326495;6453.064305675557;6453.16108905858;6498.935010649833;6234.812955611339;6283.748650053946;6298.7480500781285;6311.116443697794;6319.715612797527;6141.731496609813;6225.844353891189;6239.500839932885;6277.5605707600025;6283.528735344776;6176.66028368444;6177.938220617916;6182.350853160354;6203.751849925952;6250.124982502544;6319.178506794087;6394.840128996812;6407.9038814418755;6442.645654488861;6462.806115816533;6001.549883758648;6189.81430557084;6235.376462353728;6236.376362363727;6244.906326405198 04:11:50 INFO - PID 6123 | |1;ext.html;748.3078152708744;811.3955103447933;836.0135040652032;1124.9100071994242;1138.3682056458672;35478.645213547854;36359.63640363599;36431.81784091076;36449.08877278066;36457.635423645756;38100.80949595248;38612.61387386125;38832.80583597085;38843.611563884355;38861.61138388615;6955.826104347394;7003.5097543172;7055.788326350218;7208;7223.855522889539;7083.362497375235;7084.326988936069;7127.501074924731;7145.071140751695;7157.103367607589;7170.928290717078;7183.964080179592;7197.496175267734;7213.458990575701;7230.385417239541;7073.469489788235;7107.466939979522;7140.357367836894;7145.606991615433;7154.749583764569;7065;7149.606771627558;7163.462740294499;7179.246179151166;7182.06633137694;35027;35536.466952995725;35537.822310888536;35549.822250888836;35615.28769424623;3511.0695665648623;3519.225770330523;3532.2405682778326;3534.5581802274714;3558.323918455511;28102.156935291972;28193.85903070492;28294.71705282962;28339.433211335865;28414.147575572766;3754.2303827715255;3757.906052348686;3763.284975854579;3771.5851256362052;3798.2213646202463;192205;192415;202160;208508;209351.95324023435;45465.09069818585;45664.86702659482;45741.542584574396;45913.540864591596;45970;47444.7627761859;47458;47592.7620361896;49322.260166097534;50614.746926265136;14403.279836008158;14567;14579.271036448135;14579.489717859824;14579.92710036443;11515.481803318871;11518.481668324945;11558.075353971662;11577.884221157681;11580.594679186188;13917;14155.150690958575;14170.220637865017;14243.501477448239;14304.427822886968;5732.426757324318;5845.386234445407;5896.469317761422;5901.439363260483;5951.940480595225;1043.1654676258963;1082.99458502707;1094.4691824465128;1099.5491848342142;1107.335598640825;25615.103471378785;25669.229923102335;25685.3578660535;25718;25780.613290800655;1177.4819079605118;1178.6994316449423;1181.1554738362113;1183.1244878789635;1196.132803717298;13200;13318.933405332911;13323.93338033323;13343.332833358294;13472.326383680776;246585;247832;247903;249924;251353;51884;51925.48074519282;52205.7389713049;52335.21497177545;52427.73786131045;1419.8154239948947;1470.6764511807385;1486.3088663771182;1495.7980672609276;1512.2665507228985;23639.40901477408;24739.25782226536;24922.875385622956;24937.49968936239;25075.247742567753;36990.44514332341;47803.76098119487;48436.757816210695;48811.511884880696;48839.29062482796;232296;232426;233878;234480;234821;33444.49833252455;34285.142871427415;34785.47821782726;35010.82494587511;35079.298414031065;41524.79237603793;43160.95746595542;43169.568304317814;43398.56601433945;44216.11567768562;32140;32233.838830805696;32737.50893736548;33041.834790826855;33247.50128748023;32560.185995350304;32657.34685306328;32898.67101329052;33756.493652595724;34293.314133717686;37763.69198776265;37833.81083094677;38107.809460952514;38109.4283585752;38195;29789;29986.700132999264;30383.848080760337;31130.688693112777;31389.21526961753;23798.762012379655;25765.59555762171;26097.869510653083;26239.868800655873;26487 04:11:51 INFO - PID 6123 | |2;jquery.html;449.7369039112119;451.4131628882453;456.97258164510134;468.38407494145196;470.4190324948688;19713;20746.792532074676;21890.343289701334;22401.32796016118;22459;22326;22527;22856.200032998848;23329;23475;5450.427705090968;5452.809151679682;5548;5573.08044172711;5613.943860561383;5387.568994480452;5493.587980901429;5494.230807686907;5497;5503.697296648683;5344.22508736233;5496.890062198753;5525.060739674265;5571.220029195916;5574.526165275956;5221.216817477371;5522.420145884685;5549.861253468675;5553.028220061493;5564.081926482126;4899.853004409873;4940.975295123538;4957.876053098701;4961.677490963076;4979.651424400294;25192.244232672867;25613.74386256132;25887.741122588723;26015.21954341373;26242.343941401617;2150.32264836576;2166.9349919502442;2186.8031877131134;2188.004457971619;2193.4954960359205;16644.167791610493;16697.248623811956;16785.412510562193;17250.82749172505;17443.12784360777;2136.4979229880964;2183.5087105401158;2214.4795972946345;2214.8671079735104;2226.532428190082;100378;107422;112808;115213.84786152115;115506;12294.631161065183;12298.20061695987;12682.80975785364;12764;13154.4080516377;17654.205560749797;17677.55806104832;17694.91152544229;17765.644687106185;17807.19867605961;8255.504669719836;8426.578671066422;8467.407281490237;8554.05905350411;8576.828463430697;7676.232376762391;7775.494592851446;7807.6486558105025;8042.879356809653;8062.516249025077;7927.563983980936;7991;8093.716719914774;8130.918690813016;8246.587670616565;2245.9887700561394;2259.152817693365;2317.177402022258;2371.5494056129282;2430.611102223671;1041.6979076067855;1061.3843970497094;1075.4998925499524;1076.9946150269197;1084.143526613982;20712.48218794512;20788.58422831535;20903.79096209049;20919.790802092088;21026.47433814167;1093.830456279278;1097.25386737018;1097.8902109788958;1101.4162493878257;1104.7679987202778;10985.890141098487;11357.943210283896;11391.430428478543;11391.487383067783;11445.370504622326;477013;487976;490065;495523;497427;92902.53548732348;94689;96044;97298.02701973032;98439.50780246053;1245.701031752373;1261.949522019109;1297.9675508112184;1318.5780550223835;1320.2012782266781;20314.187432502535;20564.691529627366;21204.68192977076;21217.15131394789;21261;46550;46680.29979550242;47353;47808;47837.5216247847;60346;61427;61533;61865.690671546356;62472.37527624847;9508.191803696764;9686.564104615169;9822.263330250116;9868.259880508847;9920.454375009154;14925.850741492446;14966.251687415803;15057.54827355181;15060.322285496959;15304.311305991034;12840.743185136433;12871.22772633645;13000.284984325954;13138.408771605491;13401.865981340452;12174.026077913923;12229.75540489203;12421.689457763629;12513.562025329069;13472.32638368058;13107.606771796862;13179.736405272033;13370;13611.387487563281;13997.5100871469;9569.521523923637;9717.368371055858;9773.48510980799;9850.802983940424;9945;12765;12882.935585322013;13211.66970825737;13437.596872093853;13807.447702091804 04:11:51 INFO - PID 6123 | |3;mootools.html;1359.367893929323;1393.2128347483672;1404.9578512644625;1415.087268711681;1431.7494438473268;11384.544618215272;11877.881221187796;11897.167198296134;12155.088368372364;12540;11622.709432264197;11746.882531174686;11757.764844703122;11814.995725363355;11815.17293789433;2440.1093600835743;2456.435019945414;2507.3480894967256;2513.384220865881;2515.207709571488;2402.8798560072014;2408.650745641881;2410.9758902411013;2415.0339864054345;2442.096424323003;2459.692538432696;2464.297675162579;2467.259822053386;2504.8497090174646;2509.5859183234743;2326.654881162843;2405.879706014692;2416.395901024744;2451.7303096659352;2483.919495019672;2106.420734298065;2196.6595177747477;2272.9545409091893;2356.9410764730846;2434.342727463575;11625.534978600846;11638.883611163865;11674.35791031493;11687.7078073048;11701.239419437794;6659;6935.826604334881;6936.2023367312395;6938.930610693879;6959;3809.142942837867;4071.6742660587083;4139.4204811326435;4141.275276826574;4174.102567947906;1215.011072761009;1322.5238913990956;1354.7222819322014;1369.6165073779357;1372.2315503318075;17692.91153544237;17860.124686907948;17893;17953.461396158134;17981.640367192584;5398.514133727905;5429.4299098594865;5541.778328866801;5629.155626655953;5706.514946229534;12789.10476266671;12815.359232038361;12855.228686278853;12855.357232138544;12865.228086314664;6637.601743895381;6641.601503909781;6669.199696036507;6670;6713.765018224339;6043.305019922677;6195.132681424604;6295.401936815995;6380;6382.776602818879;4316.43886294786;4416.24923762961;4446.799364171656;4455;4477.485089214717;1258.779713550125;1269.0799170601424;1284.441268048402;1294.76046931318;1296.1963582578862;848.3128665780737;860.5310105992249;884.7832281091045;892.2549671024638;916.935814492979;6440.903386449207;6487.902681459782;6488.28628850826;6513.576617519846;6523.8695226095215;643.3116565275204;646.3956200952125;647.184547470191;656.9474442044625;657.4608820767021;4046.109855831712;4327.394164816928;4332.26351520236;4352.064306174188;4437.800298986554;14609;15264.618384540254;15275.541733748005;15320.540383788504;15432.845671543366;15621.609459763597;15761.448349307719;15770.211489425483;15787.526374208792;15801.683966320608;9254.629814807467;9397.90602093984;9423.90576094244;9449;9456.810863782823;7285.7814265572115;7321.816954576178;7611.162772095176;7663.693452261847;7671.309582137635;13201.735965280448;13346.733065338833;13421.597352079454;13521.323933803467;13523.661908451973;13729;13797.586072417844;14006.929965350108;14044.719105618035;14153.646158846112;9530;9672.129508344282;9808;9846.359986600848;10053.346532475365;11577.131715121232;11720.179587429138;11753.294802311888;11757;11776.587819426279;9265.907340926775;9455.479948602893;9474.668386606436;9601.567929443052;9687.225021998363;9251.213646840093;9321.161095501437;9337.813243734952;9376.29677774156;9380.343375963617;8309.086000540057;8400.789980250544;8437.987441507059;8454.492730435948;8456.365772566958;5984.940150598438;6001.099835024781;6034.939650603438;6154.3845615438095;6218.067289906369;6174.845628859314;6208.099825525183;6209.627422354673;6264.561480696308;6401.55189136756 04:11:51 INFO - PID 6123 | |4;prototype.html;398.481973434535;410.1735003967005;421.5657872391437;431.5059257150564;434.7478462491755;6009.939900600993;6070.635761854286;6093.177421048163;6165.352637973016;6165.969170154154;5969.761209551612;6071.3018002929675;6074.8481287967825;6090.908636370458;6108.480779133779;4564.954350456503;4583.8166473341025;4585.151746926813;4586.541345865404;4587.472440669332;4517.141743068806;4537.481697657799;4564.97717511412;4574.153781550407;4575.5424457554145;4521.412216411878;4522.118186953546;4530.501644819067;4535.160995215879;4539.818407263722;4542.909141817178;4546.477155127137;4551.8634440966825;4560.293154561048;4566.817327306921;3859.3053250414914;3947.960520394788;3956.1296514766705;3991.1818077294083;4013.418054382098;5877.05967045275;5886.293644762613;5889.528837692974;5913.586048976574;5922.851928701773;5283.339582552181;5300.946990530084;5345.812896548641;5368.91946620801;5369.382521010095;6358.968205158944;6388.488920886364;6389.616623002588;6413.711382987777;6448.387403196689;4449.466064072332;4456.3538286948215;4467.798949047268;4471.28459446487;4471.910561788779;6608.636524991123;6698.765543205965;6707.932920670828;6714.697838597275;6806.523543351967;4517.864464066083;4528.50186479487;4536.659750518725;4539.432570928634;4563.224251877189;4618;4627.398438203012;4644.8374306899095;4648.140094082538;4650.720956742606;5253.50091741284;5300.946990530122;5304.396676621086;5323.680579165185;5379.569634429236;6194.411530904647;6395.808125756234;6426.132472116298;6433.453156481658;6444.260049786531;1574.181425658651;1593.39451008616;1601;1604.646977664935;1606.1246620591805;1049.239301506417;1075.6450371377427;1078.9298695584762;1080.8811030786765;1089.4824958144977;6177.104319873593;6187.102870083812;6194.442500174916;6222.191115155001;6224.1597384352535;6536.411722944958;6594.373534514213;6599.637019963852;6612.206535215805;6621.404073633396;5906.3207731110615;6105;6218.906716399258;6221.346758590283;6234.199666257047;3473.8263086846064;3481.8433170507387;3530.982345088258;3532.1346270163463;3540.769849959796;6834.419074378733;6858.776375103793;6931.376176144171;6957.2694867038235;6992.405645520086;6695.598264104169;6771.8984215236815;6790;6812.284710105467;6823.351781580742;6714.160729908762;6829.556078854858;6881.965590172017;6902;6919.965400173068;6558.704858281293;6592.90110648331;6616.139901812926;6616.338366163538;6640.414176344912;6448.161738974091;6556.573822701509;6576.297946967749;6579.013148027642;6581.638009909501;6936.0636314096955;6946.6179360135675;6952.304769523007;6952.791416257318;6968.78046341878;4468.2180618391;4530.501644819134;4554.20301447252;4574.817007319803;4578.5421457853945;6475.902861457176;6601.042848786995;6650.3682150195655;6654;6665.266820649627;6429.903551446639;6437.806865794034;6466.482681385383;6486.351364863476;6518.2178138621775;6345.270293916259;6383.170187875547;6384.808455746335;6390.4248617624635;6446.4520515756685;6346.333634968447;6421.646809425526;6425.710843012169;6444.903326450013;6456.580322279036;6421.678916054085;6478.1578394808375;6485.876157835257;6506.958886578125;6522.836929076811;6074.726637301421;6251.187345645037;6292.244930608356;6316.747330106744;6323.557350985387 04:11:51 INFO - PID 6123 | |5;yui.html;827.3711978896044;855.935804814639;862.0904945282728;874.1127755328342;883.7083762358423;14937.626559336022;15661.92169039156;15803.288852001659;16274.83725162748;16357.182140892952;17676.292948282055;18100.094995250252;18168;18292.451226463196;18657.90671046646;1024.9077583017527;1043.4521876015076;1053.1995683280722;1053.515382923856;1057.6826951914434;1027.398971601614;1027.655735328662;1028.0695970147028;1029.526417847791;1030.8969103089669;1087.075985412401;1089.3246187363845;1090.9563617455292;1098.0666433531514;1098.3629494892944;1074.1192222377654;1078.4715489410212;1082.7509672775266;1083.875354334246;1091.3015669971185;747.6784982457541;772.5326177662489;792.1286584756779;795.1968511803062;799.6521513141802;15663.451779187788;15706;15787.131707756069;15803.604909877231;15855.524334269874;17823;18535.814641853678;18625.348112815987;18901.7164742529;18919.905400473046;15520.922395388065;15534.300956456986;15575.221238938007;15667.746580273551;15873.682526349523;3444.2594842109065;3448.9827550862087;3457.75795694299;3473.027552285364;3498.6851183393364;88467.55766221127;88919.55540222257;89629.55185224031;90368.54815725944;91751;13561.864381356258;13602.727945441036;13736.519221827188;13763.724725505434;14055.78916316256;26479.602805957926;26680.8665956669;26936;27131;27173;7904;8170.223828736261;8174.9781277340335;8188.181181881883;8229.177082291722;4056.959430405658;4122.113745544722;4135;4141.171765646883;4148.751074935513;4434.157510073076;4441.71128876622;4554.590086892195;4579.656525760582;4595.724256544618;832.7918020494876;848.6350869126335;852.9317654587618;856.8329175810657;862.0000799073046;699.9860002800017;704.9823754406181;726.393461459687;731.0459849895831;747.9887801682979;11433.885661143448;12577.685557861127;12775.680607984874;12776.105672603015;12799.616011519669;723.8490799628615;728.471857903016;740.1894925057054;747.6112421540769;747.9102507699002;5414.648047876875;5450.346881062912;5867.501262392659;5944.613600116065;6022.608530445507;73258;74668.62665686637;74875.62562187263;76009;78296;65565.6110858478;67385.66307168531;68674.3132568668;69453.65273173602;69737.3026269741;61807.38192618016;63312;64185.67907160434;66278;67542;12324;12830.615081547568;12943.158694684815;12976.675583110498;13039.804402934153;33631.3273734519;34154.48768268428;34675.492186015654;35064.64935350614;36293.63706362902;41527.377089344285;41543.37684934668;42069.15861682811;43018.78490607527;44093.118137636426;16655.75016374731;16799.32802687879;16814.243359049116;17786.46640600784;18304.633907321513;18764.812351876306;19505.70741438851;19692.11385487685;20296.492587685425;20537.17851285932;17288.13559322004;17709.64580708353;17802.554936126184;18558.628827423105;18747.34384296543;17558.20988055515;18021.189046492676;18040;18280.45158645243;18513.81486185121;17197.828021719622;17379.304827806747;17401.82598174002;17816.19827107809;18014.72977905359;12657.177283476545;12920;13052.086353955132;13277;13316.600501984956;14547;14595.336895841368;14610.050346727428;14763.188024658746;14897.47858824936 04:11:51 INFO - PID 6123 | __end_tp_report 04:11:51 INFO - PID 6123 | __start_cc_report 04:11:51 INFO - PID 6123 | _x_x_mozilla_cycle_collect,346 04:11:51 INFO - PID 6123 | __end_cc_report 04:11:51 INFO - PID 6123 | __startTimestamp1494587510995__endTimestamp 04:11:51 INFO - PID 6123 | 04:11:51 INFO - PID 6123 | ------- Summary: start ------- 04:11:51 INFO - PID 6123 | Number of tests: 6 04:11:51 INFO - PID 6123 | 04:11:51 INFO - PID 6123 | [#0] dojo.html Cycles:165 Average:5980.51 Median:6203.75 stddev:731.17 (11.8%) stddev-sans-first:704.00 04:11:51 INFO - PID 6123 | Values: 3363.6 3367.0 3389.6 3393.4 3399.9 5820.8 5957.6 5971.8 5973.3 6049.0 5972.1 5991.8 6017.3 6057.2 6100.2 5290.4 5301.1 5312.2 5342.1 5360.3 5359.5 5368.3 5374.1 5413.1 5427.9 5243.4 5317.3 5324.4 5329.4 5423.9 5301.5 5312.7 5320.8 5327.1 5331.9 5068.4 5149.9 5152.9 5172.2 5175.7 5966.8 5982.8 5997.8 6021.7 6074.9 6451.2 6467.3 6522.5 6533.3 6542.4 6390.5 6473.5 6614.1 6615.8 6650.0 5968.3 6038.4 6086.8 6107.5 6114.6 6629.5 6629.9 6674.9 6683.9 6696.0 6181.4 6264.5 6347.5 6352.1 6377.7 6407.2 6538.9 6541.3 6542.5 6546.6 6508.3 6515.8 6517.9 6520.8 6529.2 6331.7 6473.2 6542.8 6543.0 6555.2 4836.9 4875.5 4884.5 4923.0 4932.7 4367.3 4382.3 4425.0 4449.8 4489.6 6161.3 6178.1 6187.2 6187.7 6193.7 6330.5 6426.6 6498.3 6551.3 6554.3 6079.0 6111.3 6141.3 6154.8 6168.1 5632.3 5634.0 5636.2 5637.7 5676.2 6722.0 6831.5 6834.4 6835.0 6849.5 6352.3 6397.6 6405.3 6526.4 6531.1 6739.8 6755.4 6767.4 6768.4 6783.7 6343.2 6374.9 6381.6 6386.5 6420.1 6360.1 6366.9 6453.1 6453.2 6498.9 6234.8 6283.7 6298.7 6311.1 6319.7 6141.7 6225.8 6239.5 6277.6 6283.5 6176.7 6177.9 6182.4 6203.8 6250.1 6319.2 6394.8 6407.9 6442.6 6462.8 6001.5 6189.8 6235.4 6236.4 6244.9 04:11:51 INFO - PID 6123 | 04:11:51 INFO - PID 6123 | [#1] ext.html Cycles:180 Average:39155.85 Median:35018.91 stddev:59423.31 (169.7%) stddev-sans-first:59520.03 04:11:51 INFO - PID 6123 | Values: 748.3 811.4 836.0 1124.9 1138.4 35478.6 36359.6 36431.8 36449.1 36457.6 38100.8 38612.6 38832.8 38843.6 38861.6 6955.8 7003.5 7055.8 7208.0 7223.9 7083.4 7084.3 7127.5 7145.1 7157.1 7170.9 7184.0 7197.5 7213.5 7230.4 7073.5 7107.5 7140.4 7145.6 7154.7 7065.0 7149.6 7163.5 7179.2 7182.1 35027.0 35536.5 35537.8 35549.8 35615.3 3511.1 3519.2 3532.2 3534.6 3558.3 28102.2 28193.9 28294.7 28339.4 28414.1 3754.2 3757.9 3763.3 3771.6 3798.2 192205.0 192415.0 202160.0 208508.0 209352.0 45465.1 45664.9 45741.5 45913.5 45970.0 47444.8 47458.0 47592.8 49322.3 50614.7 14403.3 14567.0 14579.3 14579.5 14579.9 11515.5 11518.5 11558.1 11577.9 11580.6 13917.0 14155.2 14170.2 14243.5 14304.4 5732.4 5845.4 5896.5 5901.4 5951.9 1043.2 1083.0 1094.5 1099.5 1107.3 25615.1 25669.2 25685.4 25718.0 25780.6 1177.5 1178.7 1181.2 1183.1 1196.1 13200.0 13318.9 13323.9 13343.3 13472.3 246585.0 247832.0 247903.0 249924.0 251353.0 51884.0 51925.5 52205.7 52335.2 52427.7 1419.8 1470.7 1486.3 1495.8 1512.3 23639.4 24739.3 24922.9 24937.5 25075.2 36990.4 47803.8 48436.8 48811.5 48839.3 232296.0 232426.0 233878.0 234480.0 234821.0 33444.5 34285.1 34785.5 35010.8 35079.3 41524.8 43161.0 43169.6 43398.6 44216.1 32140.0 32233.8 32737.5 33041.8 33247.5 32560.2 32657.3 32898.7 33756.5 34293.3 37763.7 37833.8 38107.8 38109.4 38195.0 29789.0 29986.7 30383.8 31130.7 31389.2 23798.8 25765.6 26097.9 26239.9 26487.0 04:11:51 INFO - PID 6123 | 04:11:51 INFO - PID 6123 | [#2] jquery.html Cycles:180 Average:31219.65 Median:12352.49 stddev:81356.77 (658.6%) stddev-sans-first:81552.19 04:11:51 INFO - PID 6123 | Values: 449.7 451.4 457.0 468.4 470.4 19713.0 20746.8 21890.3 22401.3 22459.0 22326.0 22527.0 22856.2 23329.0 23475.0 5450.4 5452.8 5548.0 5573.1 5613.9 5387.6 5493.6 5494.2 5497.0 5503.7 5344.2 5496.9 5525.1 5571.2 5574.5 5221.2 5522.4 5549.9 5553.0 5564.1 4899.9 4941.0 4957.9 4961.7 4979.7 25192.2 25613.7 25887.7 26015.2 26242.3 2150.3 2166.9 2186.8 2188.0 2193.5 16644.2 16697.2 16785.4 17250.8 17443.1 2136.5 2183.5 2214.5 2214.9 2226.5 100378.0 107422.0 112808.0 115213.8 115506.0 12294.6 12298.2 12682.8 12764.0 13154.4 17654.2 17677.6 17694.9 17765.6 17807.2 8255.5 8426.6 8467.4 8554.1 8576.8 7676.2 7775.5 7807.6 8042.9 8062.5 7927.6 7991.0 8093.7 8130.9 8246.6 2246.0 2259.2 2317.2 2371.5 2430.6 1041.7 1061.4 1075.5 1077.0 1084.1 20712.5 20788.6 20903.8 20919.8 21026.5 1093.8 1097.3 1097.9 1101.4 1104.8 10985.9 11357.9 11391.4 11391.5 11445.4 477013.0 487976.0 490065.0 495523.0 497427.0 92902.5 94689.0 96044.0 97298.0 98439.5 1245.7 1261.9 1298.0 1318.6 1320.2 20314.2 20564.7 21204.7 21217.2 21261.0 46550.0 46680.3 47353.0 47808.0 47837.5 60346.0 61427.0 61533.0 61865.7 62472.4 9508.2 9686.6 9822.3 9868.3 9920.5 14925.9 14966.3 15057.5 15060.3 15304.3 12840.7 12871.2 13000.3 13138.4 13401.9 12174.0 12229.8 12421.7 12513.6 13472.3 13107.6 13179.7 13370.0 13611.4 13997.5 9569.5 9717.4 9773.5 9850.8 9945.0 12765.0 12882.9 13211.7 13437.6 13807.4 04:11:51 INFO - PID 6123 | 04:11:51 INFO - PID 6123 | [#3] mootools.html Cycles:180 Average:7350.07 Median:3162.18 stddev:4745.02 (150.1%) stddev-sans-first:4736.98 04:11:51 INFO - PID 6123 | Values: 1359.4 1393.2 1405.0 1415.1 1431.7 11384.5 11877.9 11897.2 12155.1 12540.0 11622.7 11746.9 11757.8 11815.0 11815.2 2440.1 2456.4 2507.3 2513.4 2515.2 2402.9 2408.7 2411.0 2415.0 2442.1 2459.7 2464.3 2467.3 2504.8 2509.6 2326.7 2405.9 2416.4 2451.7 2483.9 2106.4 2196.7 2273.0 2356.9 2434.3 11625.5 11638.9 11674.4 11687.7 11701.2 6659.0 6935.8 6936.2 6938.9 6959.0 3809.1 4071.7 4139.4 4141.3 4174.1 1215.0 1322.5 1354.7 1369.6 1372.2 17692.9 17860.1 17893.0 17953.5 17981.6 5398.5 5429.4 5541.8 5629.2 5706.5 12789.1 12815.4 12855.2 12855.4 12865.2 6637.6 6641.6 6669.2 6670.0 6713.8 6043.3 6195.1 6295.4 6380.0 6382.8 4316.4 4416.2 4446.8 4455.0 4477.5 1258.8 1269.1 1284.4 1294.8 1296.2 848.3 860.5 884.8 892.3 916.9 6440.9 6487.9 6488.3 6513.6 6523.9 643.3 646.4 647.2 656.9 657.5 4046.1 4327.4 4332.3 4352.1 4437.8 14609.0 15264.6 15275.5 15320.5 15432.8 15621.6 15761.4 15770.2 15787.5 15801.7 9254.6 9397.9 9423.9 9449.0 9456.8 7285.8 7321.8 7611.2 7663.7 7671.3 13201.7 13346.7 13421.6 13521.3 13523.7 13729.0 13797.6 14006.9 14044.7 14153.6 9530.0 9672.1 9808.0 9846.4 10053.3 11577.1 11720.2 11753.3 11757.0 11776.6 9265.9 9455.5 9474.7 9601.6 9687.2 9251.2 9321.2 9337.8 9376.3 9380.3 8309.1 8400.8 8438.0 8454.5 8456.4 5984.9 6001.1 6034.9 6154.4 6218.1 6174.8 6208.1 6209.6 6264.6 6401.6 04:11:51 INFO - PID 6123 | 04:11:51 INFO - PID 6123 | [#4] prototype.html Cycles:180 Average:5370.76 Median:6136.92 stddev:1628.56 (26.5%) stddev-sans-first:1589.79 04:11:51 INFO - PID 6123 | Values: 398.5 410.2 421.6 431.5 434.7 6009.9 6070.6 6093.2 6165.4 6166.0 5969.8 6071.3 6074.8 6090.9 6108.5 4565.0 4583.8 4585.2 4586.5 4587.5 4517.1 4537.5 4565.0 4574.2 4575.5 4521.4 4522.1 4530.5 4535.2 4539.8 4542.9 4546.5 4551.9 4560.3 4566.8 3859.3 3948.0 3956.1 3991.2 4013.4 5877.1 5886.3 5889.5 5913.6 5922.9 5283.3 5300.9 5345.8 5368.9 5369.4 6359.0 6388.5 6389.6 6413.7 6448.4 4449.5 4456.4 4467.8 4471.3 4471.9 6608.6 6698.8 6707.9 6714.7 6806.5 4517.9 4528.5 4536.7 4539.4 4563.2 4618.0 4627.4 4644.8 4648.1 4650.7 5253.5 5300.9 5304.4 5323.7 5379.6 6194.4 6395.8 6426.1 6433.5 6444.3 1574.2 1593.4 1601.0 1604.6 1606.1 1049.2 1075.6 1078.9 1080.9 1089.5 6177.1 6187.1 6194.4 6222.2 6224.2 6536.4 6594.4 6599.6 6612.2 6621.4 5906.3 6105.0 6218.9 6221.3 6234.2 3473.8 3481.8 3531.0 3532.1 3540.8 6834.4 6858.8 6931.4 6957.3 6992.4 6695.6 6771.9 6790.0 6812.3 6823.4 6714.2 6829.6 6882.0 6902.0 6920.0 6558.7 6592.9 6616.1 6616.3 6640.4 6448.2 6556.6 6576.3 6579.0 6581.6 6936.1 6946.6 6952.3 6952.8 6968.8 4468.2 4530.5 4554.2 4574.8 4578.5 6475.9 6601.0 6650.4 6654.0 6665.3 6429.9 6437.8 6466.5 6486.4 6518.2 6345.3 6383.2 6384.8 6390.4 6446.5 6346.3 6421.6 6425.7 6444.9 6456.6 6421.7 6478.2 6485.9 6507.0 6522.8 6074.7 6251.2 6292.2 6316.7 6323.6 04:11:51 INFO - PID 6123 | 04:11:51 INFO - PID 6123 | [#5] yui.html Cycles:180 Average:18825.62 Median:19212.81 stddev:22227.25 (115.7%) stddev-sans-first:22248.51 04:11:51 INFO - PID 6123 | Values: 827.4 855.9 862.1 874.1 883.7 14937.6 15661.9 15803.3 16274.8 16357.2 17676.3 18100.1 18168.0 18292.5 18657.9 1024.9 1043.5 1053.2 1053.5 1057.7 1027.4 1027.7 1028.1 1029.5 1030.9 1087.1 1089.3 1091.0 1098.1 1098.4 1074.1 1078.5 1082.8 1083.9 1091.3 747.7 772.5 792.1 795.2 799.7 15663.5 15706.0 15787.1 15803.6 15855.5 17823.0 18535.8 18625.3 18901.7 18919.9 15520.9 15534.3 15575.2 15667.7 15873.7 3444.3 3449.0 3457.8 3473.0 3498.7 88467.6 88919.6 89629.6 90368.5 91751.0 13561.9 13602.7 13736.5 13763.7 14055.8 26479.6 26680.9 26936.0 27131.0 27173.0 7904.0 8170.2 8175.0 8188.2 8229.2 4057.0 4122.1 4135.0 4141.2 4148.8 4434.2 4441.7 4554.6 4579.7 4595.7 832.8 848.6 852.9 856.8 862.0 700.0 705.0 726.4 731.0 748.0 11433.9 12577.7 12775.7 12776.1 12799.6 723.8 728.5 740.2 747.6 747.9 5414.6 5450.3 5867.5 5944.6 6022.6 73258.0 74668.6 74875.6 76009.0 78296.0 65565.6 67385.7 68674.3 69453.7 69737.3 61807.4 63312.0 64185.7 66278.0 67542.0 12324.0 12830.6 12943.2 12976.7 13039.8 33631.3 34154.5 34675.5 35064.6 36293.6 41527.4 41543.4 42069.2 43018.8 44093.1 16655.8 16799.3 16814.2 17786.5 18304.6 18764.8 19505.7 19692.1 20296.5 20537.2 17288.1 17709.6 17802.6 18558.6 18747.3 17558.2 18021.2 18040.0 18280.5 18513.8 17197.8 17379.3 17401.8 17816.2 18014.7 12657.2 12920.0 13052.1 13277.0 13316.6 14547.0 14595.3 14610.1 14763.2 14897.5 04:11:51 INFO - PID 6123 | -------- Summary: end -------- 04:11:51 INFO - PID 6123 | 04:11:51 INFO - TEST-INFO | 6123: exit 0 04:11:51 INFO - TEST-OK | dromaeo_css | took 1113807ms 04:11:51 INFO - TEST-START | kraken 04:11:51 INFO - operating with platform_type : linux_ 04:11:51 INFO - Initialising browser for kraken test... 04:11:51 INFO - TEST-INFO | started process 6539 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0TcbJu/profile http://localhost:44286/getInfo.html) 04:11:55 INFO - PID 6539 | __metrics Screen width/height:1600/1200 04:11:55 INFO - PID 6539 | colorDepth:24 04:11:55 INFO - PID 6539 | Browser inner width/height: 1024/695 04:11:55 INFO - PID 6539 | __metrics 04:11:57 INFO - TEST-INFO | 6539: exit 0 04:11:57 INFO - Browser initialized. 04:11:57 INFO - Running cycle 1/1 for kraken test... 04:11:57 INFO - TEST-INFO | started process 6716 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0TcbJu/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:12:09 INFO - PID 6716 | RSS: Main: 151093248 04:12:09 INFO - PID 6716 | 04:12:11 INFO - PID 6716 | Cycle 1(1): loaded http://localhost:44286/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44286/tests/kraken/driver.html?testName=audio-beat-detection) 04:12:12 INFO - PID 6716 | RSS: Main: 158289920 04:12:12 INFO - PID 6716 | 04:12:15 INFO - PID 6716 | Cycle 1(1): loaded http://localhost:44286/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44286/tests/kraken/driver.html?testName=audio-dft) 04:12:15 INFO - PID 6716 | RSS: Main: 156975104 04:12:15 INFO - PID 6716 | 04:12:18 INFO - PID 6716 | Cycle 1(1): loaded http://localhost:44286/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44286/tests/kraken/driver.html?testName=audio-fft) 04:12:19 INFO - PID 6716 | RSS: Main: 152936448 04:12:19 INFO - PID 6716 | 04:12:21 INFO - PID 6716 | Cycle 1(1): loaded http://localhost:44286/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44286/tests/kraken/driver.html?testName=audio-oscillator) 04:12:21 INFO - PID 6716 | RSS: Main: 154603520 04:12:21 INFO - PID 6716 | 04:12:24 INFO - PID 6716 | Cycle 1(1): loaded http://localhost:44286/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44286/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:12:24 INFO - PID 6716 | RSS: Main: 154779648 04:12:24 INFO - PID 6716 | 04:12:27 INFO - PID 6716 | Cycle 1(1): loaded http://localhost:44286/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44286/tests/kraken/driver.html?testName=imaging-darkroom) 04:12:28 INFO - PID 6716 | RSS: Main: 159514624 04:12:28 INFO - PID 6716 | 04:12:31 INFO - PID 6716 | Cycle 1(1): loaded http://localhost:44286/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44286/tests/kraken/driver.html?testName=imaging-desaturate) 04:12:32 INFO - PID 6716 | RSS: Main: 161693696 04:12:32 INFO - PID 6716 | 04:12:35 INFO - PID 6716 | Cycle 1(1): loaded http://localhost:44286/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44286/tests/kraken/driver.html?testName=json-parse-financial) 04:12:35 INFO - PID 6716 | RSS: Main: 160530432 04:12:35 INFO - PID 6716 | 04:12:37 INFO - PID 6716 | Cycle 1(1): loaded http://localhost:44286/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44286/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:12:37 INFO - PID 6716 | RSS: Main: 160747520 04:12:37 INFO - PID 6716 | 04:12:39 INFO - PID 6716 | Cycle 1(1): loaded http://localhost:44286/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44286/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:12:40 INFO - PID 6716 | RSS: Main: 160010240 04:12:40 INFO - PID 6716 | 04:12:42 INFO - PID 6716 | Cycle 1(1): loaded http://localhost:44286/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44286/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:12:42 INFO - PID 6716 | RSS: Main: 160034816 04:12:42 INFO - PID 6716 | 04:12:45 INFO - PID 6716 | Cycle 1(1): loaded http://localhost:44286/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44286/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:12:46 INFO - PID 6716 | RSS: Main: 160194560 04:12:46 INFO - PID 6716 | 04:12:49 INFO - PID 6716 | Cycle 1(1): loaded http://localhost:44286/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44286/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:12:49 INFO - PID 6716 | RSS: Main: 160952320 04:12:49 INFO - PID 6716 | 04:12:51 INFO - PID 6716 | Cycle 1(1): loaded http://localhost:44286/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44286/tests/kraken/driver.html?testName=ai-astar) 04:12:51 INFO - PID 6716 | RSS: Main: 162271232 04:12:51 INFO - PID 6716 | 04:12:51 INFO - PID 6716 | __start_tp_report 04:12:51 INFO - PID 6716 | _x_x_mozilla_page_load 04:12:51 INFO - PID 6716 | _x_x_mozilla_page_load_details 04:12:51 INFO - PID 6716 | |i|pagename|runs| 04:12:51 INFO - PID 6716 | |0;ai-astar;104;110;111;109;111;110;112;111;111;110 04:12:51 INFO - PID 6716 | |1;audio-beat-detection;147;117;119;163;118;119;125;117;141;119 04:12:51 INFO - PID 6716 | |2;audio-dft;164;165;166;164;163;162;164;166;165;167 04:12:51 INFO - PID 6716 | |3;audio-fft;73;75;74;99;76;74;74;74;95;75 04:12:51 INFO - PID 6716 | |4;audio-oscillator;82;82;99;84;82;82;101;82;83;104 04:12:51 INFO - PID 6716 | |5;imaging-gaussian-blur;113;115;114;114;114;114;114;113;114;114 04:12:51 INFO - PID 6716 | |6;imaging-darkroom;149;148;147;149;150;149;148;150;149;148 04:12:51 INFO - PID 6716 | |7;imaging-desaturate;95;95;95;95;95;94;95;94;94;94 04:12:51 INFO - PID 6716 | |8;json-parse-financial;47;47;49;49;49;47;49;48;48;48 04:12:51 INFO - PID 6716 | |9;json-stringify-tinderbox;54;54;55;54;54;56;54;54;54;54 04:12:51 INFO - PID 6716 | |10;stanford-crypto-aes;80;79;78;82;85;79;78;79;80;79 04:12:51 INFO - PID 6716 | |11;stanford-crypto-ccm;127;125;131;125;134;126;124;126;173;126 04:12:51 INFO - PID 6716 | |12;stanford-crypto-pbkdf2;183;183;181;182;185;182;192;186;186;183 04:12:51 INFO - PID 6716 | |13;stanford-crypto-sha256-iterative;67;66;68;66;68;65;65;65;67;65 04:12:51 INFO - PID 6716 | __end_tp_report 04:12:51 INFO - PID 6716 | __start_cc_report 04:12:51 INFO - PID 6716 | _x_x_mozilla_cycle_collect,785 04:12:51 INFO - PID 6716 | __end_cc_report 04:12:51 INFO - PID 6716 | __startTimestamp1494587571579__endTimestamp 04:12:51 INFO - PID 6716 | 04:12:51 INFO - PID 6716 | ------- Summary: start ------- 04:12:51 INFO - PID 6716 | Number of tests: 14 04:12:51 INFO - PID 6716 | 04:12:51 INFO - PID 6716 | [#0] ai-astar Cycles:10 Average:109.90 Median:111.00 stddev:2.23 (2.0%) stddev-sans-first:0.88 04:12:51 INFO - PID 6716 | Values: 104.0 110.0 111.0 109.0 111.0 110.0 112.0 111.0 111.0 110.0 04:12:51 INFO - PID 6716 | 04:12:51 INFO - PID 6716 | [#1] audio-beat-detection Cycles:10 Average:128.50 Median:122.00 stddev:16.15 (13.2%) stddev-sans-first:15.68 04:12:51 INFO - PID 6716 | Values: 147.0 117.0 119.0 163.0 118.0 119.0 125.0 117.0 141.0 119.0 04:12:51 INFO - PID 6716 | 04:12:51 INFO - PID 6716 | [#2] audio-dft Cycles:10 Average:164.60 Median:165.00 stddev:1.51 (0.9%) stddev-sans-first:1.58 04:12:51 INFO - PID 6716 | Values: 164.0 165.0 166.0 164.0 163.0 162.0 164.0 166.0 165.0 167.0 04:12:51 INFO - PID 6716 | 04:12:51 INFO - PID 6716 | [#3] audio-fft Cycles:10 Average:78.90 Median:75.00 stddev:9.62 (12.8%) stddev-sans-first:9.96 04:12:51 INFO - PID 6716 | Values: 73.0 75.0 74.0 99.0 76.0 74.0 74.0 74.0 95.0 75.0 04:12:51 INFO - PID 6716 | 04:12:51 INFO - PID 6716 | [#4] audio-oscillator Cycles:10 Average:88.10 Median:82.00 stddev:9.23 (11.3%) stddev-sans-first:9.52 04:12:51 INFO - PID 6716 | Values: 82.0 82.0 99.0 84.0 82.0 82.0 101.0 82.0 83.0 104.0 04:12:51 INFO - PID 6716 | 04:12:51 INFO - PID 6716 | [#5] imaging-gaussian-blur Cycles:10 Average:113.90 Median:114.00 stddev:0.57 (0.5%) stddev-sans-first:0.50 04:12:51 INFO - PID 6716 | Values: 113.0 115.0 114.0 114.0 114.0 114.0 114.0 113.0 114.0 114.0 04:12:51 INFO - PID 6716 | 04:12:51 INFO - PID 6716 | [#6] imaging-darkroom Cycles:10 Average:148.70 Median:149.00 stddev:0.95 (0.6%) stddev-sans-first:1.00 04:12:51 INFO - PID 6716 | Values: 149.0 148.0 147.0 149.0 150.0 149.0 148.0 150.0 149.0 148.0 04:12:51 INFO - PID 6716 | 04:12:51 INFO - PID 6716 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 04:12:51 INFO - PID 6716 | Values: 95.0 95.0 95.0 95.0 95.0 94.0 95.0 94.0 94.0 94.0 04:12:51 INFO - PID 6716 | 04:12:51 INFO - PID 6716 | [#8] json-parse-financial Cycles:10 Average:48.10 Median:48.50 stddev:0.88 (1.8%) stddev-sans-first:0.83 04:12:51 INFO - PID 6716 | Values: 47.0 47.0 49.0 49.0 49.0 47.0 49.0 48.0 48.0 48.0 04:12:51 INFO - PID 6716 | 04:12:51 INFO - PID 6716 | [#9] json-stringify-tinderbox Cycles:10 Average:54.30 Median:54.00 stddev:0.67 (1.2%) stddev-sans-first:0.71 04:12:51 INFO - PID 6716 | Values: 54.0 54.0 55.0 54.0 54.0 56.0 54.0 54.0 54.0 54.0 04:12:51 INFO - PID 6716 | 04:12:51 INFO - PID 6716 | [#10] stanford-crypto-aes Cycles:10 Average:79.90 Median:79.50 stddev:2.13 (2.7%) stddev-sans-first:2.26 04:12:51 INFO - PID 6716 | Values: 80.0 79.0 78.0 82.0 85.0 79.0 78.0 79.0 80.0 79.0 04:12:51 INFO - PID 6716 | 04:12:51 INFO - PID 6716 | [#11] stanford-crypto-ccm Cycles:10 Average:131.70 Median:126.50 stddev:14.83 (11.7%) stddev-sans-first:15.63 04:12:51 INFO - PID 6716 | Values: 127.0 125.0 131.0 125.0 134.0 126.0 124.0 126.0 173.0 126.0 04:12:51 INFO - PID 6716 | 04:12:51 INFO - PID 6716 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:184.30 Median:184.00 stddev:3.20 (1.7%) stddev-sans-first:3.36 04:12:51 INFO - PID 6716 | Values: 183.0 183.0 181.0 182.0 185.0 182.0 192.0 186.0 186.0 183.0 04:12:51 INFO - PID 6716 | 04:12:51 INFO - PID 6716 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.20 Median:66.50 stddev:1.23 (1.8%) stddev-sans-first:1.27 04:12:51 INFO - PID 6716 | Values: 67.0 66.0 68.0 66.0 68.0 65.0 65.0 65.0 67.0 65.0 04:12:51 INFO - PID 6716 | -------- Summary: end -------- 04:12:51 INFO - PID 6716 | 04:12:52 INFO - TEST-INFO | 6716: exit 0 04:12:52 INFO - TEST-OK | kraken | took 60836ms 04:12:52 INFO - SUITE-END | took 1174s 04:12:52 INFO - Completed test suite (00:19:34) 04:12:52 INFO - javascript benchmark 04:12:52 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7830.354024890889, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3363.630000699923, 3366.9831650841757, 3389.5932488101425, 3393.440082386405, 3399.898003059906, 5820.825375238739, 5957.642541447511, 5971.761129554818, 5973.253343332083, 6048.969755151218, 5972.134040564116, 5991.790287339944, 6017.308009578889, 6057.151998720183, 6100.23747031621, 5290.39160496544, 5301.098813201765, 5312.150055991042, 5342.091844386454, 5360.2763626910255, 5359.517643412092, 5368.32895888014, 5374.086405311087, 5413.079776438015, 5427.864303392407, 5243.449437809013, 5317.255584218213, 5324.41431442541, 5329.413764485904, 5423.918641220384, 5301.469853014706, 5312.73436328182, 5320.787168513293, 5327.094393953037, 5331.866703332447, 5068.391792984866, 5149.871253218662, 5152.948470515322, 5172.172452407597, 5175.663581867167, 5966.820995370146, 5982.760689572412, 5997.790077347272, 6021.668808215546, 6074.9392506075255, 6451.163923588122, 6467.256265529477, 6522.510811689142, 6533.346665333476, 6542.4438922691625, 6390.520710946651, 6473.514486413538, 6614.0740296358545, 6615.834604134887, 6650.0, 5968.31364393096, 6038.40449147401, 6086.847828804315, 6107.541934354941, 6114.633122012693, 6629.5359324846795, 6629.9337006630285, 6674.899876501856, 6683.899741503881, 6695.966520167368, 6181.443670069715, 6264.498840092781, 6347.492200624031, 6352.14246076783, 6377.74489020434, 6407.231132264158, 6538.869222615616, 6541.28045914949, 6542.509311801634, 6546.574472659262, 6508.284088750233, 6515.771947981798, 6517.934820651828, 6520.836979075466, 6529.183852018497, 6331.651759153291, 6473.158489396348, 6542.836429089216, 6543.0, 6555.246146693096, 4836.854894353175, 4875.488073752276, 4884.462709101996, 4923.040007198562, 4932.679375840559, 4367.344898265222, 4382.342648602735, 4424.955750442518, 4449.822007119744, 4489.551044895549, 6161.322254551996, 6178.073289006595, 6187.16473276111, 6187.721552530147, 6193.659348735772, 6330.493560515148, 6426.646534440651, 6498.285188629247, 6551.312112228243, 6554.3117972613145, 6078.969605152034, 6111.318268824403, 6141.271221159682, 6154.753809847556, 6168.1056246843955, 5632.267805185382, 5634.0, 5636.210930469738, 5637.661740295595, 5676.176954341598, 6721.966390168018, 6831.521793474509, 6834.419074378733, 6835.0, 6849.452043836382, 6352.269489008823, 6397.552171347961, 6405.295417504164, 6526.379993900572, 6531.085648009377, 6739.764108256188, 6755.42578880781, 6767.424768894699, 6768.424683901727, 6783.728650853911, 6343.238811342669, 6374.936250637435, 6381.617102973836, 6386.521010924106, 6420.101185833893, 6360.141380913703, 6366.9044964326495, 6453.064305675557, 6453.16108905858, 6498.935010649833, 6234.812955611339, 6283.748650053946, 6298.7480500781285, 6311.116443697794, 6319.715612797527, 6141.731496609813, 6225.844353891189, 6239.500839932885, 6277.5605707600025, 6283.528735344776, 6176.66028368444, 6177.938220617916, 6182.350853160354, 6203.751849925952, 6250.124982502544, 6319.178506794087, 6394.840128996812, 6407.9038814418755, 6442.645654488861, 6462.806115816533, 6001.549883758648, 6189.81430557084, 6235.376462353728, 6236.376362363727, 6244.906326405198], "value": 5927.5248742932645, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [748.3078152708744, 811.3955103447933, 836.0135040652032, 1124.9100071994242, 1138.3682056458672, 35478.645213547854, 36359.63640363599, 36431.81784091076, 36449.08877278066, 36457.635423645756, 38100.80949595248, 38612.61387386125, 38832.80583597085, 38843.611563884355, 38861.61138388615, 6955.826104347394, 7003.5097543172, 7055.788326350218, 7208.0, 7223.855522889539, 7083.362497375235, 7084.326988936069, 7127.501074924731, 7145.071140751695, 7157.103367607589, 7170.928290717078, 7183.964080179592, 7197.496175267734, 7213.458990575701, 7230.385417239541, 7073.469489788235, 7107.466939979522, 7140.357367836894, 7145.606991615433, 7154.749583764569, 7065.0, 7149.606771627558, 7163.462740294499, 7179.246179151166, 7182.06633137694, 35027.0, 35536.466952995725, 35537.822310888536, 35549.822250888836, 35615.28769424623, 3511.0695665648623, 3519.225770330523, 3532.2405682778326, 3534.5581802274714, 3558.323918455511, 28102.156935291972, 28193.85903070492, 28294.71705282962, 28339.433211335865, 28414.147575572766, 3754.2303827715255, 3757.906052348686, 3763.284975854579, 3771.5851256362052, 3798.2213646202463, 192205.0, 192415.0, 202160.0, 208508.0, 209351.95324023435, 45465.09069818585, 45664.86702659482, 45741.542584574396, 45913.540864591596, 45970.0, 47444.7627761859, 47458.0, 47592.7620361896, 49322.260166097534, 50614.746926265136, 14403.279836008158, 14567.0, 14579.271036448135, 14579.489717859824, 14579.92710036443, 11515.481803318871, 11518.481668324945, 11558.075353971662, 11577.884221157681, 11580.594679186188, 13917.0, 14155.150690958575, 14170.220637865017, 14243.501477448239, 14304.427822886968, 5732.426757324318, 5845.386234445407, 5896.469317761422, 5901.439363260483, 5951.940480595225, 1043.1654676258963, 1082.99458502707, 1094.4691824465128, 1099.5491848342142, 1107.335598640825, 25615.103471378785, 25669.229923102335, 25685.3578660535, 25718.0, 25780.613290800655, 1177.4819079605118, 1178.6994316449423, 1181.1554738362113, 1183.1244878789635, 1196.132803717298, 13200.0, 13318.933405332911, 13323.93338033323, 13343.332833358294, 13472.326383680776, 246585.0, 247832.0, 247903.0, 249924.0, 251353.0, 51884.0, 51925.48074519282, 52205.7389713049, 52335.21497177545, 52427.73786131045, 1419.8154239948947, 1470.6764511807385, 1486.3088663771182, 1495.7980672609276, 1512.2665507228985, 23639.40901477408, 24739.25782226536, 24922.875385622956, 24937.49968936239, 25075.247742567753, 36990.44514332341, 47803.76098119487, 48436.757816210695, 48811.511884880696, 48839.29062482796, 232296.0, 232426.0, 233878.0, 234480.0, 234821.0, 33444.49833252455, 34285.142871427415, 34785.47821782726, 35010.82494587511, 35079.298414031065, 41524.79237603793, 43160.95746595542, 43169.568304317814, 43398.56601433945, 44216.11567768562, 32140.0, 32233.838830805696, 32737.50893736548, 33041.834790826855, 33247.50128748023, 32560.185995350304, 32657.34685306328, 32898.67101329052, 33756.493652595724, 34293.314133717686, 37763.69198776265, 37833.81083094677, 38107.809460952514, 38109.4283585752, 38195.0, 29789.0, 29986.700132999264, 30383.848080760337, 31130.688693112777, 31389.21526961753, 23798.762012379655, 25765.59555762171, 26097.869510653083, 26239.868800655873, 26487.0], "value": 17043.79594403443, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [449.7369039112119, 451.4131628882453, 456.97258164510134, 468.38407494145196, 470.4190324948688, 19713.0, 20746.792532074676, 21890.343289701334, 22401.32796016118, 22459.0, 22326.0, 22527.0, 22856.200032998848, 23329.0, 23475.0, 5450.427705090968, 5452.809151679682, 5548.0, 5573.08044172711, 5613.943860561383, 5387.568994480452, 5493.587980901429, 5494.230807686907, 5497.0, 5503.697296648683, 5344.22508736233, 5496.890062198753, 5525.060739674265, 5571.220029195916, 5574.526165275956, 5221.216817477371, 5522.420145884685, 5549.861253468675, 5553.028220061493, 5564.081926482126, 4899.853004409873, 4940.975295123538, 4957.876053098701, 4961.677490963076, 4979.651424400294, 25192.244232672867, 25613.74386256132, 25887.741122588723, 26015.21954341373, 26242.343941401617, 2150.32264836576, 2166.9349919502442, 2186.8031877131134, 2188.004457971619, 2193.4954960359205, 16644.167791610493, 16697.248623811956, 16785.412510562193, 17250.82749172505, 17443.12784360777, 2136.4979229880964, 2183.5087105401158, 2214.4795972946345, 2214.8671079735104, 2226.532428190082, 100378.0, 107422.0, 112808.0, 115213.84786152115, 115506.0, 12294.631161065183, 12298.20061695987, 12682.80975785364, 12764.0, 13154.4080516377, 17654.205560749797, 17677.55806104832, 17694.91152544229, 17765.644687106185, 17807.19867605961, 8255.504669719836, 8426.578671066422, 8467.407281490237, 8554.05905350411, 8576.828463430697, 7676.232376762391, 7775.494592851446, 7807.6486558105025, 8042.879356809653, 8062.516249025077, 7927.563983980936, 7991.0, 8093.716719914774, 8130.918690813016, 8246.587670616565, 2245.9887700561394, 2259.152817693365, 2317.177402022258, 2371.5494056129282, 2430.611102223671, 1041.6979076067855, 1061.3843970497094, 1075.4998925499524, 1076.9946150269197, 1084.143526613982, 20712.48218794512, 20788.58422831535, 20903.79096209049, 20919.790802092088, 21026.47433814167, 1093.830456279278, 1097.25386737018, 1097.8902109788958, 1101.4162493878257, 1104.7679987202778, 10985.890141098487, 11357.943210283896, 11391.430428478543, 11391.487383067783, 11445.370504622326, 477013.0, 487976.0, 490065.0, 495523.0, 497427.0, 92902.53548732348, 94689.0, 96044.0, 97298.02701973032, 98439.50780246053, 1245.701031752373, 1261.949522019109, 1297.9675508112184, 1318.5780550223835, 1320.2012782266781, 20314.187432502535, 20564.691529627366, 21204.68192977076, 21217.15131394789, 21261.0, 46550.0, 46680.29979550242, 47353.0, 47808.0, 47837.5216247847, 60346.0, 61427.0, 61533.0, 61865.690671546356, 62472.37527624847, 9508.191803696764, 9686.564104615169, 9822.263330250116, 9868.259880508847, 9920.454375009154, 14925.850741492446, 14966.251687415803, 15057.54827355181, 15060.322285496959, 15304.311305991034, 12840.743185136433, 12871.22772633645, 13000.284984325954, 13138.408771605491, 13401.865981340452, 12174.026077913923, 12229.75540489203, 12421.689457763629, 12513.562025329069, 13472.32638368058, 13107.606771796862, 13179.736405272033, 13370.0, 13611.387487563281, 13997.5100871469, 9569.521523923637, 9717.368371055858, 9773.48510980799, 9850.802983940424, 9945.0, 12765.0, 12882.935585322013, 13211.66970825737, 13437.596872093853, 13807.447702091804], "value": 10292.55198171052, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1359.367893929323, 1393.2128347483672, 1404.9578512644625, 1415.087268711681, 1431.7494438473268, 11384.544618215272, 11877.881221187796, 11897.167198296134, 12155.088368372364, 12540.0, 11622.709432264197, 11746.882531174686, 11757.764844703122, 11814.995725363355, 11815.17293789433, 2440.1093600835743, 2456.435019945414, 2507.3480894967256, 2513.384220865881, 2515.207709571488, 2402.8798560072014, 2408.650745641881, 2410.9758902411013, 2415.0339864054345, 2442.096424323003, 2459.692538432696, 2464.297675162579, 2467.259822053386, 2504.8497090174646, 2509.5859183234743, 2326.654881162843, 2405.879706014692, 2416.395901024744, 2451.7303096659352, 2483.919495019672, 2106.420734298065, 2196.6595177747477, 2272.9545409091893, 2356.9410764730846, 2434.342727463575, 11625.534978600846, 11638.883611163865, 11674.35791031493, 11687.7078073048, 11701.239419437794, 6659.0, 6935.826604334881, 6936.2023367312395, 6938.930610693879, 6959.0, 3809.142942837867, 4071.6742660587083, 4139.4204811326435, 4141.275276826574, 4174.102567947906, 1215.011072761009, 1322.5238913990956, 1354.7222819322014, 1369.6165073779357, 1372.2315503318075, 17692.91153544237, 17860.124686907948, 17893.0, 17953.461396158134, 17981.640367192584, 5398.514133727905, 5429.4299098594865, 5541.778328866801, 5629.155626655953, 5706.514946229534, 12789.10476266671, 12815.359232038361, 12855.228686278853, 12855.357232138544, 12865.228086314664, 6637.601743895381, 6641.601503909781, 6669.199696036507, 6670.0, 6713.765018224339, 6043.305019922677, 6195.132681424604, 6295.401936815995, 6380.0, 6382.776602818879, 4316.43886294786, 4416.24923762961, 4446.799364171656, 4455.0, 4477.485089214717, 1258.779713550125, 1269.0799170601424, 1284.441268048402, 1294.76046931318, 1296.1963582578862, 848.3128665780737, 860.5310105992249, 884.7832281091045, 892.2549671024638, 916.935814492979, 6440.903386449207, 6487.902681459782, 6488.28628850826, 6513.576617519846, 6523.8695226095215, 643.3116565275204, 646.3956200952125, 647.184547470191, 656.9474442044625, 657.4608820767021, 4046.109855831712, 4327.394164816928, 4332.26351520236, 4352.064306174188, 4437.800298986554, 14609.0, 15264.618384540254, 15275.541733748005, 15320.540383788504, 15432.845671543366, 15621.609459763597, 15761.448349307719, 15770.211489425483, 15787.526374208792, 15801.683966320608, 9254.629814807467, 9397.90602093984, 9423.90576094244, 9449.0, 9456.810863782823, 7285.7814265572115, 7321.816954576178, 7611.162772095176, 7663.693452261847, 7671.309582137635, 13201.735965280448, 13346.733065338833, 13421.597352079454, 13521.323933803467, 13523.661908451973, 13729.0, 13797.586072417844, 14006.929965350108, 14044.719105618035, 14153.646158846112, 9530.0, 9672.129508344282, 9808.0, 9846.359986600848, 10053.346532475365, 11577.131715121232, 11720.179587429138, 11753.294802311888, 11757.0, 11776.587819426279, 9265.907340926775, 9455.479948602893, 9474.668386606436, 9601.567929443052, 9687.225021998363, 9251.213646840093, 9321.161095501437, 9337.813243734952, 9376.29677774156, 9380.343375963617, 8309.086000540057, 8400.789980250544, 8437.987441507059, 8454.492730435948, 8456.365772566958, 5984.940150598438, 6001.099835024781, 6034.939650603438, 6154.3845615438095, 6218.067289906369, 6174.845628859314, 6208.099825525183, 6209.627422354673, 6264.561480696308, 6401.55189136756], "value": 5459.732716678795, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [398.481973434535, 410.1735003967005, 421.5657872391437, 431.5059257150564, 434.7478462491755, 6009.939900600993, 6070.635761854286, 6093.177421048163, 6165.352637973016, 6165.969170154154, 5969.761209551612, 6071.3018002929675, 6074.8481287967825, 6090.908636370458, 6108.480779133779, 4564.954350456503, 4583.8166473341025, 4585.151746926813, 4586.541345865404, 4587.472440669332, 4517.141743068806, 4537.481697657799, 4564.97717511412, 4574.153781550407, 4575.5424457554145, 4521.412216411878, 4522.118186953546, 4530.501644819067, 4535.160995215879, 4539.818407263722, 4542.909141817178, 4546.477155127137, 4551.8634440966825, 4560.293154561048, 4566.817327306921, 3859.3053250414914, 3947.960520394788, 3956.1296514766705, 3991.1818077294083, 4013.418054382098, 5877.05967045275, 5886.293644762613, 5889.528837692974, 5913.586048976574, 5922.851928701773, 5283.339582552181, 5300.946990530084, 5345.812896548641, 5368.91946620801, 5369.382521010095, 6358.968205158944, 6388.488920886364, 6389.616623002588, 6413.711382987777, 6448.387403196689, 4449.466064072332, 4456.3538286948215, 4467.798949047268, 4471.28459446487, 4471.910561788779, 6608.636524991123, 6698.765543205965, 6707.932920670828, 6714.697838597275, 6806.523543351967, 4517.864464066083, 4528.50186479487, 4536.659750518725, 4539.432570928634, 4563.224251877189, 4618.0, 4627.398438203012, 4644.8374306899095, 4648.140094082538, 4650.720956742606, 5253.50091741284, 5300.946990530122, 5304.396676621086, 5323.680579165185, 5379.569634429236, 6194.411530904647, 6395.808125756234, 6426.132472116298, 6433.453156481658, 6444.260049786531, 1574.181425658651, 1593.39451008616, 1601.0, 1604.646977664935, 1606.1246620591805, 1049.239301506417, 1075.6450371377427, 1078.9298695584762, 1080.8811030786765, 1089.4824958144977, 6177.104319873593, 6187.102870083812, 6194.442500174916, 6222.191115155001, 6224.1597384352535, 6536.411722944958, 6594.373534514213, 6599.637019963852, 6612.206535215805, 6621.404073633396, 5906.3207731110615, 6105.0, 6218.906716399258, 6221.346758590283, 6234.199666257047, 3473.8263086846064, 3481.8433170507387, 3530.982345088258, 3532.1346270163463, 3540.769849959796, 6834.419074378733, 6858.776375103793, 6931.376176144171, 6957.2694867038235, 6992.405645520086, 6695.598264104169, 6771.8984215236815, 6790.0, 6812.284710105467, 6823.351781580742, 6714.160729908762, 6829.556078854858, 6881.965590172017, 6902.0, 6919.965400173068, 6558.704858281293, 6592.90110648331, 6616.139901812926, 6616.338366163538, 6640.414176344912, 6448.161738974091, 6556.573822701509, 6576.297946967749, 6579.013148027642, 6581.638009909501, 6936.0636314096955, 6946.6179360135675, 6952.304769523007, 6952.791416257318, 6968.78046341878, 4468.2180618391, 4530.501644819134, 4554.20301447252, 4574.817007319803, 4578.5421457853945, 6475.902861457176, 6601.042848786995, 6650.3682150195655, 6654.0, 6665.266820649627, 6429.903551446639, 6437.806865794034, 6466.482681385383, 6486.351364863476, 6518.2178138621775, 6345.270293916259, 6383.170187875547, 6384.808455746335, 6390.4248617624635, 6446.4520515756685, 6346.333634968447, 6421.646809425526, 6425.710843012169, 6444.903326450013, 6456.580322279036, 6421.678916054085, 6478.1578394808375, 6485.876157835257, 6506.958886578125, 6522.836929076811, 6074.726637301421, 6251.187345645037, 6292.244930608356, 6316.747330106744, 6323.557350985387], "value": 4863.017939053047, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [827.3711978896044, 855.935804814639, 862.0904945282728, 874.1127755328342, 883.7083762358423, 14937.626559336022, 15661.92169039156, 15803.288852001659, 16274.83725162748, 16357.182140892952, 17676.292948282055, 18100.094995250252, 18168.0, 18292.451226463196, 18657.90671046646, 1024.9077583017527, 1043.4521876015076, 1053.1995683280722, 1053.515382923856, 1057.6826951914434, 1027.398971601614, 1027.655735328662, 1028.0695970147028, 1029.526417847791, 1030.8969103089669, 1087.075985412401, 1089.3246187363845, 1090.9563617455292, 1098.0666433531514, 1098.3629494892944, 1074.1192222377654, 1078.4715489410212, 1082.7509672775266, 1083.875354334246, 1091.3015669971185, 747.6784982457541, 772.5326177662489, 792.1286584756779, 795.1968511803062, 799.6521513141802, 15663.451779187788, 15706.0, 15787.131707756069, 15803.604909877231, 15855.524334269874, 17823.0, 18535.814641853678, 18625.348112815987, 18901.7164742529, 18919.905400473046, 15520.922395388065, 15534.300956456986, 15575.221238938007, 15667.746580273551, 15873.682526349523, 3444.2594842109065, 3448.9827550862087, 3457.75795694299, 3473.027552285364, 3498.6851183393364, 88467.55766221127, 88919.55540222257, 89629.55185224031, 90368.54815725944, 91751.0, 13561.864381356258, 13602.727945441036, 13736.519221827188, 13763.724725505434, 14055.78916316256, 26479.602805957926, 26680.8665956669, 26936.0, 27131.0, 27173.0, 7904.0, 8170.223828736261, 8174.9781277340335, 8188.181181881883, 8229.177082291722, 4056.959430405658, 4122.113745544722, 4135.0, 4141.171765646883, 4148.751074935513, 4434.157510073076, 4441.71128876622, 4554.590086892195, 4579.656525760582, 4595.724256544618, 832.7918020494876, 848.6350869126335, 852.9317654587618, 856.8329175810657, 862.0000799073046, 699.9860002800017, 704.9823754406181, 726.393461459687, 731.0459849895831, 747.9887801682979, 11433.885661143448, 12577.685557861127, 12775.680607984874, 12776.105672603015, 12799.616011519669, 723.8490799628615, 728.471857903016, 740.1894925057054, 747.6112421540769, 747.9102507699002, 5414.648047876875, 5450.346881062912, 5867.501262392659, 5944.613600116065, 6022.608530445507, 73258.0, 74668.62665686637, 74875.62562187263, 76009.0, 78296.0, 65565.6110858478, 67385.66307168531, 68674.3132568668, 69453.65273173602, 69737.3026269741, 61807.38192618016, 63312.0, 64185.67907160434, 66278.0, 67542.0, 12324.0, 12830.615081547568, 12943.158694684815, 12976.675583110498, 13039.804402934153, 33631.3273734519, 34154.48768268428, 34675.492186015654, 35064.64935350614, 36293.63706362902, 41527.377089344285, 41543.37684934668, 42069.15861682811, 43018.78490607527, 44093.118137636426, 16655.75016374731, 16799.32802687879, 16814.243359049116, 17786.46640600784, 18304.633907321513, 18764.812351876306, 19505.70741438851, 19692.11385487685, 20296.492587685425, 20537.17851285932, 17288.13559322004, 17709.64580708353, 17802.554936126184, 18558.628827423105, 18747.34384296543, 17558.20988055515, 18021.189046492676, 18040.0, 18280.45158645243, 18513.81486185121, 17197.828021719622, 17379.304827806747, 17401.82598174002, 17816.19827107809, 18014.72977905359, 12657.177283476545, 12920.0, 13052.086353955132, 13277.0, 13316.600501984956, 14547.0, 14595.336895841368, 14610.050346727428, 14763.188024658746, 14897.47858824936], "value": 8348.709008734824, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1491.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 110.0, 111.0, 109.0, 111.0, 110.0, 112.0, 111.0, 111.0, 110.0], "value": 109.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 117.0, 119.0, 163.0, 118.0, 119.0, 125.0, 117.0, 141.0, 119.0], "value": 128.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 165.0, 166.0, 164.0, 163.0, 162.0, 164.0, 166.0, 165.0, 167.0], "value": 164.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 75.0, 74.0, 99.0, 76.0, 74.0, 74.0, 74.0, 95.0, 75.0], "value": 78.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 99.0, 84.0, 82.0, 82.0, 101.0, 82.0, 83.0, 104.0], "value": 88.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 115.0, 114.0, 114.0, 114.0, 114.0, 114.0, 113.0, 114.0, 114.0], "value": 113.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 148.0, 147.0, 149.0, 150.0, 149.0, 148.0, 150.0, 149.0, 148.0], "value": 148.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 94.0, 94.0, 94.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [47.0, 47.0, 49.0, 49.0, 49.0, 47.0, 49.0, 48.0, 48.0, 48.0], "value": 48.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 55.0, 54.0, 54.0, 56.0, 54.0, 54.0, 54.0, 54.0], "value": 54.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 79.0, 78.0, 82.0, 85.0, 79.0, 78.0, 79.0, 80.0, 79.0], "value": 79.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 125.0, 131.0, 125.0, 134.0, 126.0, 124.0, 126.0, 173.0, 126.0], "value": 131.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 183.0, 181.0, 182.0, 185.0, 182.0, 192.0, 186.0, 186.0, 183.0], "value": 184.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 68.0, 66.0, 68.0, 65.0, 65.0, 65.0, 67.0, 65.0], "value": 66.2, "unit": "score"}]}]} 04:12:52 INFO - Return code: 0 04:12:52 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:12:52 INFO - # TBPL SUCCESS # 04:12:52 INFO - Running post-action listener: _resource_record_post_action 04:12:52 INFO - [mozharness: 2017-05-12 11:12:52.877592Z] Finished run-tests step (success) 04:12:52 INFO - Running post-run listener: _resource_record_post_run 04:12:52 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 618496; Write bytes: 385150976; Read time: 132; Write time: 238332 04:12:52 INFO - TinderboxPrint: CPU usage
13.2% 04:12:52 INFO - TinderboxPrint: I/O read bytes / time
618,496 / 132 04:12:52 INFO - TinderboxPrint: I/O write bytes / time
385,150,976 / 238,332 04:12:52 INFO - TinderboxPrint: CPU idle
8,253.9 (86.8%) 04:12:52 INFO - TinderboxPrint: CPU user
1,201.0 (12.6%) 04:12:52 INFO - TinderboxPrint: Swap in / out
0 / 0 04:12:52 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 119799808; Read time: 0; Write time: 90932 04:12:52 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 614400; Write bytes: 265351168; Read time: 108; Write time: 147400 04:12:53 INFO - Running post-run listener: _upload_blobber_files 04:12:53 INFO - Blob upload gear active. 04:12:53 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:12:53 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 04:12:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:12:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:12:53 INFO - (blobuploader) - INFO - Open directory for files ... 04:12:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:12:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:12:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:12:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:12:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:12:54 INFO - (blobuploader) - INFO - Done attempting. 04:12:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 04:12:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:12:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:12:55 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 04:12:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:12:55 INFO - (blobuploader) - INFO - Done attempting. 04:12:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:12:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:12:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:12:58 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:12:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:12:58 INFO - (blobuploader) - INFO - Done attempting. 04:12:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:12:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:12:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:12:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:12:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:12:59 INFO - (blobuploader) - INFO - Done attempting. 04:12:59 INFO - (blobuploader) - INFO - Iteration through files over. 04:12:59 INFO - Return code: 0 04:12:59 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:12:59 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:12:59 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2260c74dea825d3d2ae11ce90c89c32d04784c0e3c5933f5b6470e6b1ba7543def8507a24cb6f35be1999f4684be1974e0dc4b3e556a196bb4fe2de3961f425a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2569eb8e65904033c616dd9fcdc1ee05ace5393be108158517e737e4200edb45c0e7ff274d886c28b6c68c3b46678934f70b261f4880020982471fcd616870d1", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3f0e71824a60e24ea91bc64ad5d0b40bda81205bb79647514eff7437ebee176785bbb5091eb91f89b9c862276b954a6b97508d8ad07bb886bc8b323b06965f1c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8fb94745dab2b17c56632f4f0f763e0e3ace254fc102ddf1e788c4ed5bfc1386b03fb4ae71c7067f8c0a42f52a91e28463e605eb3cfc8a5d8ea60d262de2f75c"} 04:12:59 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:12:59 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:12:59 INFO - Contents: 04:12:59 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2260c74dea825d3d2ae11ce90c89c32d04784c0e3c5933f5b6470e6b1ba7543def8507a24cb6f35be1999f4684be1974e0dc4b3e556a196bb4fe2de3961f425a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2569eb8e65904033c616dd9fcdc1ee05ace5393be108158517e737e4200edb45c0e7ff274d886c28b6c68c3b46678934f70b261f4880020982471fcd616870d1", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3f0e71824a60e24ea91bc64ad5d0b40bda81205bb79647514eff7437ebee176785bbb5091eb91f89b9c862276b954a6b97508d8ad07bb886bc8b323b06965f1c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8fb94745dab2b17c56632f4f0f763e0e3ace254fc102ddf1e788c4ed5bfc1386b03fb4ae71c7067f8c0a42f52a91e28463e605eb3cfc8a5d8ea60d262de2f75c"} 04:12:59 INFO - Running post-run listener: copy_logs_to_upload_dir 04:12:59 INFO - Copying logs to upload dir... 04:12:59 INFO - mkdir: /builds/slave/test/build/upload/logs 04:12:59 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.361250 ========= master_lag: 0.24 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2017-05-12 04:12:59.866609) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-12 04:12:59.872800) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1494585323.378922-522741995 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2260c74dea825d3d2ae11ce90c89c32d04784c0e3c5933f5b6470e6b1ba7543def8507a24cb6f35be1999f4684be1974e0dc4b3e556a196bb4fe2de3961f425a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2569eb8e65904033c616dd9fcdc1ee05ace5393be108158517e737e4200edb45c0e7ff274d886c28b6c68c3b46678934f70b261f4880020982471fcd616870d1", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3f0e71824a60e24ea91bc64ad5d0b40bda81205bb79647514eff7437ebee176785bbb5091eb91f89b9c862276b954a6b97508d8ad07bb886bc8b323b06965f1c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8fb94745dab2b17c56632f4f0f763e0e3ace254fc102ddf1e788c4ed5bfc1386b03fb4ae71c7067f8c0a42f52a91e28463e605eb3cfc8a5d8ea60d262de2f75c"} build_url:https://queue.taskcluster.net/v1/task/Jt9B3QZUS5CaIvbQegJIuA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011347 build_url: 'https://queue.taskcluster.net/v1/task/Jt9B3QZUS5CaIvbQegJIuA/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2260c74dea825d3d2ae11ce90c89c32d04784c0e3c5933f5b6470e6b1ba7543def8507a24cb6f35be1999f4684be1974e0dc4b3e556a196bb4fe2de3961f425a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2569eb8e65904033c616dd9fcdc1ee05ace5393be108158517e737e4200edb45c0e7ff274d886c28b6c68c3b46678934f70b261f4880020982471fcd616870d1", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3f0e71824a60e24ea91bc64ad5d0b40bda81205bb79647514eff7437ebee176785bbb5091eb91f89b9c862276b954a6b97508d8ad07bb886bc8b323b06965f1c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8fb94745dab2b17c56632f4f0f763e0e3ace254fc102ddf1e788c4ed5bfc1386b03fb4ae71c7067f8c0a42f52a91e28463e605eb3cfc8a5d8ea60d262de2f75c"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-12 04:12:59.900240) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-12 04:12:59.900645) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1494585323.378922-522741995 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004410 ========= master_lag: 0.13 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-12 04:13:00.036609) ========= ========= Started reboot skipped (results: 3, elapsed: 1 secs) (at 2017-05-12 04:13:00.036915) ========= ========= Finished reboot skipped (results: 3, elapsed: 1 secs) (at 2017-05-12 04:13:01.266954) ========= ========= Total master_lag: 0.45 =========