builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-005 starttime: 1494595768.03 results: success (0) revision: 1178b701781de2b1a5afb7b7d6b4954a3a7a51ba ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-12 06:29:28.028177) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-12 06:29:28.028663) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-12 06:29:28.028943) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-12 06:29:28.044720) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-12 06:29:28.045080) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1494595767.231991-1047568226 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-12 06:29:28-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 228M=0s 2017-05-12 06:29:28 (228 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.402581 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-12 06:29:28.470257) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-12 06:29:28.473775) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1494595767.231991-1047568226 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.012705 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-12 06:29:28.526502) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-12 06:29:28.526917) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 1178b701781de2b1a5afb7b7d6b4954a3a7a51ba --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 1178b701781de2b1a5afb7b7d6b4954a3a7a51ba --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=7fc86f70bae03e018da0b1d8000001c4-1494595767.231991-1047568226 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-12 06:29:29,009 truncating revision to first 12 chars 2017-05-12 06:29:29,009 Setting DEBUG logging. 2017-05-12 06:29:29,009 attempt 1/10 2017-05-12 06:29:29,009 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/1178b701781d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-12 06:29:29,407 unpacking tar archive at: mozilla-central-1178b701781d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.690744 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-12 06:29:29.231356) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-12 06:29:29.234868) ========= script_repo_revision: 1178b701781de2b1a5afb7b7d6b4954a3a7a51ba ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-12 06:29:29.235376) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-12 06:29:29.235666) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-12 06:29:29.246861) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2017-05-12 06:29:29.247289) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=7fc86f70bae03e018da0b1d8000001c4-1494595767.231991-1047568226 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:29:29 INFO - MultiFileLogger online at 20170512 06:29:29 in /builds/slave/test 06:29:29 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 06:29:29 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:29:29 INFO - {'append_to_log': False, 06:29:29 INFO - 'base_work_dir': '/builds/slave/test', 06:29:29 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 06:29:29 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:29:29 INFO - 'branch': 'Firefox-Non-PGO', 06:29:29 INFO - 'buildbot_json_path': 'buildprops.json', 06:29:29 INFO - 'config_files': ('talos/linux_config.py',), 06:29:29 INFO - 'default_actions': ('clobber', 06:29:29 INFO - 'read-buildbot-config', 06:29:29 INFO - 'download-and-extract', 06:29:29 INFO - 'populate-webroot', 06:29:29 INFO - 'create-virtualenv', 06:29:29 INFO - 'install', 06:29:29 INFO - 'run-tests'), 06:29:29 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:29:29 INFO - 'download_minidump_stackwalk': True, 06:29:29 INFO - 'download_symbols': 'ondemand', 06:29:29 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:29:29 INFO - 'tooltool.py': '/tools/tooltool.py', 06:29:29 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:29:29 INFO - '/tools/misc-python/virtualenv.py')}, 06:29:29 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:29:29 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:29:29 INFO - 'gecko_profile': False, 06:29:29 INFO - 'gecko_profile_interval': 0, 06:29:29 INFO - 'installer_path': 'installer.exe', 06:29:29 INFO - 'log_level': 'info', 06:29:29 INFO - 'log_name': 'talos', 06:29:29 INFO - 'log_to_console': True, 06:29:29 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:29:29 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:29:29 INFO - 'opt_config_files': (), 06:29:29 INFO - 'pip_index': False, 06:29:29 INFO - 'suite': 'dromaeojs-e10s', 06:29:29 INFO - 'system_bits': '32', 06:29:29 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:29:29 INFO - 'title': 'talos-linux64-ix-005', 06:29:29 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:29:29 INFO - 'use_talos_json': True, 06:29:29 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:29:29 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:29:29 INFO - 'work_dir': 'build'} 06:29:29 INFO - [mozharness: 2017-05-12 13:29:29.936220Z] Running clobber step. 06:29:29 INFO - Running pre-action listener: _resource_record_pre_action 06:29:29 INFO - Running main action method: clobber 06:29:29 INFO - rmtree: /builds/slave/test/build 06:29:29 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:29:30 INFO - Running post-action listener: _resource_record_post_action 06:29:30 INFO - [mozharness: 2017-05-12 13:29:30.843227Z] Finished clobber step (success) 06:29:30 INFO - [mozharness: 2017-05-12 13:29:30.843327Z] Running read-buildbot-config step. 06:29:30 INFO - Running pre-action listener: _resource_record_pre_action 06:29:30 INFO - Running main action method: read_buildbot_config 06:29:30 INFO - Using buildbot properties: 06:29:30 INFO - { 06:29:30 INFO - "project": "", 06:29:30 INFO - "product": "firefox", 06:29:30 INFO - "who": "florian@queze.net", 06:29:30 INFO - "installer_path": "public/build/target.tar.bz2", 06:29:30 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 06:29:30 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 06:29:30 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 06:29:30 INFO - "stage_platform": "linux64", 06:29:30 INFO - "basedir": "/builds/slave/test", 06:29:30 INFO - "buildnumber": 598, 06:29:30 INFO - "platform": "ubuntu64_hw", 06:29:30 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 06:29:30 INFO - "slavebuilddir": "test", 06:29:30 INFO - "taskId": "d3XPswHfTKu9ot8FDWFKTA", 06:29:30 INFO - "branch": "mozilla-central", 06:29:30 INFO - "script_repo_revision": "production", 06:29:30 INFO - "revision": "1178b701781de2b1a5afb7b7d6b4954a3a7a51ba", 06:29:30 INFO - "slavename": "talos-linux64-ix-005", 06:29:30 INFO - "repo_path": "mozilla-central" 06:29:30 INFO - } 06:29:30 INFO - Finding installer, test and symbols from parent task. 06:29:30 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/d3XPswHfTKu9ot8FDWFKTA'}, attempt #1 06:29:31 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/d3XPswHfTKu9ot8FDWFKTA'}, attempt #1 06:29:31 INFO - Task dependencies: Nexm6u4PQnSQIB9strk64w 06:29:31 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Nexm6u4PQnSQIB9strk64w'}, attempt #1 06:29:32 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/Nexm6u4PQnSQIB9strk64w/artifacts/public/build/target.tar.bz2 06:29:32 INFO - Set test_url: https://queue.taskcluster.net/v1/task/Nexm6u4PQnSQIB9strk64w/artifacts/public/build/test_packages.json 06:29:32 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/Nexm6u4PQnSQIB9strk64w/artifacts/public/build/target.crashreporter-symbols.zip 06:29:32 INFO - Running post-action listener: _resource_record_post_action 06:29:32 INFO - [mozharness: 2017-05-12 13:29:32.206647Z] Finished read-buildbot-config step (success) 06:29:32 INFO - [mozharness: 2017-05-12 13:29:32.206952Z] Running download-and-extract step. 06:29:32 INFO - Running pre-action listener: _resource_record_pre_action 06:29:32 INFO - Running main action method: download_and_extract 06:29:32 INFO - mkdir: /builds/slave/test/build/tests 06:29:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:29:32 INFO - trying https://queue.taskcluster.net/v1/task/Nexm6u4PQnSQIB9strk64w/artifacts/public/build/target.test_packages.json 06:29:32 INFO - Downloading https://queue.taskcluster.net/v1/task/Nexm6u4PQnSQIB9strk64w/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 06:29:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Nexm6u4PQnSQIB9strk64w/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 06:29:32 INFO - Downloaded 986 bytes. 06:29:32 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 06:29:32 INFO - Using the following test package requirements: 06:29:32 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 06:29:32 INFO - u'common': [u'target.common.tests.zip'], 06:29:32 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 06:29:32 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 06:29:32 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 06:29:32 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 06:29:32 INFO - u'mozbase': [u'target.common.tests.zip'], 06:29:32 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 06:29:32 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 06:29:32 INFO - u'web-platform': [u'target.common.tests.zip', 06:29:32 INFO - u'target.web-platform.tests.zip'], 06:29:32 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 06:29:32 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 06:29:32 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Nexm6u4PQnSQIB9strk64w/artifacts/public/build/target.common.tests.zip 06:29:32 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Nexm6u4PQnSQIB9strk64w/artifacts/public/build/target.common.tests.zip'}, attempt #1 06:29:32 INFO - Fetch https://queue.taskcluster.net/v1/task/Nexm6u4PQnSQIB9strk64w/artifacts/public/build/target.common.tests.zip into memory 06:29:34 INFO - Content-Length response header: 62450430 06:29:34 INFO - Bytes received: 62450430 06:29:44 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 06:29:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Nexm6u4PQnSQIB9strk64w/artifacts/public/build/target.common.tests.zip 06:29:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Nexm6u4PQnSQIB9strk64w/artifacts/public/build/target.common.tests.zip'}, attempt #1 06:29:44 INFO - Fetch https://queue.taskcluster.net/v1/task/Nexm6u4PQnSQIB9strk64w/artifacts/public/build/target.common.tests.zip into memory 06:29:45 INFO - Content-Length response header: 62450430 06:29:45 INFO - Bytes received: 62450430 06:29:58 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Nexm6u4PQnSQIB9strk64w/artifacts/public/build/target.talos.tests.zip 06:29:58 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Nexm6u4PQnSQIB9strk64w/artifacts/public/build/target.talos.tests.zip'}, attempt #1 06:29:58 INFO - Fetch https://queue.taskcluster.net/v1/task/Nexm6u4PQnSQIB9strk64w/artifacts/public/build/target.talos.tests.zip into memory 06:29:58 INFO - Content-Length response header: 14409411 06:29:58 INFO - Bytes received: 14409411 06:29: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')]} 06:29:59 INFO - trying https://queue.taskcluster.net/v1/task/Nexm6u4PQnSQIB9strk64w/artifacts/public/build/target.tar.bz2 06:29:59 INFO - Downloading https://queue.taskcluster.net/v1/task/Nexm6u4PQnSQIB9strk64w/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 06:29:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Nexm6u4PQnSQIB9strk64w/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 06:30:00 INFO - Downloaded 63467124 bytes. 06:30:00 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Nexm6u4PQnSQIB9strk64w/artifacts/public/build/target.tar.bz2 06:30:00 INFO - mkdir: /builds/slave/test/properties 06:30:00 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:30:00 INFO - Writing to file /builds/slave/test/properties/build_url 06:30:00 INFO - Contents: 06:30:00 INFO - build_url:https://queue.taskcluster.net/v1/task/Nexm6u4PQnSQIB9strk64w/artifacts/public/build/target.tar.bz2 06:30:00 INFO - Running post-action listener: _resource_record_post_action 06:30:00 INFO - Running post-action listener: set_extra_try_arguments 06:30:00 INFO - [mozharness: 2017-05-12 13:30:00.179539Z] Finished download-and-extract step (success) 06:30:00 INFO - [mozharness: 2017-05-12 13:30:00.179637Z] Running populate-webroot step. 06:30:00 INFO - Running pre-action listener: _resource_record_pre_action 06:30:00 INFO - Running main action method: populate_webroot 06:30:00 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:30:00 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:30:00 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:30:00 INFO - '--tppagecycles', 06:30:00 INFO - '7'], 06:30:00 INFO - 'tests': ['tsvgm']}}, 06:30:00 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:30:00 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:30:00 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:30:00 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:30:00 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:30:00 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:30:00 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 06:30:00 INFO - 'talos_options': ['--disable-e10s'], 06:30:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:30:00 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 06:30:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:30:00 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 06:30:00 INFO - 'talos_options': ['--disable-e10s'], 06:30:00 INFO - 'tests': ['damp', 'tps']}, 06:30:00 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 06:30:00 INFO - 'tests': ['damp', 'tps']}, 06:30:00 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:30:00 INFO - 'tests': ['dromaeo_dom']}, 06:30:00 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:30:00 INFO - 'g4': {'talos_options': ['--disable-e10s'], 06:30:00 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 06:30:00 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 06:30:00 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:30:00 INFO - 'tests': ['a11yr', 06:30:00 INFO - 'ts_paint', 06:30:00 INFO - 'tpaint', 06:30:00 INFO - 'sessionrestore', 06:30:00 INFO - 'sessionrestore_no_auto_restore', 06:30:00 INFO - 'tabpaint']}, 06:30:00 INFO - 'other-e10s': {'tests': ['a11yr', 06:30:00 INFO - 'ts_paint', 06:30:00 INFO - 'tpaint', 06:30:00 INFO - 'sessionrestore', 06:30:00 INFO - 'sessionrestore_no_auto_restore', 06:30:00 INFO - 'tabpaint']}, 06:30:00 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:30:00 INFO - 'ts_paint', 06:30:00 INFO - 'tpaint', 06:30:00 INFO - 'sessionrestore', 06:30:00 INFO - 'sessionrestore_no_auto_restore', 06:30:00 INFO - 'tabpaint']}, 06:30:00 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:30:00 INFO - 'ts_paint', 06:30:00 INFO - 'tpaint', 06:30:00 INFO - 'sessionrestore', 06:30:00 INFO - 'sessionrestore_no_auto_restore', 06:30:00 INFO - 'tabpaint']}, 06:30:00 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:30:00 INFO - 'tests': ['a11yr', 06:30:00 INFO - 'ts_paint', 06:30:00 INFO - 'tpaint', 06:30:00 INFO - 'sessionrestore', 06:30:00 INFO - 'sessionrestore_no_auto_restore', 06:30:00 INFO - 'tabpaint']}, 06:30:00 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:30:00 INFO - 'tests': ['a11yr', 06:30:00 INFO - 'ts_paint', 06:30:00 INFO - 'tpaint', 06:30:00 INFO - 'sessionrestore', 06:30:00 INFO - 'sessionrestore_no_auto_restore', 06:30:00 INFO - 'tabpaint']}, 06:30:00 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 06:30:00 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 06:30:00 INFO - 'bloom_basic_ref']}, 06:30:00 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:30:00 INFO - 'tests': ['tsvgx', 06:30:00 INFO - 'tsvgr_opacity', 06:30:00 INFO - 'tart', 06:30:00 INFO - 'tscrollx', 06:30:00 INFO - 'cart', 06:30:00 INFO - 'tsvg_static']}, 06:30:00 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:30:00 INFO - 'tsvgr_opacity', 06:30:00 INFO - 'tart', 06:30:00 INFO - 'tscrollx', 06:30:00 INFO - 'cart', 06:30:00 INFO - 'tsvg_static']}, 06:30:00 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 06:30:00 INFO - 'talos_options': ['--disable-e10s'], 06:30:00 INFO - 'tests': ['tp5o']}, 06:30:00 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 06:30:00 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 06:30:00 INFO - 'talos_options': ['--disable-e10s', 06:30:00 INFO - '--xperf_path', 06:30:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:30:00 INFO - 'tests': ['tp5n']}, 06:30:00 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 06:30:00 INFO - 'talos_options': ['--xperf_path', 06:30:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:30:00 INFO - 'tests': ['tp5n']}}, 06:30:00 INFO - 'talos.zip': {'path': '', 06:30:00 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:30:00 INFO - Running post-action listener: _resource_record_post_action 06:30:00 INFO - [mozharness: 2017-05-12 13:30:00.193235Z] Finished populate-webroot step (success) 06:30:00 INFO - [mozharness: 2017-05-12 13:30:00.193336Z] Running create-virtualenv step. 06:30:00 INFO - Running pre-action listener: _resource_record_pre_action 06:30:00 INFO - Running main action method: create_virtualenv 06:30:00 INFO - Creating virtualenv /builds/slave/test/build/venv 06:30:00 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 06:30:00 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:30:00 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:30:00 INFO - Using real prefix '/usr' 06:30:00 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:30:00 INFO - Installing distribute.............................................................................................................................................................................................done. 06:30:02 INFO - Installing pip.................done. 06:30:02 INFO - Return code: 0 06:30:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 06:30:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 06:30:03 INFO - Reading from file tmpfile_stdout 06:30:03 INFO - Output received: 06:30:03 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 06:30:03 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:30:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:30:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:30:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:30:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:30:03 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 0x26ad1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2879a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a1f770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a1ca30>, '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 0x2a1d7f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a1dca0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1494595767.231991-1047568226', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:30:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 06:30:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 06:30:03 INFO - Using env: {'DISPLAY': ':0', 06:30:03 INFO - 'HOME': '/home/cltbld', 06:30:03 INFO - 'LANG': 'en_US.UTF-8', 06:30:03 INFO - 'LANGUAGE': 'en_US:en', 06:30:03 INFO - 'LOGNAME': 'cltbld', 06:30:03 INFO - 'MAIL': '/var/mail/cltbld', 06:30:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:30:03 INFO - 'MOZ_NO_REMOTE': '1', 06:30:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:30:03 INFO - 'NO_EM_RESTART': '1', 06:30:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:30:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:30:03 INFO - 'PWD': '/builds/slave/test', 06:30:03 INFO - 'SHELL': '/bin/bash', 06:30:03 INFO - 'SHLVL': '1', 06:30:03 INFO - 'TERM': 'linux', 06:30:03 INFO - 'TMOUT': '86400', 06:30:03 INFO - 'USER': 'cltbld', 06:30:03 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1494595767.231991-1047568226', 06:30:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:30:03 INFO - '_': '/tools/buildbot/bin/python'} 06:30:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:30:04 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 06:30:04 INFO - Cleaning up... 06:30:04 INFO - Return code: 0 06:30:04 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:30:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:30:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:30:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:30:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:30:04 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 0x26ad1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2879a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a1f770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a1ca30>, '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 0x2a1d7f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a1dca0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1494595767.231991-1047568226', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:30:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 06:30:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 06:30:04 INFO - Using env: {'DISPLAY': ':0', 06:30:04 INFO - 'HOME': '/home/cltbld', 06:30:04 INFO - 'LANG': 'en_US.UTF-8', 06:30:04 INFO - 'LANGUAGE': 'en_US:en', 06:30:04 INFO - 'LOGNAME': 'cltbld', 06:30:04 INFO - 'MAIL': '/var/mail/cltbld', 06:30:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:30:04 INFO - 'MOZ_NO_REMOTE': '1', 06:30:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:30:04 INFO - 'NO_EM_RESTART': '1', 06:30:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:30:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:30:04 INFO - 'PWD': '/builds/slave/test', 06:30:04 INFO - 'SHELL': '/bin/bash', 06:30:04 INFO - 'SHLVL': '1', 06:30:04 INFO - 'TERM': 'linux', 06:30:04 INFO - 'TMOUT': '86400', 06:30:04 INFO - 'USER': 'cltbld', 06:30:04 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1494595767.231991-1047568226', 06:30:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:30:04 INFO - '_': '/tools/buildbot/bin/python'} 06:30:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:30:04 INFO - Downloading/unpacking psutil>=3.1.1 06:30:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:30:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:30:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:30:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:30:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:30:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:30:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:30:05 INFO - Installing collected packages: psutil 06:30:05 INFO - Running setup.py install for psutil 06:30:05 INFO - building 'psutil._psutil_linux' extension 06:30:05 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 06:30:06 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 06:30:06 INFO - building 'psutil._psutil_posix' extension 06:30:06 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 06:30:06 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 06:30:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:30:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:30:07 INFO - Successfully installed psutil 06:30:07 INFO - Cleaning up... 06:30:07 INFO - Return code: 0 06:30:07 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:30:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:30:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:30:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:30:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:30:07 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 0x26ad1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2879a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a1f770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a1ca30>, '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 0x2a1d7f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a1dca0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1494595767.231991-1047568226', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:30:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 06:30:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 06:30:07 INFO - Using env: {'DISPLAY': ':0', 06:30:07 INFO - 'HOME': '/home/cltbld', 06:30:07 INFO - 'LANG': 'en_US.UTF-8', 06:30:07 INFO - 'LANGUAGE': 'en_US:en', 06:30:07 INFO - 'LOGNAME': 'cltbld', 06:30:07 INFO - 'MAIL': '/var/mail/cltbld', 06:30:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:30:07 INFO - 'MOZ_NO_REMOTE': '1', 06:30:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:30:07 INFO - 'NO_EM_RESTART': '1', 06:30:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:30:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:30:07 INFO - 'PWD': '/builds/slave/test', 06:30:07 INFO - 'SHELL': '/bin/bash', 06:30:07 INFO - 'SHLVL': '1', 06:30:07 INFO - 'TERM': 'linux', 06:30:07 INFO - 'TMOUT': '86400', 06:30:07 INFO - 'USER': 'cltbld', 06:30:07 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1494595767.231991-1047568226', 06:30:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:30:07 INFO - '_': '/tools/buildbot/bin/python'} 06:30:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:30:07 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:30:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:30:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:30:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:30:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:30:08 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:30:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:30:08 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:30:08 INFO - Installing collected packages: mozsystemmonitor 06:30:08 INFO - Running setup.py install for mozsystemmonitor 06:30:08 INFO - Successfully installed mozsystemmonitor 06:30:08 INFO - Cleaning up... 06:30:08 INFO - Return code: 0 06:30:08 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:30: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')]} 06:30:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:30: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')]} 06:30:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:30: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==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26ad1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2879a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a1f770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a1ca30>, '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 0x2a1d7f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a1dca0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1494595767.231991-1047568226', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:30: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==2.5.1'] in /builds/slave/test/build 06:30: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==2.5.1 06:30:08 INFO - Using env: {'DISPLAY': ':0', 06:30:08 INFO - 'HOME': '/home/cltbld', 06:30:08 INFO - 'LANG': 'en_US.UTF-8', 06:30:08 INFO - 'LANGUAGE': 'en_US:en', 06:30:08 INFO - 'LOGNAME': 'cltbld', 06:30:08 INFO - 'MAIL': '/var/mail/cltbld', 06:30:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:30:08 INFO - 'MOZ_NO_REMOTE': '1', 06:30:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:30:08 INFO - 'NO_EM_RESTART': '1', 06:30:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:30:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:30:08 INFO - 'PWD': '/builds/slave/test', 06:30:08 INFO - 'SHELL': '/bin/bash', 06:30:08 INFO - 'SHLVL': '1', 06:30:08 INFO - 'TERM': 'linux', 06:30:08 INFO - 'TMOUT': '86400', 06:30:08 INFO - 'USER': 'cltbld', 06:30:08 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1494595767.231991-1047568226', 06:30:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:30:08 INFO - '_': '/tools/buildbot/bin/python'} 06:30:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:30:08 INFO - Downloading/unpacking jsonschema==2.5.1 06:30:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:30:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:30:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:30:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:30:09 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:30:09 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:30:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:30:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:30:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:30:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:30:10 INFO - Downloading functools32-3.2.3-2.tar.gz 06:30:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:30:10 INFO - warning: no files found matching '*.txt' 06:30:10 INFO - no previously-included directories found matching 'build' 06:30:10 INFO - no previously-included directories found matching 'dist' 06:30:10 INFO - no previously-included directories found matching '.git*' 06:30:10 INFO - Installing collected packages: jsonschema, functools32 06:30:10 INFO - Running setup.py install for functools32 06:30:10 INFO - warning: no files found matching '*.txt' 06:30:10 INFO - no previously-included directories found matching 'build' 06:30:10 INFO - no previously-included directories found matching 'dist' 06:30:10 INFO - no previously-included directories found matching '.git*' 06:30:10 INFO - Successfully installed jsonschema functools32 06:30:10 INFO - Cleaning up... 06:30:10 INFO - Return code: 0 06:30:10 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 06:30:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:30:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:30:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:30:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:30:10 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 0x26ad1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2879a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a1f770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a1ca30>, '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 0x2a1d7f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a1dca0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1494595767.231991-1047568226', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:30:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 06:30:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 06:30:10 INFO - Using env: {'DISPLAY': ':0', 06:30:10 INFO - 'HOME': '/home/cltbld', 06:30:10 INFO - 'LANG': 'en_US.UTF-8', 06:30:10 INFO - 'LANGUAGE': 'en_US:en', 06:30:10 INFO - 'LOGNAME': 'cltbld', 06:30:10 INFO - 'MAIL': '/var/mail/cltbld', 06:30:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:30:10 INFO - 'MOZ_NO_REMOTE': '1', 06:30:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:30:10 INFO - 'NO_EM_RESTART': '1', 06:30:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:30:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:30:10 INFO - 'PWD': '/builds/slave/test', 06:30:10 INFO - 'SHELL': '/bin/bash', 06:30:10 INFO - 'SHLVL': '1', 06:30:10 INFO - 'TERM': 'linux', 06:30:10 INFO - 'TMOUT': '86400', 06:30:10 INFO - 'USER': 'cltbld', 06:30:10 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1494595767.231991-1047568226', 06:30:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:30:10 INFO - '_': '/tools/buildbot/bin/python'} 06:30:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:30:10 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 06:30:10 INFO - Cleaning up... 06:30:10 INFO - Return code: 0 06:30:10 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:30:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:30:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:30:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:30:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:30:10 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 0x26ad1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2879a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a1f770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a1ca30>, '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 0x2a1d7f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a1dca0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1494595767.231991-1047568226', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:30:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 06:30:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 06:30:10 INFO - Using env: {'DISPLAY': ':0', 06:30:10 INFO - 'HOME': '/home/cltbld', 06:30:10 INFO - 'LANG': 'en_US.UTF-8', 06:30:10 INFO - 'LANGUAGE': 'en_US:en', 06:30:10 INFO - 'LOGNAME': 'cltbld', 06:30:10 INFO - 'MAIL': '/var/mail/cltbld', 06:30:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:30:10 INFO - 'MOZ_NO_REMOTE': '1', 06:30:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:30:10 INFO - 'NO_EM_RESTART': '1', 06:30:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:30:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:30:10 INFO - 'PWD': '/builds/slave/test', 06:30:10 INFO - 'SHELL': '/bin/bash', 06:30:10 INFO - 'SHLVL': '1', 06:30:10 INFO - 'TERM': 'linux', 06:30:10 INFO - 'TMOUT': '86400', 06:30:10 INFO - 'USER': 'cltbld', 06:30:10 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1494595767.231991-1047568226', 06:30:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:30:10 INFO - '_': '/tools/buildbot/bin/python'} 06:30:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:30:10 INFO - Downloading/unpacking blobuploader==1.2.4 06:30:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:30:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:30:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:30:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:30:11 INFO - Downloading blobuploader-1.2.4.tar.gz 06:30:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:30:11 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:30:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:30:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:30:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:30:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:30:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:30:12 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:30:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:30:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:30:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:30:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:30:12 INFO - Downloading docopt-0.6.1.tar.gz 06:30:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:30:12 INFO - Installing collected packages: blobuploader, requests, docopt 06:30:12 INFO - Running setup.py install for blobuploader 06:30:12 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:30:12 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:30:12 INFO - Running setup.py install for requests 06:30:12 INFO - Running setup.py install for docopt 06:30:12 INFO - Successfully installed blobuploader requests docopt 06:30:12 INFO - Cleaning up... 06:30:12 INFO - Return code: 0 06:30:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:30:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:30:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:30:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:30:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:30:12 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 0x26ad1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2879a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a1f770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a1ca30>, '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 0x2a1d7f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a1dca0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1494595767.231991-1047568226', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:30:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 06:30:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:30:12 INFO - Using env: {'DISPLAY': ':0', 06:30:12 INFO - 'HOME': '/home/cltbld', 06:30:12 INFO - 'LANG': 'en_US.UTF-8', 06:30:12 INFO - 'LANGUAGE': 'en_US:en', 06:30:12 INFO - 'LOGNAME': 'cltbld', 06:30:12 INFO - 'MAIL': '/var/mail/cltbld', 06:30:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:30:12 INFO - 'MOZ_NO_REMOTE': '1', 06:30:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:30:12 INFO - 'NO_EM_RESTART': '1', 06:30:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:30:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:30:12 INFO - 'PWD': '/builds/slave/test', 06:30:12 INFO - 'SHELL': '/bin/bash', 06:30:12 INFO - 'SHLVL': '1', 06:30:12 INFO - 'TERM': 'linux', 06:30:12 INFO - 'TMOUT': '86400', 06:30:12 INFO - 'USER': 'cltbld', 06:30:12 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1494595767.231991-1047568226', 06:30:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:30:12 INFO - '_': '/tools/buildbot/bin/python'} 06:30:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:30:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:30:13 INFO - Running setup.py (path:/tmp/pip-PD8ALB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:30:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:30:13 INFO - Running setup.py (path:/tmp/pip-3KC0Wb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:30:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:30:13 INFO - Running setup.py (path:/tmp/pip-sou1Ox-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:30:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:30:13 INFO - Running setup.py (path:/tmp/pip-vYaetB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:30:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:30:13 INFO - Running setup.py (path:/tmp/pip-ZwQ6NI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:30:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:30:13 INFO - Running setup.py (path:/tmp/pip-03sVpY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:30:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:30:13 INFO - Running setup.py (path:/tmp/pip-faCrPU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:30:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:30:13 INFO - Running setup.py (path:/tmp/pip-FxqHFP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:30:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:30:13 INFO - Running setup.py (path:/tmp/pip-ilIZ8J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:30:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:30:13 INFO - Running setup.py (path:/tmp/pip-fXn1xx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:30:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:30:13 INFO - Running setup.py (path:/tmp/pip-EKZ2cC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:30:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:30:13 INFO - Running setup.py (path:/tmp/pip-mj8KL3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:30:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:30:14 INFO - Running setup.py (path:/tmp/pip-naRahk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:30:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:30:14 INFO - Running setup.py (path:/tmp/pip-grsan_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:30:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:30:14 INFO - Running setup.py (path:/tmp/pip-VC7IeP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:30:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:30:14 INFO - Running setup.py (path:/tmp/pip-KPFzJl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:30:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:30:14 INFO - Running setup.py (path:/tmp/pip-WOmxVr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:30:14 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:30:14 INFO - Running setup.py install for manifestparser 06:30:14 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:30:14 INFO - Running setup.py install for mozcrash 06:30:14 INFO - Running setup.py install for mozdebug 06:30:14 INFO - Running setup.py install for mozdevice 06:30:14 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:30:14 INFO - Running setup.py install for mozfile 06:30:14 INFO - Running setup.py install for mozhttpd 06:30:14 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:30:14 INFO - Running setup.py install for mozinfo 06:30:15 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:30:15 INFO - Running setup.py install for mozInstall 06:30:15 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:30:15 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:30:15 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:30:15 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:30:15 INFO - Running setup.py install for mozleak 06:30:15 INFO - Running setup.py install for mozlog 06:30:15 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:30:15 INFO - Running setup.py install for moznetwork 06:30:15 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:30:15 INFO - Running setup.py install for mozprocess 06:30:15 INFO - Running setup.py install for mozprofile 06:30:15 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:30:15 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:30:15 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:30:15 INFO - Running setup.py install for mozrunner 06:30:15 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:30:15 INFO - Running setup.py install for mozscreenshot 06:30:15 INFO - Running setup.py install for moztest 06:30:16 INFO - Running setup.py install for mozversion 06:30:16 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:30:16 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:30:16 INFO - Cleaning up... 06:30:16 INFO - Return code: 0 06:30:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:30:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:30:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:30:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:30:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:30:16 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 0x26ad1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2879a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a1f770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a1ca30>, '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 0x2a1d7f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a1dca0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1494595767.231991-1047568226', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:30:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 06:30:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:30:16 INFO - Using env: {'DISPLAY': ':0', 06:30:16 INFO - 'HOME': '/home/cltbld', 06:30:16 INFO - 'LANG': 'en_US.UTF-8', 06:30:16 INFO - 'LANGUAGE': 'en_US:en', 06:30:16 INFO - 'LOGNAME': 'cltbld', 06:30:16 INFO - 'MAIL': '/var/mail/cltbld', 06:30:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:30:16 INFO - 'MOZ_NO_REMOTE': '1', 06:30:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:30:16 INFO - 'NO_EM_RESTART': '1', 06:30:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:30:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:30:16 INFO - 'PWD': '/builds/slave/test', 06:30:16 INFO - 'SHELL': '/bin/bash', 06:30:16 INFO - 'SHLVL': '1', 06:30:16 INFO - 'TERM': 'linux', 06:30:16 INFO - 'TMOUT': '86400', 06:30:16 INFO - 'USER': 'cltbld', 06:30:16 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1494595767.231991-1047568226', 06:30:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:30:16 INFO - '_': '/tools/buildbot/bin/python'} 06:30:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:30:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:30:16 INFO - Running setup.py (path:/tmp/pip-yvf5hF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:30:16 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 06:30:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:30:16 INFO - Running setup.py (path:/tmp/pip-MQJhVX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:30:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:30:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:30:16 INFO - Running setup.py (path:/tmp/pip-meO3Yo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:30:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 06:30:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:30:16 INFO - Running setup.py (path:/tmp/pip-8C_KZQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:30:16 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)) 06:30:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:30:16 INFO - Running setup.py (path:/tmp/pip-wE849T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:30:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 06:30:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:30:16 INFO - Running setup.py (path:/tmp/pip-EyP3Ih-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:30:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 06:30:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:30:16 INFO - Running setup.py (path:/tmp/pip-lyT_0a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:30:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 06:30:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:30:16 INFO - Running setup.py (path:/tmp/pip-4NjUF_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:30:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 06:30:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:30:16 INFO - Running setup.py (path:/tmp/pip-CodNaA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:30:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 06:30:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:30:17 INFO - Running setup.py (path:/tmp/pip-xj0nXx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:30:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:30:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:30:17 INFO - Running setup.py (path:/tmp/pip-89gVOb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:30:17 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 06:30:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:30:17 INFO - Running setup.py (path:/tmp/pip-zuSbrH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:30:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 06:30:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:30:17 INFO - Running setup.py (path:/tmp/pip-keck2Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:30:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 06:30:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:30:17 INFO - Running setup.py (path:/tmp/pip-GXu4tX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:30:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 06:30:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:30:17 INFO - Running setup.py (path:/tmp/pip-bMeUYt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:30:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 06:30:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:30:17 INFO - Running setup.py (path:/tmp/pip-f2Z2AH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:30:17 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 06:30:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:30:17 INFO - Running setup.py (path:/tmp/pip-9A94sg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:30:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 06:30:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:30:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:30:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 06:30:17 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)) 06:30:17 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)) 06:30:17 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:30:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:30:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:30:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:30:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:30:18 INFO - Downloading blessings-1.6.tar.gz 06:30:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:30:18 INFO - Installing collected packages: blessings 06:30:18 INFO - Running setup.py install for blessings 06:30:18 INFO - Successfully installed blessings 06:30:18 INFO - Cleaning up... 06:30:18 INFO - Return code: 0 06:30:18 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:30:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:30:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:30:19 INFO - Reading from file tmpfile_stdout 06:30:19 INFO - Current package versions: 06:30:19 INFO - argparse == 1.2.1 06:30:19 INFO - blessings == 1.6 06:30:19 INFO - blobuploader == 1.2.4 06:30:19 INFO - docopt == 0.6.1 06:30:19 INFO - functools32 == 3.2.3-2 06:30:19 INFO - jsonschema == 2.5.1 06:30:19 INFO - manifestparser == 1.1 06:30:19 INFO - mozInstall == 1.12 06:30:19 INFO - mozcrash == 1.0 06:30:19 INFO - mozdebug == 0.1 06:30:19 INFO - mozdevice == 0.50 06:30:19 INFO - mozfile == 1.2 06:30:19 INFO - mozhttpd == 0.7 06:30:19 INFO - mozinfo == 0.9 06:30:19 INFO - mozleak == 0.1 06:30:19 INFO - mozlog == 3.4 06:30:19 INFO - moznetwork == 0.27 06:30:19 INFO - mozprocess == 0.25 06:30:19 INFO - mozprofile == 0.28 06:30:19 INFO - mozrunner == 6.13 06:30:19 INFO - mozscreenshot == 0.1 06:30:19 INFO - mozsystemmonitor == 0.3 06:30:19 INFO - moztest == 0.8 06:30:19 INFO - mozversion == 1.4 06:30:19 INFO - psutil == 3.1.1 06:30:19 INFO - requests == 1.2.3 06:30:19 INFO - wsgiref == 0.1.2 06:30:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:30:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:30:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:30:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:30:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:30:19 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 0x26ad1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2879a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a1f770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a1ca30>, '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 0x2a1d7f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a1dca0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1494595767.231991-1047568226', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:30:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 06:30:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:30:19 INFO - Using env: {'DISPLAY': ':0', 06:30:19 INFO - 'HOME': '/home/cltbld', 06:30:19 INFO - 'LANG': 'en_US.UTF-8', 06:30:19 INFO - 'LANGUAGE': 'en_US:en', 06:30:19 INFO - 'LOGNAME': 'cltbld', 06:30:19 INFO - 'MAIL': '/var/mail/cltbld', 06:30:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:30:19 INFO - 'MOZ_NO_REMOTE': '1', 06:30:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:30:19 INFO - 'NO_EM_RESTART': '1', 06:30:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:30:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:30:19 INFO - 'PWD': '/builds/slave/test', 06:30:19 INFO - 'SHELL': '/bin/bash', 06:30:19 INFO - 'SHLVL': '1', 06:30:19 INFO - 'TERM': 'linux', 06:30:19 INFO - 'TMOUT': '86400', 06:30:19 INFO - 'USER': 'cltbld', 06:30:19 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1494595767.231991-1047568226', 06:30:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:30:19 INFO - '_': '/tools/buildbot/bin/python'} 06:30:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:30:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 06:30:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 06:30:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 06:30:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 06:30:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 06:30:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 06:30:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 06:30:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 06:30:19 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 06:30:19 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 06:30:19 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 06:30:19 INFO - Cleaning up... 06:30:19 INFO - Return code: 0 06:30:19 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:30:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:30:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:30:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:30:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:30:19 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 0x26ad1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2879a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a1f770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a1ca30>, '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 0x2a1d7f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a1dca0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1494595767.231991-1047568226', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:30:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 06:30:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 06:30:19 INFO - Using env: {'DISPLAY': ':0', 06:30:19 INFO - 'HOME': '/home/cltbld', 06:30:19 INFO - 'LANG': 'en_US.UTF-8', 06:30:19 INFO - 'LANGUAGE': 'en_US:en', 06:30:19 INFO - 'LOGNAME': 'cltbld', 06:30:19 INFO - 'MAIL': '/var/mail/cltbld', 06:30:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:30:19 INFO - 'MOZ_NO_REMOTE': '1', 06:30:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:30:19 INFO - 'NO_EM_RESTART': '1', 06:30:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:30:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:30:19 INFO - 'PWD': '/builds/slave/test', 06:30:19 INFO - 'SHELL': '/bin/bash', 06:30:19 INFO - 'SHLVL': '1', 06:30:19 INFO - 'TERM': 'linux', 06:30:19 INFO - 'TMOUT': '86400', 06:30:19 INFO - 'USER': 'cltbld', 06:30:19 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1494595767.231991-1047568226', 06:30:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:30:19 INFO - '_': '/tools/buildbot/bin/python'} 06:30:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:30:19 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:30:19 INFO - Cleaning up... 06:30:19 INFO - Return code: 0 06:30:19 INFO - Running post-action listener: _resource_record_post_action 06:30:19 INFO - Running post-action listener: _start_resource_monitoring 06:30:19 INFO - Starting resource monitoring. 06:30:19 INFO - [mozharness: 2017-05-12 13:30:19.688620Z] Finished create-virtualenv step (success) 06:30:19 INFO - [mozharness: 2017-05-12 13:30:19.689611Z] Running install step. 06:30:19 INFO - Running pre-action listener: _resource_record_pre_action 06:30:19 INFO - Running main action method: install 06:30:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:30:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:30:19 INFO - Reading from file tmpfile_stdout 06:30:19 INFO - Detecting whether we're running mozinstall >=1.0... 06:30:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:30:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:30:19 INFO - Reading from file tmpfile_stdout 06:30:19 INFO - Output received: 06:30:19 INFO - Usage: mozinstall [options] installer 06:30:19 INFO - Options: 06:30:19 INFO - -h, --help show this help message and exit 06:30:19 INFO - -d DEST, --destination=DEST 06:30:19 INFO - Directory to install application into. [default: 06:30:19 INFO - "/builds/slave/test"] 06:30:19 INFO - --app=APP Application being installed. [default: firefox] 06:30:19 INFO - mkdir: /builds/slave/test/build/application 06:30:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 06:30:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 06:30:35 INFO - Reading from file tmpfile_stdout 06:30:35 INFO - Output received: 06:30:35 INFO - /builds/slave/test/build/application/firefox/firefox 06:30:35 INFO - Running post-action listener: _resource_record_post_action 06:30:35 INFO - [mozharness: 2017-05-12 13:30:35.847331Z] Finished install step (success) 06:30:35 INFO - [mozharness: 2017-05-12 13:30:35.847581Z] Running run-tests step. 06:30:35 INFO - Running pre-action listener: _resource_record_pre_action 06:30:35 INFO - Running main action method: run_tests 06:30:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:30:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:30:35 INFO - Python 2.7.3 06:30:35 INFO - Return code: 0 06:30:35 INFO - grabbing minidump binary from tooltool 06:30:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:30:35 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 0x2a1ca30>, '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 0x2a1d7f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a1dca0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:30:35 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 06:30:35 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 06:30:35 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 06:30:35 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:30:35 INFO - Return code: 0 06:30:35 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:30:35 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:30:35 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:30:35 INFO - ENV: RUST_BACKTRACE is now 1 06:30:35 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:30:35 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:30:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Nexm6u4PQnSQIB9strk64w/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-005', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 06:30:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Nexm6u4PQnSQIB9strk64w/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-005 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 06:30:35 INFO - Using env: {'DISPLAY': ':0', 06:30:35 INFO - 'HOME': '/home/cltbld', 06:30:35 INFO - 'LANG': 'en_US.UTF-8', 06:30:35 INFO - 'LANGUAGE': 'en_US:en', 06:30:35 INFO - 'LOGNAME': 'cltbld', 06:30:35 INFO - 'MAIL': '/var/mail/cltbld', 06:30:35 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:30:35 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:30:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:30:35 INFO - 'MOZ_NO_REMOTE': '1', 06:30:35 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:30:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:30:35 INFO - 'NO_EM_RESTART': '1', 06:30:35 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:30:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:30:35 INFO - 'PWD': '/builds/slave/test', 06:30:35 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:30:35 INFO - 'RUST_BACKTRACE': '1', 06:30:35 INFO - 'SHELL': '/bin/bash', 06:30:35 INFO - 'SHLVL': '1', 06:30:35 INFO - 'TERM': 'linux', 06:30:35 INFO - 'TMOUT': '86400', 06:30:35 INFO - 'USER': 'cltbld', 06:30:35 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1494595767.231991-1047568226', 06:30:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:30:35 INFO - '_': '/tools/buildbot/bin/python'} 06:30:35 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Nexm6u4PQnSQIB9strk64w/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-005', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 06:30:36 INFO - mozversion application_buildid: 20170512125958 06:30:36 INFO - mozversion application_changeset: 1178b701781de2b1a5afb7b7d6b4954a3a7a51ba 06:30:36 INFO - mozversion application_display_name: Nightly 06:30:36 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:30:36 INFO - mozversion application_name: Firefox 06:30:36 INFO - mozversion application_remotingname: firefox 06:30:36 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 06:30:36 INFO - mozversion application_vendor: Mozilla 06:30:36 INFO - mozversion application_version: 55.0a1 06:30:36 INFO - mozversion platform_buildid: 20170512125958 06:30:36 INFO - mozversion platform_changeset: 1178b701781de2b1a5afb7b7d6b4954a3a7a51ba 06:30:36 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 06:30:36 INFO - mozversion platform_version: 55.0a1 06:30:36 INFO - using testdate: 1494595836 06:30:36 INFO - actual date: 1494595836 06:30:36 INFO - starting webserver on 'localhost:44893' 06:30:36 INFO - SUITE-START | Running 2 tests 06:30:36 INFO - TEST-START | dromaeo_css 06:30:36 INFO - operating with platform_type : linux_ 06:30:36 INFO - Initialising browser for dromaeo_css test... 06:30:36 INFO - TEST-INFO | started process 3311 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpX9UOHL/profile http://localhost:44893/getInfo.html) 06:30:41 INFO - PID 3311 | __metrics Screen width/height:1600/1200 06:30:41 INFO - PID 3311 | colorDepth:24 06:30:41 INFO - PID 3311 | Browser inner width/height: 1024/695 06:30:41 INFO - PID 3311 | __metrics 06:30:43 INFO - TEST-INFO | 3311: exit 0 06:30:43 INFO - Browser initialized. 06:30:43 INFO - Running cycle 1/1 for dromaeo_css test... 06:30:43 INFO - TEST-INFO | started process 3482 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpX9UOHL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:30:55 INFO - PID 3482 | RSS: Main: 155828224 06:30:55 INFO - PID 3482 | 06:33:59 INFO - PID 3482 | Cycle 1(1): loaded http://localhost:44893/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44893/tests/dromaeo/cssquery-ext.html) 06:34:02 INFO - PID 3482 | RSS: Main: 165105664 06:34:02 INFO - PID 3482 | 06:37:04 INFO - PID 3482 | Cycle 1(1): loaded http://localhost:44893/tests/dromaeo/cssquery-ext.html (next: http://localhost:44893/tests/dromaeo/cssquery-jquery.html) 06:37:05 INFO - PID 3482 | RSS: Main: 161673216 06:37:05 INFO - PID 3482 | 06:40:07 INFO - PID 3482 | Cycle 1(1): loaded http://localhost:44893/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44893/tests/dromaeo/cssquery-mootools.html) 06:40:07 INFO - PID 3482 | RSS: Main: 168890368 06:40:07 INFO - PID 3482 | 06:43:09 INFO - PID 3482 | Cycle 1(1): loaded http://localhost:44893/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44893/tests/dromaeo/cssquery-prototype.html) 06:43:10 INFO - PID 3482 | RSS: Main: 161292288 06:43:10 INFO - PID 3482 | 06:46:13 INFO - PID 3482 | Cycle 1(1): loaded http://localhost:44893/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44893/tests/dromaeo/cssquery-yui.html) 06:46:13 INFO - PID 3482 | RSS: Main: 165277696 06:46:13 INFO - PID 3482 | 06:49:15 INFO - PID 3482 | Cycle 1(1): loaded http://localhost:44893/tests/dromaeo/cssquery-yui.html (next: http://localhost:44893/tests/dromaeo/cssquery-dojo.html) 06:49:15 INFO - PID 3482 | RSS: Main: 168980480 06:49:15 INFO - PID 3482 | 06:49:15 INFO - PID 3482 | __start_tp_report 06:49:15 INFO - PID 3482 | _x_x_mozilla_page_load 06:49:15 INFO - PID 3482 | _x_x_mozilla_page_load_details 06:49:15 INFO - PID 3482 | |i|pagename|runs| 06:49:15 INFO - PID 3482 | |0;dojo.html;2745.7940654450913;2751.3534319434943;2774.3202915285756;2787.6376071110753;2788.093869492415;5271.73641317934;5289.444608316125;5294.708791016493;5295.841124766263;5320;5289.761960711768;5305.230741542474;5369.463053694629;5404.7838086476595;5410.594205434599;4402.273624851911;4738.47876733559;4750.952490475085;4760.785764640582;4780.976095119519;4805.759712014403;4855.56299933006;4856.830010949618;4884.560389564938;4908.460069392364;4667.393238878924;4680.461746899116;4738.64460165489;4774.594159496447;4781.8087276508895;4729.905401891977;4736.147493451177;4741.170295198326;4767.928481072787;4783.952160478386;4672.252439609681;4681.274402467623;4709.175894218532;4720.150372932871;4733.928991065137;5206.739663016872;5214.296070030536;5241.816536421207;5245.186996015624;5262.23697563855;5743.0811070228565;5802.854928626776;5848.122781582754;5860.062390017577;5875.676837773921;5778.3066032076;5781.4507621775865;5784.479396854304;5789.942100579025;5816.592838501307;5282.075636763551;5312.521873031368;5352.277442545206;5353.491418315254;5355.651882627617;5927.1405646181065;5933.169356290123;6000.519958403317;6017.759289628453;6064.878702425926;5556.638818476786;5585.497305242548;5634.915476267859;5675.290588676416;5716.5140963017775;5774.2782152230975;5787.479126878601;5817.476427121579;5844.88310233793;5883.852903677443;5810.0994345875615;5816;5816.185733997244;5824.097264923944;5828.854278643068;5645.971770141123;5649.0396632572565;5752.453516915886;5756.5682573807135;5768.3654797972185;4889.608831293488;4892.290617860462;4913.343764637881;4927.704337739747;4942.431620363633;4152.522459917088;4155.210510003089;4186.832526698959;4187.874363769091;4223.619874211275;4761.190597598416;4820.276958456259;4825.30033145192;4827.927581086286;4995.500449954975;5736.541076713853;5774.162746401748;5789.507891829157;5821.27234095738;5832.912506312408;4933.679310844784;4976.975115124401;4997.0505603935135;5012.523810238022;5012.573931215888;5211.530962213419;5222.92165617516;5229.555487783581;5243.501867322599;5270.1040823060175;5380.865478362915;5381.677099373972;5386.59600529954;5393.379761327341;5398.973005134949;5628.662280263197;5702.857428564319;5718.885622287614;5833.620814647034;5877.941220587911;5246.947530524646;5261.421243663118;5263.973680131575;5265.473452654704;5268.394134674408;5552;5656.208130861601;5721.971390143022;5772.884542309214;5775.162601422686;5860.765569377348;5880.117982302689;5883.646981181143;5887.381824908323;5888.587798854211;5622.016147174147;5641.210230567642;5642.802501912413;5649.745761440663;5667.3765885753355;5620.156976453564;5620.4660557247;5621.437856214346;5625.46558076982;5631.352394474688;5404.378496472956;5448.863778405572;5465.152901300305;5472.2065300531995;5525.557955363642;5617.466340697627;5628.155776633538;5631.746571404215;5650.23721797552;5664.037113690765;5406.107992181246;5423.810166644149;5457.7271136443815;5480.177973304037;5512.3660779010925 06:49:15 INFO - PID 3482 | |1;ext.html;666.883295423301;683.5522732610139;1040.07433384288;1050.7215587869216;1146.3351256271364;31383.372332553336;34439.13902152445;34807.30385392291;34811.47782783254;34882.47676284858;31831.68168318316;32000;32075.67924320756;32146.517802232986;32181.839090804515;6358.523110766711;6528.183977002875;6637.933620663804;6643.667816609174;7107.431405487574;7056.364927156555;7112.217656057829;7131.89302160468;7135.143782746052;7175.928240717578;7156.320149585781;7192.957021231919;7198.676059577331;7201.89197162043;7205.423566114699;7172;7179.1026121734785;7211.170715367747;7225.819354516153;7235.095613048369;7031.261717519638;7069.469789765788;7096.325849044384;7101.644917754092;7111.751088711922;32614.347713045605;32816.835915820506;32835.17912052194;33045.50431743526;33089.6691033089;3017.7585793136495;3058.5565093061605;3080.183751305906;3080.768942329334;3091.180837078176;24506.877465612557;24642.383940401454;24720.876395617906;24733;24843.87578062116;3144.4811606085195;3151.8424078796197;3164.9525257121163;3194.952075718866;3197.9680203197904;138786;138821.30589347088;139610.3019484906;139759;140016;38832.80583597064;40165.59834401677;40741.59258407378;41027.179456410704;41032.589674103474;42263.15473690509;42553.148937021084;42616.78691606522;42636.3604545932;42767.35848962268;13065.281409522377;13245.072844900957;13272.13731107475;13298;13308.733825323632;10510.316829406063;10516.842247366296;10553.894461055444;10576.947115264375;10641.467926603638;12942.482300708054;13085.476580936656;13089.934550327187;13145.34273286351;13248.138870973356;5163.741812909415;5191.610629202825;5319.547838433699;5322.228276899906;5420.24116623673;868.9782755431165;879.0594064351083;887.6316328723636;889.2930120554175;916.9358144929924;19260.903695481713;20195.899020504803;20636.27773027937;20763;20794.584108317747;954.4988880837616;962.9133377996014;988.0564061321421;988.1600639456548;1007.2999265510547;10406.531706073094;10555.894441055645;10752.677419677266;10816.945915270531;10836.945815270874;172480;173983;174415.12792435958;174469;174870;40965.59034409618;41371.58628413677;41676.37485437721;41772.79113604473;41881.79059104746;1194.8625908020688;1232.950681972729;1238.7646347194004;1239.0335538280156;1247.7878760610718;18770.530736731693;19237;20331.08510117078;20403.59192816165;20630.17479300811;30132.397352052398;30268;30333;30368.544471832498;30404.847975759978;141299;142136.28931855274;142243;142348;142429.28785356006;29558.704412955594;29690.70309296966;30049.849750751106;30808.075757727303;31184.37631247317;36268.45597316095;37344.253114938096;37644.81177594094;37650;38120;27843.303917401416;28111;28353.71646283593;28625.14124576266;28899.422011560073;27910.3022424441;27979.160625181277;28555.857220713762;29638.259043524085;29744.553831692974;32026.19934501563;32043.359132816746;32095.518567221978;32450.188745281557;32456.350872981937;25872.611910820975;26820.8658956704;27233.31916702098;27636.585451217845;28451.146465606063;19977.400677979684;22243.22148724787;22480.662790057835;22696.773032270128;22766.544669106857 06:49:15 INFO - PID 3482 | |2;jquery.html;412.9917401651969;418.59396385506057;422.5415424264673;434.1729006243106;439.2576545637872;12662.366881655926;17108.74336884948;17688.38090666827;17793.911030444844;17797;18227.453176404728;18444.907775461103;18453.16960736767;18526;18603.976781277026;5264.6051546134;5277.340332458442;5487.6158668893195;5488.9725551372185;5522.723863806814;5364.168553874156;5442.482964118402;5468.72656367182;5468.9726551367385;5472.616916815825;5319.946800532003;5377.946220537784;5395.460453954613;5459.481349271813;5486.039943009977;5399.19012148177;5400.108982017962;5445.019896418643;5446.809361672343;5447.972760136214;4760.738159401231;4905.975470122627;4932.2108462646165;4935.383077115361;4989.101961646902;20229.494262643406;20945;20969.370918872304;21024.789752102435;21117.47206319839;1660.7342825147919;1691.2812054876752;1705.1048199695135;1715.382462313566;1719.423992962359;13971.930140349234;14170;14454.783178252335;14457.493987710379;14672.19302938338;2060.9793902060937;2082.03185518733;2128.98935505323;2130.5632345369318;2143.9892800536054;75567.62216188884;76071.61964190143;77345.61327193385;95504.52247738786;98753.0124698751;10885.86337191862;11064.778704425866;11108.000279974842;11247.437628118561;11362.659120226406;15387;15452.845471545366;15496.922515387576;15559.14424706652;33930.66069339324;8837.204651581389;8994.370394072483;9070.86393704095;9271.490068046187;9311.906880931105;7306.7077316906725;7383.15093764224;7422.851542969111;7506.737264195727;7566.9621651892485;9150.588223529958;9438;9611.327207095575;9622.9037709622;9717.271204659537;3683.2633473305445;3741.3639681254253;3837.4503584184517;4082.81627326771;4111.876643700693;846.585173265108;862.8162081917703;865.5412631305418;880.7709995401242;892.5091199840062;16360.509184724477;16789.16054197285;16959.830401696072;17086.40197593078;17549.385771497935;862.3403096631082;869.6695255802755;879.89881163667;880.335346813152;897.3001059173855;9203.309751768644;9291.58187881547;9561.665341713007;9569.61721531145;9590.856137157949;343763;345902;348148;350352;355266;68851.31148688449;69232;70479;71137.64431177812;72028.27971720215;1083.252555736555;1088.5863371918779;1128.9322640641587;1133.0255979857316;1133.2463911498926;16919.23863426124;17147.399841005506;17554.38559650406;17885.552861178054;18229.45311640653;36658.26683466262;37664;38244.23511529809;38346;39058;46245.76877115593;47122.29316560323;48072.7596362016;48137;48217.517824821305;8253.711120110767;8292.709755158541;8355.289800367036;8527.616257268313;8600;12070.517179312728;12105.394730263275;12231.877681223074;12329.630111096682;12791.296478693761;10097.192224621866;10495.422751748727;10612.575496980344;10781.838272425763;10914.29057111317;9410.10603992647;9419.246460283299;9536.427814331162;9538.523073846141;9724.95137524308;10545.683629491128;10551.736206594896;10711.625093121704;10787.352758834495;10850.348979061282;8258.545779981918;8411.495310281403;8435.198656127657;8505.829883402173;8723.956380218313;10272.126869215901;10310.226732995205;10423.843642345219;10470.738231543968;10544.89455105439 06:49:15 INFO - PID 3482 | |3;mootools.html;1193.4271549656164;1249.843769528809;1255.7111864271217;1259.1374908187886;1260.5651050387612;10107.241956853228;10164.898351016487;10405.063544281013;10517.526711297991;10574.841377379336;10541.209409294315;10709.518071686773;10712.839307410375;10789.730256743585;10816.837747433776;2278.4303924018955;2284.6915666385075;2296;2299.586074506588;2304.942376440594;2078.9792102079014;2157.3959291398432;2157.5253444242244;2159.6220661384273;2164.6428339323993;2127.957440851182;2136.423165745248;2166.945826354338;2170.934871953844;2172.7827217278304;2183.9890800546054;2224.688543603889;2229.587526307638;2240.2159244264376;2243.495213576932;2086.3428020173596;2112.324056301984;2149.0866381787678;2241.42843574889;2241.484458574537;10237.948810255975;10271.589136434608;10315.484225788681;10325.019123183285;10330.12193963514;5465.562754979632;5611.915821262684;5649.152627105967;5694.145878118274;5709.400512946122;3308.4375656138513;3331.466965285567;3421.7775844570024;3430.8627654893776;3431.7769344992494;1117.3631030312724;1129.5312445335258;1146.9655910322704;1181.8699943006263;1188.6255829413794;14980;15050.849491505054;15086.698266034618;15104.622384440367;15155.772663410058;4556.3621093047;4759.619230461555;5003.624728145403;5005.624578156653;5016.1723315653235;10778.514966826511;10778.622748203776;10788.46057697112;10796.946015269874;10804.945975270231;5569.443055694479;5581.665100094007;5588.720563971867;5592.748326325325;5596.244506991586;4944.134776414113;5144;5150.793968241228;5260.368755749258;5319.760610772524;3793.0896584819443;3837.865674701372;3879.282332768447;3953.1698343347643;3954.387070004154;1118.9048930840806;1133.1727838677812;1134.7163209197702;1136.9886301137049;1145.2956431794387;683.6308393467472;705.340506626306;707.6815433055043;722.7181399254295;723.2731105239201;5344.385395679469;5452.073147564924;5469.124940009579;5515.062439385314;5560.944390556043;504.89144833860894;525.1859617592715;530.8805518758326;531.5030446532504;533.1496263459776;3119.313750974782;3747.737658363943;3767.585565587783;3831.9042023949623;3895.337792575269;12774.872251277367;12879.742405151845;13046.282454464907;13167.67080822987;13385.732285354434;12520;12829.61511154667;12922.741545169043;12997.610071697864;13014.15407998496;7468.775936721907;7486.663100160506;7623;7636.732714354971;7696.1144519591935;5489.34127904638;5580.497755202051;5581.860453488695;5625.296837895263;5741.483266506035;11491.310521368745;11497.82753258685;11598.594049208237;11641.708957275798;11669.533218671158;11764.941175294069;11861;11980.944859060884;11991.580294689644;12006.819897701367;6999.895001574879;7055.964720176572;7112.857742845011;8180.263776260165;8493.193146651058;9800.460974646463;9873.901260987299;9916;9945.552450139616;9965.202783777135;8119.5534245617055;8297.585120743817;8366.958165209135;8500.70247541333;8531.573421329032;7815;7935.761927142195;8007.079185893696;8031.759047228593;8065.717699880476;6853.931460685529;6878.69045892926;6923.411510021705;6973.895391569029;6978.232394436709;5138.794448222029;5206.505381988705;5257.8159764408065;5369.409364969928;5489.066858633962;5414.83755487336;5459.754311055933;5462.399136095106;5593.524550413261;5647.3787883333625 06:49:15 INFO - PID 3482 | |4;prototype.html;372.93846515324975;381.6812961177417;384.66726281766273;396.3104198694271;402.80262671291075;5319.840404787853;5557.916631250535;5624.147458990589;5662.433756624336;5678.971605141974;5324.494173053564;5430.429804870491;5465.426130256315;5506.174073888918;5511.476409741068;4344.283193273114;4345.630621397185;4377.846775362863;4378.10248898975;4392.945693033681;4273.312041743509;4354.629856462205;4382.430284063067;4383.211022016036;4385.693001489897;4321.006168581228;4322.935155972663;4323.659665503688;4332.696711230215;4341.479022517302;4316.6762492813;4341.979634785823;4347.847825326098;4364.956350436519;4365.3233748768835;3904.2581909437117;3947.9735268830023;3957.3972541120893;3964.365701487748;3970.285348637244;5371.167469042305;5380.408155102936;5384;5390.1375779875425;5424.728763561806;5170.379554453452;5177.948220517822;5202.791888324463;5204.453532379083;5210.879660872893;5653.378128405872;5868.853278668024;5872.9428702833475;5875;5911.822645320647;4455.465344158722;4464;4472.575105364985;4478;4483.529229430928;6009.729562169713;6162.044883043135;6176.7838125665385;6199.721012554401;6222.657753823538;4134.028503301722;4153.418521407006;4158;4158.875233742992;4168.979155104265;4215.957840421618;4217.894552636148;4220.134872351161;4226.76752778594;4233.618974292329;4755.120302744003;4812.157872372391;4858.46556878743;4871.756412179377;4878;5845.269341332333;5850.5612079094235;5883.146943693226;5883.794067207627;5887.116932460165;1447.3269929482842;1455.8544145585568;1456.774199999002;1459.9854001459848;1460.0874453466583;961.0581630002637;963.5182408795603;980.6518685866557;982.8181786369545;987.0080569028081;5120.411152717411;5149.201873709581;5155.845324640267;5161.81933632321;5211.348581427322;6140.815775526741;6157.753689852445;6158.291796443466;6175.2589689237575;6181.35095814933;5020.422651395063;5113.079645663816;5147.974260128675;5148.382194136652;5190.870228244324;3221.4040402525607;3258.4949332853444;3260.402402822647;3272.296456261915;3279.9344013119603;5515.834524964257;5624.29696287964;5627.803026894039;5638.774449022075;5643.379228284885;6189.102580125857;6240.968795155995;6268.247810262797;6287.842803929847;6303.2751233607805;5594.049011668027;5601.691906945076;5605.981846535244;5611.438856114356;5639.802606908738;5947.91078133837;6010.519158467225;6025.444987457421;6116.602420842631;6118.418750218722;5886.3223981165165;5938.762449501972;5982.341942386421;5998.760049598141;6015.338312785502;5626.381098079126;5636.689982051026;5667.178259152317;5682.176084467646;5706.857328566819;4162.125953549788;4188.821812657462;4192.3082691355585;4193.308104162779;4203.285441474895;6044.24446944132;6145.446909778141;6157.568970172045;6207.6275423474735;6214.477453024038;5941.22764040672;5946.881062378641;5953.523718102455;5957.582969192288;5964.677441911587;5797.536197104306;5917.467427931507;5922.970385148046;5948.4421698669985;5959.642421454727;5756.827295181151;5780.364159942319;5794.101914203306;5797.507211887037;5818.796342128006;5967.6419414835245;6005.969970150121;6007.87984240304;6017.338092809699;6024.518038556817;5671.234383358194;5745.770169193185;5780.421957804186;5789.189513468202;5813.186153938367 06:49:15 INFO - PID 3482 | |5;yui.html;736.7163641997831;738.0405472885254;747.0661672908864;751.4852326156583;754.479409207647;10525.421101839414;10934.617288394908;12309.322987235699;13142;13221.471141154354;14551.345189466472;14749.48376806812;15060.924695376509;15070.849291507082;15144.242787860618;868.4962721621476;893.2184338703635;898.0480690468092;899.7390756680555;901.3375169250595;906.0848542971613;911.08436021798;911.5943405184695;911.9589618467152;913.3332667152982;952.8904176019743;958.3291695812959;961.1445813226235;961.9903800961971;961.9903800962006;947.0198344713189;948.3219498058921;948.7343543807744;956.1490273656451;958.5494817435829;695.8747425463415;697.3863000559526;700.3731660164125;702.4696354252507;703.6305939381814;12265.202761820454;12279.815802762965;12835.87164128356;14450;14553.490627827976;13647.658808529766;14056;14131.505397311148;14260.572182834532;14317.49888753899;12379.133460657758;12522.499100035988;12539.498420063186;12624.053196010336;12669.239845609292;2882.26502241927;2889.8555072246304;2890.1185138532737;2905.273681579605;2912.6504819421593;65483.672581637264;65844.3415565843;66311.66844165797;66985.3301466984;68098.9785153223;8935.597898094602;9001.324900632479;9097.772555686028;9187.448753074703;9264.95367523158;17226.138693065295;17247.223874925658;17339;17368.218430170673;17411;5671.177679236487;5750.827475175752;5774.566907481955;5791.623544469596;5832.650040997553;2820.139857343489;2867.44084903446;2883.3224192314788;2884.4952133376573;2886.0764555342507;3248.8862889799216;3289.292802047571;3303.620083690358;3323.3851737428654;3333.4999750037205;655.3937607712846;658.1739916404881;659.4987809264993;666.506784979112;667.0328024364691;550.4522999615408;552.1524459954031;554.9056660367747;562.8002059268982;572.7079189613327;9317.767055823522;9472.573734181979;9661.951690241503;9789.853152202722;9820.607175713034;560.6467925207094;568.6190252530814;570.0650932470669;578.2194038048684;589.0545674192945;4179.477565304337;4329.631981281626;4350.456192975878;4360.389545463638;4520.932186017212;62019.069713954326;62107.378926211066;62557;63172;65193;54554.454455454936;55232.72383638056;56215.71892140513;56365.71817140888;56967.715161424756;50656.24015639768;51562.74218628958;52368.47631523712;53475.46524534705;53846.7307663467;8541.359398045295;8816.559172041501;8982.820343593223;9163.908360916572;9219.44683319003;25186.37034074163;25638;26198.607020895084;27968.58047129254;28584;42834.571654283056;44501;44728.32907506325;45309.32036019397;46349.14603415826;13598.388072536958;13848.376823042785;14111.788323174955;14129.717405651623;14284.642883927985;14248.358823852745;14957.551273461813;15440.536783896501;15443.382264709286;15544.766828497808;14344.354504047134;14449.566513004627;14536.491222807152;14544.272786360429;14819.851801481847;12895.355232238539;13011;13049.739005220032;13097.607071787861;13267.270300133585;13332.466701332227;13335.933125349755;13360.532381366605;13497.392617332047;13599.320033998458;9908.35595686278;9950.800983980134;10005.099541041342;10634.149268058381;10856.620018299322;10630.618019657395;10863.239573229797;10996.615118471134;11524.711882203012;11581.768364632491 06:49:15 INFO - PID 3482 | __end_tp_report 06:49:15 INFO - PID 3482 | __start_cc_report 06:49:15 INFO - PID 3482 | _x_x_mozilla_cycle_collect,361 06:49:15 INFO - PID 3482 | __end_cc_report 06:49:15 INFO - PID 3482 | __startTimestamp1494596955793__endTimestamp 06:49:15 INFO - PID 3482 | 06:49:15 INFO - PID 3482 | ------- Summary: start ------- 06:49:15 INFO - PID 3482 | Number of tests: 6 06:49:15 INFO - PID 3482 | 06:49:15 INFO - PID 3482 | [#0] dojo.html Cycles:165 Average:5274.80 Median:5398.97 stddev:626.54 (11.6%) stddev-sans-first:596.23 06:49:15 INFO - PID 3482 | Values: 2745.8 2751.4 2774.3 2787.6 2788.1 5271.7 5289.4 5294.7 5295.8 5320.0 5289.8 5305.2 5369.5 5404.8 5410.6 4402.3 4738.5 4751.0 4760.8 4781.0 4805.8 4855.6 4856.8 4884.6 4908.5 4667.4 4680.5 4738.6 4774.6 4781.8 4729.9 4736.1 4741.2 4767.9 4784.0 4672.3 4681.3 4709.2 4720.2 4733.9 5206.7 5214.3 5241.8 5245.2 5262.2 5743.1 5802.9 5848.1 5860.1 5875.7 5778.3 5781.5 5784.5 5789.9 5816.6 5282.1 5312.5 5352.3 5353.5 5355.7 5927.1 5933.2 6000.5 6017.8 6064.9 5556.6 5585.5 5634.9 5675.3 5716.5 5774.3 5787.5 5817.5 5844.9 5883.9 5810.1 5816.0 5816.2 5824.1 5828.9 5646.0 5649.0 5752.5 5756.6 5768.4 4889.6 4892.3 4913.3 4927.7 4942.4 4152.5 4155.2 4186.8 4187.9 4223.6 4761.2 4820.3 4825.3 4827.9 4995.5 5736.5 5774.2 5789.5 5821.3 5832.9 4933.7 4977.0 4997.1 5012.5 5012.6 5211.5 5222.9 5229.6 5243.5 5270.1 5380.9 5381.7 5386.6 5393.4 5399.0 5628.7 5702.9 5718.9 5833.6 5877.9 5246.9 5261.4 5264.0 5265.5 5268.4 5552.0 5656.2 5722.0 5772.9 5775.2 5860.8 5880.1 5883.6 5887.4 5888.6 5622.0 5641.2 5642.8 5649.7 5667.4 5620.2 5620.5 5621.4 5625.5 5631.4 5404.4 5448.9 5465.2 5472.2 5525.6 5617.5 5628.2 5631.7 5650.2 5664.0 5406.1 5423.8 5457.7 5480.2 5512.4 06:49:15 INFO - PID 3482 | 06:49:15 INFO - PID 3482 | [#1] ext.html Cycles:180 Average:29966.49 Median:16944.42 stddev:39354.70 (232.3%) stddev-sans-first:39403.60 06:49:15 INFO - PID 3482 | Values: 666.9 683.6 1040.1 1050.7 1146.3 31383.4 34439.1 34807.3 34811.5 34882.5 31831.7 32000.0 32075.7 32146.5 32181.8 6358.5 6528.2 6637.9 6643.7 7107.4 7056.4 7112.2 7131.9 7135.1 7175.9 7156.3 7193.0 7198.7 7201.9 7205.4 7172.0 7179.1 7211.2 7225.8 7235.1 7031.3 7069.5 7096.3 7101.6 7111.8 32614.3 32816.8 32835.2 33045.5 33089.7 3017.8 3058.6 3080.2 3080.8 3091.2 24506.9 24642.4 24720.9 24733.0 24843.9 3144.5 3151.8 3165.0 3195.0 3198.0 138786.0 138821.3 139610.3 139759.0 140016.0 38832.8 40165.6 40741.6 41027.2 41032.6 42263.2 42553.1 42616.8 42636.4 42767.4 13065.3 13245.1 13272.1 13298.0 13308.7 10510.3 10516.8 10553.9 10576.9 10641.5 12942.5 13085.5 13089.9 13145.3 13248.1 5163.7 5191.6 5319.5 5322.2 5420.2 869.0 879.1 887.6 889.3 916.9 19260.9 20195.9 20636.3 20763.0 20794.6 954.5 962.9 988.1 988.2 1007.3 10406.5 10555.9 10752.7 10816.9 10836.9 172480.0 173983.0 174415.1 174469.0 174870.0 40965.6 41371.6 41676.4 41772.8 41881.8 1194.9 1233.0 1238.8 1239.0 1247.8 18770.5 19237.0 20331.1 20403.6 20630.2 30132.4 30268.0 30333.0 30368.5 30404.8 141299.0 142136.3 142243.0 142348.0 142429.3 29558.7 29690.7 30049.8 30808.1 31184.4 36268.5 37344.3 37644.8 37650.0 38120.0 27843.3 28111.0 28353.7 28625.1 28899.4 27910.3 27979.2 28555.9 29638.3 29744.6 32026.2 32043.4 32095.5 32450.2 32456.4 25872.6 26820.9 27233.3 27636.6 28451.1 19977.4 22243.2 22480.7 22696.8 22766.5 06:49:15 INFO - PID 3482 | 06:49:15 INFO - PID 3482 | [#2] jquery.html Cycles:180 Average:24103.73 Median:415.79 stddev:57948.15 (13936.8%) stddev-sans-first:58083.41 06:49:15 INFO - PID 3482 | Values: 413.0 418.6 422.5 434.2 439.3 12662.4 17108.7 17688.4 17793.9 17797.0 18227.5 18444.9 18453.2 18526.0 18604.0 5264.6 5277.3 5487.6 5489.0 5522.7 5364.2 5442.5 5468.7 5469.0 5472.6 5319.9 5377.9 5395.5 5459.5 5486.0 5399.2 5400.1 5445.0 5446.8 5448.0 4760.7 4906.0 4932.2 4935.4 4989.1 20229.5 20945.0 20969.4 21024.8 21117.5 1660.7 1691.3 1705.1 1715.4 1719.4 13971.9 14170.0 14454.8 14457.5 14672.2 2061.0 2082.0 2129.0 2130.6 2144.0 75567.6 76071.6 77345.6 95504.5 98753.0 10885.9 11064.8 11108.0 11247.4 11362.7 15387.0 15452.8 15496.9 15559.1 33930.7 8837.2 8994.4 9070.9 9271.5 9311.9 7306.7 7383.2 7422.9 7506.7 7567.0 9150.6 9438.0 9611.3 9622.9 9717.3 3683.3 3741.4 3837.5 4082.8 4111.9 846.6 862.8 865.5 880.8 892.5 16360.5 16789.2 16959.8 17086.4 17549.4 862.3 869.7 879.9 880.3 897.3 9203.3 9291.6 9561.7 9569.6 9590.9 343763.0 345902.0 348148.0 350352.0 355266.0 68851.3 69232.0 70479.0 71137.6 72028.3 1083.3 1088.6 1128.9 1133.0 1133.2 16919.2 17147.4 17554.4 17885.6 18229.5 36658.3 37664.0 38244.2 38346.0 39058.0 46245.8 47122.3 48072.8 48137.0 48217.5 8253.7 8292.7 8355.3 8527.6 8600.0 12070.5 12105.4 12231.9 12329.6 12791.3 10097.2 10495.4 10612.6 10781.8 10914.3 9410.1 9419.2 9536.4 9538.5 9725.0 10545.7 10551.7 10711.6 10787.4 10850.3 8258.5 8411.5 8435.2 8505.8 8724.0 10272.1 10310.2 10423.8 10470.7 10544.9 06:49:15 INFO - PID 3482 | 06:49:15 INFO - PID 3482 | [#3] mootools.html Cycles:180 Average:6243.20 Median:3589.76 stddev:4015.80 (111.9%) stddev-sans-first:4009.14 06:49:15 INFO - PID 3482 | Values: 1193.4 1249.8 1255.7 1259.1 1260.6 10107.2 10164.9 10405.1 10517.5 10574.8 10541.2 10709.5 10712.8 10789.7 10816.8 2278.4 2284.7 2296.0 2299.6 2304.9 2079.0 2157.4 2157.5 2159.6 2164.6 2128.0 2136.4 2166.9 2170.9 2172.8 2184.0 2224.7 2229.6 2240.2 2243.5 2086.3 2112.3 2149.1 2241.4 2241.5 10237.9 10271.6 10315.5 10325.0 10330.1 5465.6 5611.9 5649.2 5694.1 5709.4 3308.4 3331.5 3421.8 3430.9 3431.8 1117.4 1129.5 1147.0 1181.9 1188.6 14980.0 15050.8 15086.7 15104.6 15155.8 4556.4 4759.6 5003.6 5005.6 5016.2 10778.5 10778.6 10788.5 10796.9 10804.9 5569.4 5581.7 5588.7 5592.7 5596.2 4944.1 5144.0 5150.8 5260.4 5319.8 3793.1 3837.9 3879.3 3953.2 3954.4 1118.9 1133.2 1134.7 1137.0 1145.3 683.6 705.3 707.7 722.7 723.3 5344.4 5452.1 5469.1 5515.1 5560.9 504.9 525.2 530.9 531.5 533.1 3119.3 3747.7 3767.6 3831.9 3895.3 12774.9 12879.7 13046.3 13167.7 13385.7 12520.0 12829.6 12922.7 12997.6 13014.2 7468.8 7486.7 7623.0 7636.7 7696.1 5489.3 5580.5 5581.9 5625.3 5741.5 11491.3 11497.8 11598.6 11641.7 11669.5 11764.9 11861.0 11980.9 11991.6 12006.8 6999.9 7056.0 7112.9 8180.3 8493.2 9800.5 9873.9 9916.0 9945.6 9965.2 8119.6 8297.6 8367.0 8500.7 8531.6 7815.0 7935.8 8007.1 8031.8 8065.7 6853.9 6878.7 6923.4 6973.9 6978.2 5138.8 5206.5 5257.8 5369.4 5489.1 5414.8 5459.8 5462.4 5593.5 5647.4 06:49:15 INFO - PID 3482 | 06:49:15 INFO - PID 3482 | [#4] prototype.html Cycles:180 Average:4886.78 Median:5513.66 stddev:1425.18 (25.8%) stddev-sans-first:1388.32 06:49:15 INFO - PID 3482 | Values: 372.9 381.7 384.7 396.3 402.8 5319.8 5557.9 5624.1 5662.4 5679.0 5324.5 5430.4 5465.4 5506.2 5511.5 4344.3 4345.6 4377.8 4378.1 4392.9 4273.3 4354.6 4382.4 4383.2 4385.7 4321.0 4322.9 4323.7 4332.7 4341.5 4316.7 4342.0 4347.8 4365.0 4365.3 3904.3 3948.0 3957.4 3964.4 3970.3 5371.2 5380.4 5384.0 5390.1 5424.7 5170.4 5177.9 5202.8 5204.5 5210.9 5653.4 5868.9 5872.9 5875.0 5911.8 4455.5 4464.0 4472.6 4478.0 4483.5 6009.7 6162.0 6176.8 6199.7 6222.7 4134.0 4153.4 4158.0 4158.9 4169.0 4216.0 4217.9 4220.1 4226.8 4233.6 4755.1 4812.2 4858.5 4871.8 4878.0 5845.3 5850.6 5883.1 5883.8 5887.1 1447.3 1455.9 1456.8 1460.0 1460.1 961.1 963.5 980.7 982.8 987.0 5120.4 5149.2 5155.8 5161.8 5211.3 6140.8 6157.8 6158.3 6175.3 6181.4 5020.4 5113.1 5148.0 5148.4 5190.9 3221.4 3258.5 3260.4 3272.3 3279.9 5515.8 5624.3 5627.8 5638.8 5643.4 6189.1 6241.0 6268.2 6287.8 6303.3 5594.0 5601.7 5606.0 5611.4 5639.8 5947.9 6010.5 6025.4 6116.6 6118.4 5886.3 5938.8 5982.3 5998.8 6015.3 5626.4 5636.7 5667.2 5682.2 5706.9 4162.1 4188.8 4192.3 4193.3 4203.3 6044.2 6145.4 6157.6 6207.6 6214.5 5941.2 5946.9 5953.5 5957.6 5964.7 5797.5 5917.5 5923.0 5948.4 5959.6 5756.8 5780.4 5794.1 5797.5 5818.8 5967.6 6006.0 6007.9 6017.3 6024.5 5671.2 5745.8 5780.4 5789.2 5813.2 06:49:15 INFO - PID 3482 | 06:49:15 INFO - PID 3482 | [#5] yui.html Cycles:180 Average:14965.39 Median:24915.13 stddev:18064.67 (72.5%) stddev-sans-first:18083.74 06:49:15 INFO - PID 3482 | Values: 736.7 738.0 747.1 751.5 754.5 10525.4 10934.6 12309.3 13142.0 13221.5 14551.3 14749.5 15060.9 15070.8 15144.2 868.5 893.2 898.0 899.7 901.3 906.1 911.1 911.6 912.0 913.3 952.9 958.3 961.1 962.0 962.0 947.0 948.3 948.7 956.1 958.5 695.9 697.4 700.4 702.5 703.6 12265.2 12279.8 12835.9 14450.0 14553.5 13647.7 14056.0 14131.5 14260.6 14317.5 12379.1 12522.5 12539.5 12624.1 12669.2 2882.3 2889.9 2890.1 2905.3 2912.7 65483.7 65844.3 66311.7 66985.3 68099.0 8935.6 9001.3 9097.8 9187.4 9265.0 17226.1 17247.2 17339.0 17368.2 17411.0 5671.2 5750.8 5774.6 5791.6 5832.7 2820.1 2867.4 2883.3 2884.5 2886.1 3248.9 3289.3 3303.6 3323.4 3333.5 655.4 658.2 659.5 666.5 667.0 550.5 552.2 554.9 562.8 572.7 9317.8 9472.6 9662.0 9789.9 9820.6 560.6 568.6 570.1 578.2 589.1 4179.5 4329.6 4350.5 4360.4 4520.9 62019.1 62107.4 62557.0 63172.0 65193.0 54554.5 55232.7 56215.7 56365.7 56967.7 50656.2 51562.7 52368.5 53475.5 53846.7 8541.4 8816.6 8982.8 9163.9 9219.4 25186.4 25638.0 26198.6 27968.6 28584.0 42834.6 44501.0 44728.3 45309.3 46349.1 13598.4 13848.4 14111.8 14129.7 14284.6 14248.4 14957.6 15440.5 15443.4 15544.8 14344.4 14449.6 14536.5 14544.3 14819.9 12895.4 13011.0 13049.7 13097.6 13267.3 13332.5 13335.9 13360.5 13497.4 13599.3 9908.4 9950.8 10005.1 10634.1 10856.6 10630.6 10863.2 10996.6 11524.7 11581.8 06:49:15 INFO - PID 3482 | -------- Summary: end -------- 06:49:15 INFO - PID 3482 | 06:49:16 INFO - TEST-INFO | 3482: exit 0 06:49:16 INFO - TEST-OK | dromaeo_css | took 1120336ms 06:49:16 INFO - TEST-START | kraken 06:49:16 INFO - operating with platform_type : linux_ 06:49:16 INFO - Initialising browser for kraken test... 06:49:16 INFO - TEST-INFO | started process 3927 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7Xf2nC/profile http://localhost:44893/getInfo.html) 06:49:20 INFO - PID 3927 | __metrics Screen width/height:1600/1200 06:49:20 INFO - PID 3927 | colorDepth:24 06:49:20 INFO - PID 3927 | Browser inner width/height: 1024/695 06:49:20 INFO - PID 3927 | __metrics 06:49:22 INFO - TEST-INFO | 3927: exit 0 06:49:22 INFO - Browser initialized. 06:49:22 INFO - Running cycle 1/1 for kraken test... 06:49:22 INFO - TEST-INFO | started process 4098 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7Xf2nC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:49:34 INFO - PID 4098 | RSS: Main: 158887936 06:49:34 INFO - PID 4098 | 06:49:36 INFO - PID 4098 | Cycle 1(1): loaded http://localhost:44893/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44893/tests/kraken/driver.html?testName=audio-beat-detection) 06:49:37 INFO - PID 4098 | RSS: Main: 163577856 06:49:37 INFO - PID 4098 | 06:49:40 INFO - PID 4098 | Cycle 1(1): loaded http://localhost:44893/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44893/tests/kraken/driver.html?testName=audio-dft) 06:49:41 INFO - PID 4098 | RSS: Main: 162562048 06:49:41 INFO - PID 4098 | 06:49:44 INFO - PID 4098 | Cycle 1(1): loaded http://localhost:44893/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44893/tests/kraken/driver.html?testName=audio-fft) 06:49:44 INFO - PID 4098 | RSS: Main: 158638080 06:49:44 INFO - PID 4098 | 06:49:46 INFO - PID 4098 | Cycle 1(1): loaded http://localhost:44893/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44893/tests/kraken/driver.html?testName=audio-oscillator) 06:49:47 INFO - PID 4098 | RSS: Main: 159469568 06:49:47 INFO - PID 4098 | 06:49:49 INFO - PID 4098 | Cycle 1(1): loaded http://localhost:44893/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44893/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:49:50 INFO - PID 4098 | RSS: Main: 160022528 06:49:50 INFO - PID 4098 | 06:49:53 INFO - PID 4098 | Cycle 1(1): loaded http://localhost:44893/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44893/tests/kraken/driver.html?testName=imaging-darkroom) 06:49:53 INFO - PID 4098 | RSS: Main: 164016128 06:49:53 INFO - PID 4098 | 06:49:57 INFO - PID 4098 | Cycle 1(1): loaded http://localhost:44893/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44893/tests/kraken/driver.html?testName=imaging-desaturate) 06:49:57 INFO - PID 4098 | RSS: Main: 163405824 06:49:57 INFO - PID 4098 | 06:50:00 INFO - PID 4098 | Cycle 1(1): loaded http://localhost:44893/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44893/tests/kraken/driver.html?testName=json-parse-financial) 06:50:01 INFO - PID 4098 | RSS: Main: 164519936 06:50:01 INFO - PID 4098 | 06:50:03 INFO - PID 4098 | Cycle 1(1): loaded http://localhost:44893/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44893/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:50:03 INFO - PID 4098 | RSS: Main: 164458496 06:50:03 INFO - PID 4098 | 06:50:05 INFO - PID 4098 | Cycle 1(1): loaded http://localhost:44893/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44893/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:50:06 INFO - PID 4098 | RSS: Main: 164409344 06:50:06 INFO - PID 4098 | 06:50:08 INFO - PID 4098 | Cycle 1(1): loaded http://localhost:44893/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44893/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:50:08 INFO - PID 4098 | RSS: Main: 164364288 06:50:08 INFO - PID 4098 | 06:50:11 INFO - PID 4098 | Cycle 1(1): loaded http://localhost:44893/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44893/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:50:12 INFO - PID 4098 | RSS: Main: 164528128 06:50:12 INFO - PID 4098 | 06:50:15 INFO - PID 4098 | Cycle 1(1): loaded http://localhost:44893/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44893/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:50:16 INFO - PID 4098 | RSS: Main: 164311040 06:50:16 INFO - PID 4098 | 06:50:18 INFO - PID 4098 | Cycle 1(1): loaded http://localhost:44893/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44893/tests/kraken/driver.html?testName=ai-astar) 06:50:18 INFO - PID 4098 | RSS: Main: 165781504 06:50:18 INFO - PID 4098 | 06:50:18 INFO - PID 4098 | __start_tp_report 06:50:18 INFO - PID 4098 | _x_x_mozilla_page_load 06:50:18 INFO - PID 4098 | _x_x_mozilla_page_load_details 06:50:18 INFO - PID 4098 | |i|pagename|runs| 06:50:18 INFO - PID 4098 | |0;ai-astar;104;113;112;112;112;112;112;111;111;111 06:50:18 INFO - PID 4098 | |1;audio-beat-detection;156;124;123;165;125;124;124;127;145;125 06:50:18 INFO - PID 4098 | |2;audio-dft;164;164;165;164;165;169;189;172;166;162 06:50:18 INFO - PID 4098 | |3;audio-fft;74;75;75;108;76;76;75;79;95;75 06:50:18 INFO - PID 4098 | |4;audio-oscillator;84;83;104;84;83;86;100;87;83;105 06:50:18 INFO - PID 4098 | |5;imaging-gaussian-blur;114;115;114;115;114;114;114;115;114;113 06:50:18 INFO - PID 4098 | |6;imaging-darkroom;150;150;150;153;149;152;150;150;150;150 06:50:18 INFO - PID 4098 | |7;imaging-desaturate;94;96;94;95;94;95;94;94;95;94 06:50:18 INFO - PID 4098 | |8;json-parse-financial;54;61;53;56;57;55;56;54;54;55 06:50:18 INFO - PID 4098 | |9;json-stringify-tinderbox;55;56;55;56;63;55;56;60;56;55 06:50:18 INFO - PID 4098 | |10;stanford-crypto-aes;84;82;81;83;82;82;84;83;81;82 06:50:18 INFO - PID 4098 | |11;stanford-crypto-ccm;140;139;134;134;136;145;132;138;226;133 06:50:18 INFO - PID 4098 | |12;stanford-crypto-pbkdf2;194;196;195;194;197;190;193;194;196;196 06:50:18 INFO - PID 4098 | |13;stanford-crypto-sha256-iterative;76;74;76;74;75;74;75;78;76;71 06:50:18 INFO - PID 4098 | __end_tp_report 06:50:18 INFO - PID 4098 | __start_cc_report 06:50:18 INFO - PID 4098 | _x_x_mozilla_cycle_collect,871 06:50:18 INFO - PID 4098 | __end_cc_report 06:50:18 INFO - PID 4098 | __startTimestamp1494597018374__endTimestamp 06:50:18 INFO - PID 4098 | 06:50:18 INFO - PID 4098 | ------- Summary: start ------- 06:50:18 INFO - PID 4098 | Number of tests: 14 06:50:18 INFO - PID 4098 | 06:50:18 INFO - PID 4098 | [#0] ai-astar Cycles:10 Average:111.00 Median:112.00 stddev:2.54 (2.3%) stddev-sans-first:0.67 06:50:18 INFO - PID 4098 | Values: 104.0 113.0 112.0 112.0 112.0 112.0 112.0 111.0 111.0 111.0 06:50:18 INFO - PID 4098 | 06:50:18 INFO - PID 4098 | [#1] audio-beat-detection Cycles:10 Average:133.80 Median:126.00 stddev:15.63 (12.4%) stddev-sans-first:14.36 06:50:18 INFO - PID 4098 | Values: 156.0 124.0 123.0 165.0 125.0 124.0 124.0 127.0 145.0 125.0 06:50:18 INFO - PID 4098 | 06:50:18 INFO - PID 4098 | [#2] audio-dft Cycles:10 Average:168.00 Median:165.50 stddev:7.92 (4.8%) stddev-sans-first:8.26 06:50:18 INFO - PID 4098 | Values: 164.0 164.0 165.0 164.0 165.0 169.0 189.0 172.0 166.0 162.0 06:50:18 INFO - PID 4098 | 06:50:18 INFO - PID 4098 | [#3] audio-fft Cycles:10 Average:80.80 Median:75.50 stddev:11.41 (15.1%) stddev-sans-first:11.83 06:50:18 INFO - PID 4098 | Values: 74.0 75.0 75.0 108.0 76.0 76.0 75.0 79.0 95.0 75.0 06:50:18 INFO - PID 4098 | 06:50:18 INFO - PID 4098 | [#4] audio-oscillator Cycles:10 Average:89.90 Median:83.50 stddev:9.22 (11.0%) stddev-sans-first:9.53 06:50:18 INFO - PID 4098 | Values: 84.0 83.0 104.0 84.0 83.0 86.0 100.0 87.0 83.0 105.0 06:50:18 INFO - PID 4098 | 06:50:18 INFO - PID 4098 | [#5] imaging-gaussian-blur Cycles:10 Average:114.20 Median:114.00 stddev:0.63 (0.6%) stddev-sans-first:0.67 06:50:18 INFO - PID 4098 | Values: 114.0 115.0 114.0 115.0 114.0 114.0 114.0 115.0 114.0 113.0 06:50:18 INFO - PID 4098 | 06:50:18 INFO - PID 4098 | [#6] imaging-darkroom Cycles:10 Average:150.40 Median:150.00 stddev:1.17 (0.8%) stddev-sans-first:1.24 06:50:18 INFO - PID 4098 | Values: 150.0 150.0 150.0 153.0 149.0 152.0 150.0 150.0 150.0 150.0 06:50:18 INFO - PID 4098 | 06:50:18 INFO - PID 4098 | [#7] imaging-desaturate Cycles:10 Average:94.50 Median:94.50 stddev:0.71 (0.7%) stddev-sans-first:0.73 06:50:18 INFO - PID 4098 | Values: 94.0 96.0 94.0 95.0 94.0 95.0 94.0 94.0 95.0 94.0 06:50:18 INFO - PID 4098 | 06:50:18 INFO - PID 4098 | [#8] json-parse-financial Cycles:10 Average:55.50 Median:55.50 stddev:2.27 (4.1%) stddev-sans-first:2.35 06:50:18 INFO - PID 4098 | Values: 54.0 61.0 53.0 56.0 57.0 55.0 56.0 54.0 54.0 55.0 06:50:18 INFO - PID 4098 | 06:50:18 INFO - PID 4098 | [#9] json-stringify-tinderbox Cycles:10 Average:56.70 Median:56.00 stddev:2.67 (4.8%) stddev-sans-first:2.76 06:50:18 INFO - PID 4098 | Values: 55.0 56.0 55.0 56.0 63.0 55.0 56.0 60.0 56.0 55.0 06:50:18 INFO - PID 4098 | 06:50:18 INFO - PID 4098 | [#10] stanford-crypto-aes Cycles:10 Average:82.40 Median:82.50 stddev:1.07 (1.3%) stddev-sans-first:0.97 06:50:18 INFO - PID 4098 | Values: 84.0 82.0 81.0 83.0 82.0 82.0 84.0 83.0 81.0 82.0 06:50:18 INFO - PID 4098 | 06:50:18 INFO - PID 4098 | [#11] stanford-crypto-ccm Cycles:10 Average:145.70 Median:138.50 stddev:28.48 (20.6%) stddev-sans-first:30.14 06:50:18 INFO - PID 4098 | Values: 140.0 139.0 134.0 134.0 136.0 145.0 132.0 138.0 226.0 133.0 06:50:18 INFO - PID 4098 | 06:50:18 INFO - PID 4098 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:194.50 Median:195.50 stddev:2.01 (1.0%) stddev-sans-first:2.13 06:50:18 INFO - PID 4098 | Values: 194.0 196.0 195.0 194.0 197.0 190.0 193.0 194.0 196.0 196.0 06:50:18 INFO - PID 4098 | 06:50:18 INFO - PID 4098 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.90 Median:75.50 stddev:1.85 (2.5%) stddev-sans-first:1.92 06:50:18 INFO - PID 4098 | Values: 76.0 74.0 76.0 74.0 75.0 74.0 75.0 78.0 76.0 71.0 06:50:18 INFO - PID 4098 | -------- Summary: end -------- 06:50:18 INFO - PID 4098 | 06:50:19 INFO - TEST-INFO | 4098: exit 0 06:50:19 INFO - TEST-OK | kraken | took 62962ms 06:50:19 INFO - SUITE-END | took 1183s 06:50:20 INFO - Completed test suite (00:19:43) 06:50:20 INFO - javascript benchmark 06:50:20 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6746.49656390667, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2745.7940654450913, 2751.3534319434943, 2774.3202915285756, 2787.6376071110753, 2788.093869492415, 5271.73641317934, 5289.444608316125, 5294.708791016493, 5295.841124766263, 5320.0, 5289.761960711768, 5305.230741542474, 5369.463053694629, 5404.7838086476595, 5410.594205434599, 4402.273624851911, 4738.47876733559, 4750.952490475085, 4760.785764640582, 4780.976095119519, 4805.759712014403, 4855.56299933006, 4856.830010949618, 4884.560389564938, 4908.460069392364, 4667.393238878924, 4680.461746899116, 4738.64460165489, 4774.594159496447, 4781.8087276508895, 4729.905401891977, 4736.147493451177, 4741.170295198326, 4767.928481072787, 4783.952160478386, 4672.252439609681, 4681.274402467623, 4709.175894218532, 4720.150372932871, 4733.928991065137, 5206.739663016872, 5214.296070030536, 5241.816536421207, 5245.186996015624, 5262.23697563855, 5743.0811070228565, 5802.854928626776, 5848.122781582754, 5860.062390017577, 5875.676837773921, 5778.3066032076, 5781.4507621775865, 5784.479396854304, 5789.942100579025, 5816.592838501307, 5282.075636763551, 5312.521873031368, 5352.277442545206, 5353.491418315254, 5355.651882627617, 5927.1405646181065, 5933.169356290123, 6000.519958403317, 6017.759289628453, 6064.878702425926, 5556.638818476786, 5585.497305242548, 5634.915476267859, 5675.290588676416, 5716.5140963017775, 5774.2782152230975, 5787.479126878601, 5817.476427121579, 5844.88310233793, 5883.852903677443, 5810.0994345875615, 5816.0, 5816.185733997244, 5824.097264923944, 5828.854278643068, 5645.971770141123, 5649.0396632572565, 5752.453516915886, 5756.5682573807135, 5768.3654797972185, 4889.608831293488, 4892.290617860462, 4913.343764637881, 4927.704337739747, 4942.431620363633, 4152.522459917088, 4155.210510003089, 4186.832526698959, 4187.874363769091, 4223.619874211275, 4761.190597598416, 4820.276958456259, 4825.30033145192, 4827.927581086286, 4995.500449954975, 5736.541076713853, 5774.162746401748, 5789.507891829157, 5821.27234095738, 5832.912506312408, 4933.679310844784, 4976.975115124401, 4997.0505603935135, 5012.523810238022, 5012.573931215888, 5211.530962213419, 5222.92165617516, 5229.555487783581, 5243.501867322599, 5270.1040823060175, 5380.865478362915, 5381.677099373972, 5386.59600529954, 5393.379761327341, 5398.973005134949, 5628.662280263197, 5702.857428564319, 5718.885622287614, 5833.620814647034, 5877.941220587911, 5246.947530524646, 5261.421243663118, 5263.973680131575, 5265.473452654704, 5268.394134674408, 5552.0, 5656.208130861601, 5721.971390143022, 5772.884542309214, 5775.162601422686, 5860.765569377348, 5880.117982302689, 5883.646981181143, 5887.381824908323, 5888.587798854211, 5622.016147174147, 5641.210230567642, 5642.802501912413, 5649.745761440663, 5667.3765885753355, 5620.156976453564, 5620.4660557247, 5621.437856214346, 5625.46558076982, 5631.352394474688, 5404.378496472956, 5448.863778405572, 5465.152901300305, 5472.2065300531995, 5525.557955363642, 5617.466340697627, 5628.155776633538, 5631.746571404215, 5650.23721797552, 5664.037113690765, 5406.107992181246, 5423.810166644149, 5457.7271136443815, 5480.177973304037, 5512.3660779010925], "value": 5228.886092276523, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [666.883295423301, 683.5522732610139, 1040.07433384288, 1050.7215587869216, 1146.3351256271364, 31383.372332553336, 34439.13902152445, 34807.30385392291, 34811.47782783254, 34882.47676284858, 31831.68168318316, 32000.0, 32075.67924320756, 32146.517802232986, 32181.839090804515, 6358.523110766711, 6528.183977002875, 6637.933620663804, 6643.667816609174, 7107.431405487574, 7056.364927156555, 7112.217656057829, 7131.89302160468, 7135.143782746052, 7175.928240717578, 7156.320149585781, 7192.957021231919, 7198.676059577331, 7201.89197162043, 7205.423566114699, 7172.0, 7179.1026121734785, 7211.170715367747, 7225.819354516153, 7235.095613048369, 7031.261717519638, 7069.469789765788, 7096.325849044384, 7101.644917754092, 7111.751088711922, 32614.347713045605, 32816.835915820506, 32835.17912052194, 33045.50431743526, 33089.6691033089, 3017.7585793136495, 3058.5565093061605, 3080.183751305906, 3080.768942329334, 3091.180837078176, 24506.877465612557, 24642.383940401454, 24720.876395617906, 24733.0, 24843.87578062116, 3144.4811606085195, 3151.8424078796197, 3164.9525257121163, 3194.952075718866, 3197.9680203197904, 138786.0, 138821.30589347088, 139610.3019484906, 139759.0, 140016.0, 38832.80583597064, 40165.59834401677, 40741.59258407378, 41027.179456410704, 41032.589674103474, 42263.15473690509, 42553.148937021084, 42616.78691606522, 42636.3604545932, 42767.35848962268, 13065.281409522377, 13245.072844900957, 13272.13731107475, 13298.0, 13308.733825323632, 10510.316829406063, 10516.842247366296, 10553.894461055444, 10576.947115264375, 10641.467926603638, 12942.482300708054, 13085.476580936656, 13089.934550327187, 13145.34273286351, 13248.138870973356, 5163.741812909415, 5191.610629202825, 5319.547838433699, 5322.228276899906, 5420.24116623673, 868.9782755431165, 879.0594064351083, 887.6316328723636, 889.2930120554175, 916.9358144929924, 19260.903695481713, 20195.899020504803, 20636.27773027937, 20763.0, 20794.584108317747, 954.4988880837616, 962.9133377996014, 988.0564061321421, 988.1600639456548, 1007.2999265510547, 10406.531706073094, 10555.894441055645, 10752.677419677266, 10816.945915270531, 10836.945815270874, 172480.0, 173983.0, 174415.12792435958, 174469.0, 174870.0, 40965.59034409618, 41371.58628413677, 41676.37485437721, 41772.79113604473, 41881.79059104746, 1194.8625908020688, 1232.950681972729, 1238.7646347194004, 1239.0335538280156, 1247.7878760610718, 18770.530736731693, 19237.0, 20331.08510117078, 20403.59192816165, 20630.17479300811, 30132.397352052398, 30268.0, 30333.0, 30368.544471832498, 30404.847975759978, 141299.0, 142136.28931855274, 142243.0, 142348.0, 142429.28785356006, 29558.704412955594, 29690.70309296966, 30049.849750751106, 30808.075757727303, 31184.37631247317, 36268.45597316095, 37344.253114938096, 37644.81177594094, 37650.0, 38120.0, 27843.303917401416, 28111.0, 28353.71646283593, 28625.14124576266, 28899.422011560073, 27910.3022424441, 27979.160625181277, 28555.857220713762, 29638.259043524085, 29744.553831692974, 32026.19934501563, 32043.359132816746, 32095.518567221978, 32450.188745281557, 32456.350872981937, 25872.611910820975, 26820.8658956704, 27233.31916702098, 27636.585451217845, 28451.146465606063, 19977.400677979684, 22243.22148724787, 22480.662790057835, 22696.773032270128, 22766.544669106857], "value": 14597.55361679572, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [412.9917401651969, 418.59396385506057, 422.5415424264673, 434.1729006243106, 439.2576545637872, 12662.366881655926, 17108.74336884948, 17688.38090666827, 17793.911030444844, 17797.0, 18227.453176404728, 18444.907775461103, 18453.16960736767, 18526.0, 18603.976781277026, 5264.6051546134, 5277.340332458442, 5487.6158668893195, 5488.9725551372185, 5522.723863806814, 5364.168553874156, 5442.482964118402, 5468.72656367182, 5468.9726551367385, 5472.616916815825, 5319.946800532003, 5377.946220537784, 5395.460453954613, 5459.481349271813, 5486.039943009977, 5399.19012148177, 5400.108982017962, 5445.019896418643, 5446.809361672343, 5447.972760136214, 4760.738159401231, 4905.975470122627, 4932.2108462646165, 4935.383077115361, 4989.101961646902, 20229.494262643406, 20945.0, 20969.370918872304, 21024.789752102435, 21117.47206319839, 1660.7342825147919, 1691.2812054876752, 1705.1048199695135, 1715.382462313566, 1719.423992962359, 13971.930140349234, 14170.0, 14454.783178252335, 14457.493987710379, 14672.19302938338, 2060.9793902060937, 2082.03185518733, 2128.98935505323, 2130.5632345369318, 2143.9892800536054, 75567.62216188884, 76071.61964190143, 77345.61327193385, 95504.52247738786, 98753.0124698751, 10885.86337191862, 11064.778704425866, 11108.000279974842, 11247.437628118561, 11362.659120226406, 15387.0, 15452.845471545366, 15496.922515387576, 15559.14424706652, 33930.66069339324, 8837.204651581389, 8994.370394072483, 9070.86393704095, 9271.490068046187, 9311.906880931105, 7306.7077316906725, 7383.15093764224, 7422.851542969111, 7506.737264195727, 7566.9621651892485, 9150.588223529958, 9438.0, 9611.327207095575, 9622.9037709622, 9717.271204659537, 3683.2633473305445, 3741.3639681254253, 3837.4503584184517, 4082.81627326771, 4111.876643700693, 846.585173265108, 862.8162081917703, 865.5412631305418, 880.7709995401242, 892.5091199840062, 16360.509184724477, 16789.16054197285, 16959.830401696072, 17086.40197593078, 17549.385771497935, 862.3403096631082, 869.6695255802755, 879.89881163667, 880.335346813152, 897.3001059173855, 9203.309751768644, 9291.58187881547, 9561.665341713007, 9569.61721531145, 9590.856137157949, 343763.0, 345902.0, 348148.0, 350352.0, 355266.0, 68851.31148688449, 69232.0, 70479.0, 71137.64431177812, 72028.27971720215, 1083.252555736555, 1088.5863371918779, 1128.9322640641587, 1133.0255979857316, 1133.2463911498926, 16919.23863426124, 17147.399841005506, 17554.38559650406, 17885.552861178054, 18229.45311640653, 36658.26683466262, 37664.0, 38244.23511529809, 38346.0, 39058.0, 46245.76877115593, 47122.29316560323, 48072.7596362016, 48137.0, 48217.517824821305, 8253.711120110767, 8292.709755158541, 8355.289800367036, 8527.616257268313, 8600.0, 12070.517179312728, 12105.394730263275, 12231.877681223074, 12329.630111096682, 12791.296478693761, 10097.192224621866, 10495.422751748727, 10612.575496980344, 10781.838272425763, 10914.29057111317, 9410.10603992647, 9419.246460283299, 9536.427814331162, 9538.523073846141, 9724.95137524308, 10545.683629491128, 10551.736206594896, 10711.625093121704, 10787.352758834495, 10850.348979061282, 8258.545779981918, 8411.495310281403, 8435.198656127657, 8505.829883402173, 8723.956380218313, 10272.126869215901, 10310.226732995205, 10423.843642345219, 10470.738231543968, 10544.89455105439], "value": 9054.350450780408, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1193.4271549656164, 1249.843769528809, 1255.7111864271217, 1259.1374908187886, 1260.5651050387612, 10107.241956853228, 10164.898351016487, 10405.063544281013, 10517.526711297991, 10574.841377379336, 10541.209409294315, 10709.518071686773, 10712.839307410375, 10789.730256743585, 10816.837747433776, 2278.4303924018955, 2284.6915666385075, 2296.0, 2299.586074506588, 2304.942376440594, 2078.9792102079014, 2157.3959291398432, 2157.5253444242244, 2159.6220661384273, 2164.6428339323993, 2127.957440851182, 2136.423165745248, 2166.945826354338, 2170.934871953844, 2172.7827217278304, 2183.9890800546054, 2224.688543603889, 2229.587526307638, 2240.2159244264376, 2243.495213576932, 2086.3428020173596, 2112.324056301984, 2149.0866381787678, 2241.42843574889, 2241.484458574537, 10237.948810255975, 10271.589136434608, 10315.484225788681, 10325.019123183285, 10330.12193963514, 5465.562754979632, 5611.915821262684, 5649.152627105967, 5694.145878118274, 5709.400512946122, 3308.4375656138513, 3331.466965285567, 3421.7775844570024, 3430.8627654893776, 3431.7769344992494, 1117.3631030312724, 1129.5312445335258, 1146.9655910322704, 1181.8699943006263, 1188.6255829413794, 14980.0, 15050.849491505054, 15086.698266034618, 15104.622384440367, 15155.772663410058, 4556.3621093047, 4759.619230461555, 5003.624728145403, 5005.624578156653, 5016.1723315653235, 10778.514966826511, 10778.622748203776, 10788.46057697112, 10796.946015269874, 10804.945975270231, 5569.443055694479, 5581.665100094007, 5588.720563971867, 5592.748326325325, 5596.244506991586, 4944.134776414113, 5144.0, 5150.793968241228, 5260.368755749258, 5319.760610772524, 3793.0896584819443, 3837.865674701372, 3879.282332768447, 3953.1698343347643, 3954.387070004154, 1118.9048930840806, 1133.1727838677812, 1134.7163209197702, 1136.9886301137049, 1145.2956431794387, 683.6308393467472, 705.340506626306, 707.6815433055043, 722.7181399254295, 723.2731105239201, 5344.385395679469, 5452.073147564924, 5469.124940009579, 5515.062439385314, 5560.944390556043, 504.89144833860894, 525.1859617592715, 530.8805518758326, 531.5030446532504, 533.1496263459776, 3119.313750974782, 3747.737658363943, 3767.585565587783, 3831.9042023949623, 3895.337792575269, 12774.872251277367, 12879.742405151845, 13046.282454464907, 13167.67080822987, 13385.732285354434, 12520.0, 12829.61511154667, 12922.741545169043, 12997.610071697864, 13014.15407998496, 7468.775936721907, 7486.663100160506, 7623.0, 7636.732714354971, 7696.1144519591935, 5489.34127904638, 5580.497755202051, 5581.860453488695, 5625.296837895263, 5741.483266506035, 11491.310521368745, 11497.82753258685, 11598.594049208237, 11641.708957275798, 11669.533218671158, 11764.941175294069, 11861.0, 11980.944859060884, 11991.580294689644, 12006.819897701367, 6999.895001574879, 7055.964720176572, 7112.857742845011, 8180.263776260165, 8493.193146651058, 9800.460974646463, 9873.901260987299, 9916.0, 9945.552450139616, 9965.202783777135, 8119.5534245617055, 8297.585120743817, 8366.958165209135, 8500.70247541333, 8531.573421329032, 7815.0, 7935.761927142195, 8007.079185893696, 8031.759047228593, 8065.717699880476, 6853.931460685529, 6878.69045892926, 6923.411510021705, 6973.895391569029, 6978.232394436709, 5138.794448222029, 5206.505381988705, 5257.8159764408065, 5369.409364969928, 5489.066858633962, 5414.83755487336, 5459.754311055933, 5462.399136095106, 5593.524550413261, 5647.3787883333625], "value": 4664.393697984419, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [372.93846515324975, 381.6812961177417, 384.66726281766273, 396.3104198694271, 402.80262671291075, 5319.840404787853, 5557.916631250535, 5624.147458990589, 5662.433756624336, 5678.971605141974, 5324.494173053564, 5430.429804870491, 5465.426130256315, 5506.174073888918, 5511.476409741068, 4344.283193273114, 4345.630621397185, 4377.846775362863, 4378.10248898975, 4392.945693033681, 4273.312041743509, 4354.629856462205, 4382.430284063067, 4383.211022016036, 4385.693001489897, 4321.006168581228, 4322.935155972663, 4323.659665503688, 4332.696711230215, 4341.479022517302, 4316.6762492813, 4341.979634785823, 4347.847825326098, 4364.956350436519, 4365.3233748768835, 3904.2581909437117, 3947.9735268830023, 3957.3972541120893, 3964.365701487748, 3970.285348637244, 5371.167469042305, 5380.408155102936, 5384.0, 5390.1375779875425, 5424.728763561806, 5170.379554453452, 5177.948220517822, 5202.791888324463, 5204.453532379083, 5210.879660872893, 5653.378128405872, 5868.853278668024, 5872.9428702833475, 5875.0, 5911.822645320647, 4455.465344158722, 4464.0, 4472.575105364985, 4478.0, 4483.529229430928, 6009.729562169713, 6162.044883043135, 6176.7838125665385, 6199.721012554401, 6222.657753823538, 4134.028503301722, 4153.418521407006, 4158.0, 4158.875233742992, 4168.979155104265, 4215.957840421618, 4217.894552636148, 4220.134872351161, 4226.76752778594, 4233.618974292329, 4755.120302744003, 4812.157872372391, 4858.46556878743, 4871.756412179377, 4878.0, 5845.269341332333, 5850.5612079094235, 5883.146943693226, 5883.794067207627, 5887.116932460165, 1447.3269929482842, 1455.8544145585568, 1456.774199999002, 1459.9854001459848, 1460.0874453466583, 961.0581630002637, 963.5182408795603, 980.6518685866557, 982.8181786369545, 987.0080569028081, 5120.411152717411, 5149.201873709581, 5155.845324640267, 5161.81933632321, 5211.348581427322, 6140.815775526741, 6157.753689852445, 6158.291796443466, 6175.2589689237575, 6181.35095814933, 5020.422651395063, 5113.079645663816, 5147.974260128675, 5148.382194136652, 5190.870228244324, 3221.4040402525607, 3258.4949332853444, 3260.402402822647, 3272.296456261915, 3279.9344013119603, 5515.834524964257, 5624.29696287964, 5627.803026894039, 5638.774449022075, 5643.379228284885, 6189.102580125857, 6240.968795155995, 6268.247810262797, 6287.842803929847, 6303.2751233607805, 5594.049011668027, 5601.691906945076, 5605.981846535244, 5611.438856114356, 5639.802606908738, 5947.91078133837, 6010.519158467225, 6025.444987457421, 6116.602420842631, 6118.418750218722, 5886.3223981165165, 5938.762449501972, 5982.341942386421, 5998.760049598141, 6015.338312785502, 5626.381098079126, 5636.689982051026, 5667.178259152317, 5682.176084467646, 5706.857328566819, 4162.125953549788, 4188.821812657462, 4192.3082691355585, 4193.308104162779, 4203.285441474895, 6044.24446944132, 6145.446909778141, 6157.568970172045, 6207.6275423474735, 6214.477453024038, 5941.22764040672, 5946.881062378641, 5953.523718102455, 5957.582969192288, 5964.677441911587, 5797.536197104306, 5917.467427931507, 5922.970385148046, 5948.4421698669985, 5959.642421454727, 5756.827295181151, 5780.364159942319, 5794.101914203306, 5797.507211887037, 5818.796342128006, 5967.6419414835245, 6005.969970150121, 6007.87984240304, 6017.338092809699, 6024.518038556817, 5671.234383358194, 5745.770169193185, 5780.421957804186, 5789.189513468202, 5813.186153938367], "value": 4441.875727137728, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [736.7163641997831, 738.0405472885254, 747.0661672908864, 751.4852326156583, 754.479409207647, 10525.421101839414, 10934.617288394908, 12309.322987235699, 13142.0, 13221.471141154354, 14551.345189466472, 14749.48376806812, 15060.924695376509, 15070.849291507082, 15144.242787860618, 868.4962721621476, 893.2184338703635, 898.0480690468092, 899.7390756680555, 901.3375169250595, 906.0848542971613, 911.08436021798, 911.5943405184695, 911.9589618467152, 913.3332667152982, 952.8904176019743, 958.3291695812959, 961.1445813226235, 961.9903800961971, 961.9903800962006, 947.0198344713189, 948.3219498058921, 948.7343543807744, 956.1490273656451, 958.5494817435829, 695.8747425463415, 697.3863000559526, 700.3731660164125, 702.4696354252507, 703.6305939381814, 12265.202761820454, 12279.815802762965, 12835.87164128356, 14450.0, 14553.490627827976, 13647.658808529766, 14056.0, 14131.505397311148, 14260.572182834532, 14317.49888753899, 12379.133460657758, 12522.499100035988, 12539.498420063186, 12624.053196010336, 12669.239845609292, 2882.26502241927, 2889.8555072246304, 2890.1185138532737, 2905.273681579605, 2912.6504819421593, 65483.672581637264, 65844.3415565843, 66311.66844165797, 66985.3301466984, 68098.9785153223, 8935.597898094602, 9001.324900632479, 9097.772555686028, 9187.448753074703, 9264.95367523158, 17226.138693065295, 17247.223874925658, 17339.0, 17368.218430170673, 17411.0, 5671.177679236487, 5750.827475175752, 5774.566907481955, 5791.623544469596, 5832.650040997553, 2820.139857343489, 2867.44084903446, 2883.3224192314788, 2884.4952133376573, 2886.0764555342507, 3248.8862889799216, 3289.292802047571, 3303.620083690358, 3323.3851737428654, 3333.4999750037205, 655.3937607712846, 658.1739916404881, 659.4987809264993, 666.506784979112, 667.0328024364691, 550.4522999615408, 552.1524459954031, 554.9056660367747, 562.8002059268982, 572.7079189613327, 9317.767055823522, 9472.573734181979, 9661.951690241503, 9789.853152202722, 9820.607175713034, 560.6467925207094, 568.6190252530814, 570.0650932470669, 578.2194038048684, 589.0545674192945, 4179.477565304337, 4329.631981281626, 4350.456192975878, 4360.389545463638, 4520.932186017212, 62019.069713954326, 62107.378926211066, 62557.0, 63172.0, 65193.0, 54554.454455454936, 55232.72383638056, 56215.71892140513, 56365.71817140888, 56967.715161424756, 50656.24015639768, 51562.74218628958, 52368.47631523712, 53475.46524534705, 53846.7307663467, 8541.359398045295, 8816.559172041501, 8982.820343593223, 9163.908360916572, 9219.44683319003, 25186.37034074163, 25638.0, 26198.607020895084, 27968.58047129254, 28584.0, 42834.571654283056, 44501.0, 44728.32907506325, 45309.32036019397, 46349.14603415826, 13598.388072536958, 13848.376823042785, 14111.788323174955, 14129.717405651623, 14284.642883927985, 14248.358823852745, 14957.551273461813, 15440.536783896501, 15443.382264709286, 15544.766828497808, 14344.354504047134, 14449.566513004627, 14536.491222807152, 14544.272786360429, 14819.851801481847, 12895.355232238539, 13011.0, 13049.739005220032, 13097.607071787861, 13267.270300133585, 13332.466701332227, 13335.933125349755, 13360.532381366605, 13497.392617332047, 13599.320033998458, 9908.35595686278, 9950.800983980134, 10005.099541041342, 10634.149268058381, 10856.620018299322, 10630.618019657395, 10863.239573229797, 10996.615118471134, 11524.711882203012, 11581.768364632491], "value": 6584.613614574492, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1552.3000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 113.0, 112.0, 112.0, 112.0, 112.0, 112.0, 111.0, 111.0, 111.0], "value": 111.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 124.0, 123.0, 165.0, 125.0, 124.0, 124.0, 127.0, 145.0, 125.0], "value": 133.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 164.0, 165.0, 164.0, 165.0, 169.0, 189.0, 172.0, 166.0, 162.0], "value": 168.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 75.0, 108.0, 76.0, 76.0, 75.0, 79.0, 95.0, 75.0], "value": 80.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 104.0, 84.0, 83.0, 86.0, 100.0, 87.0, 83.0, 105.0], "value": 89.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 115.0, 114.0, 115.0, 114.0, 114.0, 114.0, 115.0, 114.0, 113.0], "value": 114.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 150.0, 150.0, 153.0, 149.0, 152.0, 150.0, 150.0, 150.0, 150.0], "value": 150.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 96.0, 94.0, 95.0, 94.0, 95.0, 94.0, 94.0, 95.0, 94.0], "value": 94.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 61.0, 53.0, 56.0, 57.0, 55.0, 56.0, 54.0, 54.0, 55.0], "value": 55.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 56.0, 55.0, 56.0, 63.0, 55.0, 56.0, 60.0, 56.0, 55.0], "value": 56.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 82.0, 81.0, 83.0, 82.0, 82.0, 84.0, 83.0, 81.0, 82.0], "value": 82.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 139.0, 134.0, 134.0, 136.0, 145.0, 132.0, 138.0, 226.0, 133.0], "value": 145.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [194.0, 196.0, 195.0, 194.0, 197.0, 190.0, 193.0, 194.0, 196.0, 196.0], "value": 194.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 74.0, 76.0, 74.0, 75.0, 74.0, 75.0, 78.0, 76.0, 71.0], "value": 74.9, "unit": "score"}]}]} 06:50:20 INFO - Return code: 0 06:50:20 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:50:20 INFO - # TBPL SUCCESS # 06:50:20 INFO - Running post-action listener: _resource_record_post_action 06:50:20 INFO - [mozharness: 2017-05-12 13:50:20.186792Z] Finished run-tests step (success) 06:50:20 INFO - Running post-run listener: _resource_record_post_run 06:50:20 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 10604544; Write bytes: 377876480; Read time: 2924; Write time: 205876 06:50:20 INFO - TinderboxPrint: CPU usage
13.3% 06:50:20 INFO - TinderboxPrint: I/O read bytes / time
10,604,544 / 2,924 06:50:20 INFO - TinderboxPrint: I/O write bytes / time
377,876,480 / 205,876 06:50:20 INFO - TinderboxPrint: CPU idle
8,303.7 (86.7%) 06:50:20 INFO - TinderboxPrint: CPU user
1,214.4 (12.7%) 06:50:20 INFO - TinderboxPrint: Swap in / out
0 / 0 06:50:20 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 114012160; Read time: 0; Write time: 89768 06:50:20 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 8261632; Write bytes: 263864320; Read time: 2376; Write time: 116108 06:50:20 INFO - Running post-run listener: _upload_blobber_files 06:50:20 INFO - Blob upload gear active. 06:50:20 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:50:20 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 06:50:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:50:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:50:21 INFO - (blobuploader) - INFO - Open directory for files ... 06:50:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 06:50:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:50:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:50:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 06:50:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:50:22 INFO - (blobuploader) - INFO - Done attempting. 06:50:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 06:50:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:50:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:50:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 06:50:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:50:22 INFO - (blobuploader) - INFO - Done attempting. 06:50:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:50:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:50:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:50:26 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:50:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:50:26 INFO - (blobuploader) - INFO - Done attempting. 06:50:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 06:50:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:50:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:50:27 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 06:50:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:50:27 INFO - (blobuploader) - INFO - Done attempting. 06:50:27 INFO - (blobuploader) - INFO - Iteration through files over. 06:50:27 INFO - Return code: 0 06:50:27 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:50:27 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:50:27 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/83f90b92be9cfc29a677abdb15ad1dd9955ea1ce4a1d21c583855cd7c75149ba9536ab6aa4fc510ca5796dc82ef68f2e9abe03d64c8551d3329b277c1cebe6d2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/444deb7ecdc8695292cc6ea40ff0840d364f210856585224146acd7f17b60d2459a10267fe80e5c9f11e2a3d5ae089b6b4ab1ead85ef06c0933e4cdcfd934314", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c1f4c2510c963aabb244a27394ca40da825aec03f1c15d1d71a6ed51d1893af1d6202d9b149083f327c53e1f21285bc910bf06a58cafde38eadfe29b844ab70d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2269669366822d1824fe47c93cd224f7651e17e0f950f9aa8a45a69d28b714fc93d17dae2330f437c0e910dd019e82fac6d03cdb6d769806ae13d63c990fe1b3"} 06:50:27 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:50:27 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:50:27 INFO - Contents: 06:50:27 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/83f90b92be9cfc29a677abdb15ad1dd9955ea1ce4a1d21c583855cd7c75149ba9536ab6aa4fc510ca5796dc82ef68f2e9abe03d64c8551d3329b277c1cebe6d2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/444deb7ecdc8695292cc6ea40ff0840d364f210856585224146acd7f17b60d2459a10267fe80e5c9f11e2a3d5ae089b6b4ab1ead85ef06c0933e4cdcfd934314", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c1f4c2510c963aabb244a27394ca40da825aec03f1c15d1d71a6ed51d1893af1d6202d9b149083f327c53e1f21285bc910bf06a58cafde38eadfe29b844ab70d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2269669366822d1824fe47c93cd224f7651e17e0f950f9aa8a45a69d28b714fc93d17dae2330f437c0e910dd019e82fac6d03cdb6d769806ae13d63c990fe1b3"} 06:50:27 INFO - Running post-run listener: copy_logs_to_upload_dir 06:50:27 INFO - Copying logs to upload dir... 06:50:27 INFO - mkdir: /builds/slave/test/build/upload/logs 06:50:27 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1257.370589 ========= master_lag: 0.47 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2017-05-12 06:50:27.085795) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-12 06:50:27.088988) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1494595767.231991-1047568226 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/83f90b92be9cfc29a677abdb15ad1dd9955ea1ce4a1d21c583855cd7c75149ba9536ab6aa4fc510ca5796dc82ef68f2e9abe03d64c8551d3329b277c1cebe6d2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/444deb7ecdc8695292cc6ea40ff0840d364f210856585224146acd7f17b60d2459a10267fe80e5c9f11e2a3d5ae089b6b4ab1ead85ef06c0933e4cdcfd934314", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c1f4c2510c963aabb244a27394ca40da825aec03f1c15d1d71a6ed51d1893af1d6202d9b149083f327c53e1f21285bc910bf06a58cafde38eadfe29b844ab70d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2269669366822d1824fe47c93cd224f7651e17e0f950f9aa8a45a69d28b714fc93d17dae2330f437c0e910dd019e82fac6d03cdb6d769806ae13d63c990fe1b3"} build_url:https://queue.taskcluster.net/v1/task/Nexm6u4PQnSQIB9strk64w/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011265 build_url: 'https://queue.taskcluster.net/v1/task/Nexm6u4PQnSQIB9strk64w/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/83f90b92be9cfc29a677abdb15ad1dd9955ea1ce4a1d21c583855cd7c75149ba9536ab6aa4fc510ca5796dc82ef68f2e9abe03d64c8551d3329b277c1cebe6d2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/444deb7ecdc8695292cc6ea40ff0840d364f210856585224146acd7f17b60d2459a10267fe80e5c9f11e2a3d5ae089b6b4ab1ead85ef06c0933e4cdcfd934314", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c1f4c2510c963aabb244a27394ca40da825aec03f1c15d1d71a6ed51d1893af1d6202d9b149083f327c53e1f21285bc910bf06a58cafde38eadfe29b844ab70d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2269669366822d1824fe47c93cd224f7651e17e0f950f9aa8a45a69d28b714fc93d17dae2330f437c0e910dd019e82fac6d03cdb6d769806ae13d63c990fe1b3"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-12 06:50:27.117345) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-12 06:50:27.117708) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1494595767.231991-1047568226 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004374 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-12 06:50:27.198501) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-12 06:50:27.201842) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-12 06:50:27.202173) ========= ========= Total master_lag: 0.64 =========