builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-060 starttime: 1494553161.42 results: success (0) revision: 2a8e0c4be57d244bf59543750d047b2ab7c8bbdc ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-11 18:39:21.418110) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-11 18:39:21.418568) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-11 18:39:21.418865) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-11 18:39:21.433079) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-11 18:39:21.433381) ========= 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=337fe3f4b1febe37b85fccc40000019e-1494553160.648458-1493621536 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-11 18:39:21-- 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% 53.5M=0s 2017-05-11 18:39:21 (53.5 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.150627 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-11 18:39:21.597709) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-11 18:39:21.598023) ========= 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=337fe3f4b1febe37b85fccc40000019e-1494553160.648458-1493621536 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016073 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-11 18:39:21.646921) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-11 18:39:21.647258) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 2a8e0c4be57d244bf59543750d047b2ab7c8bbdc --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 2a8e0c4be57d244bf59543750d047b2ab7c8bbdc --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=337fe3f4b1febe37b85fccc40000019e-1494553160.648458-1493621536 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-11 18:39:21,927 truncating revision to first 12 chars 2017-05-11 18:39:21,927 Setting DEBUG logging. 2017-05-11 18:39:21,927 attempt 1/10 2017-05-11 18:39:21,927 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/2a8e0c4be57d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-11 18:39:22,383 unpacking tar archive at: mozilla-central-2a8e0c4be57d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.779259 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-11 18:39:22.442911) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-11 18:39:22.443238) ========= script_repo_revision: 2a8e0c4be57d244bf59543750d047b2ab7c8bbdc ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-11 18:39:22.446772) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-11 18:39:22.447060) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-11 18:39:22.456849) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2017-05-11 18:39:22.457279) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=337fe3f4b1febe37b85fccc40000019e-1494553160.648458-1493621536 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:39:22 INFO - MultiFileLogger online at 20170511 18:39:22 in /builds/slave/test 18:39:22 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 18:39:22 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:39:22 INFO - {'append_to_log': False, 18:39:22 INFO - 'base_work_dir': '/builds/slave/test', 18:39:22 INFO - 'blob_upload_branch': 'Firefox', 18:39:22 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:39:22 INFO - 'branch': 'Firefox', 18:39:22 INFO - 'buildbot_json_path': 'buildprops.json', 18:39:22 INFO - 'config_files': ('talos/linux_config.py',), 18:39:22 INFO - 'default_actions': ('clobber', 18:39:22 INFO - 'read-buildbot-config', 18:39:22 INFO - 'download-and-extract', 18:39:22 INFO - 'populate-webroot', 18:39:22 INFO - 'create-virtualenv', 18:39:22 INFO - 'install', 18:39:22 INFO - 'run-tests'), 18:39:22 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:39:22 INFO - 'download_minidump_stackwalk': True, 18:39:22 INFO - 'download_symbols': 'ondemand', 18:39:22 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:39:22 INFO - 'tooltool.py': '/tools/tooltool.py', 18:39:22 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:39:22 INFO - '/tools/misc-python/virtualenv.py')}, 18:39:22 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:39:22 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:39:22 INFO - 'gecko_profile': False, 18:39:22 INFO - 'gecko_profile_interval': 0, 18:39:22 INFO - 'installer_path': 'installer.exe', 18:39:22 INFO - 'log_level': 'info', 18:39:22 INFO - 'log_name': 'talos', 18:39:22 INFO - 'log_to_console': True, 18:39:22 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:39:22 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:39:22 INFO - 'opt_config_files': (), 18:39:22 INFO - 'pip_index': False, 18:39:22 INFO - 'suite': 'dromaeojs-e10s', 18:39:22 INFO - 'system_bits': '32', 18:39:22 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:39:22 INFO - 'title': 'talos-linux64-ix-060', 18:39:22 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:39:22 INFO - 'use_talos_json': True, 18:39:22 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:39:22 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:39:22 INFO - 'work_dir': 'build'} 18:39:22 INFO - [mozharness: 2017-05-12 01:39:22.838128Z] Running clobber step. 18:39:22 INFO - Running pre-action listener: _resource_record_pre_action 18:39:22 INFO - Running main action method: clobber 18:39:22 INFO - rmtree: /builds/slave/test/build 18:39:22 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:39:24 INFO - Running post-action listener: _resource_record_post_action 18:39:24 INFO - [mozharness: 2017-05-12 01:39:24.383415Z] Finished clobber step (success) 18:39:24 INFO - [mozharness: 2017-05-12 01:39:24.383516Z] Running read-buildbot-config step. 18:39:24 INFO - Running pre-action listener: _resource_record_pre_action 18:39:24 INFO - Running main action method: read_buildbot_config 18:39:24 INFO - Using buildbot properties: 18:39:24 INFO - { 18:39:24 INFO - "project": "", 18:39:24 INFO - "product": "firefox", 18:39:24 INFO - "who": "kwierso@gmail.com", 18:39:24 INFO - "installer_path": "public/build/target.tar.bz2", 18:39:24 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 18:39:24 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 18:39:24 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 18:39:24 INFO - "stage_platform": "linux64-pgo", 18:39:24 INFO - "basedir": "/builds/slave/test", 18:39:24 INFO - "buildnumber": 207, 18:39:24 INFO - "platform": "ubuntu64_hw", 18:39:24 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 18:39:24 INFO - "slavebuilddir": "test", 18:39:24 INFO - "taskId": "XD3r_UV_SDaLG47GL2G1SQ", 18:39:24 INFO - "branch": "mozilla-central", 18:39:24 INFO - "script_repo_revision": "production", 18:39:24 INFO - "revision": "2a8e0c4be57d244bf59543750d047b2ab7c8bbdc", 18:39:24 INFO - "slavename": "talos-linux64-ix-060", 18:39:24 INFO - "repo_path": "mozilla-central" 18:39:24 INFO - } 18:39:24 INFO - Finding installer, test and symbols from parent task. 18:39:24 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XD3r_UV_SDaLG47GL2G1SQ'}, attempt #1 18:39:24 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XD3r_UV_SDaLG47GL2G1SQ'}, attempt #1 18:39:25 INFO - Task dependencies: ciflkEnOT-KA2bdcDyiU1w 18:39:25 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ciflkEnOT-KA2bdcDyiU1w'}, attempt #1 18:39:25 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/ciflkEnOT-KA2bdcDyiU1w/artifacts/public/build/target.tar.bz2 18:39:25 INFO - Set test_url: https://queue.taskcluster.net/v1/task/ciflkEnOT-KA2bdcDyiU1w/artifacts/public/build/test_packages.json 18:39:25 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/ciflkEnOT-KA2bdcDyiU1w/artifacts/public/build/target.crashreporter-symbols.zip 18:39:25 INFO - Running post-action listener: _resource_record_post_action 18:39:25 INFO - [mozharness: 2017-05-12 01:39:25.741836Z] Finished read-buildbot-config step (success) 18:39:25 INFO - [mozharness: 2017-05-12 01:39:25.742050Z] Running download-and-extract step. 18:39:25 INFO - Running pre-action listener: _resource_record_pre_action 18:39:25 INFO - Running main action method: download_and_extract 18:39:25 INFO - mkdir: /builds/slave/test/build/tests 18:39:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:39:25 INFO - trying https://queue.taskcluster.net/v1/task/ciflkEnOT-KA2bdcDyiU1w/artifacts/public/build/target.test_packages.json 18:39:25 INFO - Downloading https://queue.taskcluster.net/v1/task/ciflkEnOT-KA2bdcDyiU1w/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 18:39:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ciflkEnOT-KA2bdcDyiU1w/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 18:39:26 INFO - Downloaded 986 bytes. 18:39:26 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 18:39:26 INFO - Using the following test package requirements: 18:39:26 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 18:39:26 INFO - u'common': [u'target.common.tests.zip'], 18:39:26 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 18:39:26 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 18:39:26 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 18:39:26 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 18:39:26 INFO - u'mozbase': [u'target.common.tests.zip'], 18:39:26 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 18:39:26 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 18:39:26 INFO - u'web-platform': [u'target.common.tests.zip', 18:39:26 INFO - u'target.web-platform.tests.zip'], 18:39:26 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 18:39:26 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 18:39:26 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ciflkEnOT-KA2bdcDyiU1w/artifacts/public/build/target.common.tests.zip 18:39:26 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ciflkEnOT-KA2bdcDyiU1w/artifacts/public/build/target.common.tests.zip'}, attempt #1 18:39:26 INFO - Fetch https://queue.taskcluster.net/v1/task/ciflkEnOT-KA2bdcDyiU1w/artifacts/public/build/target.common.tests.zip into memory 18:39:27 INFO - Content-Length response header: 60742174 18:39:27 INFO - Bytes received: 60742174 18:39:37 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 18:39:37 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ciflkEnOT-KA2bdcDyiU1w/artifacts/public/build/target.common.tests.zip 18:39:37 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ciflkEnOT-KA2bdcDyiU1w/artifacts/public/build/target.common.tests.zip'}, attempt #1 18:39:37 INFO - Fetch https://queue.taskcluster.net/v1/task/ciflkEnOT-KA2bdcDyiU1w/artifacts/public/build/target.common.tests.zip into memory 18:39:38 INFO - Content-Length response header: 60742174 18:39:38 INFO - Bytes received: 60742174 18:39:49 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ciflkEnOT-KA2bdcDyiU1w/artifacts/public/build/target.talos.tests.zip 18:39:49 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ciflkEnOT-KA2bdcDyiU1w/artifacts/public/build/target.talos.tests.zip'}, attempt #1 18:39:49 INFO - Fetch https://queue.taskcluster.net/v1/task/ciflkEnOT-KA2bdcDyiU1w/artifacts/public/build/target.talos.tests.zip into memory 18:39:50 INFO - Content-Length response header: 14409411 18:39:50 INFO - Bytes received: 14409411 18:39: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')]} 18:39:50 INFO - trying https://queue.taskcluster.net/v1/task/ciflkEnOT-KA2bdcDyiU1w/artifacts/public/build/target.tar.bz2 18:39:50 INFO - Downloading https://queue.taskcluster.net/v1/task/ciflkEnOT-KA2bdcDyiU1w/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 18:39:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ciflkEnOT-KA2bdcDyiU1w/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 18:39:51 INFO - Downloaded 68832966 bytes. 18:39:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ciflkEnOT-KA2bdcDyiU1w/artifacts/public/build/target.tar.bz2 18:39:51 INFO - mkdir: /builds/slave/test/properties 18:39:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:39:51 INFO - Writing to file /builds/slave/test/properties/build_url 18:39:51 INFO - Contents: 18:39:51 INFO - build_url:https://queue.taskcluster.net/v1/task/ciflkEnOT-KA2bdcDyiU1w/artifacts/public/build/target.tar.bz2 18:39:51 INFO - Running post-action listener: _resource_record_post_action 18:39:51 INFO - Running post-action listener: set_extra_try_arguments 18:39:51 INFO - [mozharness: 2017-05-12 01:39:51.484516Z] Finished download-and-extract step (success) 18:39:51 INFO - [mozharness: 2017-05-12 01:39:51.484612Z] Running populate-webroot step. 18:39:51 INFO - Running pre-action listener: _resource_record_pre_action 18:39:51 INFO - Running main action method: populate_webroot 18:39:51 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:39:51 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:39:51 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:39:51 INFO - '--tppagecycles', 18:39:51 INFO - '7'], 18:39:51 INFO - 'tests': ['tsvgm']}}, 18:39:51 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 18:39:51 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:39:51 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:39:51 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:39:51 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:39:51 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:39:51 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 18:39:51 INFO - 'talos_options': ['--disable-e10s'], 18:39:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:39:51 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 18:39:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:39:51 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 18:39:51 INFO - 'talos_options': ['--disable-e10s'], 18:39:51 INFO - 'tests': ['damp', 'tps']}, 18:39:51 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 18:39:51 INFO - 'tests': ['damp', 'tps']}, 18:39:51 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:39:51 INFO - 'tests': ['dromaeo_dom']}, 18:39:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:39:51 INFO - 'g4': {'talos_options': ['--disable-e10s'], 18:39:51 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 18:39:51 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 18:39:51 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:39:51 INFO - 'tests': ['a11yr', 18:39:51 INFO - 'ts_paint', 18:39:51 INFO - 'tpaint', 18:39:51 INFO - 'sessionrestore', 18:39:51 INFO - 'sessionrestore_no_auto_restore', 18:39:51 INFO - 'tabpaint']}, 18:39:51 INFO - 'other-e10s': {'tests': ['a11yr', 18:39:51 INFO - 'ts_paint', 18:39:51 INFO - 'tpaint', 18:39:51 INFO - 'sessionrestore', 18:39:51 INFO - 'sessionrestore_no_auto_restore', 18:39:51 INFO - 'tabpaint']}, 18:39:51 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:39:51 INFO - 'ts_paint', 18:39:51 INFO - 'tpaint', 18:39:51 INFO - 'sessionrestore', 18:39:51 INFO - 'sessionrestore_no_auto_restore', 18:39:51 INFO - 'tabpaint']}, 18:39:51 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:39:51 INFO - 'ts_paint', 18:39:51 INFO - 'tpaint', 18:39:51 INFO - 'sessionrestore', 18:39:51 INFO - 'sessionrestore_no_auto_restore', 18:39:51 INFO - 'tabpaint']}, 18:39:51 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:39:51 INFO - 'tests': ['a11yr', 18:39:51 INFO - 'ts_paint', 18:39:51 INFO - 'tpaint', 18:39:51 INFO - 'sessionrestore', 18:39:51 INFO - 'sessionrestore_no_auto_restore', 18:39:51 INFO - 'tabpaint']}, 18:39:51 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:39:51 INFO - 'tests': ['a11yr', 18:39:51 INFO - 'ts_paint', 18:39:51 INFO - 'tpaint', 18:39:51 INFO - 'sessionrestore', 18:39:51 INFO - 'sessionrestore_no_auto_restore', 18:39:51 INFO - 'tabpaint']}, 18:39:51 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 18:39:51 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 18:39:51 INFO - 'bloom_basic_ref']}, 18:39:51 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:39:51 INFO - 'tests': ['tsvgx', 18:39:51 INFO - 'tsvgr_opacity', 18:39:51 INFO - 'tart', 18:39:51 INFO - 'tscrollx', 18:39:51 INFO - 'cart', 18:39:51 INFO - 'tsvg_static']}, 18:39:51 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:39:51 INFO - 'tsvgr_opacity', 18:39:51 INFO - 'tart', 18:39:51 INFO - 'tscrollx', 18:39:51 INFO - 'cart', 18:39:51 INFO - 'tsvg_static']}, 18:39:51 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 18:39:51 INFO - 'talos_options': ['--disable-e10s'], 18:39:51 INFO - 'tests': ['tp5o']}, 18:39:51 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 18:39:51 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 18:39:51 INFO - 'talos_options': ['--disable-e10s', 18:39:51 INFO - '--xperf_path', 18:39:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:39:51 INFO - 'tests': ['tp5n']}, 18:39:51 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 18:39:51 INFO - 'talos_options': ['--xperf_path', 18:39:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:39:51 INFO - 'tests': ['tp5n']}}, 18:39:51 INFO - 'talos.zip': {'path': '', 18:39:51 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:39:51 INFO - Running post-action listener: _resource_record_post_action 18:39:51 INFO - [mozharness: 2017-05-12 01:39:51.498067Z] Finished populate-webroot step (success) 18:39:51 INFO - [mozharness: 2017-05-12 01:39:51.498155Z] Running create-virtualenv step. 18:39:51 INFO - Running pre-action listener: _resource_record_pre_action 18:39:51 INFO - Running main action method: create_virtualenv 18:39:51 INFO - Creating virtualenv /builds/slave/test/build/venv 18:39:51 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 18:39:51 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:39:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:39:51 INFO - Using real prefix '/usr' 18:39:51 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:39:52 INFO - Installing distribute.............................................................................................................................................................................................done. 18:39:54 INFO - Installing pip.................done. 18:39:54 INFO - Return code: 0 18:39:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 18:39:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 18:39:54 INFO - Reading from file tmpfile_stdout 18:39:54 INFO - Output received: 18:39:54 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) 18:39:54 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:39:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:39:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:39:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:39:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:39:54 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 0x14521f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x161ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17c4770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17c1a30>, '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 0x17c27f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17c2ca0>, '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': '337fe3f4b1febe37b85fccc40000019e-1494553160.648458-1493621536', '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 18:39:54 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 18:39:54 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 18:39:54 INFO - Using env: {'DISPLAY': ':0', 18:39:54 INFO - 'HOME': '/home/cltbld', 18:39:54 INFO - 'LANG': 'en_US.UTF-8', 18:39:54 INFO - 'LANGUAGE': 'en_US:en', 18:39:54 INFO - 'LOGNAME': 'cltbld', 18:39:54 INFO - 'MAIL': '/var/mail/cltbld', 18:39:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:39:54 INFO - 'MOZ_NO_REMOTE': '1', 18:39:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:39:54 INFO - 'NO_EM_RESTART': '1', 18:39:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:39:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:39:54 INFO - 'PWD': '/builds/slave/test', 18:39:54 INFO - 'SHELL': '/bin/bash', 18:39:54 INFO - 'SHLVL': '1', 18:39:54 INFO - 'TERM': 'linux', 18:39:54 INFO - 'TMOUT': '86400', 18:39:54 INFO - 'USER': 'cltbld', 18:39:54 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1494553160.648458-1493621536', 18:39:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:39:54 INFO - '_': '/tools/buildbot/bin/python'} 18:39:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:39:54 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 18:39:54 INFO - Cleaning up... 18:39:54 INFO - Return code: 0 18:39:54 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:39:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:39:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:39:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:39:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:39:54 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 0x14521f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x161ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17c4770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17c1a30>, '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 0x17c27f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17c2ca0>, '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': '337fe3f4b1febe37b85fccc40000019e-1494553160.648458-1493621536', '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 18:39:54 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 18:39:54 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 18:39:54 INFO - Using env: {'DISPLAY': ':0', 18:39:54 INFO - 'HOME': '/home/cltbld', 18:39:54 INFO - 'LANG': 'en_US.UTF-8', 18:39:54 INFO - 'LANGUAGE': 'en_US:en', 18:39:54 INFO - 'LOGNAME': 'cltbld', 18:39:54 INFO - 'MAIL': '/var/mail/cltbld', 18:39:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:39:54 INFO - 'MOZ_NO_REMOTE': '1', 18:39:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:39:54 INFO - 'NO_EM_RESTART': '1', 18:39:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:39:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:39:54 INFO - 'PWD': '/builds/slave/test', 18:39:54 INFO - 'SHELL': '/bin/bash', 18:39:54 INFO - 'SHLVL': '1', 18:39:54 INFO - 'TERM': 'linux', 18:39:54 INFO - 'TMOUT': '86400', 18:39:54 INFO - 'USER': 'cltbld', 18:39:54 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1494553160.648458-1493621536', 18:39:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:39:54 INFO - '_': '/tools/buildbot/bin/python'} 18:39:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:39:54 INFO - Downloading/unpacking psutil>=3.1.1 18:39:54 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 18:39:54 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 18:39:54 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 18:39:54 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 18:39:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:39:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:39:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:39:55 INFO - Installing collected packages: psutil 18:39:55 INFO - Running setup.py install for psutil 18:39:55 INFO - building 'psutil._psutil_linux' extension 18:39:55 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 18:39:56 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 18:39:56 INFO - building 'psutil._psutil_posix' extension 18:39:56 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 18:39:56 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 18:39:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:39:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:39:56 INFO - Successfully installed psutil 18:39:56 INFO - Cleaning up... 18:39:56 INFO - Return code: 0 18:39:56 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:39: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')]} 18:39:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:39: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')]} 18:39:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:39:56 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 0x14521f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x161ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17c4770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17c1a30>, '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 0x17c27f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17c2ca0>, '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': '337fe3f4b1febe37b85fccc40000019e-1494553160.648458-1493621536', '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 18:39:56 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 18:39:56 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 18:39:56 INFO - Using env: {'DISPLAY': ':0', 18:39:56 INFO - 'HOME': '/home/cltbld', 18:39:56 INFO - 'LANG': 'en_US.UTF-8', 18:39:56 INFO - 'LANGUAGE': 'en_US:en', 18:39:56 INFO - 'LOGNAME': 'cltbld', 18:39:56 INFO - 'MAIL': '/var/mail/cltbld', 18:39:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:39:56 INFO - 'MOZ_NO_REMOTE': '1', 18:39:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:39:56 INFO - 'NO_EM_RESTART': '1', 18:39:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:39:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:39:56 INFO - 'PWD': '/builds/slave/test', 18:39:56 INFO - 'SHELL': '/bin/bash', 18:39:56 INFO - 'SHLVL': '1', 18:39:56 INFO - 'TERM': 'linux', 18:39:56 INFO - 'TMOUT': '86400', 18:39:56 INFO - 'USER': 'cltbld', 18:39:56 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1494553160.648458-1493621536', 18:39:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:39:56 INFO - '_': '/tools/buildbot/bin/python'} 18:39:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:39:56 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:39:56 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 18:39:56 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 18:39:56 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 18:39:56 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 18:39:57 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:39:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:39:57 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:39:57 INFO - Installing collected packages: mozsystemmonitor 18:39:57 INFO - Running setup.py install for mozsystemmonitor 18:39:57 INFO - Successfully installed mozsystemmonitor 18:39:57 INFO - Cleaning up... 18:39:57 INFO - Return code: 0 18:39:57 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:39:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:39:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:39:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:39:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:39:57 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 0x14521f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x161ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17c4770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17c1a30>, '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 0x17c27f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17c2ca0>, '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': '337fe3f4b1febe37b85fccc40000019e-1494553160.648458-1493621536', '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 18:39:57 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 18:39:57 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 18:39:57 INFO - Using env: {'DISPLAY': ':0', 18:39:57 INFO - 'HOME': '/home/cltbld', 18:39:57 INFO - 'LANG': 'en_US.UTF-8', 18:39:57 INFO - 'LANGUAGE': 'en_US:en', 18:39:57 INFO - 'LOGNAME': 'cltbld', 18:39:57 INFO - 'MAIL': '/var/mail/cltbld', 18:39:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:39:57 INFO - 'MOZ_NO_REMOTE': '1', 18:39:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:39:57 INFO - 'NO_EM_RESTART': '1', 18:39:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:39:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:39:57 INFO - 'PWD': '/builds/slave/test', 18:39:57 INFO - 'SHELL': '/bin/bash', 18:39:57 INFO - 'SHLVL': '1', 18:39:57 INFO - 'TERM': 'linux', 18:39:57 INFO - 'TMOUT': '86400', 18:39:57 INFO - 'USER': 'cltbld', 18:39:57 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1494553160.648458-1493621536', 18:39:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:39:57 INFO - '_': '/tools/buildbot/bin/python'} 18:39:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:39:58 INFO - Downloading/unpacking jsonschema==2.5.1 18:39: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 18:39: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 18:39: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 18:39: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 18:39:59 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:39:59 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:39:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:39:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:39:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:39:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:39:59 INFO - Downloading functools32-3.2.3-2.tar.gz 18:39:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:39:59 INFO - warning: no files found matching '*.txt' 18:39:59 INFO - no previously-included directories found matching 'build' 18:39:59 INFO - no previously-included directories found matching 'dist' 18:39:59 INFO - no previously-included directories found matching '.git*' 18:39:59 INFO - Installing collected packages: jsonschema, functools32 18:39:59 INFO - Running setup.py install for functools32 18:39:59 INFO - warning: no files found matching '*.txt' 18:39:59 INFO - no previously-included directories found matching 'build' 18:39:59 INFO - no previously-included directories found matching 'dist' 18:39:59 INFO - no previously-included directories found matching '.git*' 18:39:59 INFO - Successfully installed jsonschema functools32 18:39:59 INFO - Cleaning up... 18:39:59 INFO - Return code: 0 18:39:59 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 18:39: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')]} 18:39:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:39: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')]} 18:39:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:39: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', '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 0x14521f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x161ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17c4770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17c1a30>, '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 0x17c27f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17c2ca0>, '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': '337fe3f4b1febe37b85fccc40000019e-1494553160.648458-1493621536', '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 18:39: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 18:39: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 functools32==3.2.3-2 18:39:59 INFO - Using env: {'DISPLAY': ':0', 18:39:59 INFO - 'HOME': '/home/cltbld', 18:39:59 INFO - 'LANG': 'en_US.UTF-8', 18:39:59 INFO - 'LANGUAGE': 'en_US:en', 18:39:59 INFO - 'LOGNAME': 'cltbld', 18:39:59 INFO - 'MAIL': '/var/mail/cltbld', 18:39:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:39:59 INFO - 'MOZ_NO_REMOTE': '1', 18:39:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:39:59 INFO - 'NO_EM_RESTART': '1', 18:39:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:39:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:39:59 INFO - 'PWD': '/builds/slave/test', 18:39:59 INFO - 'SHELL': '/bin/bash', 18:39:59 INFO - 'SHLVL': '1', 18:39:59 INFO - 'TERM': 'linux', 18:39:59 INFO - 'TMOUT': '86400', 18:39:59 INFO - 'USER': 'cltbld', 18:39:59 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1494553160.648458-1493621536', 18:39:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:39:59 INFO - '_': '/tools/buildbot/bin/python'} 18:39:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:39:59 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 18:39:59 INFO - Cleaning up... 18:39:59 INFO - Return code: 0 18:39:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:39: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')]} 18:39:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:39: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')]} 18:39:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:39: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', '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 0x14521f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x161ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17c4770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17c1a30>, '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 0x17c27f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17c2ca0>, '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': '337fe3f4b1febe37b85fccc40000019e-1494553160.648458-1493621536', '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 18:39: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 18:39: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 blobuploader==1.2.4 18:39:59 INFO - Using env: {'DISPLAY': ':0', 18:39:59 INFO - 'HOME': '/home/cltbld', 18:39:59 INFO - 'LANG': 'en_US.UTF-8', 18:39:59 INFO - 'LANGUAGE': 'en_US:en', 18:39:59 INFO - 'LOGNAME': 'cltbld', 18:39:59 INFO - 'MAIL': '/var/mail/cltbld', 18:39:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:39:59 INFO - 'MOZ_NO_REMOTE': '1', 18:39:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:39:59 INFO - 'NO_EM_RESTART': '1', 18:39:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:39:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:39:59 INFO - 'PWD': '/builds/slave/test', 18:39:59 INFO - 'SHELL': '/bin/bash', 18:39:59 INFO - 'SHLVL': '1', 18:39:59 INFO - 'TERM': 'linux', 18:39:59 INFO - 'TMOUT': '86400', 18:39:59 INFO - 'USER': 'cltbld', 18:39:59 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1494553160.648458-1493621536', 18:39:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:39:59 INFO - '_': '/tools/buildbot/bin/python'} 18:39:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:39:59 INFO - Downloading/unpacking blobuploader==1.2.4 18:39:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:39:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:39:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:39:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:40:01 INFO - Downloading blobuploader-1.2.4.tar.gz 18:40:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:40:01 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:40:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:40:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:40:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:40:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:40:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:40:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:40:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:40:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:40:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:40:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:40:01 INFO - Downloading docopt-0.6.1.tar.gz 18:40:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:40:01 INFO - Installing collected packages: blobuploader, requests, docopt 18:40:01 INFO - Running setup.py install for blobuploader 18:40:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:40:01 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:40:01 INFO - Running setup.py install for requests 18:40:02 INFO - Running setup.py install for docopt 18:40:02 INFO - Successfully installed blobuploader requests docopt 18:40:02 INFO - Cleaning up... 18:40:02 INFO - Return code: 0 18:40:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:40:02 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')]} 18:40:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:40:02 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')]} 18:40:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:40:02 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 0x14521f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x161ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17c4770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17c1a30>, '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 0x17c27f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17c2ca0>, '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': '337fe3f4b1febe37b85fccc40000019e-1494553160.648458-1493621536', '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 18:40:02 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 18:40:02 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 18:40:02 INFO - Using env: {'DISPLAY': ':0', 18:40:02 INFO - 'HOME': '/home/cltbld', 18:40:02 INFO - 'LANG': 'en_US.UTF-8', 18:40:02 INFO - 'LANGUAGE': 'en_US:en', 18:40:02 INFO - 'LOGNAME': 'cltbld', 18:40:02 INFO - 'MAIL': '/var/mail/cltbld', 18:40:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:40:02 INFO - 'MOZ_NO_REMOTE': '1', 18:40:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:40:02 INFO - 'NO_EM_RESTART': '1', 18:40:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:40:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:40:02 INFO - 'PWD': '/builds/slave/test', 18:40:02 INFO - 'SHELL': '/bin/bash', 18:40:02 INFO - 'SHLVL': '1', 18:40:02 INFO - 'TERM': 'linux', 18:40:02 INFO - 'TMOUT': '86400', 18:40:02 INFO - 'USER': 'cltbld', 18:40:02 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1494553160.648458-1493621536', 18:40:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:40:02 INFO - '_': '/tools/buildbot/bin/python'} 18:40:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:40:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:40:02 INFO - Running setup.py (path:/tmp/pip-71grlQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:40:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:40:02 INFO - Running setup.py (path:/tmp/pip-XdAeuj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:40:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:40:02 INFO - Running setup.py (path:/tmp/pip-g_zEY7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:40:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:40:02 INFO - Running setup.py (path:/tmp/pip-DhGcFw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:40:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:40:02 INFO - Running setup.py (path:/tmp/pip-haM6hg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:40:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:40:02 INFO - Running setup.py (path:/tmp/pip-VNWZlm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:40:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:40:02 INFO - Running setup.py (path:/tmp/pip-THEGJB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:40:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:40:02 INFO - Running setup.py (path:/tmp/pip-OmyvmC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:40:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:40:03 INFO - Running setup.py (path:/tmp/pip-NQ8eGS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:40:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:40:03 INFO - Running setup.py (path:/tmp/pip-HTHSZL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:40:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:40:03 INFO - Running setup.py (path:/tmp/pip-GQ4qrf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:40:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:40:03 INFO - Running setup.py (path:/tmp/pip-ADo1SO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:40:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:40:03 INFO - Running setup.py (path:/tmp/pip-ttcp3y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:40:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:40:03 INFO - Running setup.py (path:/tmp/pip-UvMJqb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:40:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:40:03 INFO - Running setup.py (path:/tmp/pip-uaPZaF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:40:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:40:03 INFO - Running setup.py (path:/tmp/pip-ZI9zPc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:40:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:40:03 INFO - Running setup.py (path:/tmp/pip-dtTDNw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:40:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:40:03 INFO - Running setup.py install for manifestparser 18:40:03 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:40:03 INFO - Running setup.py install for mozcrash 18:40:03 INFO - Running setup.py install for mozdebug 18:40:03 INFO - Running setup.py install for mozdevice 18:40:04 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:40:04 INFO - Running setup.py install for mozfile 18:40:04 INFO - Running setup.py install for mozhttpd 18:40:04 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:40:04 INFO - Running setup.py install for mozinfo 18:40:04 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:40:04 INFO - Running setup.py install for mozInstall 18:40:04 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:40:04 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:40:04 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:40:04 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:40:04 INFO - Running setup.py install for mozleak 18:40:04 INFO - Running setup.py install for mozlog 18:40:04 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:40:04 INFO - Running setup.py install for moznetwork 18:40:04 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:40:04 INFO - Running setup.py install for mozprocess 18:40:04 INFO - Running setup.py install for mozprofile 18:40:05 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:40:05 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:40:05 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:40:05 INFO - Running setup.py install for mozrunner 18:40:05 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:40:05 INFO - Running setup.py install for mozscreenshot 18:40:05 INFO - Running setup.py install for moztest 18:40:05 INFO - Running setup.py install for mozversion 18:40:05 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:40:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:40:05 INFO - Cleaning up... 18:40:05 INFO - Return code: 0 18:40:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:40:05 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')]} 18:40:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:40:05 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')]} 18:40:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:40:05 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 0x14521f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x161ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17c4770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17c1a30>, '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 0x17c27f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17c2ca0>, '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': '337fe3f4b1febe37b85fccc40000019e-1494553160.648458-1493621536', '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 18:40:05 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 18:40:05 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 18:40:05 INFO - Using env: {'DISPLAY': ':0', 18:40:05 INFO - 'HOME': '/home/cltbld', 18:40:05 INFO - 'LANG': 'en_US.UTF-8', 18:40:05 INFO - 'LANGUAGE': 'en_US:en', 18:40:05 INFO - 'LOGNAME': 'cltbld', 18:40:05 INFO - 'MAIL': '/var/mail/cltbld', 18:40:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:40:05 INFO - 'MOZ_NO_REMOTE': '1', 18:40:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:40:05 INFO - 'NO_EM_RESTART': '1', 18:40:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:40:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:40:05 INFO - 'PWD': '/builds/slave/test', 18:40:05 INFO - 'SHELL': '/bin/bash', 18:40:05 INFO - 'SHLVL': '1', 18:40:05 INFO - 'TERM': 'linux', 18:40:05 INFO - 'TMOUT': '86400', 18:40:05 INFO - 'USER': 'cltbld', 18:40:05 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1494553160.648458-1493621536', 18:40:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:40:05 INFO - '_': '/tools/buildbot/bin/python'} 18:40:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:40:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:40:05 INFO - Running setup.py (path:/tmp/pip-piDHCc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:40:05 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)) 18:40:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:40:05 INFO - Running setup.py (path:/tmp/pip-KRsasu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:40:05 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)) 18:40:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:40:05 INFO - Running setup.py (path:/tmp/pip-4RF1Bb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:40:05 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)) 18:40:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:40:05 INFO - Running setup.py (path:/tmp/pip-J2XiAG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:40:06 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)) 18:40:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:40:06 INFO - Running setup.py (path:/tmp/pip-Kc8A0g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:40:06 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)) 18:40:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:40:06 INFO - Running setup.py (path:/tmp/pip-nWzdek-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:40:06 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)) 18:40:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:40:06 INFO - Running setup.py (path:/tmp/pip-RjUHlH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:40:06 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)) 18:40:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:40:06 INFO - Running setup.py (path:/tmp/pip-FfaWS_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:40:06 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)) 18:40:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:40:06 INFO - Running setup.py (path:/tmp/pip-KcY7MH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:40:06 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)) 18:40:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:40:06 INFO - Running setup.py (path:/tmp/pip-dDkb3g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:40:06 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)) 18:40:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:40:06 INFO - Running setup.py (path:/tmp/pip-A9qeiF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:40:06 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)) 18:40:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:40:06 INFO - Running setup.py (path:/tmp/pip-hegqa0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:40:06 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)) 18:40:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:40:06 INFO - Running setup.py (path:/tmp/pip-l4tIgh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:40:06 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)) 18:40:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:40:06 INFO - Running setup.py (path:/tmp/pip-AV63Dm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:40:06 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)) 18:40:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:40:06 INFO - Running setup.py (path:/tmp/pip-nt1K08-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:40:06 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)) 18:40:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:40:06 INFO - Running setup.py (path:/tmp/pip-VHDGeN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:40:06 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)) 18:40:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:40:06 INFO - Running setup.py (path:/tmp/pip-BaZeIe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:40:06 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)) 18:40:06 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)) 18:40:06 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)) 18:40:06 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)) 18:40:06 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)) 18:40:06 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)) 18:40:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:40:06 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 18:40:06 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 18:40:06 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 18:40:06 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 18:40:08 INFO - Downloading blessings-1.6.tar.gz 18:40:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:40:08 INFO - Installing collected packages: blessings 18:40:08 INFO - Running setup.py install for blessings 18:40:08 INFO - Successfully installed blessings 18:40:08 INFO - Cleaning up... 18:40:08 INFO - Return code: 0 18:40:08 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:40:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:40:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:40:08 INFO - Reading from file tmpfile_stdout 18:40:08 INFO - Current package versions: 18:40:08 INFO - argparse == 1.2.1 18:40:08 INFO - blessings == 1.6 18:40:08 INFO - blobuploader == 1.2.4 18:40:08 INFO - docopt == 0.6.1 18:40:08 INFO - functools32 == 3.2.3-2 18:40:08 INFO - jsonschema == 2.5.1 18:40:08 INFO - manifestparser == 1.1 18:40:08 INFO - mozInstall == 1.12 18:40:08 INFO - mozcrash == 1.0 18:40:08 INFO - mozdebug == 0.1 18:40:08 INFO - mozdevice == 0.50 18:40:08 INFO - mozfile == 1.2 18:40:08 INFO - mozhttpd == 0.7 18:40:08 INFO - mozinfo == 0.9 18:40:08 INFO - mozleak == 0.1 18:40:08 INFO - mozlog == 3.4 18:40:08 INFO - moznetwork == 0.27 18:40:08 INFO - mozprocess == 0.25 18:40:08 INFO - mozprofile == 0.28 18:40:08 INFO - mozrunner == 6.13 18:40:08 INFO - mozscreenshot == 0.1 18:40:08 INFO - mozsystemmonitor == 0.3 18:40:08 INFO - moztest == 0.8 18:40:08 INFO - mozversion == 1.4 18:40:08 INFO - psutil == 3.1.1 18:40:08 INFO - requests == 1.2.3 18:40:08 INFO - wsgiref == 0.1.2 18:40:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:40:08 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')]} 18:40:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:40:08 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')]} 18:40:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:40:08 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 0x14521f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x161ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17c4770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17c1a30>, '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 0x17c27f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17c2ca0>, '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': '337fe3f4b1febe37b85fccc40000019e-1494553160.648458-1493621536', '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 18:40:08 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 18:40:08 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 18:40:08 INFO - Using env: {'DISPLAY': ':0', 18:40:08 INFO - 'HOME': '/home/cltbld', 18:40:08 INFO - 'LANG': 'en_US.UTF-8', 18:40:08 INFO - 'LANGUAGE': 'en_US:en', 18:40:08 INFO - 'LOGNAME': 'cltbld', 18:40:08 INFO - 'MAIL': '/var/mail/cltbld', 18:40:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:40:08 INFO - 'MOZ_NO_REMOTE': '1', 18:40:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:40:08 INFO - 'NO_EM_RESTART': '1', 18:40:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:40:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:40:08 INFO - 'PWD': '/builds/slave/test', 18:40:08 INFO - 'SHELL': '/bin/bash', 18:40:08 INFO - 'SHLVL': '1', 18:40:08 INFO - 'TERM': 'linux', 18:40:08 INFO - 'TMOUT': '86400', 18:40:08 INFO - 'USER': 'cltbld', 18:40:08 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1494553160.648458-1493621536', 18:40:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:40:08 INFO - '_': '/tools/buildbot/bin/python'} 18:40:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:40:08 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)) 18:40:08 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)) 18:40:08 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)) 18:40:08 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)) 18:40:08 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)) 18:40:08 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)) 18:40:08 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)) 18:40:08 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)) 18:40:08 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)) 18:40:08 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)) 18:40:08 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)) 18:40:08 INFO - Cleaning up... 18:40:08 INFO - Return code: 0 18:40:08 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:40:08 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')]} 18:40:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:40:08 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')]} 18:40:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:40:08 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 0x14521f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x161ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17c4770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17c1a30>, '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 0x17c27f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17c2ca0>, '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': '337fe3f4b1febe37b85fccc40000019e-1494553160.648458-1493621536', '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 18:40:08 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 18:40:08 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 18:40:08 INFO - Using env: {'DISPLAY': ':0', 18:40:08 INFO - 'HOME': '/home/cltbld', 18:40:08 INFO - 'LANG': 'en_US.UTF-8', 18:40:08 INFO - 'LANGUAGE': 'en_US:en', 18:40:08 INFO - 'LOGNAME': 'cltbld', 18:40:08 INFO - 'MAIL': '/var/mail/cltbld', 18:40:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:40:08 INFO - 'MOZ_NO_REMOTE': '1', 18:40:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:40:08 INFO - 'NO_EM_RESTART': '1', 18:40:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:40:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:40:08 INFO - 'PWD': '/builds/slave/test', 18:40:08 INFO - 'SHELL': '/bin/bash', 18:40:08 INFO - 'SHLVL': '1', 18:40:08 INFO - 'TERM': 'linux', 18:40:08 INFO - 'TMOUT': '86400', 18:40:08 INFO - 'USER': 'cltbld', 18:40:08 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1494553160.648458-1493621536', 18:40:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:40:08 INFO - '_': '/tools/buildbot/bin/python'} 18:40:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:40:08 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:40:08 INFO - Cleaning up... 18:40:08 INFO - Return code: 0 18:40:08 INFO - Running post-action listener: _resource_record_post_action 18:40:08 INFO - Running post-action listener: _start_resource_monitoring 18:40:08 INFO - Starting resource monitoring. 18:40:08 INFO - [mozharness: 2017-05-12 01:40:08.950300Z] Finished create-virtualenv step (success) 18:40:08 INFO - [mozharness: 2017-05-12 01:40:08.950819Z] Running install step. 18:40:08 INFO - Running pre-action listener: _resource_record_pre_action 18:40:08 INFO - Running main action method: install 18:40:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:40:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:40:09 INFO - Reading from file tmpfile_stdout 18:40:09 INFO - Detecting whether we're running mozinstall >=1.0... 18:40:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:40:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:40:09 INFO - Reading from file tmpfile_stdout 18:40:09 INFO - Output received: 18:40:09 INFO - Usage: mozinstall [options] installer 18:40:09 INFO - Options: 18:40:09 INFO - -h, --help show this help message and exit 18:40:09 INFO - -d DEST, --destination=DEST 18:40:09 INFO - Directory to install application into. [default: 18:40:09 INFO - "/builds/slave/test"] 18:40:09 INFO - --app=APP Application being installed. [default: firefox] 18:40:09 INFO - mkdir: /builds/slave/test/build/application 18:40:09 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'] 18:40:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 18:40:26 INFO - Reading from file tmpfile_stdout 18:40:26 INFO - Output received: 18:40:26 INFO - /builds/slave/test/build/application/firefox/firefox 18:40:26 INFO - Running post-action listener: _resource_record_post_action 18:40:26 INFO - [mozharness: 2017-05-12 01:40:26.364271Z] Finished install step (success) 18:40:26 INFO - [mozharness: 2017-05-12 01:40:26.364391Z] Running run-tests step. 18:40:26 INFO - Running pre-action listener: _resource_record_pre_action 18:40:26 INFO - Running main action method: run_tests 18:40:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:40:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:40:26 INFO - Python 2.7.3 18:40:26 INFO - Return code: 0 18:40:26 INFO - grabbing minidump binary from tooltool 18:40:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:40:26 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 0x17c1a30>, '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 0x17c27f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17c2ca0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:40:26 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 18:40:26 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 18:40:26 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 18:40:26 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:40:26 INFO - Return code: 0 18:40:26 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:40:26 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:40:26 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:40:26 INFO - ENV: RUST_BACKTRACE is now 1 18:40:26 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:40:26 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:40:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ciflkEnOT-KA2bdcDyiU1w/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--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 18:40:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ciflkEnOT-KA2bdcDyiU1w/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-060 --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 18:40:26 INFO - Using env: {'DISPLAY': ':0', 18:40:26 INFO - 'HOME': '/home/cltbld', 18:40:26 INFO - 'LANG': 'en_US.UTF-8', 18:40:26 INFO - 'LANGUAGE': 'en_US:en', 18:40:26 INFO - 'LOGNAME': 'cltbld', 18:40:26 INFO - 'MAIL': '/var/mail/cltbld', 18:40:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:40:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:40:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:40:26 INFO - 'MOZ_NO_REMOTE': '1', 18:40:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:40:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:40:26 INFO - 'NO_EM_RESTART': '1', 18:40:26 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:40:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:40:26 INFO - 'PWD': '/builds/slave/test', 18:40:26 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:40:26 INFO - 'RUST_BACKTRACE': '1', 18:40:26 INFO - 'SHELL': '/bin/bash', 18:40:26 INFO - 'SHLVL': '1', 18:40:26 INFO - 'TERM': 'linux', 18:40:26 INFO - 'TMOUT': '86400', 18:40:26 INFO - 'USER': 'cltbld', 18:40:26 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1494553160.648458-1493621536', 18:40:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:40:26 INFO - '_': '/tools/buildbot/bin/python'} 18:40:26 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ciflkEnOT-KA2bdcDyiU1w/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--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 18:40:26 INFO - mozversion application_buildid: 20170512003303 18:40:26 INFO - mozversion application_changeset: 2a8e0c4be57d244bf59543750d047b2ab7c8bbdc 18:40:26 INFO - mozversion application_display_name: Nightly 18:40:26 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:40:26 INFO - mozversion application_name: Firefox 18:40:26 INFO - mozversion application_remotingname: firefox 18:40:26 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 18:40:26 INFO - mozversion application_vendor: Mozilla 18:40:26 INFO - mozversion application_version: 55.0a1 18:40:26 INFO - mozversion platform_buildid: 20170512003303 18:40:26 INFO - mozversion platform_changeset: 2a8e0c4be57d244bf59543750d047b2ab7c8bbdc 18:40:26 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 18:40:26 INFO - mozversion platform_version: 55.0a1 18:40:26 INFO - using testdate: 1494553226 18:40:26 INFO - actual date: 1494553226 18:40:26 INFO - starting webserver on 'localhost:52596' 18:40:26 INFO - SUITE-START | Running 2 tests 18:40:26 INFO - TEST-START | dromaeo_css 18:40:26 INFO - operating with platform_type : linux_ 18:40:26 INFO - Initialising browser for dromaeo_css test... 18:40:26 INFO - TEST-INFO | started process 15753 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfwAzFd/profile http://localhost:52596/getInfo.html) 18:40:30 INFO - PID 15753 | __metrics Screen width/height:1600/1200 18:40:30 INFO - PID 15753 | colorDepth:24 18:40:30 INFO - PID 15753 | Browser inner width/height: 1024/695 18:40:30 INFO - PID 15753 | __metrics 18:40:32 INFO - TEST-INFO | 15753: exit 0 18:40:32 INFO - Browser initialized. 18:40:32 INFO - Running cycle 1/1 for dromaeo_css test... 18:40:32 INFO - TEST-INFO | started process 15926 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfwAzFd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:40:43 INFO - PID 15926 | RSS: Main: 151355392 18:40:43 INFO - PID 15926 | 18:43:45 INFO - PID 15926 | Cycle 1(1): loaded http://localhost:52596/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52596/tests/dromaeo/cssquery-ext.html) 18:43:46 INFO - PID 15926 | RSS: Main: 162852864 18:43:46 INFO - PID 15926 | 18:46:48 INFO - PID 15926 | Cycle 1(1): loaded http://localhost:52596/tests/dromaeo/cssquery-ext.html (next: http://localhost:52596/tests/dromaeo/cssquery-jquery.html) 18:46:48 INFO - PID 15926 | RSS: Main: 160403456 18:46:48 INFO - PID 15926 | 18:49:50 INFO - PID 15926 | Cycle 1(1): loaded http://localhost:52596/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52596/tests/dromaeo/cssquery-mootools.html) 18:49:51 INFO - PID 15926 | RSS: Main: 167673856 18:49:51 INFO - PID 15926 | 18:52:52 INFO - PID 15926 | Cycle 1(1): loaded http://localhost:52596/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52596/tests/dromaeo/cssquery-prototype.html) 18:52:53 INFO - PID 15926 | RSS: Main: 158572544 18:52:53 INFO - PID 15926 | 18:55:55 INFO - PID 15926 | Cycle 1(1): loaded http://localhost:52596/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52596/tests/dromaeo/cssquery-yui.html) 18:55:56 INFO - PID 15926 | RSS: Main: 164401152 18:55:56 INFO - PID 15926 | 18:58:58 INFO - PID 15926 | Cycle 1(1): loaded http://localhost:52596/tests/dromaeo/cssquery-yui.html (next: http://localhost:52596/tests/dromaeo/cssquery-dojo.html) 18:58:58 INFO - PID 15926 | RSS: Main: 166371328 18:58:58 INFO - PID 15926 | 18:58:58 INFO - PID 15926 | __start_tp_report 18:58:58 INFO - PID 15926 | _x_x_mozilla_page_load 18:58:58 INFO - PID 15926 | _x_x_mozilla_page_load_details 18:58:58 INFO - PID 15926 | |i|pagename|runs| 18:58:58 INFO - PID 15926 | |0;dojo.html;3248;3362.0922350965225;3374.392609330321;3376.189714468528;3387.9491807622876;5811.447912448321;5997.580169388139;6015.879682406355;6032.48723858472;6042.637441753498;5930.911036334458;5996.220491336131;6006.849828754283;6049.425304596068;6071.423214794588;4948.755490483156;5303.124984377573;5321.52106310431;5334.679919204841;5343.465653434664;5342.732863356836;5365.141577347606;5368.973155134238;5415.0523658359825;5422.75597598109;5308.469153084699;5348.117560602496;5357.196420536911;5394;5400.054990376669;5350.705711185883;5353.197020446925;5359.892802143974;5360.571154307646;5369.516743493065;5343.091674415358;5347.54545863602;5353.839384818461;5360.3299587551555;5360.383555891044;5845.386234445365;5854.356020837705;5924.763009479616;5949.048152295655;6000.879982400371;6500.349965003509;6501.2198536175965;6505.837354066186;6508.967455162694;6509.1863517060365;6554.541182117254;6577.539572229945;6581.078648989145;6584.144061272052;6608.2730899601;5877.794277200277;5938.049912014057;6009.248843894513;6056.394360563952;6090.177825993434;6635.668216589152;6666.166729158856;6689.5986240825705;6705.161854768154;6709.027191057269;6189.907151392733;6225.968870155711;6307.653079080603;6360.363963603602;6405.231372235268;6419.871602567922;6421.325760795143;6430.196225471816;6438.163038805019;6448.387403196689;6281.528885333618;6325.9051114233325;6330.4619107375465;6409.935900640934;6438.356164383618;6439.452646525097;6490.8052758417325;6494.837629059311;6511.73953041873;6516.609003459713;4902.7058376497525;4902.828401006019;4920.926186107211;4921.040397122599;4938.358013458299;4273.166732487135;4288.656907447396;4360.825566977349;4392.143532011291;4394.604485596247;6041.456268935817;6045.972184728606;6051.909221361683;6083.7870674526175;6110.083487476914;6465.321141280192;6474.061261117112;6503.902441463382;6561.639109849004;6570.901436478457;5781.913271300934;5904.704764761745;6029.638221706711;6033.215681961317;6040.728167232397;5550.111982082847;5596.916046259309;5611.859703507445;5617.073182924853;5634.830955071355;6829.282925292872;6838.692258848364;6838.897416538756;6853.9314606853295;6862.519623626398;6440.806775796734;6461.547691661539;6493;6533.18335208099;6593.175853018372;6615.6030638161865;6821.317868213139;6834.838077526932;6862.382385585322;6873.690683919136;6255.343188965275;6314.179156709598;6329.335419780857;6331.683415829282;6337.968310158604;6301.117843502005;6447.871042579029;6599.373059559334;6600.9009864851105;6607.702653380513;6289.182406287154;6331.96834015827;6354.936450635434;6377.330380310001;6380.489560835029;6344.492440604648;6344.873102537831;6347.270063942706;6348.619082855043;6350.587211831216;6136.641621527207;6158.076288556752;6169.290531588925;6225.688715564294;6330.366963303817;6259.906101408392;6319.115323854572;6333.96833015832;6347.079673447417;6347.079673447417;6137.3862613738265;6140.201773769381;6145.9692701536205;6153.907691384543;6159.753609855556 18:58:58 INFO - PID 15926 | |1;ext.html;794.9801254968626;806.5967016491754;1136.8010598145322;1170.941452927354;1224.3021477757682;37856.62143378565;38814.611853881455;38967.61032389682;39020.219595608105;39069.804650976774;36144.63855361446;36393.45409818855;36394;36422.63577364226;36506;6659.267480577133;6771.187457505106;7186.568805871664;7355.3380195782365;7355.37479314259;7230.27697230278;7269.091363579552;7280;7356.411487081021;7361.263873612649;7298.671559779797;7328.340449359556;7337.0828646419195;7357.0803649543805;7391.556506609621;7265.673044713;7294.197638259814;7301.817454563678;7360.484766066377;7367.594782286972;7130.429565634789;7149.82125446868;7162.319579639978;7163.355298023151;7185.209626941032;36020.279594408225;36260.456093158624;36420.90737277886;36506.63493365059;36755.44866827;3519.9296014079832;3550.2544465661986;3580.122869896892;3581.2658405026905;3581.8209089545417;28580.714192858013;28613;28793;28845;28854.855725721445;3750.6811920986747;3772.2832661794446;3775.848966041355;3783.9432408513894;3789.621037896216;203680;204345;204902;204955;205180.99999999852;46054;48838.511614884104;48920.75539622279;49532;49850;50081.24878126831;50440;50580.24129637985;50609.24086138711;51007.489925101014;14121.08212966154;14130.929345353414;14211.36048877803;14273.64315892111;14297.142171469744;10972.890271097187;11057.834132488018;11059.502322395512;11084;11155.163362747826;14409.495667651581;14589.562313130624;14645.633859153606;14680.767176886722;14710.779338309934;5834.708264586754;5883.558733095035;5888.968305934446;5889.1755154278435;5926.436988486087;1070.7751372211767;1093.7101668057971;1107.1530279336314;1123.6966019174777;1136.5908273021705;26245.21264362072;26364.20907372782;26409.73590264111;26417.603735943976;26456.73543264581;1218.61004478566;1224.136983426682;1227.79127548317;1230.7107829660022;1246.6073186946082;13495;13569.439514455766;13799.310034498234;13884.305784710725;13906.930465347608;262602;263749;264822;265284;266215;53237.7338113307;53367.73316133395;53409.465905341225;53456.19815702768;53475.46524534705;1489.2628149066281;1516.9848301516843;1550.6588550518868;1566.1621032747425;1570.0501196776015;23742.050317987087;25565.113619412557;25720.742792571833;25768.484630307663;26031;38183;38233.426498601984;38337.616623833404;38359.80820095882;38493.615063849;206031;207220;207448;208176;209024;34303;35846.160768295944;36490;36627.633723662424;36669;42338.788306059505;42842;44397;44403.77798110989;44449.33326000048;32276.35447291088;32783.67216327806;33190.66809331972;33288.762049214216;33452.832735836164;32708.50937235991;33608.66391336153;33632.15919602029;34124.82937585396;34337.65662343444;38049.619503804606;38621;38744.80627596844;39182.412263815495;39388;31484.37031259316;31765.36469270648;31768.682313176574;31821;32200.516992245604;23842.25814031339;26129.73870261273;26615.201543953714;26740.732592673823;26763 18:58:58 INFO - PID 15926 | |2;jquery.html;447.81863345345147;450.8985478267392;461.8545158275143;469.03379039179293;473.1365258403414;19001.524961875944;19675.31136410226;20054.475513109108;20399.388018359474;20513.58972820543;21311.786882131175;21969.67045494315;22422.103115875347;22858.77141228587;22954.426139346524;5633.915491267624;5798.942010579883;5799.884002319951;5824.009918313896;5848.4736373726355;5301.5228629423345;5549.694766787825;5573.386927437979;5575.303087114111;5578.107502799553;5473.698946557938;5477.260569823063;5538.861528461801;5539.9169012464845;5541.861453463675;5502.367227768797;5681.460261275172;5701.6864072476;5707.971460142714;5734.168545560912;5118.488151184889;5180.222966555009;5194.896102077975;5196.53231209193;5206.323177986837;26144.607830882553;26173.73826261751;26451.206463806117;26489.47021059568;26521.336966575796;2046.7134601155851;2056.321413933398;2096.5178009058004;2101.191041449038;2101.9264325748527;17428.302867885268;17633.823661763345;17806.732899006525;17840.3755868544;17985.1007449627;2160.632692442273;2235.362921567362;2248.067052173346;2259.1302348595746;2271.3526644906124;116505;116906.41546792297;118603;119445;120900.39549802194;12468.314242716737;12786;12840.61478155657;13003.869961300456;13248.138870973356;18041.09794510269;18179.54551136232;18221.817781822276;18255.72616410755;18362.724559131624;9051.773705657411;9203.217726493189;9318.207952323994;9359.251259899193;9398.436093834393;8408.453450525696;8509.446885952393;8523.701670441505;8683.6526538939;8730.607122679494;7931.76204713848;8084.555349455836;8160.919540229885;8247.793805154799;8312.25189732927;2371.964420533659;2373.3956125117215;2383.475635360218;2388.4267775734047;2524.0282491241005;1021.8620486234263;1041.9114375278034;1062.8627368715554;1079.1366906474789;1101.9008289254007;20946.266880659103;21549.89225053896;21553.245636402964;21587.13651453924;21652.566948661253;1093.1091160704;1104.2104894999952;1105.4583254205381;1108.3128460354633;1108.684025052856;10997.12067790887;11596.536138554533;11737.237079589799;11808.114391420506;11832.290062596272;501317;514424;534491;537490;543076;98354.50822745984;101418.49290753646;102737.48631256795;105513;107502.46248768707;1231.6181983585118;1266.2845492297006;1315.4606611289325;1319.7954317080676;1321.2138777427415;20527.4868128292;20642.27752028672;21239.8938005309;21348.466288342916;21348.679769803155;46217;46475;47027.4161617367;47087.293690593986;47230.291545626154;58310.12534811896;59337.14308569929;59778;60465;61915;9692;9771.511424428609;9810.460424676712;9854.655087071918;9860.556274967501;14629.926850366106;14759.553885513065;15372.538823835303;15871.365145394055;16392.590185245463;13368.264745439094;13464.326783660581;13682.52111176104;13918.652033698834;14172.29138543048;12344.259344439362;12727.74544509086;12759.872401275868;12909.096363254483;13447.731045379232;13746.65633359134;13970.860291396955;13995.930020349833;14302.57092287233;14330.21183834899;9845.655402060893;9942.602295908371;10072.647457338959;10102;10239.385636861813;13509.662258443617;13689.247091410069;13774.104683195561;13785.172889626654;14158.575242742734 18:58:58 INFO - PID 15926 | |3;mootools.html;1367.5897230830751;1397.210576024546;1400.376832309622;1405.7961595568636;1420.8437071922087;11539.192256542035;12035.217710848789;12045.518179272829;12046.698832529191;12263.693407664812;11826.7634647307;11982.880171198285;11991.400429978488;12057.216280941733;12090.03279737621;2473.1714875516677;2483.85096894186;2506.5613517634433;2520.9117680881172;2524.066095544651;2335.9532809343887;2430.283066495388;2434.3670645632087;2438.7561243875557;2438.878056097197;2264.230161745006;2279.6124658807958;2307.5500277445904;2313.363824948144;2323.105604342332;2192.199847055829;2213.6679498075255;2244.9775502244934;2250.7411647660565;2277.202978957368;2045.6215600114026;2129.542148438093;2259.3109101723967;2273.079402841852;2330.1262026739973;11572.363520006396;11723.237989530653;11724.941375293154;11754;11769.352685602289;6206.906896396557;6423.8394040148905;6430.488835123742;6452.128962590037;6475.643839588821;3752.2683076800035;4019.77891215983;4088.8160032798596;4113.835446582163;4121.91756164878;1343.9529616463474;1349.5411560069526;1395.4906459142442;1434.9497767578189;1450.4633285684365;17950.19224134917;18213.180406881722;18245.817541824545;18256;18311.72532412015;5244.895102097937;5396.1494364121245;5474.425185355481;5527.115661494222;5563;12689.048321375934;12772.680682983;12778.297193654438;12831.35843207836;12849.807252891214;6613.338666133348;6626.56927299724;6634.933650663528;6635.469162466991;6650.767223147167;6018.307894592091;6061.272647282354;6070.969645151746;6145.508359331243;6159.384061593805;4297.59172878576;4336.392904993303;4396.956030439718;4441.333799930037;4446.82212711488;1209.6915286601861;1236.145781328008;1236.9072319576069;1237.3380241570896;1245.862955074941;837.3092198935902;858.5020688001069;861.4917198852708;882.7219425880827;900.1403659505157;6299.716512756937;6346.333634968354;6404.903926441107;6479.967600161969;6525.140335004596;626.8056902360283;631.1731631562668;992.270681049428;995.1143482300758;1005.1807776661997;4531.524189960007;4588.931166032512;4800.039992001613;4976.328195693607;5362.490563396471;15384.769228461582;15499.147546884804;15910.522684319489;15924.840751592335;15945.920270398807;15297.847021529866;15602.921985390001;15770.605734856721;15777.68444631124;15821.525354239391;9338.252939764803;9459.810803784023;9561.378510396802;9630.422174669542;9699.369540979813;6970.756023539152;7367.115946086504;7524.473286869867;7576.962115189609;7589.43079269046;13410.061295709596;13556.322183890568;13785.379657915217;13867;14072.718545629235;13891.861081389057;13969.511067112602;14039.649008774863;14202.573922782332;14450.277486125442;9325.30060245498;9504.42973421597;9560.139587437165;9561.61753529851;9624.711258662252;11156.10751139923;11158.442077896236;11223.102151827998;11284.09727221804;11317.773644527228;9106.908930910871;9114.316426267924;9193.080691930754;9248;9326.253899688145;8869.955650221707;9124.31567632417;9125.133112354315;9368.625254989724;9465.432074075577;8019.398545109024;8140.75577732669;8172.632231549714;8198.098209196864;8218.547979861165;6109.938900611115;6205.937940620716;6285.43431091204;6289.213848268966;6290.559660823881;5999.340072592098;6112.083187521907;6255.781047663492;6289.874202516015;6322.36776322364 18:58:58 INFO - PID 15926 | |4;prototype.html;418.9958100418996;420.4828061484374;422.9619334259916;424.08609446642487;434.06675647358156;5993.340732519419;6128.785492507763;6162.907556386658;6167.105769663402;6182.165407669963;5920.171176035358;5939.227900372956;5997.640141591508;6032.909506357408;6062.9090563641585;4484.66365022623;4558.407407037081;4579.725216487005;4588.187665871978;4591.163534586159;4575.542445755431;4591.6097131743845;4602.815887364518;4605.608523275526;4614.238650622643;4539.909201815962;4562.908741825161;4563.2926896330955;4570.223062079454;4571.588557029867;4408.867733967986;4513.871532116971;4553.4991150973365;4563.95436045642;4574.473935497427;3959.940600890989;3966.5438474575503;3967.900802479961;3971;3980.7611543307203;5897.2038774765715;5904.793332233351;5934.851628709273;5947.1376650385455;5951.3751056139345;5218.321083636066;5362.490563396471;5399.271098401744;5403.675779453245;5431.918521222185;6429.967850160766;6433.7426502939825;6435.871282574322;6440.4525615322755;6446.806595802133;4373.606375426227;4448.399466072071;4449.132419178261;4453.064856380164;4462.152191083716;6474.967625161891;6623.701933413008;6725.19297684281;6758.357955994222;6758.526903116784;4545.272756358967;4563.817447302071;4577.244754615518;4587.128445595326;4592.816287348469;4609.469910960215;4611.377464042378;4612.285095810088;4626.7223966562115;4652.488226295105;5261.657992230493;5338.54622357104;5372.1941708744;5377.435369286247;5385.8114965976;6393.6163830170335;6406;6432.71052802625;6445.9355406446275;6452.483261716723;1570.1991984088197;1589.6502769390715;1590.801149856268;1600.391851096599;1607.429362576292;1026.97432564185;1038.9532471038822;1074.188987314588;1077.1329080090602;1081.3079629037422;6093.29927058394;6105.297890742621;6112.72492737819;6123.663198524124;6139.723712432862;6533.901991470132;6643.10318107059;6698.799036028927;6712;6729.49528785343;6019.247594050744;6091.48222401092;6098.847528811815;6099.512039036867;6112.908306375408;3407.9488807667904;3457.3085382923514;3505.4216054351255;3521.4189658706537;3527.8236088195486;6821.590704557742;6873.965630171917;6881.174259088842;6953.408960238336;6970.233274339818;6744.966275168691;6753.636227320497;6767;6783.186017677812;6821.795346139624;6719.664016799141;6949.687264073129;6963.199232088274;7003.719851205895;7015.088038555057;6668.699908504226;6701.229358623821;6709.7651582194385;6711.563748356341;6713.56361836479;6411.134496843053;6475.805725828232;6548.3124271952665;6611.925454663605;6615.636140012345;6928.896066558905;6958.617276049866;6980.406665433495;6990.161180658353;7019.3682568569075;4546.976930190681;4558.293464513005;4560.863174104782;4579.335996280587;4581.198290299251;6592.934070659232;6594.736210551524;6632.403083722488;6676.49926255523;6682.832929176615;6418;6468.708908099241;6476.740930362921;6482.319356467503;6495.480361571157;6359.96820015897;6367.490600752021;6425.742970281323;6484.643344615903;6503.2196136462035;6453.645049522322;6458.709358078804;6481.254655714653;6499.350064993463;6514.348565143448;6393.8721225576155;6417.48660107181;6432.710528026157;6518.934810651833;6540.476761859135;6294.402031806971;6318.336574659595;6321.683915804099;6331.430171284423;6350.237971443456 18:58:58 INFO - PID 15926 | |5;yui.html;817.0522194254662;827.2472050434098;855.3413871319084;872.3021582733813;890.1943740914472;16776.1611919404;17386.13069346534;17389.04360260187;19909.701354479694;20443.284485043027;18420.53948651281;18688.906555467205;18786.154623041963;18965.715514267296;19192;1004.1464754958264;1004.7186787699437;1009.8737657792776;1010.3382284603559;1010.656376831877;988.41189492252;989.376692683612;995.4326034160531;997.9451130187837;1013.0983424751977;1051.8001579699833;1065.323519565078;1074.457399013497;1079.6868908016666;1080.168270431767;994.4182653147917;1068.775557133003;1072.8873468285797;1073.3023534702468;1076.9138468922467;759.2597217712741;762.4205603741196;764.7973287078928;768.3852917665901;768.9961550192269;17683;17809;17833.375831845824;17849.10754462272;17867.1959761811;18635.813641863544;18681.53296167593;19066.237350505962;19072.904635476734;19360.903195483934;13798.793018104736;13869;13888.722225555432;14478.420863165566;14904.701905961929;3568.50040994261;3569.6965757910607;3574.374484465234;3590.335787879251;3591.694705949971;66061.66969165123;87173;88137;88256.55871720664;88965;11533.480993355319;14752.188629625474;14763.483278085216;15001.399944002118;15055.171965541782;25298.74701252964;25793.87103064473;26037.73962260353;27327.180184594494;27369;8110.83778324442;8202.179782021869;8333.458325208841;8403.15968403167;8563.743087707378;3879.4568760373572;3923.136909879822;3927.7250592458254;3939.0940083780893;3963.2073585282483;4455.5098939117315;4536.092781443725;4538.909221815546;4564.475085365159;4629.953700462952;863.0808189278524;876.9517676527852;897.9506127162938;898.2903506230135;900.7162743735702;668.4151367553391;703.9929600703928;707.7770502291864;721.3471808013755;723.5043994863536;11650.6504804856;12009.579664711693;12424;13377.130486518345;13382.063255572017;690.4545409126835;701.4073108223542;706.7632343165097;721.5742711800063;739.5783314439573;5372.489613486712;5886.499647530008;5892.941070589325;5899.115132730125;5924.911126333022;80333.59833200797;81825.59087204645;84629.15370846212;85728.14271857326;87025;69167.04142307541;72581.6370918142;73710;73906;74603.62698186474;60586.39413605807;62637.68681156565;62965.68517157385;63968.36031639717;64906.35093649098;12742.808857866954;12747.362631868555;12807.61577152687;12846.550370737354;12859.421326040163;34895.47656785201;35317.29365412729;35733.28533429265;35812.64187358093;36273;41608.167836643705;42519;42747;43464.34803477887;44180.337294941244;15439;15839.366425342858;15911.840881591035;15947.202639867728;16044.117573533567;18342.266309347477;18545.35091271799;18652.906735466237;19142.904285479042;19379;17049.232784524476;17347.045912474936;17425.47723568295;17492.73760893613;18062.458126256235;16403.17984100814;16426.75359869627;16488.587785305463;16708.331666733193;17059;16810.075445850594;16943;16970.830291696926;17129.143542823058;17266.568335791704;12216.511339546318;12236.265824050586;12486.875131248935;12504.687382815502;12727;14081.788773168615;14117.43530258778;14315.642108947359;14330.498432555227;14356 18:58:58 INFO - PID 15926 | __end_tp_report 18:58:58 INFO - PID 15926 | __start_cc_report 18:58:58 INFO - PID 15926 | _x_x_mozilla_cycle_collect,318 18:58:58 INFO - PID 15926 | __end_cc_report 18:58:58 INFO - PID 15926 | __startTimestamp1494554338377__endTimestamp 18:58:58 INFO - PID 15926 | 18:58:58 INFO - PID 15926 | ------- Summary: start ------- 18:58:58 INFO - PID 15926 | Number of tests: 6 18:58:58 INFO - PID 15926 | 18:58:58 INFO - PID 15926 | [#0] dojo.html Cycles:165 Average:5971.05 Median:6169.29 stddev:735.09 (11.9%) stddev-sans-first:705.62 18:58:58 INFO - PID 15926 | Values: 3248.0 3362.1 3374.4 3376.2 3387.9 5811.4 5997.6 6015.9 6032.5 6042.6 5930.9 5996.2 6006.8 6049.4 6071.4 4948.8 5303.1 5321.5 5334.7 5343.5 5342.7 5365.1 5369.0 5415.1 5422.8 5308.5 5348.1 5357.2 5394.0 5400.1 5350.7 5353.2 5359.9 5360.6 5369.5 5343.1 5347.5 5353.8 5360.3 5360.4 5845.4 5854.4 5924.8 5949.0 6000.9 6500.3 6501.2 6505.8 6509.0 6509.2 6554.5 6577.5 6581.1 6584.1 6608.3 5877.8 5938.0 6009.2 6056.4 6090.2 6635.7 6666.2 6689.6 6705.2 6709.0 6189.9 6226.0 6307.7 6360.4 6405.2 6419.9 6421.3 6430.2 6438.2 6448.4 6281.5 6325.9 6330.5 6409.9 6438.4 6439.5 6490.8 6494.8 6511.7 6516.6 4902.7 4902.8 4920.9 4921.0 4938.4 4273.2 4288.7 4360.8 4392.1 4394.6 6041.5 6046.0 6051.9 6083.8 6110.1 6465.3 6474.1 6503.9 6561.6 6570.9 5781.9 5904.7 6029.6 6033.2 6040.7 5550.1 5596.9 5611.9 5617.1 5634.8 6829.3 6838.7 6838.9 6853.9 6862.5 6440.8 6461.5 6493.0 6533.2 6593.2 6615.6 6821.3 6834.8 6862.4 6873.7 6255.3 6314.2 6329.3 6331.7 6338.0 6301.1 6447.9 6599.4 6600.9 6607.7 6289.2 6332.0 6354.9 6377.3 6380.5 6344.5 6344.9 6347.3 6348.6 6350.6 6136.6 6158.1 6169.3 6225.7 6330.4 6259.9 6319.1 6334.0 6347.1 6347.1 6137.4 6140.2 6146.0 6153.9 6159.8 18:58:58 INFO - PID 15926 | 18:58:58 INFO - PID 15926 | [#1] ext.html Cycles:180 Average:39180.77 Median:3565.19 stddev:59068.34 (1656.8%) stddev-sans-first:59163.73 18:58:58 INFO - PID 15926 | Values: 795.0 806.6 1136.8 1170.9 1224.3 37856.6 38814.6 38967.6 39020.2 39069.8 36144.6 36393.5 36394.0 36422.6 36506.0 6659.3 6771.2 7186.6 7355.3 7355.4 7230.3 7269.1 7280.0 7356.4 7361.3 7298.7 7328.3 7337.1 7357.1 7391.6 7265.7 7294.2 7301.8 7360.5 7367.6 7130.4 7149.8 7162.3 7163.4 7185.2 36020.3 36260.5 36420.9 36506.6 36755.4 3519.9 3550.3 3580.1 3581.3 3581.8 28580.7 28613.0 28793.0 28845.0 28854.9 3750.7 3772.3 3775.8 3783.9 3789.6 203680.0 204345.0 204902.0 204955.0 205181.0 46054.0 48838.5 48920.8 49532.0 49850.0 50081.2 50440.0 50580.2 50609.2 51007.5 14121.1 14130.9 14211.4 14273.6 14297.1 10972.9 11057.8 11059.5 11084.0 11155.2 14409.5 14589.6 14645.6 14680.8 14710.8 5834.7 5883.6 5889.0 5889.2 5926.4 1070.8 1093.7 1107.2 1123.7 1136.6 26245.2 26364.2 26409.7 26417.6 26456.7 1218.6 1224.1 1227.8 1230.7 1246.6 13495.0 13569.4 13799.3 13884.3 13906.9 262602.0 263749.0 264822.0 265284.0 266215.0 53237.7 53367.7 53409.5 53456.2 53475.5 1489.3 1517.0 1550.7 1566.2 1570.1 23742.1 25565.1 25720.7 25768.5 26031.0 38183.0 38233.4 38337.6 38359.8 38493.6 206031.0 207220.0 207448.0 208176.0 209024.0 34303.0 35846.2 36490.0 36627.6 36669.0 42338.8 42842.0 44397.0 44403.8 44449.3 32276.4 32783.7 33190.7 33288.8 33452.8 32708.5 33608.7 33632.2 34124.8 34337.7 38049.6 38621.0 38744.8 39182.4 39388.0 31484.4 31765.4 31768.7 31821.0 32200.5 23842.3 26129.7 26615.2 26740.7 26763.0 18:58:58 INFO - PID 15926 | 18:58:58 INFO - PID 15926 | [#2] jquery.html Cycles:180 Average:32775.66 Median:21570.19 stddev:87468.93 (405.5%) stddev-sans-first:87680.62 18:58:58 INFO - PID 15926 | Values: 447.8 450.9 461.9 469.0 473.1 19001.5 19675.3 20054.5 20399.4 20513.6 21311.8 21969.7 22422.1 22858.8 22954.4 5633.9 5798.9 5799.9 5824.0 5848.5 5301.5 5549.7 5573.4 5575.3 5578.1 5473.7 5477.3 5538.9 5539.9 5541.9 5502.4 5681.5 5701.7 5708.0 5734.2 5118.5 5180.2 5194.9 5196.5 5206.3 26144.6 26173.7 26451.2 26489.5 26521.3 2046.7 2056.3 2096.5 2101.2 2101.9 17428.3 17633.8 17806.7 17840.4 17985.1 2160.6 2235.4 2248.1 2259.1 2271.4 116505.0 116906.4 118603.0 119445.0 120900.4 12468.3 12786.0 12840.6 13003.9 13248.1 18041.1 18179.5 18221.8 18255.7 18362.7 9051.8 9203.2 9318.2 9359.3 9398.4 8408.5 8509.4 8523.7 8683.7 8730.6 7931.8 8084.6 8160.9 8247.8 8312.3 2372.0 2373.4 2383.5 2388.4 2524.0 1021.9 1041.9 1062.9 1079.1 1101.9 20946.3 21549.9 21553.2 21587.1 21652.6 1093.1 1104.2 1105.5 1108.3 1108.7 10997.1 11596.5 11737.2 11808.1 11832.3 501317.0 514424.0 534491.0 537490.0 543076.0 98354.5 101418.5 102737.5 105513.0 107502.5 1231.6 1266.3 1315.5 1319.8 1321.2 20527.5 20642.3 21239.9 21348.5 21348.7 46217.0 46475.0 47027.4 47087.3 47230.3 58310.1 59337.1 59778.0 60465.0 61915.0 9692.0 9771.5 9810.5 9854.7 9860.6 14629.9 14759.6 15372.5 15871.4 16392.6 13368.3 13464.3 13682.5 13918.7 14172.3 12344.3 12727.7 12759.9 12909.1 13447.7 13746.7 13970.9 13995.9 14302.6 14330.2 9845.7 9942.6 10072.6 10102.0 10239.4 13509.7 13689.2 13774.1 13785.2 14158.6 18:58:58 INFO - PID 15926 | 18:58:58 INFO - PID 15926 | [#3] mootools.html Cycles:180 Average:7338.58 Median:3138.17 stddev:4792.61 (152.7%) stddev-sans-first:4785.05 18:58:58 INFO - PID 15926 | Values: 1367.6 1397.2 1400.4 1405.8 1420.8 11539.2 12035.2 12045.5 12046.7 12263.7 11826.8 11982.9 11991.4 12057.2 12090.0 2473.2 2483.9 2506.6 2520.9 2524.1 2336.0 2430.3 2434.4 2438.8 2438.9 2264.2 2279.6 2307.6 2313.4 2323.1 2192.2 2213.7 2245.0 2250.7 2277.2 2045.6 2129.5 2259.3 2273.1 2330.1 11572.4 11723.2 11724.9 11754.0 11769.4 6206.9 6423.8 6430.5 6452.1 6475.6 3752.3 4019.8 4088.8 4113.8 4121.9 1344.0 1349.5 1395.5 1434.9 1450.5 17950.2 18213.2 18245.8 18256.0 18311.7 5244.9 5396.1 5474.4 5527.1 5563.0 12689.0 12772.7 12778.3 12831.4 12849.8 6613.3 6626.6 6634.9 6635.5 6650.8 6018.3 6061.3 6071.0 6145.5 6159.4 4297.6 4336.4 4397.0 4441.3 4446.8 1209.7 1236.1 1236.9 1237.3 1245.9 837.3 858.5 861.5 882.7 900.1 6299.7 6346.3 6404.9 6480.0 6525.1 626.8 631.2 992.3 995.1 1005.2 4531.5 4588.9 4800.0 4976.3 5362.5 15384.8 15499.1 15910.5 15924.8 15945.9 15297.8 15602.9 15770.6 15777.7 15821.5 9338.3 9459.8 9561.4 9630.4 9699.4 6970.8 7367.1 7524.5 7577.0 7589.4 13410.1 13556.3 13785.4 13867.0 14072.7 13891.9 13969.5 14039.6 14202.6 14450.3 9325.3 9504.4 9560.1 9561.6 9624.7 11156.1 11158.4 11223.1 11284.1 11317.8 9106.9 9114.3 9193.1 9248.0 9326.3 8870.0 9124.3 9125.1 9368.6 9465.4 8019.4 8140.8 8172.6 8198.1 8218.5 6109.9 6205.9 6285.4 6289.2 6290.6 5999.3 6112.1 6255.8 6289.9 6322.4 18:58:58 INFO - PID 15926 | 18:58:58 INFO - PID 15926 | [#4] prototype.html Cycles:180 Average:5381.40 Median:6102.40 stddev:1636.68 (26.8%) stddev-sans-first:1598.33 18:58:58 INFO - PID 15926 | Values: 419.0 420.5 423.0 424.1 434.1 5993.3 6128.8 6162.9 6167.1 6182.2 5920.2 5939.2 5997.6 6032.9 6062.9 4484.7 4558.4 4579.7 4588.2 4591.2 4575.5 4591.6 4602.8 4605.6 4614.2 4539.9 4562.9 4563.3 4570.2 4571.6 4408.9 4513.9 4553.5 4564.0 4574.5 3959.9 3966.5 3967.9 3971.0 3980.8 5897.2 5904.8 5934.9 5947.1 5951.4 5218.3 5362.5 5399.3 5403.7 5431.9 6430.0 6433.7 6435.9 6440.5 6446.8 4373.6 4448.4 4449.1 4453.1 4462.2 6475.0 6623.7 6725.2 6758.4 6758.5 4545.3 4563.8 4577.2 4587.1 4592.8 4609.5 4611.4 4612.3 4626.7 4652.5 5261.7 5338.5 5372.2 5377.4 5385.8 6393.6 6406.0 6432.7 6445.9 6452.5 1570.2 1589.7 1590.8 1600.4 1607.4 1027.0 1039.0 1074.2 1077.1 1081.3 6093.3 6105.3 6112.7 6123.7 6139.7 6533.9 6643.1 6698.8 6712.0 6729.5 6019.2 6091.5 6098.8 6099.5 6112.9 3407.9 3457.3 3505.4 3521.4 3527.8 6821.6 6874.0 6881.2 6953.4 6970.2 6745.0 6753.6 6767.0 6783.2 6821.8 6719.7 6949.7 6963.2 7003.7 7015.1 6668.7 6701.2 6709.8 6711.6 6713.6 6411.1 6475.8 6548.3 6611.9 6615.6 6928.9 6958.6 6980.4 6990.2 7019.4 4547.0 4558.3 4560.9 4579.3 4581.2 6592.9 6594.7 6632.4 6676.5 6682.8 6418.0 6468.7 6476.7 6482.3 6495.5 6360.0 6367.5 6425.7 6484.6 6503.2 6453.6 6458.7 6481.3 6499.4 6514.3 6393.9 6417.5 6432.7 6518.9 6540.5 6294.4 6318.3 6321.7 6331.4 6350.2 18:58:58 INFO - PID 15926 | 18:58:58 INFO - PID 15926 | [#5] yui.html Cycles:180 Average:18964.24 Median:25546.31 stddev:22645.65 (88.6%) stddev-sans-first:22668.17 18:58:58 INFO - PID 15926 | Values: 817.1 827.2 855.3 872.3 890.2 16776.2 17386.1 17389.0 19909.7 20443.3 18420.5 18688.9 18786.2 18965.7 19192.0 1004.1 1004.7 1009.9 1010.3 1010.7 988.4 989.4 995.4 997.9 1013.1 1051.8 1065.3 1074.5 1079.7 1080.2 994.4 1068.8 1072.9 1073.3 1076.9 759.3 762.4 764.8 768.4 769.0 17683.0 17809.0 17833.4 17849.1 17867.2 18635.8 18681.5 19066.2 19072.9 19360.9 13798.8 13869.0 13888.7 14478.4 14904.7 3568.5 3569.7 3574.4 3590.3 3591.7 66061.7 87173.0 88137.0 88256.6 88965.0 11533.5 14752.2 14763.5 15001.4 15055.2 25298.7 25793.9 26037.7 27327.2 27369.0 8110.8 8202.2 8333.5 8403.2 8563.7 3879.5 3923.1 3927.7 3939.1 3963.2 4455.5 4536.1 4538.9 4564.5 4630.0 863.1 877.0 898.0 898.3 900.7 668.4 704.0 707.8 721.3 723.5 11650.7 12009.6 12424.0 13377.1 13382.1 690.5 701.4 706.8 721.6 739.6 5372.5 5886.5 5892.9 5899.1 5924.9 80333.6 81825.6 84629.2 85728.1 87025.0 69167.0 72581.6 73710.0 73906.0 74603.6 60586.4 62637.7 62965.7 63968.4 64906.4 12742.8 12747.4 12807.6 12846.6 12859.4 34895.5 35317.3 35733.3 35812.6 36273.0 41608.2 42519.0 42747.0 43464.3 44180.3 15439.0 15839.4 15911.8 15947.2 16044.1 18342.3 18545.4 18652.9 19142.9 19379.0 17049.2 17347.0 17425.5 17492.7 18062.5 16403.2 16426.8 16488.6 16708.3 17059.0 16810.1 16943.0 16970.8 17129.1 17266.6 12216.5 12236.3 12486.9 12504.7 12727.0 14081.8 14117.4 14315.6 14330.5 14356.0 18:58:58 INFO - PID 15926 | -------- Summary: end -------- 18:58:58 INFO - PID 15926 | 18:58:59 INFO - TEST-INFO | 15926: exit 0 18:58:59 INFO - TEST-OK | dromaeo_css | took 1112498ms 18:58:59 INFO - TEST-START | kraken 18:58:59 INFO - operating with platform_type : linux_ 18:58:59 INFO - Initialising browser for kraken test... 18:58:59 INFO - TEST-INFO | started process 16344 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpg2yNJl/profile http://localhost:52596/getInfo.html) 18:59:02 INFO - PID 16344 | __metrics Screen width/height:1600/1200 18:59:02 INFO - PID 16344 | colorDepth:24 18:59:02 INFO - PID 16344 | Browser inner width/height: 1024/695 18:59:02 INFO - PID 16344 | __metrics 18:59:04 INFO - TEST-INFO | 16344: exit 0 18:59:04 INFO - Browser initialized. 18:59:04 INFO - Running cycle 1/1 for kraken test... 18:59:04 INFO - TEST-INFO | started process 16516 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpg2yNJl/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:59:16 INFO - PID 16516 | RSS: Main: 151003136 18:59:16 INFO - PID 16516 | 18:59:18 INFO - PID 16516 | Cycle 1(1): loaded http://localhost:52596/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52596/tests/kraken/driver.html?testName=audio-beat-detection) 18:59:19 INFO - PID 16516 | RSS: Main: 157618176 18:59:19 INFO - PID 16516 | 18:59:22 INFO - PID 16516 | Cycle 1(1): loaded http://localhost:52596/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52596/tests/kraken/driver.html?testName=audio-dft) 18:59:22 INFO - PID 16516 | RSS: Main: 156385280 18:59:22 INFO - PID 16516 | 18:59:25 INFO - PID 16516 | Cycle 1(1): loaded http://localhost:52596/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52596/tests/kraken/driver.html?testName=audio-fft) 18:59:26 INFO - PID 16516 | RSS: Main: 152576000 18:59:26 INFO - PID 16516 | 18:59:28 INFO - PID 16516 | Cycle 1(1): loaded http://localhost:52596/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52596/tests/kraken/driver.html?testName=audio-oscillator) 18:59:28 INFO - PID 16516 | RSS: Main: 153985024 18:59:28 INFO - PID 16516 | 18:59:31 INFO - PID 16516 | Cycle 1(1): loaded http://localhost:52596/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52596/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:59:31 INFO - PID 16516 | RSS: Main: 154124288 18:59:31 INFO - PID 16516 | 18:59:34 INFO - PID 16516 | Cycle 1(1): loaded http://localhost:52596/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52596/tests/kraken/driver.html?testName=imaging-darkroom) 18:59:35 INFO - PID 16516 | RSS: Main: 159354880 18:59:35 INFO - PID 16516 | 18:59:38 INFO - PID 16516 | Cycle 1(1): loaded http://localhost:52596/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52596/tests/kraken/driver.html?testName=imaging-desaturate) 18:59:39 INFO - PID 16516 | RSS: Main: 161148928 18:59:39 INFO - PID 16516 | 18:59:42 INFO - PID 16516 | Cycle 1(1): loaded http://localhost:52596/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52596/tests/kraken/driver.html?testName=json-parse-financial) 18:59:42 INFO - PID 16516 | RSS: Main: 160153600 18:59:42 INFO - PID 16516 | 18:59:44 INFO - PID 16516 | Cycle 1(1): loaded http://localhost:52596/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52596/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:59:44 INFO - PID 16516 | RSS: Main: 159498240 18:59:44 INFO - PID 16516 | 18:59:46 INFO - PID 16516 | Cycle 1(1): loaded http://localhost:52596/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52596/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:59:47 INFO - PID 16516 | RSS: Main: 159342592 18:59:47 INFO - PID 16516 | 18:59:49 INFO - PID 16516 | Cycle 1(1): loaded http://localhost:52596/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52596/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:59:49 INFO - PID 16516 | RSS: Main: 159510528 18:59:49 INFO - PID 16516 | 18:59:52 INFO - PID 16516 | Cycle 1(1): loaded http://localhost:52596/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52596/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:59:53 INFO - PID 16516 | RSS: Main: 159518720 18:59:53 INFO - PID 16516 | 18:59:56 INFO - PID 16516 | Cycle 1(1): loaded http://localhost:52596/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52596/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:59:56 INFO - PID 16516 | RSS: Main: 160272384 18:59:56 INFO - PID 16516 | 18:59:58 INFO - PID 16516 | Cycle 1(1): loaded http://localhost:52596/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52596/tests/kraken/driver.html?testName=ai-astar) 18:59:58 INFO - PID 16516 | RSS: Main: 162156544 18:59:58 INFO - PID 16516 | 18:59:58 INFO - PID 16516 | __start_tp_report 18:59:58 INFO - PID 16516 | _x_x_mozilla_page_load 18:59:58 INFO - PID 16516 | _x_x_mozilla_page_load_details 18:59:58 INFO - PID 16516 | |i|pagename|runs| 18:59:58 INFO - PID 16516 | |0;ai-astar;104;112;115;108;111;110;110;109;110;110 18:59:58 INFO - PID 16516 | |1;audio-beat-detection;147;128;126;165;120;121;122;122;145;120 18:59:58 INFO - PID 16516 | |2;audio-dft;163;164;166;163;163;163;164;165;167;168 18:59:58 INFO - PID 16516 | |3;audio-fft;79;78;76;97;76;75;74;75;96;74 18:59:58 INFO - PID 16516 | |4;audio-oscillator;83;82;100;83;80;82;95;82;82;99 18:59:58 INFO - PID 16516 | |5;imaging-gaussian-blur;115;115;115;113;114;115;113;113;114;114 18:59:58 INFO - PID 16516 | |6;imaging-darkroom;148;150;149;149;148;148;148;149;149;148 18:59:58 INFO - PID 16516 | |7;imaging-desaturate;95;95;96;95;95;95;95;94;95;96 18:59:58 INFO - PID 16516 | |8;json-parse-financial;47;48;46;47;47;48;49;51;47;47 18:59:58 INFO - PID 16516 | |9;json-stringify-tinderbox;56;55;56;57;55;56;56;56;56;56 18:59:58 INFO - PID 16516 | |10;stanford-crypto-aes;87;78;79;81;78;80;78;87;79;79 18:59:58 INFO - PID 16516 | |11;stanford-crypto-ccm;130;129;129;122;125;126;128;127;179;126 18:59:58 INFO - PID 16516 | |12;stanford-crypto-pbkdf2;180;184;182;180;181;187;180;183;184;186 18:59:58 INFO - PID 16516 | |13;stanford-crypto-sha256-iterative;68;67;65;66;66;66;69;67;64;66 18:59:58 INFO - PID 16516 | __end_tp_report 18:59:58 INFO - PID 16516 | __start_cc_report 18:59:58 INFO - PID 16516 | _x_x_mozilla_cycle_collect,774 18:59:58 INFO - PID 16516 | __end_cc_report 18:59:58 INFO - PID 16516 | __startTimestamp1494554398567__endTimestamp 18:59:58 INFO - PID 16516 | 18:59:58 INFO - PID 16516 | ------- Summary: start ------- 18:59:58 INFO - PID 16516 | Number of tests: 14 18:59:58 INFO - PID 16516 | 18:59:58 INFO - PID 16516 | [#0] ai-astar Cycles:10 Average:109.90 Median:110.00 stddev:2.81 (2.6%) stddev-sans-first:2.01 18:59:58 INFO - PID 16516 | Values: 104.0 112.0 115.0 108.0 111.0 110.0 110.0 109.0 110.0 110.0 18:59:58 INFO - PID 16516 | 18:59:58 INFO - PID 16516 | [#1] audio-beat-detection Cycles:10 Average:131.60 Median:127.00 stddev:15.43 (12.1%) stddev-sans-first:15.33 18:59:58 INFO - PID 16516 | Values: 147.0 128.0 126.0 165.0 120.0 121.0 122.0 122.0 145.0 120.0 18:59:58 INFO - PID 16516 | 18:59:58 INFO - PID 16516 | [#2] audio-dft Cycles:10 Average:164.60 Median:164.50 stddev:1.84 (1.1%) stddev-sans-first:1.86 18:59:58 INFO - PID 16516 | Values: 163.0 164.0 166.0 163.0 163.0 163.0 164.0 165.0 167.0 168.0 18:59:58 INFO - PID 16516 | 18:59:58 INFO - PID 16516 | [#3] audio-fft Cycles:10 Average:80.00 Median:77.00 stddev:8.84 (11.5%) stddev-sans-first:9.37 18:59:58 INFO - PID 16516 | Values: 79.0 78.0 76.0 97.0 76.0 75.0 74.0 75.0 96.0 74.0 18:59:58 INFO - PID 16516 | 18:59:58 INFO - PID 16516 | [#4] audio-oscillator Cycles:10 Average:86.80 Median:82.50 stddev:7.87 (9.5%) stddev-sans-first:8.23 18:59:58 INFO - PID 16516 | Values: 83.0 82.0 100.0 83.0 80.0 82.0 95.0 82.0 82.0 99.0 18:59:58 INFO - PID 16516 | 18:59:58 INFO - PID 16516 | [#5] imaging-gaussian-blur Cycles:10 Average:114.10 Median:114.50 stddev:0.88 (0.8%) stddev-sans-first:0.87 18:59:58 INFO - PID 16516 | Values: 115.0 115.0 115.0 113.0 114.0 115.0 113.0 113.0 114.0 114.0 18:59:58 INFO - PID 16516 | 18:59:58 INFO - PID 16516 | [#6] imaging-darkroom Cycles:10 Average:148.60 Median:149.00 stddev:0.70 (0.5%) stddev-sans-first:0.71 18:59:58 INFO - PID 16516 | Values: 148.0 150.0 149.0 149.0 148.0 148.0 148.0 149.0 149.0 148.0 18:59:58 INFO - PID 16516 | 18:59:58 INFO - PID 16516 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 18:59:58 INFO - PID 16516 | Values: 95.0 95.0 96.0 95.0 95.0 95.0 95.0 94.0 95.0 96.0 18:59:58 INFO - PID 16516 | 18:59:58 INFO - PID 16516 | [#8] json-parse-financial Cycles:10 Average:47.70 Median:47.50 stddev:1.42 (3.0%) stddev-sans-first:1.48 18:59:58 INFO - PID 16516 | Values: 47.0 48.0 46.0 47.0 47.0 48.0 49.0 51.0 47.0 47.0 18:59:58 INFO - PID 16516 | 18:59:58 INFO - PID 16516 | [#9] json-stringify-tinderbox Cycles:10 Average:55.90 Median:56.00 stddev:0.57 (1.0%) stddev-sans-first:0.60 18:59:58 INFO - PID 16516 | Values: 56.0 55.0 56.0 57.0 55.0 56.0 56.0 56.0 56.0 56.0 18:59:58 INFO - PID 16516 | 18:59:58 INFO - PID 16516 | [#10] stanford-crypto-aes Cycles:10 Average:80.60 Median:79.50 stddev:3.50 (4.4%) stddev-sans-first:2.85 18:59:58 INFO - PID 16516 | Values: 87.0 78.0 79.0 81.0 78.0 80.0 78.0 87.0 79.0 79.0 18:59:58 INFO - PID 16516 | 18:59:58 INFO - PID 16516 | [#11] stanford-crypto-ccm Cycles:10 Average:132.10 Median:128.50 stddev:16.64 (13.0%) stddev-sans-first:17.64 18:59:58 INFO - PID 16516 | Values: 130.0 129.0 129.0 122.0 125.0 126.0 128.0 127.0 179.0 126.0 18:59:58 INFO - PID 16516 | 18:59:58 INFO - PID 16516 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:182.70 Median:183.50 stddev:2.54 (1.4%) stddev-sans-first:2.50 18:59:58 INFO - PID 16516 | Values: 180.0 184.0 182.0 180.0 181.0 187.0 180.0 183.0 184.0 186.0 18:59:58 INFO - PID 16516 | 18:59:58 INFO - PID 16516 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.40 Median:66.50 stddev:1.43 (2.2%) stddev-sans-first:1.39 18:59:58 INFO - PID 16516 | Values: 68.0 67.0 65.0 66.0 66.0 66.0 69.0 67.0 64.0 66.0 18:59:58 INFO - PID 16516 | -------- Summary: end -------- 18:59:58 INFO - PID 16516 | 18:59:59 INFO - TEST-INFO | 16516: exit 0 18:59:59 INFO - TEST-OK | kraken | took 60471ms 18:59:59 INFO - SUITE-END | took 1172s 18:59:59 INFO - Completed test suite (00:19:33) 18:59:59 INFO - javascript benchmark 18:59:59 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7870.413266839734, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3248.0, 3362.0922350965225, 3374.392609330321, 3376.189714468528, 3387.9491807622876, 5811.447912448321, 5997.580169388139, 6015.879682406355, 6032.48723858472, 6042.637441753498, 5930.911036334458, 5996.220491336131, 6006.849828754283, 6049.425304596068, 6071.423214794588, 4948.755490483156, 5303.124984377573, 5321.52106310431, 5334.679919204841, 5343.465653434664, 5342.732863356836, 5365.141577347606, 5368.973155134238, 5415.0523658359825, 5422.75597598109, 5308.469153084699, 5348.117560602496, 5357.196420536911, 5394.0, 5400.054990376669, 5350.705711185883, 5353.197020446925, 5359.892802143974, 5360.571154307646, 5369.516743493065, 5343.091674415358, 5347.54545863602, 5353.839384818461, 5360.3299587551555, 5360.383555891044, 5845.386234445365, 5854.356020837705, 5924.763009479616, 5949.048152295655, 6000.879982400371, 6500.349965003509, 6501.2198536175965, 6505.837354066186, 6508.967455162694, 6509.1863517060365, 6554.541182117254, 6577.539572229945, 6581.078648989145, 6584.144061272052, 6608.2730899601, 5877.794277200277, 5938.049912014057, 6009.248843894513, 6056.394360563952, 6090.177825993434, 6635.668216589152, 6666.166729158856, 6689.5986240825705, 6705.161854768154, 6709.027191057269, 6189.907151392733, 6225.968870155711, 6307.653079080603, 6360.363963603602, 6405.231372235268, 6419.871602567922, 6421.325760795143, 6430.196225471816, 6438.163038805019, 6448.387403196689, 6281.528885333618, 6325.9051114233325, 6330.4619107375465, 6409.935900640934, 6438.356164383618, 6439.452646525097, 6490.8052758417325, 6494.837629059311, 6511.73953041873, 6516.609003459713, 4902.7058376497525, 4902.828401006019, 4920.926186107211, 4921.040397122599, 4938.358013458299, 4273.166732487135, 4288.656907447396, 4360.825566977349, 4392.143532011291, 4394.604485596247, 6041.456268935817, 6045.972184728606, 6051.909221361683, 6083.7870674526175, 6110.083487476914, 6465.321141280192, 6474.061261117112, 6503.902441463382, 6561.639109849004, 6570.901436478457, 5781.913271300934, 5904.704764761745, 6029.638221706711, 6033.215681961317, 6040.728167232397, 5550.111982082847, 5596.916046259309, 5611.859703507445, 5617.073182924853, 5634.830955071355, 6829.282925292872, 6838.692258848364, 6838.897416538756, 6853.9314606853295, 6862.519623626398, 6440.806775796734, 6461.547691661539, 6493.0, 6533.18335208099, 6593.175853018372, 6615.6030638161865, 6821.317868213139, 6834.838077526932, 6862.382385585322, 6873.690683919136, 6255.343188965275, 6314.179156709598, 6329.335419780857, 6331.683415829282, 6337.968310158604, 6301.117843502005, 6447.871042579029, 6599.373059559334, 6600.9009864851105, 6607.702653380513, 6289.182406287154, 6331.96834015827, 6354.936450635434, 6377.330380310001, 6380.489560835029, 6344.492440604648, 6344.873102537831, 6347.270063942706, 6348.619082855043, 6350.587211831216, 6136.641621527207, 6158.076288556752, 6169.290531588925, 6225.688715564294, 6330.366963303817, 6259.906101408392, 6319.115323854572, 6333.96833015832, 6347.079673447417, 6347.079673447417, 6137.3862613738265, 6140.201773769381, 6145.9692701536205, 6153.907691384543, 6159.753609855556], "value": 5917.336727091115, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [794.9801254968626, 806.5967016491754, 1136.8010598145322, 1170.941452927354, 1224.3021477757682, 37856.62143378565, 38814.611853881455, 38967.61032389682, 39020.219595608105, 39069.804650976774, 36144.63855361446, 36393.45409818855, 36394.0, 36422.63577364226, 36506.0, 6659.267480577133, 6771.187457505106, 7186.568805871664, 7355.3380195782365, 7355.37479314259, 7230.27697230278, 7269.091363579552, 7280.0, 7356.411487081021, 7361.263873612649, 7298.671559779797, 7328.340449359556, 7337.0828646419195, 7357.0803649543805, 7391.556506609621, 7265.673044713, 7294.197638259814, 7301.817454563678, 7360.484766066377, 7367.594782286972, 7130.429565634789, 7149.82125446868, 7162.319579639978, 7163.355298023151, 7185.209626941032, 36020.279594408225, 36260.456093158624, 36420.90737277886, 36506.63493365059, 36755.44866827, 3519.9296014079832, 3550.2544465661986, 3580.122869896892, 3581.2658405026905, 3581.8209089545417, 28580.714192858013, 28613.0, 28793.0, 28845.0, 28854.855725721445, 3750.6811920986747, 3772.2832661794446, 3775.848966041355, 3783.9432408513894, 3789.621037896216, 203680.0, 204345.0, 204902.0, 204955.0, 205180.99999999852, 46054.0, 48838.511614884104, 48920.75539622279, 49532.0, 49850.0, 50081.24878126831, 50440.0, 50580.24129637985, 50609.24086138711, 51007.489925101014, 14121.08212966154, 14130.929345353414, 14211.36048877803, 14273.64315892111, 14297.142171469744, 10972.890271097187, 11057.834132488018, 11059.502322395512, 11084.0, 11155.163362747826, 14409.495667651581, 14589.562313130624, 14645.633859153606, 14680.767176886722, 14710.779338309934, 5834.708264586754, 5883.558733095035, 5888.968305934446, 5889.1755154278435, 5926.436988486087, 1070.7751372211767, 1093.7101668057971, 1107.1530279336314, 1123.6966019174777, 1136.5908273021705, 26245.21264362072, 26364.20907372782, 26409.73590264111, 26417.603735943976, 26456.73543264581, 1218.61004478566, 1224.136983426682, 1227.79127548317, 1230.7107829660022, 1246.6073186946082, 13495.0, 13569.439514455766, 13799.310034498234, 13884.305784710725, 13906.930465347608, 262602.0, 263749.0, 264822.0, 265284.0, 266215.0, 53237.7338113307, 53367.73316133395, 53409.465905341225, 53456.19815702768, 53475.46524534705, 1489.2628149066281, 1516.9848301516843, 1550.6588550518868, 1566.1621032747425, 1570.0501196776015, 23742.050317987087, 25565.113619412557, 25720.742792571833, 25768.484630307663, 26031.0, 38183.0, 38233.426498601984, 38337.616623833404, 38359.80820095882, 38493.615063849, 206031.0, 207220.0, 207448.0, 208176.0, 209024.0, 34303.0, 35846.160768295944, 36490.0, 36627.633723662424, 36669.0, 42338.788306059505, 42842.0, 44397.0, 44403.77798110989, 44449.33326000048, 32276.35447291088, 32783.67216327806, 33190.66809331972, 33288.762049214216, 33452.832735836164, 32708.50937235991, 33608.66391336153, 33632.15919602029, 34124.82937585396, 34337.65662343444, 38049.619503804606, 38621.0, 38744.80627596844, 39182.412263815495, 39388.0, 31484.37031259316, 31765.36469270648, 31768.682313176574, 31821.0, 32200.516992245604, 23842.25814031339, 26129.73870261273, 26615.201543953714, 26740.732592673823, 26763.0], "value": 17248.91619545032, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [447.81863345345147, 450.8985478267392, 461.8545158275143, 469.03379039179293, 473.1365258403414, 19001.524961875944, 19675.31136410226, 20054.475513109108, 20399.388018359474, 20513.58972820543, 21311.786882131175, 21969.67045494315, 22422.103115875347, 22858.77141228587, 22954.426139346524, 5633.915491267624, 5798.942010579883, 5799.884002319951, 5824.009918313896, 5848.4736373726355, 5301.5228629423345, 5549.694766787825, 5573.386927437979, 5575.303087114111, 5578.107502799553, 5473.698946557938, 5477.260569823063, 5538.861528461801, 5539.9169012464845, 5541.861453463675, 5502.367227768797, 5681.460261275172, 5701.6864072476, 5707.971460142714, 5734.168545560912, 5118.488151184889, 5180.222966555009, 5194.896102077975, 5196.53231209193, 5206.323177986837, 26144.607830882553, 26173.73826261751, 26451.206463806117, 26489.47021059568, 26521.336966575796, 2046.7134601155851, 2056.321413933398, 2096.5178009058004, 2101.191041449038, 2101.9264325748527, 17428.302867885268, 17633.823661763345, 17806.732899006525, 17840.3755868544, 17985.1007449627, 2160.632692442273, 2235.362921567362, 2248.067052173346, 2259.1302348595746, 2271.3526644906124, 116505.0, 116906.41546792297, 118603.0, 119445.0, 120900.39549802194, 12468.314242716737, 12786.0, 12840.61478155657, 13003.869961300456, 13248.138870973356, 18041.09794510269, 18179.54551136232, 18221.817781822276, 18255.72616410755, 18362.724559131624, 9051.773705657411, 9203.217726493189, 9318.207952323994, 9359.251259899193, 9398.436093834393, 8408.453450525696, 8509.446885952393, 8523.701670441505, 8683.6526538939, 8730.607122679494, 7931.76204713848, 8084.555349455836, 8160.919540229885, 8247.793805154799, 8312.25189732927, 2371.964420533659, 2373.3956125117215, 2383.475635360218, 2388.4267775734047, 2524.0282491241005, 1021.8620486234263, 1041.9114375278034, 1062.8627368715554, 1079.1366906474789, 1101.9008289254007, 20946.266880659103, 21549.89225053896, 21553.245636402964, 21587.13651453924, 21652.566948661253, 1093.1091160704, 1104.2104894999952, 1105.4583254205381, 1108.3128460354633, 1108.684025052856, 10997.12067790887, 11596.536138554533, 11737.237079589799, 11808.114391420506, 11832.290062596272, 501317.0, 514424.0, 534491.0, 537490.0, 543076.0, 98354.50822745984, 101418.49290753646, 102737.48631256795, 105513.0, 107502.46248768707, 1231.6181983585118, 1266.2845492297006, 1315.4606611289325, 1319.7954317080676, 1321.2138777427415, 20527.4868128292, 20642.27752028672, 21239.8938005309, 21348.466288342916, 21348.679769803155, 46217.0, 46475.0, 47027.4161617367, 47087.293690593986, 47230.291545626154, 58310.12534811896, 59337.14308569929, 59778.0, 60465.0, 61915.0, 9692.0, 9771.511424428609, 9810.460424676712, 9854.655087071918, 9860.556274967501, 14629.926850366106, 14759.553885513065, 15372.538823835303, 15871.365145394055, 16392.590185245463, 13368.264745439094, 13464.326783660581, 13682.52111176104, 13918.652033698834, 14172.29138543048, 12344.259344439362, 12727.74544509086, 12759.872401275868, 12909.096363254483, 13447.731045379232, 13746.65633359134, 13970.860291396955, 13995.930020349833, 14302.57092287233, 14330.21183834899, 9845.655402060893, 9942.602295908371, 10072.647457338959, 10102.0, 10239.385636861813, 13509.662258443617, 13689.247091410069, 13774.104683195561, 13785.172889626654, 14158.575242742734], "value": 10521.152960890187, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1367.5897230830751, 1397.210576024546, 1400.376832309622, 1405.7961595568636, 1420.8437071922087, 11539.192256542035, 12035.217710848789, 12045.518179272829, 12046.698832529191, 12263.693407664812, 11826.7634647307, 11982.880171198285, 11991.400429978488, 12057.216280941733, 12090.03279737621, 2473.1714875516677, 2483.85096894186, 2506.5613517634433, 2520.9117680881172, 2524.066095544651, 2335.9532809343887, 2430.283066495388, 2434.3670645632087, 2438.7561243875557, 2438.878056097197, 2264.230161745006, 2279.6124658807958, 2307.5500277445904, 2313.363824948144, 2323.105604342332, 2192.199847055829, 2213.6679498075255, 2244.9775502244934, 2250.7411647660565, 2277.202978957368, 2045.6215600114026, 2129.542148438093, 2259.3109101723967, 2273.079402841852, 2330.1262026739973, 11572.363520006396, 11723.237989530653, 11724.941375293154, 11754.0, 11769.352685602289, 6206.906896396557, 6423.8394040148905, 6430.488835123742, 6452.128962590037, 6475.643839588821, 3752.2683076800035, 4019.77891215983, 4088.8160032798596, 4113.835446582163, 4121.91756164878, 1343.9529616463474, 1349.5411560069526, 1395.4906459142442, 1434.9497767578189, 1450.4633285684365, 17950.19224134917, 18213.180406881722, 18245.817541824545, 18256.0, 18311.72532412015, 5244.895102097937, 5396.1494364121245, 5474.425185355481, 5527.115661494222, 5563.0, 12689.048321375934, 12772.680682983, 12778.297193654438, 12831.35843207836, 12849.807252891214, 6613.338666133348, 6626.56927299724, 6634.933650663528, 6635.469162466991, 6650.767223147167, 6018.307894592091, 6061.272647282354, 6070.969645151746, 6145.508359331243, 6159.384061593805, 4297.59172878576, 4336.392904993303, 4396.956030439718, 4441.333799930037, 4446.82212711488, 1209.6915286601861, 1236.145781328008, 1236.9072319576069, 1237.3380241570896, 1245.862955074941, 837.3092198935902, 858.5020688001069, 861.4917198852708, 882.7219425880827, 900.1403659505157, 6299.716512756937, 6346.333634968354, 6404.903926441107, 6479.967600161969, 6525.140335004596, 626.8056902360283, 631.1731631562668, 992.270681049428, 995.1143482300758, 1005.1807776661997, 4531.524189960007, 4588.931166032512, 4800.039992001613, 4976.328195693607, 5362.490563396471, 15384.769228461582, 15499.147546884804, 15910.522684319489, 15924.840751592335, 15945.920270398807, 15297.847021529866, 15602.921985390001, 15770.605734856721, 15777.68444631124, 15821.525354239391, 9338.252939764803, 9459.810803784023, 9561.378510396802, 9630.422174669542, 9699.369540979813, 6970.756023539152, 7367.115946086504, 7524.473286869867, 7576.962115189609, 7589.43079269046, 13410.061295709596, 13556.322183890568, 13785.379657915217, 13867.0, 14072.718545629235, 13891.861081389057, 13969.511067112602, 14039.649008774863, 14202.573922782332, 14450.277486125442, 9325.30060245498, 9504.42973421597, 9560.139587437165, 9561.61753529851, 9624.711258662252, 11156.10751139923, 11158.442077896236, 11223.102151827998, 11284.09727221804, 11317.773644527228, 9106.908930910871, 9114.316426267924, 9193.080691930754, 9248.0, 9326.253899688145, 8869.955650221707, 9124.31567632417, 9125.133112354315, 9368.625254989724, 9465.432074075577, 8019.398545109024, 8140.75577732669, 8172.632231549714, 8198.098209196864, 8218.547979861165, 6109.938900611115, 6205.937940620716, 6285.43431091204, 6289.213848268966, 6290.559660823881, 5999.340072592098, 6112.083187521907, 6255.781047663492, 6289.874202516015, 6322.36776322364], "value": 5463.152855075229, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [418.9958100418996, 420.4828061484374, 422.9619334259916, 424.08609446642487, 434.06675647358156, 5993.340732519419, 6128.785492507763, 6162.907556386658, 6167.105769663402, 6182.165407669963, 5920.171176035358, 5939.227900372956, 5997.640141591508, 6032.909506357408, 6062.9090563641585, 4484.66365022623, 4558.407407037081, 4579.725216487005, 4588.187665871978, 4591.163534586159, 4575.542445755431, 4591.6097131743845, 4602.815887364518, 4605.608523275526, 4614.238650622643, 4539.909201815962, 4562.908741825161, 4563.2926896330955, 4570.223062079454, 4571.588557029867, 4408.867733967986, 4513.871532116971, 4553.4991150973365, 4563.95436045642, 4574.473935497427, 3959.940600890989, 3966.5438474575503, 3967.900802479961, 3971.0, 3980.7611543307203, 5897.2038774765715, 5904.793332233351, 5934.851628709273, 5947.1376650385455, 5951.3751056139345, 5218.321083636066, 5362.490563396471, 5399.271098401744, 5403.675779453245, 5431.918521222185, 6429.967850160766, 6433.7426502939825, 6435.871282574322, 6440.4525615322755, 6446.806595802133, 4373.606375426227, 4448.399466072071, 4449.132419178261, 4453.064856380164, 4462.152191083716, 6474.967625161891, 6623.701933413008, 6725.19297684281, 6758.357955994222, 6758.526903116784, 4545.272756358967, 4563.817447302071, 4577.244754615518, 4587.128445595326, 4592.816287348469, 4609.469910960215, 4611.377464042378, 4612.285095810088, 4626.7223966562115, 4652.488226295105, 5261.657992230493, 5338.54622357104, 5372.1941708744, 5377.435369286247, 5385.8114965976, 6393.6163830170335, 6406.0, 6432.71052802625, 6445.9355406446275, 6452.483261716723, 1570.1991984088197, 1589.6502769390715, 1590.801149856268, 1600.391851096599, 1607.429362576292, 1026.97432564185, 1038.9532471038822, 1074.188987314588, 1077.1329080090602, 1081.3079629037422, 6093.29927058394, 6105.297890742621, 6112.72492737819, 6123.663198524124, 6139.723712432862, 6533.901991470132, 6643.10318107059, 6698.799036028927, 6712.0, 6729.49528785343, 6019.247594050744, 6091.48222401092, 6098.847528811815, 6099.512039036867, 6112.908306375408, 3407.9488807667904, 3457.3085382923514, 3505.4216054351255, 3521.4189658706537, 3527.8236088195486, 6821.590704557742, 6873.965630171917, 6881.174259088842, 6953.408960238336, 6970.233274339818, 6744.966275168691, 6753.636227320497, 6767.0, 6783.186017677812, 6821.795346139624, 6719.664016799141, 6949.687264073129, 6963.199232088274, 7003.719851205895, 7015.088038555057, 6668.699908504226, 6701.229358623821, 6709.7651582194385, 6711.563748356341, 6713.56361836479, 6411.134496843053, 6475.805725828232, 6548.3124271952665, 6611.925454663605, 6615.636140012345, 6928.896066558905, 6958.617276049866, 6980.406665433495, 6990.161180658353, 7019.3682568569075, 4546.976930190681, 4558.293464513005, 4560.863174104782, 4579.335996280587, 4581.198290299251, 6592.934070659232, 6594.736210551524, 6632.403083722488, 6676.49926255523, 6682.832929176615, 6418.0, 6468.708908099241, 6476.740930362921, 6482.319356467503, 6495.480361571157, 6359.96820015897, 6367.490600752021, 6425.742970281323, 6484.643344615903, 6503.2196136462035, 6453.645049522322, 6458.709358078804, 6481.254655714653, 6499.350064993463, 6514.348565143448, 6393.8721225576155, 6417.48660107181, 6432.710528026157, 6518.934810651833, 6540.476761859135, 6294.402031806971, 6318.336574659595, 6321.683915804099, 6331.430171284423, 6350.237971443456], "value": 4870.658344875333, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [817.0522194254662, 827.2472050434098, 855.3413871319084, 872.3021582733813, 890.1943740914472, 16776.1611919404, 17386.13069346534, 17389.04360260187, 19909.701354479694, 20443.284485043027, 18420.53948651281, 18688.906555467205, 18786.154623041963, 18965.715514267296, 19192.0, 1004.1464754958264, 1004.7186787699437, 1009.8737657792776, 1010.3382284603559, 1010.656376831877, 988.41189492252, 989.376692683612, 995.4326034160531, 997.9451130187837, 1013.0983424751977, 1051.8001579699833, 1065.323519565078, 1074.457399013497, 1079.6868908016666, 1080.168270431767, 994.4182653147917, 1068.775557133003, 1072.8873468285797, 1073.3023534702468, 1076.9138468922467, 759.2597217712741, 762.4205603741196, 764.7973287078928, 768.3852917665901, 768.9961550192269, 17683.0, 17809.0, 17833.375831845824, 17849.10754462272, 17867.1959761811, 18635.813641863544, 18681.53296167593, 19066.237350505962, 19072.904635476734, 19360.903195483934, 13798.793018104736, 13869.0, 13888.722225555432, 14478.420863165566, 14904.701905961929, 3568.50040994261, 3569.6965757910607, 3574.374484465234, 3590.335787879251, 3591.694705949971, 66061.66969165123, 87173.0, 88137.0, 88256.55871720664, 88965.0, 11533.480993355319, 14752.188629625474, 14763.483278085216, 15001.399944002118, 15055.171965541782, 25298.74701252964, 25793.87103064473, 26037.73962260353, 27327.180184594494, 27369.0, 8110.83778324442, 8202.179782021869, 8333.458325208841, 8403.15968403167, 8563.743087707378, 3879.4568760373572, 3923.136909879822, 3927.7250592458254, 3939.0940083780893, 3963.2073585282483, 4455.5098939117315, 4536.092781443725, 4538.909221815546, 4564.475085365159, 4629.953700462952, 863.0808189278524, 876.9517676527852, 897.9506127162938, 898.2903506230135, 900.7162743735702, 668.4151367553391, 703.9929600703928, 707.7770502291864, 721.3471808013755, 723.5043994863536, 11650.6504804856, 12009.579664711693, 12424.0, 13377.130486518345, 13382.063255572017, 690.4545409126835, 701.4073108223542, 706.7632343165097, 721.5742711800063, 739.5783314439573, 5372.489613486712, 5886.499647530008, 5892.941070589325, 5899.115132730125, 5924.911126333022, 80333.59833200797, 81825.59087204645, 84629.15370846212, 85728.14271857326, 87025.0, 69167.04142307541, 72581.6370918142, 73710.0, 73906.0, 74603.62698186474, 60586.39413605807, 62637.68681156565, 62965.68517157385, 63968.36031639717, 64906.35093649098, 12742.808857866954, 12747.362631868555, 12807.61577152687, 12846.550370737354, 12859.421326040163, 34895.47656785201, 35317.29365412729, 35733.28533429265, 35812.64187358093, 36273.0, 41608.167836643705, 42519.0, 42747.0, 43464.34803477887, 44180.337294941244, 15439.0, 15839.366425342858, 15911.840881591035, 15947.202639867728, 16044.117573533567, 18342.266309347477, 18545.35091271799, 18652.906735466237, 19142.904285479042, 19379.0, 17049.232784524476, 17347.045912474936, 17425.47723568295, 17492.73760893613, 18062.458126256235, 16403.17984100814, 16426.75359869627, 16488.587785305463, 16708.331666733193, 17059.0, 16810.075445850594, 16943.0, 16970.830291696926, 17129.143542823058, 17266.568335791704, 12216.511339546318, 12236.265824050586, 12486.875131248935, 12504.687382815502, 12727.0, 14081.788773168615, 14117.43530258778, 14315.642108947359, 14330.498432555227, 14356.0], "value": 8317.123273785766, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1496.1000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 112.0, 115.0, 108.0, 111.0, 110.0, 110.0, 109.0, 110.0, 110.0], "value": 109.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 128.0, 126.0, 165.0, 120.0, 121.0, 122.0, 122.0, 145.0, 120.0], "value": 131.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 164.0, 166.0, 163.0, 163.0, 163.0, 164.0, 165.0, 167.0, 168.0], "value": 164.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 78.0, 76.0, 97.0, 76.0, 75.0, 74.0, 75.0, 96.0, 74.0], "value": 80.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 100.0, 83.0, 80.0, 82.0, 95.0, 82.0, 82.0, 99.0], "value": 86.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 115.0, 115.0, 113.0, 114.0, 115.0, 113.0, 113.0, 114.0, 114.0], "value": 114.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 150.0, 149.0, 149.0, 148.0, 148.0, 148.0, 149.0, 149.0, 148.0], "value": 148.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 96.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [47.0, 48.0, 46.0, 47.0, 47.0, 48.0, 49.0, 51.0, 47.0, 47.0], "value": 47.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 55.0, 56.0, 57.0, 55.0, 56.0, 56.0, 56.0, 56.0, 56.0], "value": 55.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 78.0, 79.0, 81.0, 78.0, 80.0, 78.0, 87.0, 79.0, 79.0], "value": 80.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 129.0, 129.0, 122.0, 125.0, 126.0, 128.0, 127.0, 179.0, 126.0], "value": 132.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [180.0, 184.0, 182.0, 180.0, 181.0, 187.0, 180.0, 183.0, 184.0, 186.0], "value": 182.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 65.0, 66.0, 66.0, 66.0, 69.0, 67.0, 64.0, 66.0], "value": 66.4, "unit": "score"}]}]} 18:59:59 INFO - Return code: 0 18:59:59 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:59:59 INFO - # TBPL SUCCESS # 18:59:59 INFO - Running post-action listener: _resource_record_post_action 18:59:59 INFO - [mozharness: 2017-05-12 01:59:59.878063Z] Finished run-tests step (success) 18:59:59 INFO - Running post-run listener: _resource_record_post_run 18:59:59 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 4096; Write bytes: 380801024; Read time: 16; Write time: 281260 18:59:59 INFO - TinderboxPrint: CPU usage
13.2% 18:59:59 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 18:59:59 INFO - TinderboxPrint: I/O write bytes / time
380,801,024 / 281,260 18:59:59 INFO - TinderboxPrint: CPU idle
8,240.6 (86.8%) 18:59:59 INFO - TinderboxPrint: CPU user
1,199.3 (12.6%) 18:59:59 INFO - TinderboxPrint: Swap in / out
0 / 0 18:59:59 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 111910912; Read time: 0; Write time: 125296 18:59:59 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 0; Write bytes: 268337152; Read time: 0; Write time: 155936 19:00:00 INFO - Running post-run listener: _upload_blobber_files 19:00:00 INFO - Blob upload gear active. 19:00:00 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:00:00 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 19:00:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 19:00:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 19:00:00 INFO - (blobuploader) - INFO - Open directory for files ... 19:00:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 19:00:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:00:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:00:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 19:00:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:00:01 INFO - (blobuploader) - INFO - Done attempting. 19:00:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 19:00:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:00:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:00:03 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 19:00:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:00:03 INFO - (blobuploader) - INFO - Done attempting. 19:00:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:00:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:00:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:00:06 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:00:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:00:06 INFO - (blobuploader) - INFO - Done attempting. 19:00:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 19:00:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:00:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:00:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 19:00:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:00:07 INFO - (blobuploader) - INFO - Done attempting. 19:00:07 INFO - (blobuploader) - INFO - Iteration through files over. 19:00:07 INFO - Return code: 0 19:00:07 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:00:07 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:00:07 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/21e3dc771454ab514b6c357a6cc1972aa4080b141aa1f5cfe0317372fb5c731f25be3e2a25780b5d0eaff4e4c03bbeb50f3891c2c8dc5606d1da3468932d57a1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8c9dd0bd9d01a5e2020875cda4bc432a1ea52448ad22882e4d401a2b1bac7505a31f6d6ef8671743dfd0b77679c4df162c12665fb7c9bad027a66b59efac5c26", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4b0dd9c4f61ac7acd5c90fb72b3d87ac56cfedef264522b6a5a497e5f103ceb4ef01ace75feb28890bfd6c665abb9f464a4df42e228a35c693e56737251ef8e9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/18b0eb3ad450b25c95228162d69ed00735ecefbd15db6710cf4b9fb82e4c834b0edef3b33221a07484bef2dde246481ac87b12b6e715a41f10e13b848c9486df"} 19:00:07 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:00:07 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:00:07 INFO - Contents: 19:00:07 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/21e3dc771454ab514b6c357a6cc1972aa4080b141aa1f5cfe0317372fb5c731f25be3e2a25780b5d0eaff4e4c03bbeb50f3891c2c8dc5606d1da3468932d57a1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8c9dd0bd9d01a5e2020875cda4bc432a1ea52448ad22882e4d401a2b1bac7505a31f6d6ef8671743dfd0b77679c4df162c12665fb7c9bad027a66b59efac5c26", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4b0dd9c4f61ac7acd5c90fb72b3d87ac56cfedef264522b6a5a497e5f103ceb4ef01ace75feb28890bfd6c665abb9f464a4df42e228a35c693e56737251ef8e9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/18b0eb3ad450b25c95228162d69ed00735ecefbd15db6710cf4b9fb82e4c834b0edef3b33221a07484bef2dde246481ac87b12b6e715a41f10e13b848c9486df"} 19:00:07 INFO - Running post-run listener: copy_logs_to_upload_dir 19:00:07 INFO - Copying logs to upload dir... 19:00:07 INFO - mkdir: /builds/slave/test/build/upload/logs 19:00:07 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1244.430328 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2017-05-11 19:00:06.938497) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-11 19:00:06.942805) ========= 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=337fe3f4b1febe37b85fccc40000019e-1494553160.648458-1493621536 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/21e3dc771454ab514b6c357a6cc1972aa4080b141aa1f5cfe0317372fb5c731f25be3e2a25780b5d0eaff4e4c03bbeb50f3891c2c8dc5606d1da3468932d57a1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8c9dd0bd9d01a5e2020875cda4bc432a1ea52448ad22882e4d401a2b1bac7505a31f6d6ef8671743dfd0b77679c4df162c12665fb7c9bad027a66b59efac5c26", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4b0dd9c4f61ac7acd5c90fb72b3d87ac56cfedef264522b6a5a497e5f103ceb4ef01ace75feb28890bfd6c665abb9f464a4df42e228a35c693e56737251ef8e9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/18b0eb3ad450b25c95228162d69ed00735ecefbd15db6710cf4b9fb82e4c834b0edef3b33221a07484bef2dde246481ac87b12b6e715a41f10e13b848c9486df"} build_url:https://queue.taskcluster.net/v1/task/ciflkEnOT-KA2bdcDyiU1w/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011260 build_url: 'https://queue.taskcluster.net/v1/task/ciflkEnOT-KA2bdcDyiU1w/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/21e3dc771454ab514b6c357a6cc1972aa4080b141aa1f5cfe0317372fb5c731f25be3e2a25780b5d0eaff4e4c03bbeb50f3891c2c8dc5606d1da3468932d57a1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8c9dd0bd9d01a5e2020875cda4bc432a1ea52448ad22882e4d401a2b1bac7505a31f6d6ef8671743dfd0b77679c4df162c12665fb7c9bad027a66b59efac5c26", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4b0dd9c4f61ac7acd5c90fb72b3d87ac56cfedef264522b6a5a497e5f103ceb4ef01ace75feb28890bfd6c665abb9f464a4df42e228a35c693e56737251ef8e9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/18b0eb3ad450b25c95228162d69ed00735ecefbd15db6710cf4b9fb82e4c834b0edef3b33221a07484bef2dde246481ac87b12b6e715a41f10e13b848c9486df"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-11 19:00:06.976276) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-11 19:00:06.982746) ========= 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=337fe3f4b1febe37b85fccc40000019e-1494553160.648458-1493621536 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004450 ========= master_lag: 0.07 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-11 19:00:07.060244) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-11 19:00:07.060576) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-11 19:00:07.060891) ========= ========= Total master_lag: 0.21 =========