builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-008 starttime: 1495209865.89 results: success (0) revision: 1ea1b40c2679da341d50d27226c61033bac06711 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-19 09:04:25.885503) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-19 09:04:25.885979) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-19 09:04:25.886260) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-19 09:04:25.902047) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-19 09:04:25.902309) ========= 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=32c5991c409366f7fec8a718000001d2-1495209716.159476-1249182171 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-19 09:04:27-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 77.2M=0s 2017-05-19 09:04:27 (77.2 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.114477 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-19 09:04:26.032845) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-19 09:04:26.033172) ========= 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=32c5991c409366f7fec8a718000001d2-1495209716.159476-1249182171 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019242 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-19 09:04:26.082180) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-19 09:04:26.082493) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 1ea1b40c2679da341d50d27226c61033bac06711 --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 1ea1b40c2679da341d50d27226c61033bac06711 --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=32c5991c409366f7fec8a718000001d2-1495209716.159476-1249182171 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-19 09:04:27,367 truncating revision to first 12 chars 2017-05-19 09:04:27,367 Setting DEBUG logging. 2017-05-19 09:04:27,367 attempt 1/10 2017-05-19 09:04:27,367 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/1ea1b40c2679?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-19 09:04:27,837 unpacking tar archive at: mozilla-central-1ea1b40c2679/testing/mozharness/ program finished with exit code 0 elapsedTime=0.882588 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-19 09:04:26.980161) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-19 09:04:26.980467) ========= script_repo_revision: 1ea1b40c2679da341d50d27226c61033bac06711 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-19 09:04:26.983907) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-19 09:04:26.984182) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-19 09:04:26.993789) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2017-05-19 09:04:26.994058) ========= /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=32c5991c409366f7fec8a718000001d2-1495209716.159476-1249182171 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:04:28 INFO - MultiFileLogger online at 20170519 09:04:28 in /builds/slave/test 09:04:28 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 09:04:28 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:04:28 INFO - {'append_to_log': False, 09:04:28 INFO - 'base_work_dir': '/builds/slave/test', 09:04:28 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 09:04:28 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:04:28 INFO - 'branch': 'Firefox-Non-PGO', 09:04:28 INFO - 'buildbot_json_path': 'buildprops.json', 09:04:28 INFO - 'config_files': ('talos/linux_config.py',), 09:04:28 INFO - 'default_actions': ('clobber', 09:04:28 INFO - 'read-buildbot-config', 09:04:28 INFO - 'download-and-extract', 09:04:28 INFO - 'populate-webroot', 09:04:28 INFO - 'create-virtualenv', 09:04:28 INFO - 'install', 09:04:28 INFO - 'run-tests'), 09:04:28 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:04:28 INFO - 'download_minidump_stackwalk': True, 09:04:28 INFO - 'download_symbols': 'ondemand', 09:04:28 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:04:28 INFO - 'tooltool.py': '/tools/tooltool.py', 09:04:28 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:04:28 INFO - '/tools/misc-python/virtualenv.py')}, 09:04:28 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:04:28 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:04:28 INFO - 'gecko_profile': False, 09:04:28 INFO - 'gecko_profile_interval': 0, 09:04:28 INFO - 'installer_path': 'installer.exe', 09:04:28 INFO - 'log_level': 'info', 09:04:28 INFO - 'log_name': 'talos', 09:04:28 INFO - 'log_to_console': True, 09:04:28 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:04:28 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:04:28 INFO - 'opt_config_files': (), 09:04:28 INFO - 'pip_index': False, 09:04:28 INFO - 'suite': 'dromaeojs-e10s', 09:04:28 INFO - 'system_bits': '32', 09:04:28 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:04:28 INFO - 'title': 'talos-linux64-ix-008', 09:04:28 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:04:28 INFO - 'use_talos_json': True, 09:04:28 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:04:28 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:04:28 INFO - 'work_dir': 'build'} 09:04:28 INFO - [mozharness: 2017-05-19 16:04:28.373630Z] Running clobber step. 09:04:28 INFO - Running pre-action listener: _resource_record_pre_action 09:04:28 INFO - Running main action method: clobber 09:04:28 INFO - rmtree: /builds/slave/test/build 09:04:28 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:04:29 INFO - Running post-action listener: _resource_record_post_action 09:04:29 INFO - [mozharness: 2017-05-19 16:04:29.402476Z] Finished clobber step (success) 09:04:29 INFO - [mozharness: 2017-05-19 16:04:29.402578Z] Running read-buildbot-config step. 09:04:29 INFO - Running pre-action listener: _resource_record_pre_action 09:04:29 INFO - Running main action method: read_buildbot_config 09:04:29 INFO - Using buildbot properties: 09:04:29 INFO - { 09:04:29 INFO - "project": "", 09:04:29 INFO - "product": "firefox", 09:04:29 INFO - "who": "ffxbld@noreply.mozilla.org", 09:04:29 INFO - "installer_path": "public/build/target.tar.bz2", 09:04:29 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 09:04:29 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 09:04:29 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 09:04:29 INFO - "stage_platform": "linux64", 09:04:29 INFO - "basedir": "/builds/slave/test", 09:04:29 INFO - "buildnumber": 617, 09:04:29 INFO - "platform": "ubuntu64_hw", 09:04:29 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 09:04:29 INFO - "slavebuilddir": "test", 09:04:29 INFO - "taskId": "Tq7XzvH2T5G1RNQgEBeWUg", 09:04:29 INFO - "branch": "mozilla-central", 09:04:29 INFO - "script_repo_revision": "production", 09:04:29 INFO - "revision": "1ea1b40c2679da341d50d27226c61033bac06711", 09:04:29 INFO - "slavename": "talos-linux64-ix-008", 09:04:29 INFO - "repo_path": "mozilla-central" 09:04:29 INFO - } 09:04:29 INFO - Finding installer, test and symbols from parent task. 09:04:29 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Tq7XzvH2T5G1RNQgEBeWUg'}, attempt #1 09:04:29 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Tq7XzvH2T5G1RNQgEBeWUg'}, attempt #1 09:04:30 INFO - Task dependencies: FzpKbT3fTzWzpvRwY_vjTw 09:04:30 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FzpKbT3fTzWzpvRwY_vjTw'}, attempt #1 09:04:30 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/FzpKbT3fTzWzpvRwY_vjTw/artifacts/public/build/target.tar.bz2 09:04:30 INFO - Set test_url: https://queue.taskcluster.net/v1/task/FzpKbT3fTzWzpvRwY_vjTw/artifacts/public/build/test_packages.json 09:04:30 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/FzpKbT3fTzWzpvRwY_vjTw/artifacts/public/build/target.crashreporter-symbols.zip 09:04:30 INFO - Running post-action listener: _resource_record_post_action 09:04:30 INFO - [mozharness: 2017-05-19 16:04:30.744849Z] Finished read-buildbot-config step (success) 09:04:30 INFO - [mozharness: 2017-05-19 16:04:30.745069Z] Running download-and-extract step. 09:04:30 INFO - Running pre-action listener: _resource_record_pre_action 09:04:30 INFO - Running main action method: download_and_extract 09:04:30 INFO - mkdir: /builds/slave/test/build/tests 09:04:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:04:30 INFO - trying https://queue.taskcluster.net/v1/task/FzpKbT3fTzWzpvRwY_vjTw/artifacts/public/build/target.test_packages.json 09:04:30 INFO - Downloading https://queue.taskcluster.net/v1/task/FzpKbT3fTzWzpvRwY_vjTw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 09:04:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FzpKbT3fTzWzpvRwY_vjTw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 09:04:31 INFO - Downloaded 986 bytes. 09:04:31 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 09:04:31 INFO - Using the following test package requirements: 09:04:31 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 09:04:31 INFO - u'common': [u'target.common.tests.zip'], 09:04:31 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 09:04:31 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 09:04:31 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 09:04:31 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 09:04:31 INFO - u'mozbase': [u'target.common.tests.zip'], 09:04:31 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 09:04:31 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 09:04:31 INFO - u'web-platform': [u'target.common.tests.zip', 09:04:31 INFO - u'target.web-platform.tests.zip'], 09:04:31 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 09:04:31 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 09:04:31 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FzpKbT3fTzWzpvRwY_vjTw/artifacts/public/build/target.common.tests.zip 09:04:31 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FzpKbT3fTzWzpvRwY_vjTw/artifacts/public/build/target.common.tests.zip'}, attempt #1 09:04:31 INFO - Fetch https://queue.taskcluster.net/v1/task/FzpKbT3fTzWzpvRwY_vjTw/artifacts/public/build/target.common.tests.zip into memory 09:04:32 INFO - Content-Length response header: 62465451 09:04:32 INFO - Bytes received: 62465451 09:04:43 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 09:04:43 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FzpKbT3fTzWzpvRwY_vjTw/artifacts/public/build/target.common.tests.zip 09:04:43 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FzpKbT3fTzWzpvRwY_vjTw/artifacts/public/build/target.common.tests.zip'}, attempt #1 09:04:43 INFO - Fetch https://queue.taskcluster.net/v1/task/FzpKbT3fTzWzpvRwY_vjTw/artifacts/public/build/target.common.tests.zip into memory 09:04:44 INFO - Content-Length response header: 62465451 09:04:44 INFO - Bytes received: 62465451 09:04:55 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FzpKbT3fTzWzpvRwY_vjTw/artifacts/public/build/target.talos.tests.zip 09:04:55 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FzpKbT3fTzWzpvRwY_vjTw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 09:04:55 INFO - Fetch https://queue.taskcluster.net/v1/task/FzpKbT3fTzWzpvRwY_vjTw/artifacts/public/build/target.talos.tests.zip into memory 09:04:56 INFO - Content-Length response header: 14410001 09:04:56 INFO - Bytes received: 14410001 09:04:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:04:56 INFO - trying https://queue.taskcluster.net/v1/task/FzpKbT3fTzWzpvRwY_vjTw/artifacts/public/build/target.tar.bz2 09:04:56 INFO - Downloading https://queue.taskcluster.net/v1/task/FzpKbT3fTzWzpvRwY_vjTw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 09:04:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FzpKbT3fTzWzpvRwY_vjTw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 09:04:58 INFO - Downloaded 58106268 bytes. 09:04:58 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/FzpKbT3fTzWzpvRwY_vjTw/artifacts/public/build/target.tar.bz2 09:04:58 INFO - mkdir: /builds/slave/test/properties 09:04:58 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:04:58 INFO - Writing to file /builds/slave/test/properties/build_url 09:04:58 INFO - Contents: 09:04:58 INFO - build_url:https://queue.taskcluster.net/v1/task/FzpKbT3fTzWzpvRwY_vjTw/artifacts/public/build/target.tar.bz2 09:04:58 INFO - Running post-action listener: _resource_record_post_action 09:04:58 INFO - Running post-action listener: set_extra_try_arguments 09:04:58 INFO - [mozharness: 2017-05-19 16:04:58.597919Z] Finished download-and-extract step (success) 09:04:58 INFO - [mozharness: 2017-05-19 16:04:58.598018Z] Running populate-webroot step. 09:04:58 INFO - Running pre-action listener: _resource_record_pre_action 09:04:58 INFO - Running main action method: populate_webroot 09:04:58 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:04:58 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:04:58 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:04:58 INFO - '--tppagecycles', 09:04:58 INFO - '7'], 09:04:58 INFO - 'tests': ['tsvgm']}}, 09:04:58 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:04:58 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:04:58 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:04:58 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:04:58 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:04:58 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:04:58 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 09:04:58 INFO - 'talos_options': ['--disable-e10s'], 09:04:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:04:58 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 09:04:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:04:58 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 09:04:58 INFO - 'talos_options': ['--disable-e10s'], 09:04:58 INFO - 'tests': ['damp', 'tps']}, 09:04:58 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 09:04:58 INFO - 'tests': ['damp', 'tps']}, 09:04:58 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:04:58 INFO - 'tests': ['dromaeo_dom']}, 09:04:58 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:04:58 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:04:58 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 09:04:58 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 09:04:58 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 09:04:58 INFO - 'tests': ['ts_paint', 'tp5o']}, 09:04:58 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:04:58 INFO - 'tests': ['a11yr', 09:04:58 INFO - 'ts_paint', 09:04:58 INFO - 'tpaint', 09:04:58 INFO - 'sessionrestore', 09:04:58 INFO - 'sessionrestore_no_auto_restore', 09:04:58 INFO - 'tabpaint']}, 09:04:58 INFO - 'other-e10s': {'tests': ['a11yr', 09:04:58 INFO - 'ts_paint', 09:04:58 INFO - 'tpaint', 09:04:58 INFO - 'sessionrestore', 09:04:58 INFO - 'sessionrestore_no_auto_restore', 09:04:58 INFO - 'tabpaint']}, 09:04:58 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:04:58 INFO - 'ts_paint', 09:04:58 INFO - 'tpaint', 09:04:58 INFO - 'sessionrestore', 09:04:58 INFO - 'sessionrestore_no_auto_restore', 09:04:58 INFO - 'tabpaint']}, 09:04:58 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:04:58 INFO - 'ts_paint', 09:04:58 INFO - 'tpaint', 09:04:58 INFO - 'sessionrestore', 09:04:58 INFO - 'sessionrestore_no_auto_restore', 09:04:58 INFO - 'tabpaint']}, 09:04:58 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:04:58 INFO - 'tests': ['a11yr', 09:04:58 INFO - 'ts_paint', 09:04:58 INFO - 'tpaint', 09:04:58 INFO - 'sessionrestore', 09:04:58 INFO - 'sessionrestore_no_auto_restore', 09:04:58 INFO - 'tabpaint']}, 09:04:58 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:04:58 INFO - 'tests': ['a11yr', 09:04:58 INFO - 'ts_paint', 09:04:58 INFO - 'tpaint', 09:04:58 INFO - 'sessionrestore', 09:04:58 INFO - 'sessionrestore_no_auto_restore', 09:04:58 INFO - 'tabpaint']}, 09:04:58 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 09:04:58 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 09:04:58 INFO - 'bloom_basic_ref']}, 09:04:58 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:04:58 INFO - 'tests': ['tsvgx', 09:04:58 INFO - 'tsvgr_opacity', 09:04:58 INFO - 'tart', 09:04:58 INFO - 'tscrollx', 09:04:58 INFO - 'cart', 09:04:58 INFO - 'tsvg_static']}, 09:04:58 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:04:58 INFO - 'tsvgr_opacity', 09:04:58 INFO - 'tart', 09:04:58 INFO - 'tscrollx', 09:04:58 INFO - 'cart', 09:04:58 INFO - 'tsvg_static']}, 09:04:58 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 09:04:58 INFO - 'talos_options': ['--disable-e10s'], 09:04:58 INFO - 'tests': ['tp5o']}, 09:04:58 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 09:04:58 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 09:04:58 INFO - 'talos_options': ['--disable-e10s', 09:04:58 INFO - '--xperf_path', 09:04:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:04:58 INFO - 'tests': ['tp5n']}, 09:04:58 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 09:04:58 INFO - 'talos_options': ['--xperf_path', 09:04:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:04:58 INFO - 'tests': ['tp5n']}}, 09:04:58 INFO - 'talos.zip': {'path': '', 09:04:58 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:04:58 INFO - Running post-action listener: _resource_record_post_action 09:04:58 INFO - [mozharness: 2017-05-19 16:04:58.611954Z] Finished populate-webroot step (success) 09:04:58 INFO - [mozharness: 2017-05-19 16:04:58.612043Z] Running create-virtualenv step. 09:04:58 INFO - Running pre-action listener: _resource_record_pre_action 09:04:58 INFO - Running main action method: create_virtualenv 09:04:58 INFO - Creating virtualenv /builds/slave/test/build/venv 09:04:58 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 09:04:58 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:04:58 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:04:58 INFO - Using real prefix '/usr' 09:04:58 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:04:59 INFO - Installing distribute.............................................................................................................................................................................................done. 09:05:01 INFO - Installing pip.................done. 09:05:01 INFO - Return code: 0 09:05:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:05:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:05:01 INFO - Reading from file tmpfile_stdout 09:05:01 INFO - Output received: 09:05:01 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 09:05:01 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:05:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:05:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:05:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:05:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:05:01 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 0xc051f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdd2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf785c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf757a0>, '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 0xf766a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf76b30>, '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': '32c5991c409366f7fec8a718000001d2-1495209716.159476-1249182171', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:05:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 09:05:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:05:01 INFO - Using env: {'DISPLAY': ':0', 09:05:01 INFO - 'HOME': '/home/cltbld', 09:05:01 INFO - 'LANG': 'en_US.UTF-8', 09:05:01 INFO - 'LANGUAGE': 'en_US:en', 09:05:01 INFO - 'LOGNAME': 'cltbld', 09:05:01 INFO - 'MAIL': '/var/mail/cltbld', 09:05:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:05:01 INFO - 'MOZ_NO_REMOTE': '1', 09:05:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:05:01 INFO - 'NO_EM_RESTART': '1', 09:05:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:05:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:05:01 INFO - 'PWD': '/builds/slave/test', 09:05:01 INFO - 'SHELL': '/bin/bash', 09:05:01 INFO - 'SHLVL': '1', 09:05:01 INFO - 'TERM': 'linux', 09:05:01 INFO - 'TMOUT': '86400', 09:05:01 INFO - 'USER': 'cltbld', 09:05:01 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1495209716.159476-1249182171', 09:05:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:05:01 INFO - '_': '/tools/buildbot/bin/python'} 09:05:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:05:01 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 09:05:01 INFO - Cleaning up... 09:05:01 INFO - Return code: 0 09:05:01 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:05:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:05:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:05:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:05:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:05:01 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 0xc051f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdd2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf785c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf757a0>, '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 0xf766a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf76b30>, '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': '32c5991c409366f7fec8a718000001d2-1495209716.159476-1249182171', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:05:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 09:05:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 09:05:01 INFO - Using env: {'DISPLAY': ':0', 09:05:01 INFO - 'HOME': '/home/cltbld', 09:05:01 INFO - 'LANG': 'en_US.UTF-8', 09:05:01 INFO - 'LANGUAGE': 'en_US:en', 09:05:01 INFO - 'LOGNAME': 'cltbld', 09:05:01 INFO - 'MAIL': '/var/mail/cltbld', 09:05:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:05:01 INFO - 'MOZ_NO_REMOTE': '1', 09:05:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:05:01 INFO - 'NO_EM_RESTART': '1', 09:05:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:05:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:05:01 INFO - 'PWD': '/builds/slave/test', 09:05:01 INFO - 'SHELL': '/bin/bash', 09:05:01 INFO - 'SHLVL': '1', 09:05:01 INFO - 'TERM': 'linux', 09:05:01 INFO - 'TMOUT': '86400', 09:05:01 INFO - 'USER': 'cltbld', 09:05:01 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1495209716.159476-1249182171', 09:05:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:05:01 INFO - '_': '/tools/buildbot/bin/python'} 09:05:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:05:01 INFO - Downloading/unpacking psutil>=3.1.1 09:05:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:05:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:05:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:05:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:05:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:05:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:05:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:05:03 INFO - Installing collected packages: psutil 09:05:03 INFO - Running setup.py install for psutil 09:05:03 INFO - building 'psutil._psutil_linux' extension 09:05:03 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 09:05:03 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 09:05:03 INFO - building 'psutil._psutil_posix' extension 09:05:03 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 09:05:03 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 09:05:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:05:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:05:03 INFO - Successfully installed psutil 09:05:03 INFO - Cleaning up... 09:05:03 INFO - Return code: 0 09:05:03 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:05: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')]} 09:05:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:05: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')]} 09:05:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:05: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xc051f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdd2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf785c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf757a0>, '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 0xf766a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf76b30>, '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': '32c5991c409366f7fec8a718000001d2-1495209716.159476-1249182171', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:05: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 09:05: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 mozsystemmonitor==0.3 09:05:03 INFO - Using env: {'DISPLAY': ':0', 09:05:03 INFO - 'HOME': '/home/cltbld', 09:05:03 INFO - 'LANG': 'en_US.UTF-8', 09:05:03 INFO - 'LANGUAGE': 'en_US:en', 09:05:03 INFO - 'LOGNAME': 'cltbld', 09:05:03 INFO - 'MAIL': '/var/mail/cltbld', 09:05:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:05:03 INFO - 'MOZ_NO_REMOTE': '1', 09:05:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:05:03 INFO - 'NO_EM_RESTART': '1', 09:05:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:05:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:05:03 INFO - 'PWD': '/builds/slave/test', 09:05:03 INFO - 'SHELL': '/bin/bash', 09:05:03 INFO - 'SHLVL': '1', 09:05:03 INFO - 'TERM': 'linux', 09:05:03 INFO - 'TMOUT': '86400', 09:05:03 INFO - 'USER': 'cltbld', 09:05:03 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1495209716.159476-1249182171', 09:05:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:05:03 INFO - '_': '/tools/buildbot/bin/python'} 09:05:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:05:03 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:05:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:05:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:05:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:05:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:05:04 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:05:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:05:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:05:04 INFO - Installing collected packages: mozsystemmonitor 09:05:04 INFO - Running setup.py install for mozsystemmonitor 09:05:04 INFO - Successfully installed mozsystemmonitor 09:05:04 INFO - Cleaning up... 09:05:05 INFO - Return code: 0 09:05:05 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:05:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:05:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:05:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:05:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:05:05 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 0xc051f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdd2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf785c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf757a0>, '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 0xf766a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf76b30>, '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': '32c5991c409366f7fec8a718000001d2-1495209716.159476-1249182171', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:05:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 09:05:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 09:05:05 INFO - Using env: {'DISPLAY': ':0', 09:05:05 INFO - 'HOME': '/home/cltbld', 09:05:05 INFO - 'LANG': 'en_US.UTF-8', 09:05:05 INFO - 'LANGUAGE': 'en_US:en', 09:05:05 INFO - 'LOGNAME': 'cltbld', 09:05:05 INFO - 'MAIL': '/var/mail/cltbld', 09:05:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:05:05 INFO - 'MOZ_NO_REMOTE': '1', 09:05:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:05:05 INFO - 'NO_EM_RESTART': '1', 09:05:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:05:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:05:05 INFO - 'PWD': '/builds/slave/test', 09:05:05 INFO - 'SHELL': '/bin/bash', 09:05:05 INFO - 'SHLVL': '1', 09:05:05 INFO - 'TERM': 'linux', 09:05:05 INFO - 'TMOUT': '86400', 09:05:05 INFO - 'USER': 'cltbld', 09:05:05 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1495209716.159476-1249182171', 09:05:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:05:05 INFO - '_': '/tools/buildbot/bin/python'} 09:05:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:05:05 INFO - Downloading/unpacking jsonschema==2.5.1 09:05:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:05:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:05:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:05:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:05:06 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:05:06 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:05:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:05:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:05:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:05:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:05:06 INFO - Downloading functools32-3.2.3-2.tar.gz 09:05:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:05:06 INFO - warning: no files found matching '*.txt' 09:05:06 INFO - no previously-included directories found matching 'build' 09:05:06 INFO - no previously-included directories found matching 'dist' 09:05:06 INFO - no previously-included directories found matching '.git*' 09:05:06 INFO - Installing collected packages: jsonschema, functools32 09:05:06 INFO - Running setup.py install for functools32 09:05:06 INFO - warning: no files found matching '*.txt' 09:05:06 INFO - no previously-included directories found matching 'build' 09:05:06 INFO - no previously-included directories found matching 'dist' 09:05:06 INFO - no previously-included directories found matching '.git*' 09:05:06 INFO - Successfully installed jsonschema functools32 09:05:06 INFO - Cleaning up... 09:05:06 INFO - Return code: 0 09:05:06 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:05:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:05:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:05:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:05:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:05:06 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 0xc051f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdd2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf785c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf757a0>, '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 0xf766a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf76b30>, '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': '32c5991c409366f7fec8a718000001d2-1495209716.159476-1249182171', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:05:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 09:05:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 09:05:06 INFO - Using env: {'DISPLAY': ':0', 09:05:06 INFO - 'HOME': '/home/cltbld', 09:05:06 INFO - 'LANG': 'en_US.UTF-8', 09:05:06 INFO - 'LANGUAGE': 'en_US:en', 09:05:06 INFO - 'LOGNAME': 'cltbld', 09:05:06 INFO - 'MAIL': '/var/mail/cltbld', 09:05:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:05:06 INFO - 'MOZ_NO_REMOTE': '1', 09:05:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:05:06 INFO - 'NO_EM_RESTART': '1', 09:05:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:05:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:05:06 INFO - 'PWD': '/builds/slave/test', 09:05:06 INFO - 'SHELL': '/bin/bash', 09:05:06 INFO - 'SHLVL': '1', 09:05:06 INFO - 'TERM': 'linux', 09:05:06 INFO - 'TMOUT': '86400', 09:05:06 INFO - 'USER': 'cltbld', 09:05:06 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1495209716.159476-1249182171', 09:05:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:05:06 INFO - '_': '/tools/buildbot/bin/python'} 09:05:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:05:06 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:05:06 INFO - Cleaning up... 09:05:06 INFO - Return code: 0 09:05:06 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:05:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:05:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:05:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:05:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:05:06 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 0xc051f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdd2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf785c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf757a0>, '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 0xf766a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf76b30>, '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': '32c5991c409366f7fec8a718000001d2-1495209716.159476-1249182171', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:05:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:05:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:05:06 INFO - Using env: {'DISPLAY': ':0', 09:05:06 INFO - 'HOME': '/home/cltbld', 09:05:06 INFO - 'LANG': 'en_US.UTF-8', 09:05:06 INFO - 'LANGUAGE': 'en_US:en', 09:05:06 INFO - 'LOGNAME': 'cltbld', 09:05:06 INFO - 'MAIL': '/var/mail/cltbld', 09:05:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:05:06 INFO - 'MOZ_NO_REMOTE': '1', 09:05:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:05:06 INFO - 'NO_EM_RESTART': '1', 09:05:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:05:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:05:06 INFO - 'PWD': '/builds/slave/test', 09:05:06 INFO - 'SHELL': '/bin/bash', 09:05:06 INFO - 'SHLVL': '1', 09:05:06 INFO - 'TERM': 'linux', 09:05:06 INFO - 'TMOUT': '86400', 09:05:06 INFO - 'USER': 'cltbld', 09:05:06 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1495209716.159476-1249182171', 09:05:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:05:06 INFO - '_': '/tools/buildbot/bin/python'} 09:05:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:05:07 INFO - Downloading/unpacking blobuploader==1.2.4 09:05: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 09:05: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 09:05: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 09:05: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 09:05:08 INFO - Downloading blobuploader-1.2.4.tar.gz 09:05:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:05:08 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:05: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 09:05: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 09:05: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 09:05: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 09:05:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:05:08 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:05: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 09:05: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 09:05: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 09:05: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 09:05:08 INFO - Downloading docopt-0.6.1.tar.gz 09:05:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:05:09 INFO - Installing collected packages: blobuploader, requests, docopt 09:05:09 INFO - Running setup.py install for blobuploader 09:05:09 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:05:09 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:05:09 INFO - Running setup.py install for requests 09:05:09 INFO - Running setup.py install for docopt 09:05:09 INFO - Successfully installed blobuploader requests docopt 09:05:09 INFO - Cleaning up... 09:05:09 INFO - Return code: 0 09:05:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:05:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:05:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:05:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:05:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:05:09 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 0xc051f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdd2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf785c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf757a0>, '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 0xf766a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf76b30>, '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': '32c5991c409366f7fec8a718000001d2-1495209716.159476-1249182171', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:05:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:05:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:05:09 INFO - Using env: {'DISPLAY': ':0', 09:05:09 INFO - 'HOME': '/home/cltbld', 09:05:09 INFO - 'LANG': 'en_US.UTF-8', 09:05:09 INFO - 'LANGUAGE': 'en_US:en', 09:05:09 INFO - 'LOGNAME': 'cltbld', 09:05:09 INFO - 'MAIL': '/var/mail/cltbld', 09:05:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:05:09 INFO - 'MOZ_NO_REMOTE': '1', 09:05:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:05:09 INFO - 'NO_EM_RESTART': '1', 09:05:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:05:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:05:09 INFO - 'PWD': '/builds/slave/test', 09:05:09 INFO - 'SHELL': '/bin/bash', 09:05:09 INFO - 'SHLVL': '1', 09:05:09 INFO - 'TERM': 'linux', 09:05:09 INFO - 'TMOUT': '86400', 09:05:09 INFO - 'USER': 'cltbld', 09:05:09 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1495209716.159476-1249182171', 09:05:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:05:09 INFO - '_': '/tools/buildbot/bin/python'} 09:05:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:05:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:05:09 INFO - Running setup.py (path:/tmp/pip-aAv2qJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:05:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:05:09 INFO - Running setup.py (path:/tmp/pip-lTx_ah-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:05:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:05:09 INFO - Running setup.py (path:/tmp/pip-QJstOu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:05:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:05:10 INFO - Running setup.py (path:/tmp/pip-ecnhJd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:05:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:05:10 INFO - Running setup.py (path:/tmp/pip-wa4t9E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:05:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:05:10 INFO - Running setup.py (path:/tmp/pip-uatbMO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:05:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:05:10 INFO - Running setup.py (path:/tmp/pip-JDIqfW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:05:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:05:10 INFO - Running setup.py (path:/tmp/pip-5bI45s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:05:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:05:10 INFO - Running setup.py (path:/tmp/pip-2ZfyLV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:05:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:05:10 INFO - Running setup.py (path:/tmp/pip-rbEyTc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:05:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:05:10 INFO - Running setup.py (path:/tmp/pip-0uEvjM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:05:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:05:10 INFO - Running setup.py (path:/tmp/pip-8UtKrQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:05:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:05:10 INFO - Running setup.py (path:/tmp/pip-8nskkX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:05:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:05:10 INFO - Running setup.py (path:/tmp/pip-JSIsVn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:05:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:05:10 INFO - Running setup.py (path:/tmp/pip-dPlJMi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:05:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:05:10 INFO - Running setup.py (path:/tmp/pip-vjWPpy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:05:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:05:10 INFO - Running setup.py (path:/tmp/pip-5ozWb9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:05:11 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:05:11 INFO - Running setup.py install for manifestparser 09:05:11 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:05:11 INFO - Running setup.py install for mozcrash 09:05:11 INFO - Running setup.py install for mozdebug 09:05:11 INFO - Running setup.py install for mozdevice 09:05:11 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:05:11 INFO - Running setup.py install for mozfile 09:05:11 INFO - Running setup.py install for mozhttpd 09:05:11 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:05:11 INFO - Running setup.py install for mozinfo 09:05:11 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:05:11 INFO - Running setup.py install for mozInstall 09:05:11 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:05:11 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:05:11 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:05:11 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:05:11 INFO - Running setup.py install for mozleak 09:05:11 INFO - Running setup.py install for mozlog 09:05:12 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:05:12 INFO - Running setup.py install for moznetwork 09:05:12 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:05:12 INFO - Running setup.py install for mozprocess 09:05:12 INFO - Running setup.py install for mozprofile 09:05:12 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:05:12 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:05:12 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:05:12 INFO - Running setup.py install for mozrunner 09:05:12 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:05:12 INFO - Running setup.py install for mozscreenshot 09:05:12 INFO - Running setup.py install for moztest 09:05:12 INFO - Running setup.py install for mozversion 09:05:12 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:05:12 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:05:12 INFO - Cleaning up... 09:05:12 INFO - Return code: 0 09:05:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:05: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')]} 09:05:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:05: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')]} 09:05:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:05:12 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 0xc051f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdd2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf785c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf757a0>, '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 0xf766a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf76b30>, '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': '32c5991c409366f7fec8a718000001d2-1495209716.159476-1249182171', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:05:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:05:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:05:12 INFO - Using env: {'DISPLAY': ':0', 09:05:12 INFO - 'HOME': '/home/cltbld', 09:05:12 INFO - 'LANG': 'en_US.UTF-8', 09:05:12 INFO - 'LANGUAGE': 'en_US:en', 09:05:12 INFO - 'LOGNAME': 'cltbld', 09:05:12 INFO - 'MAIL': '/var/mail/cltbld', 09:05:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:05:12 INFO - 'MOZ_NO_REMOTE': '1', 09:05:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:05:12 INFO - 'NO_EM_RESTART': '1', 09:05:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:05:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:05:12 INFO - 'PWD': '/builds/slave/test', 09:05:12 INFO - 'SHELL': '/bin/bash', 09:05:12 INFO - 'SHLVL': '1', 09:05:12 INFO - 'TERM': 'linux', 09:05:12 INFO - 'TMOUT': '86400', 09:05:12 INFO - 'USER': 'cltbld', 09:05:12 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1495209716.159476-1249182171', 09:05:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:05:12 INFO - '_': '/tools/buildbot/bin/python'} 09:05:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:05:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:05:13 INFO - Running setup.py (path:/tmp/pip-2gjG_1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:05:13 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 09:05:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:05:13 INFO - Running setup.py (path:/tmp/pip-vU__vN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:05:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:05:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:05:13 INFO - Running setup.py (path:/tmp/pip-KuBLl0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:05:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:05:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:05:13 INFO - Running setup.py (path:/tmp/pip-Pwbtlv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:05:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.50 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:05:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:05:13 INFO - Running setup.py (path:/tmp/pip-NUggOA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:05:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 09:05:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:05:13 INFO - Running setup.py (path:/tmp/pip-t02vgP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:05:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 09:05:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:05:13 INFO - Running setup.py (path:/tmp/pip-X3MVLX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:05:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 09:05:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:05:13 INFO - Running setup.py (path:/tmp/pip-rfkqhS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:05:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 09:05:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:05:13 INFO - Running setup.py (path:/tmp/pip-wm6mqs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:05:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 09:05:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:05:13 INFO - Running setup.py (path:/tmp/pip-s8obbR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:05:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:05:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:05:13 INFO - Running setup.py (path:/tmp/pip-Fui9eS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:05:13 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 09:05:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:05:13 INFO - Running setup.py (path:/tmp/pip-ie1l3s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:05:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 09:05:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:05:13 INFO - Running setup.py (path:/tmp/pip-2__Xkz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:05:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 09:05:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:05:14 INFO - Running setup.py (path:/tmp/pip-VKFDNy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:05:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 09:05:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:05:14 INFO - Running setup.py (path:/tmp/pip-KPjKp7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:05:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 09:05:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:05:14 INFO - Running setup.py (path:/tmp/pip-BtPlfY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:05:14 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 09:05:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:05:14 INFO - Running setup.py (path:/tmp/pip-0Btk9x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:05:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 09:05:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:05:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:05:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:05:14 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:05:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:05:14 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:05:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:05:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:05:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:05:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:05:15 INFO - Downloading blessings-1.6.tar.gz 09:05:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:05:15 INFO - Installing collected packages: blessings 09:05:15 INFO - Running setup.py install for blessings 09:05:15 INFO - Successfully installed blessings 09:05:15 INFO - Cleaning up... 09:05:15 INFO - Return code: 0 09:05:15 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:05:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:05:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:05:15 INFO - Reading from file tmpfile_stdout 09:05:15 INFO - Current package versions: 09:05:15 INFO - argparse == 1.2.1 09:05:15 INFO - blessings == 1.6 09:05:15 INFO - blobuploader == 1.2.4 09:05:15 INFO - docopt == 0.6.1 09:05:15 INFO - functools32 == 3.2.3-2 09:05:15 INFO - jsonschema == 2.5.1 09:05:15 INFO - manifestparser == 1.1 09:05:15 INFO - mozInstall == 1.12 09:05:15 INFO - mozcrash == 1.0 09:05:15 INFO - mozdebug == 0.1 09:05:15 INFO - mozdevice == 0.50 09:05:15 INFO - mozfile == 1.2 09:05:15 INFO - mozhttpd == 0.7 09:05:15 INFO - mozinfo == 0.9 09:05:15 INFO - mozleak == 0.1 09:05:15 INFO - mozlog == 3.4 09:05:15 INFO - moznetwork == 0.27 09:05:15 INFO - mozprocess == 0.25 09:05:15 INFO - mozprofile == 0.28 09:05:15 INFO - mozrunner == 6.13 09:05:15 INFO - mozscreenshot == 0.1 09:05:15 INFO - mozsystemmonitor == 0.3 09:05:15 INFO - moztest == 0.8 09:05:15 INFO - mozversion == 1.4 09:05:15 INFO - psutil == 3.1.1 09:05:15 INFO - requests == 1.2.3 09:05:15 INFO - wsgiref == 0.1.2 09:05:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:05:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:05:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:05:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:05:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:05:15 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 0xc051f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdd2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf785c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf757a0>, '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 0xf766a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf76b30>, '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': '32c5991c409366f7fec8a718000001d2-1495209716.159476-1249182171', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:05:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 09:05:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:05:15 INFO - Using env: {'DISPLAY': ':0', 09:05:15 INFO - 'HOME': '/home/cltbld', 09:05:15 INFO - 'LANG': 'en_US.UTF-8', 09:05:15 INFO - 'LANGUAGE': 'en_US:en', 09:05:15 INFO - 'LOGNAME': 'cltbld', 09:05:15 INFO - 'MAIL': '/var/mail/cltbld', 09:05:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:05:15 INFO - 'MOZ_NO_REMOTE': '1', 09:05:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:05:15 INFO - 'NO_EM_RESTART': '1', 09:05:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:05:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:05:15 INFO - 'PWD': '/builds/slave/test', 09:05:15 INFO - 'SHELL': '/bin/bash', 09:05:15 INFO - 'SHLVL': '1', 09:05:15 INFO - 'TERM': 'linux', 09:05:15 INFO - 'TMOUT': '86400', 09:05:15 INFO - 'USER': 'cltbld', 09:05:15 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1495209716.159476-1249182171', 09:05:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:05:15 INFO - '_': '/tools/buildbot/bin/python'} 09:05:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:05:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:05:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 09:05:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 09:05:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:05:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 09:05:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 09:05:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 09:05:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 09:05:16 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 09:05:16 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:05:16 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:05:16 INFO - Cleaning up... 09:05:16 INFO - Return code: 0 09:05:16 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:05: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')]} 09:05:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:05: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')]} 09:05:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:05:16 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 0xc051f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdd2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf785c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf757a0>, '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 0xf766a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf76b30>, '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': '32c5991c409366f7fec8a718000001d2-1495209716.159476-1249182171', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:05:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 09:05:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:05:16 INFO - Using env: {'DISPLAY': ':0', 09:05:16 INFO - 'HOME': '/home/cltbld', 09:05:16 INFO - 'LANG': 'en_US.UTF-8', 09:05:16 INFO - 'LANGUAGE': 'en_US:en', 09:05:16 INFO - 'LOGNAME': 'cltbld', 09:05:16 INFO - 'MAIL': '/var/mail/cltbld', 09:05:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:05:16 INFO - 'MOZ_NO_REMOTE': '1', 09:05:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:05:16 INFO - 'NO_EM_RESTART': '1', 09:05:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:05:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:05:16 INFO - 'PWD': '/builds/slave/test', 09:05:16 INFO - 'SHELL': '/bin/bash', 09:05:16 INFO - 'SHLVL': '1', 09:05:16 INFO - 'TERM': 'linux', 09:05:16 INFO - 'TMOUT': '86400', 09:05:16 INFO - 'USER': 'cltbld', 09:05:16 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1495209716.159476-1249182171', 09:05:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:05:16 INFO - '_': '/tools/buildbot/bin/python'} 09:05:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:05:16 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:05:16 INFO - Cleaning up... 09:05:16 INFO - Return code: 0 09:05:16 INFO - Running post-action listener: _resource_record_post_action 09:05:16 INFO - Running post-action listener: _start_resource_monitoring 09:05:16 INFO - Starting resource monitoring. 09:05:16 INFO - [mozharness: 2017-05-19 16:05:16.290155Z] Finished create-virtualenv step (success) 09:05:16 INFO - [mozharness: 2017-05-19 16:05:16.290670Z] Running install step. 09:05:16 INFO - Running pre-action listener: _resource_record_pre_action 09:05:16 INFO - Running main action method: install 09:05:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:05:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:05:16 INFO - Reading from file tmpfile_stdout 09:05:16 INFO - Detecting whether we're running mozinstall >=1.0... 09:05:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:05:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:05:16 INFO - Reading from file tmpfile_stdout 09:05:16 INFO - Output received: 09:05:16 INFO - Usage: mozinstall [options] installer 09:05:16 INFO - Options: 09:05:16 INFO - -h, --help show this help message and exit 09:05:16 INFO - -d DEST, --destination=DEST 09:05:16 INFO - Directory to install application into. [default: 09:05:16 INFO - "/builds/slave/test"] 09:05:16 INFO - --app=APP Application being installed. [default: firefox] 09:05:16 INFO - mkdir: /builds/slave/test/build/application 09:05:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 09:05:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 09:05:33 INFO - Reading from file tmpfile_stdout 09:05:33 INFO - Output received: 09:05:33 INFO - /builds/slave/test/build/application/firefox/firefox 09:05:33 INFO - Running post-action listener: _resource_record_post_action 09:05:33 INFO - [mozharness: 2017-05-19 16:05:33.388988Z] Finished install step (success) 09:05:33 INFO - [mozharness: 2017-05-19 16:05:33.389139Z] Running run-tests step. 09:05:33 INFO - Running pre-action listener: _resource_record_pre_action 09:05:33 INFO - Running main action method: run_tests 09:05:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:05:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:05:33 INFO - Python 2.7.3 09:05:33 INFO - Return code: 0 09:05:33 INFO - grabbing minidump binary from tooltool 09:05:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:05:33 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 0xf757a0>, '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 0xf766a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf76b30>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:05:33 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 09:05:33 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 09:05:33 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 09:05:33 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:05:33 INFO - Return code: 0 09:05:33 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:05:33 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:05:33 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:05:33 INFO - ENV: RUST_BACKTRACE is now 1 09:05:33 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:05:33 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:05:33 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/FzpKbT3fTzWzpvRwY_vjTw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 09:05:33 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/FzpKbT3fTzWzpvRwY_vjTw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-008 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 09:05:33 INFO - Using env: {'DISPLAY': ':0', 09:05:33 INFO - 'HOME': '/home/cltbld', 09:05:33 INFO - 'LANG': 'en_US.UTF-8', 09:05:33 INFO - 'LANGUAGE': 'en_US:en', 09:05:33 INFO - 'LOGNAME': 'cltbld', 09:05:33 INFO - 'MAIL': '/var/mail/cltbld', 09:05:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:05:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:05:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:05:33 INFO - 'MOZ_NO_REMOTE': '1', 09:05:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:05:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:05:33 INFO - 'NO_EM_RESTART': '1', 09:05:33 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:05:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:05:33 INFO - 'PWD': '/builds/slave/test', 09:05:33 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:05:33 INFO - 'RUST_BACKTRACE': '1', 09:05:33 INFO - 'SHELL': '/bin/bash', 09:05:33 INFO - 'SHLVL': '1', 09:05:33 INFO - 'TERM': 'linux', 09:05:33 INFO - 'TMOUT': '86400', 09:05:33 INFO - 'USER': 'cltbld', 09:05:33 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1495209716.159476-1249182171', 09:05:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:05:33 INFO - '_': '/tools/buildbot/bin/python'} 09:05:33 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/FzpKbT3fTzWzpvRwY_vjTw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 09:05:33 INFO - mozversion application_buildid: 20170519153622 09:05:33 INFO - mozversion application_changeset: 1ea1b40c2679da341d50d27226c61033bac06711 09:05:33 INFO - mozversion application_display_name: Nightly 09:05:33 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:05:33 INFO - mozversion application_name: Firefox 09:05:33 INFO - mozversion application_remotingname: firefox 09:05:33 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 09:05:33 INFO - mozversion application_vendor: Mozilla 09:05:33 INFO - mozversion application_version: 55.0a1 09:05:33 INFO - mozversion platform_buildid: 20170519153622 09:05:33 INFO - mozversion platform_changeset: 1ea1b40c2679da341d50d27226c61033bac06711 09:05:33 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 09:05:33 INFO - mozversion platform_version: 55.0a1 09:05:33 INFO - using testdate: 1495209933 09:05:33 INFO - actual date: 1495209933 09:05:33 INFO - starting webserver on 'localhost:47031' 09:05:33 INFO - SUITE-START | Running 2 tests 09:05:33 INFO - TEST-START | dromaeo_css 09:05:33 INFO - operating with platform_type : linux_ 09:05:33 INFO - Initialising browser for dromaeo_css test... 09:05:33 INFO - TEST-INFO | started process 5889 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwKxpaR/profile http://localhost:47031/getInfo.html) 09:05:34 INFO - PID 5889 | JavaScript warning: resource://gre/modules/addons/XPIProvider.jsm, line 2941: String.localeCompare is deprecated; use String.prototype.localeCompare instead 09:05:37 INFO - PID 5889 | __metrics Screen width/height:1600/1200 09:05:37 INFO - PID 5889 | colorDepth:24 09:05:37 INFO - PID 5889 | Browser inner width/height: 1024/695 09:05:37 INFO - PID 5889 | __metrics 09:05:39 INFO - TEST-INFO | 5889: exit 0 09:05:39 INFO - Browser initialized. 09:05:39 INFO - Running cycle 1/1 for dromaeo_css test... 09:05:39 INFO - TEST-INFO | started process 6050 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwKxpaR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:05:51 INFO - PID 6050 | RSS: Main: 166608896 09:05:51 INFO - PID 6050 | 09:08:56 INFO - PID 6050 | Cycle 1(1): loaded http://localhost:47031/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47031/tests/dromaeo/cssquery-ext.html) 09:08:57 INFO - PID 6050 | RSS: Main: 173809664 09:08:57 INFO - PID 6050 | 09:11:59 INFO - PID 6050 | Cycle 1(1): loaded http://localhost:47031/tests/dromaeo/cssquery-ext.html (next: http://localhost:47031/tests/dromaeo/cssquery-jquery.html) 09:11:59 INFO - PID 6050 | RSS: Main: 170835968 09:11:59 INFO - PID 6050 | 09:15:01 INFO - PID 6050 | Cycle 1(1): loaded http://localhost:47031/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47031/tests/dromaeo/cssquery-mootools.html) 09:15:02 INFO - PID 6050 | RSS: Main: 173563904 09:15:02 INFO - PID 6050 | 09:18:04 INFO - PID 6050 | Cycle 1(1): loaded http://localhost:47031/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47031/tests/dromaeo/cssquery-prototype.html) 09:18:04 INFO - PID 6050 | RSS: Main: 171347968 09:18:04 INFO - PID 6050 | 09:21:07 INFO - PID 6050 | Cycle 1(1): loaded http://localhost:47031/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47031/tests/dromaeo/cssquery-yui.html) 09:21:08 INFO - PID 6050 | RSS: Main: 171466752 09:21:08 INFO - PID 6050 | 09:24:10 INFO - PID 6050 | Cycle 1(1): loaded http://localhost:47031/tests/dromaeo/cssquery-yui.html (next: http://localhost:47031/tests/dromaeo/cssquery-dojo.html) 09:24:10 INFO - PID 6050 | RSS: Main: 175439872 09:24:10 INFO - PID 6050 | 09:24:10 INFO - PID 6050 | __start_tp_report 09:24:10 INFO - PID 6050 | _x_x_mozilla_page_load 09:24:10 INFO - PID 6050 | _x_x_mozilla_page_load_details 09:24:10 INFO - PID 6050 | |i|pagename|runs| 09:24:10 INFO - PID 6050 | |0;dojo.html;2727.222741518667;2741.533939230331;2748.0519220868805;2779.847108409038;2785.86070696465;5306.602004849642;5331.92002119968;5364.785408583652;5380.515753582182;5385.111456609659;5333.973330133354;5357.571394288458;5382.085045542258;5449.482299181582;5452.182172674101;4564.5435456454425;4753.287006948951;4766.332713420124;4781.760911954406;4800.015996720673;4818.204996175627;4840.9515904840855;4862.902741945159;4867.050925069613;4867.3915760529935;4707.552782485658;4709.529047095298;4804.375431193957;4814.951850481485;4817.879553011167;4815.349927759743;4820.204666230068;4821.5178482151505;4859.07677541266;4878.414590249193;4753.857384278477;4773.856784296477;4776.641751868624;4792.544708252745;4825.927611085802;5265.526102650741;5346.385165705916;5390.5418039466695;5391.487808658171;5444.047291723932;5763.6541807491685;5812.564057695689;5817.563682723812;5824.767009319622;5834.620749651302;5877.412258774131;5908.113782932552;5935.9406405935815;5943.910841337383;5950.553708471839;5286.392064912584;5410.107332290128;5416.647917885325;5422.15956526735;5436.70098144598;5976.073708575178;6030.7889223876955;6114.633122012693;6124.142620033199;6141.477974372228;5662.094064949588;5663.348714897757;5678.687672177987;5678.716064196774;5684.914726279109;5690.943090569124;5714.314282286152;5776.797812076557;5799.971000144972;5822.272215973004;5746.913796293059;5844.736986835603;5849.5027922626205;5862.472377486047;5911.9113213301835;5668.631538949955;5685.204071430003;5736.770529178786;5758.827235182951;5776.306843178845;4917.582005529499;4950.158473059589;4950.381202349707;4955.033768415196;4985.401751789808;4200.306949353322;4203.369494575777;4212.705110642226;4215.59951804578;4248.4052232687445;4817.397825271841;4900.240462728283;4901.681390709592;4931.9753401232765;4976.925346119811;5876.618019828783;5898.439648233411;5930.229070220844;5937.435943585352;5970.671613061237;4918.704877707349;4925.38432695913;4939.728314942641;4946.455889852114;4984.451710311862;5045.091883460939;5120.129577971679;5149.382074151126;5178.249153872743;5202.687838729613;5435.755391007335;5448.482394172547;5458.863528411822;5492.1212605982855;5505.201745746765;5848.678322692293;5892.793752218652;5901.557383196192;5907.232059832194;5921.4966727826895;5321.680699157908;5358.517733404013;5438.075527160471;5445.346558413015;5449.7002664852225;5702.6293290935955;5833.1250312451775;5838.299404071538;5838.737256823369;5843.094320380348;5929.584929055098;5935.940640593539;5940.584159108821;5976.701164941648;5997.520198384032;5555.8888822222525;5571.498565128995;5653.349864765604;5694.943050569441;5791.362950075572;5738.512226460798;5741.62679425836;5742.052561327501;5743.712814359182;5782.10377391505;5517.282753242052;5555.083411237262;5585.357683866408;5593.244911936999;5669.574781891292;5736.71316434185;5753.683547404933;5767.798127065533;5782.277215348082;5789.681567513659;5580.107182850725;5580.609357344947;5587.078132108157;5593.916091258553;5599.832005039855 09:24:10 INFO - PID 6050 | |1;ext.html;708.1679027143106;725.8004048886555;749.9925000749993;1055.6674647486045;1066.7386490309875;31781.36437271256;32691.346173076523;32770.34459310818;32803.67196328039;32929.83535082324;34520.1369965751;34731.4790278146;35012.82493587529;35065.12337191572;35095.82452087736;6757.763478278249;6905.689243984008;6952.89570656438;7118.07465029548;7153.713851445936;7038.366547010768;7168.390686791629;7169.211386747454;7178.174509931347;7180.31786980236;7135.286471352849;7138.464615153858;7168.641567921609;7173.85652286954;7204.171520275157;7037.824054398681;7107.680154393013;7108.964455177716;7150.785476435715;7161.606111663857;7025.121859767529;7079.858402831915;7086.893696594555;7104.964475177642;7105.573665580082;32361.190970225933;32378.67621323804;32407.351852963046;32437;32533.186670333194;3047.3752880659413;3064.540318952175;3065.111117775842;3087.598612180402;3097.7676674249296;24768.752312476823;24782.132625358205;24899.62650560243;25002.4999500009;25045;3140.3876244132402;3149.086764838194;3154.1799132225556;3159.873605055795;3163.8734450621946;132509.33745331308;132970.33514832365;147502.26248868686;149997;150017;39009;39129;39134.804325978184;39176;39277.80361098176;40838.38742418866;40972.38541421822;46422.767886161026;46662.06675866464;46820.7658961703;12734.936325318315;12826.486940522274;12838.16551924122;12858;12883.677908052186;10076.891541930381;10118.241131914989;10148.188144948386;10156.136728378171;10276.332038417479;13138.357705286839;13144.342782860818;13165.802512962313;13187;13307.600771976857;5652.037414474461;5663.490285874291;5687.516561092353;5693.886122277531;5725.2843394575675;879.7448739865496;909.1454033208763;914.8307563100848;921.203159267229;938.5401153434905;20541.691874621894;21308.78691213068;21615.459613509473;21655.675164872224;21790.564188716136;971.582219645545;982.9262805289488;988.4267125067444;1007.2345017786389;1010;11271.492782824793;11365.715857103638;11474.368909710047;11475.311481311148;11588.826167607493;171905;172635;172825;173633.13183434002;173745;39715;39918.600813991485;40072.39891401631;40079.79960100181;40130.39804402936;1198.6164427383153;1236.975260494785;1251.9624411267675;1258.1758947889148;1258.3771033338373;19669;19749.40751777449;20583.279585214445;21474.677879831503;21475.78524214738;29240;29382.706172937997;29443.411131776815;29459.410811784073;29564.260893476974;148273;148458;148796;148906;149391.25304373843;28551;29619.259518512208;29701.851490742407;30004;30121.24696882508;35924.10189745173;36069.45895811512;36147.27705445929;36219.63780362268;36268.45597315989;26694.332641683337;27517.587236191073;27527;27747;28286.009989650265;26889.462210756068;27529.44941101127;27729.306767330978;28781.136565903056;28806.71193288124;29966.25084372908;30076.24809379783;30127.698723013367;30247.546286805275;30397;25823.870880645478;26329.21012369632;26468.368035594078;26971.325716857235;27332.590011149452;19891.21372136399;22457.550848983257;22578;22677.773222268224;22747.772522274565 09:24:10 INFO - PID 6050 | |2;jquery.html;416.91453252083323;422.67665236094393;423.7732812945074;430.81690281630307;440.7311539960626;14158.221297828615;14725.190114543695;16291.348346066157;16979.490615281546;17097.48707538776;18112.728309075374;18140.909295453504;18541.814581854178;18551.907240463814;18746.156422960965;5465.781368745245;5492.340919089705;5520.558355331584;5571.359293681217;5650.7174641267975;5474.42518535554;5571.13647384656;5582.441755824426;5582.525485333731;5583.5254003409755;4961.3798275215595;5456.563474921997;5465.480779325958;5482.17767334899;5482.972585137069;5411.458854114597;5448.291722076145;5448.727563621823;5454.836354909339;5474.589405794542;5055.545000949932;5065.594752419797;5068.518490743373;5115.130427827278;5122.103631864409;21792.237271695572;22433.32700019002;22467.213647522258;22704.091836326526;22761.658575121386;1572.3239007226887;1609.8873078884483;1610.903345799244;1611.8629916457114;1615.7576363545445;14292.428302867873;14468.131912085204;14888.106713597219;15067.623309417242;15163.62090947724;2046.3963130876277;2095.1409921931936;2101.0965284927474;2151.709519214902;2152.6770984352315;86681;95422.52288738581;95680.04319956781;95789.521052395;96356.51821740916;17901.462956111336;18303;18418.907905460386;18422.723659145122;18589.749997500985;33730.156746081055;33765.324693505994;33861.153471163416;33902.83048584791;34150.82924585411;8935.910640893639;9085.591148398338;9257.120573545502;9349.579268932914;9532.428054316762;7286.890696639554;7309.963450182715;7594.96202518995;7616.9238307617325;7627.046619172604;9022.639094436281;9469.573869175765;9596.23230141587;9607.637326935517;9652.324337296322;4046.676265898721;4086.300754132771;4112.547619761824;4136.482939632546;4171.5828417158045;830.9709160179365;866.7009881590841;883.1036497954581;897.0984160918235;900.2168113741087;17177.484675459757;17466.476005719847;17707.734383983992;17745.11274436273;17774.340808740937;884.8805411269525;888.9244414224863;892.1123482135317;902.2331018634239;903.9141281578239;9427.670031548863;9632.855507167398;9845.950770246103;9898.653547125816;9927.751806204902;335592;337500;339710;339877;343908;76433.61783191048;78335.60832195917;78547.60726196447;80128.59935700284;82675.5866220665;1064.5635289531256;1086.8532748079067;1127.689885281554;1128.0749785176076;1129.768397478515;17277.308907643554;17650.382236621655;18180.363687271412;18222.908885455487;18417.53956151107;38299.042523937125;38882;38888.611113888495;39782.80108599438;39810.601893981846;47264.29103563518;47282.29076563785;47473;47510;47513.28730068982;8386.66453341884;8472.322214222972;8566.657333706582;8687.916679161037;8751.91248087511;12760.106792524433;13023.544175953795;13621.659458513617;13770.518031868836;13827.723445531234;10608.310459820086;10722.356658600509;10865.239433239914;10918;11064;10872.891271087505;11065.114790816877;11089.611863584736;11110.388928609003;11489.253198542068;10615.681529554126;10714.30357026822;10721.785564288826;11314.660560183207;11445.849367784363;8090.514569125636;8170.428070035278;8198.795030124294;8526;8547.74356769298;10053.246006549392;10511.632092877018;10885.619003334845;10976.670699879016;11280.605178818701 09:24:10 INFO - PID 6050 | |3;mootools.html;1272.147661067085;1323.3581712869263;1338.4579245405607;1343.946242150314;1349.4399824073007;10126.29115961883;10443.947780261107;10485.056344928955;10506.422146781924;10719.517621707022;10556.261061725663;10682.359058456497;10730.892691073086;10743.946280268588;10746.892531074687;2238.4292005538605;2268.8411811173223;2272.261515007621;2273.227102785053;2274.8748818814956;2177.0638625391075;2236.452069243038;2237.1387015998876;2237.8321625878125;2245.9438514037197;2191.736991561007;2207.6798864164684;2240.305505293364;2251.583457060449;2255.954880902381;2177.738671359431;2192.134107027723;2221.2114699281683;2236.1726161320253;2237.7538470768204;2029.2897485879823;2159.255057005331;2163.329367895957;2180.226019762993;2189.386971647941;10353.171746260281;10386;10443.216758743125;10451.268411211218;10477.26659133861;5751.3961034091235;5945.881082378328;5964.135200395962;5990.460858522711;5993.280806303272;3459.498372735939;3752.6434988676033;3794.29805485986;3794.4118661607495;3843.6348546888003;1149.408054851752;1160.0893298760516;1161.4657257661486;1226.301008425198;1230.4155526125107;14558.92720536401;14559.563213103624;14568.49010284635;14647.12117272967;14717.337719802634;4799.544043315879;4805.8077676892535;4981.402231732215;4993.775280112331;5004.049230646166;10980.835287470694;11001;11061.72345691348;11062.446877656084;11080.61217857371;5697.658140511582;5709.685967271756;5712.11462223356;5733.913991290134;5752.13717942312;5235.476452354734;5263.26314315996;5268.157094864803;5341.626086174008;5358.5981051421295;3857.8456861725776;3917.5298964123917;3958.148997965394;3998.3802510610903;4020.0552870075508;1159.3913195572222;1162.96511104667;1163.0985985861025;1164.895159435655;1178.7465694875643;690.3027941778739;725.7423614616735;726.2410780734145;740.7037185125993;744.6686224629988;5589.636673616202;5740.454656807597;5746.856328591819;5812.94187058124;5855.326637436664;537.5726297593422;562.864912421016;565.6379916853217;567.7473524281737;569.0951387294222;3485.477178423206;3498.930021399558;3511.6839484446523;3624.4019736743144;4019.618136277049;13114.540991065267;13590;13781.724365512835;13816.93091534556;13918.791218131737;13403.458602260866;13516.932415338057;13648.863511364958;13868.167909925436;13888.097273677178;7481.700731970769;7515.098188217339;7518;7562.319391254813;7620.657070431844;5994.31065427464;6021.969890150521;6024.397560244116;6071.696415179312;6182.412670796267;12038.518459261531;12107.878921211028;12124.696882578006;12304.507819687471;12638.873611264138;12376;12573.308468034345;12625.305608191271;12775;12836.844683978487;7389.298016688406;7593.620318984139;7596.126445458843;7609.048868891388;7620.5808680523105;9468.384555004179;9659.227261818896;9815.95092024564;9818.509074546388;9829.066238707312;8008.039035315799;8084.272415482635;8136.67453301885;8269.29710974574;8310.335173186251;8129.959350203211;8151.103378628465;8191.631376588187;8204.138565450781;8454.873176902229;7341;7346.6693998769115;7417.443691723034;7448.553086814808;7461.067366579177;5282.630215884851;5288.524032837063;5335.119705248746;5515.4760297771645;5541.972290138524;5410.47926496151;5446.482584154499;5453.26380938584;5537.723113844372;5591.8881622368135 09:24:10 INFO - PID 6050 | |4;prototype.html;387.7150294533519;387.8564930975536;391.3425445251977;396.831346677662;398.03873645146973;5501.039251738746;5512.228288039678;5551.639143455673;5605.803796867111;5713.914291285634;5411.83764487065;5480.88933300025;5502.367227768807;5506.476884695958;5526.723663816803;4033.0723933495315;4126.112885729567;4131.772752498611;4138.296489596761;4183.518895327031;4129.97935010326;4140.772257525835;4145.668346532285;4151.377293405983;4157.711109556032;4117.155983023488;4125.401816736571;4125.886010777103;4129.607687269705;4134.896627584304;4031.657309128728;4111.629953304202;4119.402686610425;4136.379543068534;4137.262349813086;3563.394222982099;3573.5711714594413;3576.517170182044;3578.6421357864006;3598.1364472526666;5386.865328366822;5392.946070539284;5421.593380496479;5438.075527160392;5446.210299506589;4710.222813235812;4868.002059577813;4888.755562221874;4895;4927.595635243938;5834.970825145847;5859.1797148399255;5867.647941123546;5869;5869.50109240715;4067.8983025424304;4074.3073677474604;4087.1621317629815;4088.1414902870138;4104.117614712851;6007.545661244758;6149.13912052313;6195.380461953769;6236.906446403353;6281.089242059876;4102.856400025985;4149.439825623502;4156.709030367906;4162.084341444877;4168.916621667549;4213.304804707189;4219.303814870574;4224.809883555247;4226.1758957003085;4235.174141042467;4747.145513807479;4832.405306248929;4876.805182730253;4897.853064408074;4902.460729319772;5804.187413762077;5850.8537286567325;5856;5881.794137205177;5893.410658934073;1437.4250299880132;1446.3130013243624;1456.6139972907188;1457.358762144653;1458.7017554376614;967.583938906277;972.5331840716495;977.5161295158941;983.4197823284296;984.6159997600942;4967.801287948441;5029.2958985742025;5042.7982880685095;5051.974740126276;5085.64400491962;6081.604695694766;6086.543509236825;6102.603330783485;6115.969420152871;6133.1413602095745;4895.701785473588;5005.998800239967;5010.974945125324;5048.066107770074;5067.214581739836;3195.6644552322136;3195.936081278408;3205.4230238557284;3206.502992036238;3210.9036728898172;5510.366307874646;5557.663504742885;5561.694106824163;5564.527015203672;5612.943870561324;6108;6201.379862013762;6203.875922481616;6228.377162283736;6251;5609.242752228479;5643.915341269884;5644.43555644424;5652.247803181027;5661.575381846378;6119.328402958367;6126.142340072304;6150.569460137926;6153.476954458921;6174.413430724074;5964.433378829004;5965.822474796755;5978.8206353809455;5986.580939334205;6012;5607.579431542569;5626.690532020778;5640.407757185437;5640.492355688008;5645.71771411436;4058.0869304406274;4154.314538101179;4171.97914010428;4185.644220241192;4187.078842654611;6088.147659327787;6116.633002019893;6132.9080063799975;6153.600015998945;6163.568550201443;5852.209951656472;5892.175095486549;5930.495907847881;5931.851703707442;5934.109883517507;5731.398203188605;5888.9366337227175;5906.822795316148;5956.74908269251;5962.642241465526;5804.506616937439;5817.76728930838;5818.040023396262;5837.824865254049;5855.414458554111;5806.2451881255165;5947.10793380979;5963.642181469126;5964.657951960774;5964.970175149097;5708.885822283614;5725.2843394575675;5737.196792449144;5741.425857414392;5763.971180144073 09:24:10 INFO - PID 6050 | |5;yui.html;723.3200791256222;725.6770737022025;746.5595298773726;747.1072068877693;749.5877267502874;12072.939635301811;12567.183133096343;13502.864971350284;14484;14488.927555362236;14285.571432857005;14720.926395368007;14732.33704483298;14767.113973161619;15107.169105699182;812.540914383373;834.0366876257932;834.3367023216557;834.7495751274623;836.7657056024323;887.0375642427973;901.0718959471754;907.3920473282916;907.718607231757;908.3505293714992;930.4789317981918;933.2953620016877;933.3093510801991;934.6027938126304;936.1153709744294;926.0600490502146;931.6226928094133;932.2309094996655;935.3218916285673;936.2229349639816;685.3044160177424;686.5674624986277;688.4733179117978;689.9793006209821;691.6991108867609;12928.09503334767;12959;13591.932040339734;15291.847081529153;15509.510360168984;14681.412743490248;14788.18664973426;14863.777043344358;14915.552533424014;15065.472708455152;12731.681707957283;12903.225806451643;12907;13044.08691391603;13083.280419577015;2827.9858600706866;2836.4610723962587;2848.2594525423333;2856.228818219069;2858.099698594936;64491.03263451052;64557;64867.75554267172;65656.67171664159;66358;10564.894351056544;10583.523741431654;10636.734081647866;10683.091937185427;10712.517936692868;16099.839001609835;16366.608838248882;16385.91807040957;16495.83504164943;16521.91739041297;5666.631668941505;5793.652380857162;5997.16039754426;6044.455998960115;6077.574569780073;2788;2831.2638713934525;2842.445723083979;2855.314724466113;2868.3976364963173;3467.514547963287;3526.2242306692488;3541.964580354215;3543.114221444639;3564.483149943244;764.7361660227212;779.4076501858628;783.5416281475286;785.2147852147853;791.1179035375629;569.4903061759702;573.1860757724041;592.2537602620642;594.7264258441165;606.6572386601556;9884.357516761387;10319.226058045677;10966;11315.773684526263;11792.521061636224;600.921880155577;604.0908432808595;609.7835268479714;619.8078595635277;620.2990620598785;4511.368408422823;4650.930236046462;4716.056788642285;4751.287306903992;4809.0862736080035;55759;57126.42873571294;57464.138037929464;60051.699741501885;60125;53023;53480.73259633677;53562.46437535575;53710.73144634252;53909.730451347496;47504.524954750705;48176.75911620419;48296;48543.5145648539;50057.24914126291;9080.40977336471;9101.06420115093;9122.361434699507;9168.31237657165;9457.19613832832;24652.630210547213;24979.750202497744;25649.358766030997;25975.22074337773;26487.867560662075;30744;30997;31142.377152457277;31301.217469563442;31924;12189.451474683483;12303.44634491432;12357.876421235673;12410.193337433038;12538.310392928477;12875.420606072561;13106.803397948848;13188.472461101448;13271;13362.866371336162;12407.93796031014;12609.68475788076;12767.233965962072;12814.55149069778;12885.935570322088;11319.886801131883;11478.770424591294;11491.425428728697;11548.016961835869;11723.062155027748;11084.168687348643;11230.270032447865;11332.490037948477;11451.885481145415;11491.253068550517;8119.918800811916;8411.074781773877;8519.531425771394;8525;8725.91274087251;10320.845187322346;10431.634892778717;10557;10653.147748180281;10688.305260158066 09:24:10 INFO - PID 6050 | __end_tp_report 09:24:10 INFO - PID 6050 | __start_cc_report 09:24:10 INFO - PID 6050 | _x_x_mozilla_cycle_collect,290 09:24:10 INFO - PID 6050 | __end_cc_report 09:24:10 INFO - PID 6050 | __startTimestamp1495211050275__endTimestamp 09:24:10 INFO - PID 6050 | 09:24:10 INFO - PID 6050 | ------- Summary: start ------- 09:24:10 INFO - PID 6050 | Number of tests: 6 09:24:10 INFO - PID 6050 | 09:24:10 INFO - PID 6050 | [#0] dojo.html Cycles:165 Average:5333.70 Median:5458.86 stddev:645.45 (11.8%) stddev-sans-first:614.19 09:24:10 INFO - PID 6050 | Values: 2727.2 2741.5 2748.1 2779.8 2785.9 5306.6 5331.9 5364.8 5380.5 5385.1 5334.0 5357.6 5382.1 5449.5 5452.2 4564.5 4753.3 4766.3 4781.8 4800.0 4818.2 4841.0 4862.9 4867.1 4867.4 4707.6 4709.5 4804.4 4815.0 4817.9 4815.3 4820.2 4821.5 4859.1 4878.4 4753.9 4773.9 4776.6 4792.5 4825.9 5265.5 5346.4 5390.5 5391.5 5444.0 5763.7 5812.6 5817.6 5824.8 5834.6 5877.4 5908.1 5935.9 5943.9 5950.6 5286.4 5410.1 5416.6 5422.2 5436.7 5976.1 6030.8 6114.6 6124.1 6141.5 5662.1 5663.3 5678.7 5678.7 5684.9 5690.9 5714.3 5776.8 5800.0 5822.3 5746.9 5844.7 5849.5 5862.5 5911.9 5668.6 5685.2 5736.8 5758.8 5776.3 4917.6 4950.2 4950.4 4955.0 4985.4 4200.3 4203.4 4212.7 4215.6 4248.4 4817.4 4900.2 4901.7 4932.0 4976.9 5876.6 5898.4 5930.2 5937.4 5970.7 4918.7 4925.4 4939.7 4946.5 4984.5 5045.1 5120.1 5149.4 5178.2 5202.7 5435.8 5448.5 5458.9 5492.1 5505.2 5848.7 5892.8 5901.6 5907.2 5921.5 5321.7 5358.5 5438.1 5445.3 5449.7 5702.6 5833.1 5838.3 5838.7 5843.1 5929.6 5935.9 5940.6 5976.7 5997.5 5555.9 5571.5 5653.3 5694.9 5791.4 5738.5 5741.6 5742.1 5743.7 5782.1 5517.3 5555.1 5585.4 5593.2 5669.6 5736.7 5753.7 5767.8 5782.3 5789.7 5580.1 5580.6 5587.1 5593.9 5599.8 09:24:10 INFO - PID 6050 | 09:24:10 INFO - PID 6050 | [#1] ext.html Cycles:180 Average:30084.19 Median:30124.47 stddev:40032.26 (132.9%) stddev-sans-first:40083.78 09:24:10 INFO - PID 6050 | Values: 708.2 725.8 750.0 1055.7 1066.7 31781.4 32691.3 32770.3 32803.7 32929.8 34520.1 34731.5 35012.8 35065.1 35095.8 6757.8 6905.7 6952.9 7118.1 7153.7 7038.4 7168.4 7169.2 7178.2 7180.3 7135.3 7138.5 7168.6 7173.9 7204.2 7037.8 7107.7 7109.0 7150.8 7161.6 7025.1 7079.9 7086.9 7105.0 7105.6 32361.2 32378.7 32407.4 32437.0 32533.2 3047.4 3064.5 3065.1 3087.6 3097.8 24768.8 24782.1 24899.6 25002.5 25045.0 3140.4 3149.1 3154.2 3159.9 3163.9 132509.3 132970.3 147502.3 149997.0 150017.0 39009.0 39129.0 39134.8 39176.0 39277.8 40838.4 40972.4 46422.8 46662.1 46820.8 12734.9 12826.5 12838.2 12858.0 12883.7 10076.9 10118.2 10148.2 10156.1 10276.3 13138.4 13144.3 13165.8 13187.0 13307.6 5652.0 5663.5 5687.5 5693.9 5725.3 879.7 909.1 914.8 921.2 938.5 20541.7 21308.8 21615.5 21655.7 21790.6 971.6 982.9 988.4 1007.2 1010.0 11271.5 11365.7 11474.4 11475.3 11588.8 171905.0 172635.0 172825.0 173633.1 173745.0 39715.0 39918.6 40072.4 40079.8 40130.4 1198.6 1237.0 1252.0 1258.2 1258.4 19669.0 19749.4 20583.3 21474.7 21475.8 29240.0 29382.7 29443.4 29459.4 29564.3 148273.0 148458.0 148796.0 148906.0 149391.3 28551.0 29619.3 29701.9 30004.0 30121.2 35924.1 36069.5 36147.3 36219.6 36268.5 26694.3 27517.6 27527.0 27747.0 28286.0 26889.5 27529.4 27729.3 28781.1 28806.7 29966.3 30076.2 30127.7 30247.5 30397.0 25823.9 26329.2 26468.4 26971.3 27332.6 19891.2 22457.6 22578.0 22677.8 22747.8 09:24:10 INFO - PID 6050 | 09:24:10 INFO - PID 6050 | [#2] jquery.html Cycles:180 Average:25174.72 Median:4066.49 stddev:56913.82 (1399.6%) stddev-sans-first:57043.12 09:24:10 INFO - PID 6050 | Values: 416.9 422.7 423.8 430.8 440.7 14158.2 14725.2 16291.3 16979.5 17097.5 18112.7 18140.9 18541.8 18551.9 18746.2 5465.8 5492.3 5520.6 5571.4 5650.7 5474.4 5571.1 5582.4 5582.5 5583.5 4961.4 5456.6 5465.5 5482.2 5483.0 5411.5 5448.3 5448.7 5454.8 5474.6 5055.5 5065.6 5068.5 5115.1 5122.1 21792.2 22433.3 22467.2 22704.1 22761.7 1572.3 1609.9 1610.9 1611.9 1615.8 14292.4 14468.1 14888.1 15067.6 15163.6 2046.4 2095.1 2101.1 2151.7 2152.7 86681.0 95422.5 95680.0 95789.5 96356.5 17901.5 18303.0 18418.9 18422.7 18589.7 33730.2 33765.3 33861.2 33902.8 34150.8 8935.9 9085.6 9257.1 9349.6 9532.4 7286.9 7310.0 7595.0 7616.9 7627.0 9022.6 9469.6 9596.2 9607.6 9652.3 4046.7 4086.3 4112.5 4136.5 4171.6 831.0 866.7 883.1 897.1 900.2 17177.5 17466.5 17707.7 17745.1 17774.3 884.9 888.9 892.1 902.2 903.9 9427.7 9632.9 9846.0 9898.7 9927.8 335592.0 337500.0 339710.0 339877.0 343908.0 76433.6 78335.6 78547.6 80128.6 82675.6 1064.6 1086.9 1127.7 1128.1 1129.8 17277.3 17650.4 18180.4 18222.9 18417.5 38299.0 38882.0 38888.6 39782.8 39810.6 47264.3 47282.3 47473.0 47510.0 47513.3 8386.7 8472.3 8566.7 8687.9 8751.9 12760.1 13023.5 13621.7 13770.5 13827.7 10608.3 10722.4 10865.2 10918.0 11064.0 10872.9 11065.1 11089.6 11110.4 11489.3 10615.7 10714.3 10721.8 11314.7 11445.8 8090.5 8170.4 8198.8 8526.0 8547.7 10053.2 10511.6 10885.6 10976.7 11280.6 09:24:10 INFO - PID 6050 | 09:24:10 INFO - PID 6050 | [#3] mootools.html Cycles:180 Average:6386.58 Median:3773.47 stddev:4098.24 (108.6%) stddev-sans-first:4091.72 09:24:10 INFO - PID 6050 | Values: 1272.1 1323.4 1338.5 1343.9 1349.4 10126.3 10443.9 10485.1 10506.4 10719.5 10556.3 10682.4 10730.9 10743.9 10746.9 2238.4 2268.8 2272.3 2273.2 2274.9 2177.1 2236.5 2237.1 2237.8 2245.9 2191.7 2207.7 2240.3 2251.6 2256.0 2177.7 2192.1 2221.2 2236.2 2237.8 2029.3 2159.3 2163.3 2180.2 2189.4 10353.2 10386.0 10443.2 10451.3 10477.3 5751.4 5945.9 5964.1 5990.5 5993.3 3459.5 3752.6 3794.3 3794.4 3843.6 1149.4 1160.1 1161.5 1226.3 1230.4 14558.9 14559.6 14568.5 14647.1 14717.3 4799.5 4805.8 4981.4 4993.8 5004.0 10980.8 11001.0 11061.7 11062.4 11080.6 5697.7 5709.7 5712.1 5733.9 5752.1 5235.5 5263.3 5268.2 5341.6 5358.6 3857.8 3917.5 3958.1 3998.4 4020.1 1159.4 1163.0 1163.1 1164.9 1178.7 690.3 725.7 726.2 740.7 744.7 5589.6 5740.5 5746.9 5812.9 5855.3 537.6 562.9 565.6 567.7 569.1 3485.5 3498.9 3511.7 3624.4 4019.6 13114.5 13590.0 13781.7 13816.9 13918.8 13403.5 13516.9 13648.9 13868.2 13888.1 7481.7 7515.1 7518.0 7562.3 7620.7 5994.3 6022.0 6024.4 6071.7 6182.4 12038.5 12107.9 12124.7 12304.5 12638.9 12376.0 12573.3 12625.3 12775.0 12836.8 7389.3 7593.6 7596.1 7609.0 7620.6 9468.4 9659.2 9816.0 9818.5 9829.1 8008.0 8084.3 8136.7 8269.3 8310.3 8130.0 8151.1 8191.6 8204.1 8454.9 7341.0 7346.7 7417.4 7448.6 7461.1 5282.6 5288.5 5335.1 5515.5 5542.0 5410.5 5446.5 5453.3 5537.7 5591.9 09:24:10 INFO - PID 6050 | 09:24:10 INFO - PID 6050 | [#4] prototype.html Cycles:180 Average:4819.91 Median:5511.30 stddev:1445.23 (26.2%) stddev-sans-first:1410.48 09:24:10 INFO - PID 6050 | Values: 387.7 387.9 391.3 396.8 398.0 5501.0 5512.2 5551.6 5605.8 5713.9 5411.8 5480.9 5502.4 5506.5 5526.7 4033.1 4126.1 4131.8 4138.3 4183.5 4130.0 4140.8 4145.7 4151.4 4157.7 4117.2 4125.4 4125.9 4129.6 4134.9 4031.7 4111.6 4119.4 4136.4 4137.3 3563.4 3573.6 3576.5 3578.6 3598.1 5386.9 5392.9 5421.6 5438.1 5446.2 4710.2 4868.0 4888.8 4895.0 4927.6 5835.0 5859.2 5867.6 5869.0 5869.5 4067.9 4074.3 4087.2 4088.1 4104.1 6007.5 6149.1 6195.4 6236.9 6281.1 4102.9 4149.4 4156.7 4162.1 4168.9 4213.3 4219.3 4224.8 4226.2 4235.2 4747.1 4832.4 4876.8 4897.9 4902.5 5804.2 5850.9 5856.0 5881.8 5893.4 1437.4 1446.3 1456.6 1457.4 1458.7 967.6 972.5 977.5 983.4 984.6 4967.8 5029.3 5042.8 5052.0 5085.6 6081.6 6086.5 6102.6 6116.0 6133.1 4895.7 5006.0 5011.0 5048.1 5067.2 3195.7 3195.9 3205.4 3206.5 3210.9 5510.4 5557.7 5561.7 5564.5 5612.9 6108.0 6201.4 6203.9 6228.4 6251.0 5609.2 5643.9 5644.4 5652.2 5661.6 6119.3 6126.1 6150.6 6153.5 6174.4 5964.4 5965.8 5978.8 5986.6 6012.0 5607.6 5626.7 5640.4 5640.5 5645.7 4058.1 4154.3 4172.0 4185.6 4187.1 6088.1 6116.6 6132.9 6153.6 6163.6 5852.2 5892.2 5930.5 5931.9 5934.1 5731.4 5888.9 5906.8 5956.7 5962.6 5804.5 5817.8 5818.0 5837.8 5855.4 5806.2 5947.1 5963.6 5964.7 5965.0 5708.9 5725.3 5737.2 5741.4 5764.0 09:24:10 INFO - PID 6050 | 09:24:10 INFO - PID 6050 | [#5] yui.html Cycles:180 Average:14056.20 Median:3534.09 stddev:16676.14 (471.9%) stddev-sans-first:16692.86 09:24:10 INFO - PID 6050 | Values: 723.3 725.7 746.6 747.1 749.6 12072.9 12567.2 13502.9 14484.0 14488.9 14285.6 14720.9 14732.3 14767.1 15107.2 812.5 834.0 834.3 834.7 836.8 887.0 901.1 907.4 907.7 908.4 930.5 933.3 933.3 934.6 936.1 926.1 931.6 932.2 935.3 936.2 685.3 686.6 688.5 690.0 691.7 12928.1 12959.0 13591.9 15291.8 15509.5 14681.4 14788.2 14863.8 14915.6 15065.5 12731.7 12903.2 12907.0 13044.1 13083.3 2828.0 2836.5 2848.3 2856.2 2858.1 64491.0 64557.0 64867.8 65656.7 66358.0 10564.9 10583.5 10636.7 10683.1 10712.5 16099.8 16366.6 16385.9 16495.8 16521.9 5666.6 5793.7 5997.2 6044.5 6077.6 2788.0 2831.3 2842.4 2855.3 2868.4 3467.5 3526.2 3542.0 3543.1 3564.5 764.7 779.4 783.5 785.2 791.1 569.5 573.2 592.3 594.7 606.7 9884.4 10319.2 10966.0 11315.8 11792.5 600.9 604.1 609.8 619.8 620.3 4511.4 4650.9 4716.1 4751.3 4809.1 55759.0 57126.4 57464.1 60051.7 60125.0 53023.0 53480.7 53562.5 53710.7 53909.7 47504.5 48176.8 48296.0 48543.5 50057.2 9080.4 9101.1 9122.4 9168.3 9457.2 24652.6 24979.8 25649.4 25975.2 26487.9 30744.0 30997.0 31142.4 31301.2 31924.0 12189.5 12303.4 12357.9 12410.2 12538.3 12875.4 13106.8 13188.5 13271.0 13362.9 12407.9 12609.7 12767.2 12814.6 12885.9 11319.9 11478.8 11491.4 11548.0 11723.1 11084.2 11230.3 11332.5 11451.9 11491.3 8119.9 8411.1 8519.5 8525.0 8725.9 10320.8 10431.6 10557.0 10653.1 10688.3 09:24:10 INFO - PID 6050 | -------- Summary: end -------- 09:24:10 INFO - PID 6050 | 09:24:11 INFO - TEST-INFO | 6050: exit 0 09:24:11 INFO - TEST-OK | dromaeo_css | took 1117407ms 09:24:11 INFO - TEST-START | kraken 09:24:11 INFO - operating with platform_type : linux_ 09:24:11 INFO - Initialising browser for kraken test... 09:24:11 INFO - TEST-INFO | started process 6451 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPbPh2u/profile http://localhost:47031/getInfo.html) 09:24:11 INFO - PID 6451 | JavaScript warning: resource://gre/modules/addons/XPIProvider.jsm, line 2941: String.localeCompare is deprecated; use String.prototype.localeCompare instead 09:24:14 INFO - PID 6451 | __metrics Screen width/height:1600/1200 09:24:14 INFO - PID 6451 | colorDepth:24 09:24:14 INFO - PID 6451 | Browser inner width/height: 1024/695 09:24:14 INFO - PID 6451 | __metrics 09:24:16 INFO - TEST-INFO | 6451: exit 0 09:24:16 INFO - Browser initialized. 09:24:16 INFO - Running cycle 1/1 for kraken test... 09:24:16 INFO - TEST-INFO | started process 6613 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPbPh2u/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:24:28 INFO - PID 6613 | RSS: Main: 166092800 09:24:28 INFO - PID 6613 | 09:24:30 INFO - PID 6613 | Cycle 1(1): loaded http://localhost:47031/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47031/tests/kraken/driver.html?testName=audio-beat-detection) 09:24:31 INFO - PID 6613 | RSS: Main: 170303488 09:24:31 INFO - PID 6613 | 09:24:34 INFO - PID 6613 | Cycle 1(1): loaded http://localhost:47031/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47031/tests/kraken/driver.html?testName=audio-dft) 09:24:35 INFO - PID 6613 | RSS: Main: 170147840 09:24:35 INFO - PID 6613 | 09:24:37 INFO - PID 6613 | Cycle 1(1): loaded http://localhost:47031/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47031/tests/kraken/driver.html?testName=audio-fft) 09:24:38 INFO - PID 6613 | RSS: Main: 165199872 09:24:38 INFO - PID 6613 | 09:24:40 INFO - PID 6613 | Cycle 1(1): loaded http://localhost:47031/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47031/tests/kraken/driver.html?testName=audio-oscillator) 09:24:41 INFO - PID 6613 | RSS: Main: 165859328 09:24:41 INFO - PID 6613 | 09:24:43 INFO - PID 6613 | Cycle 1(1): loaded http://localhost:47031/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47031/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:24:44 INFO - PID 6613 | RSS: Main: 166092800 09:24:44 INFO - PID 6613 | 09:24:47 INFO - PID 6613 | Cycle 1(1): loaded http://localhost:47031/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47031/tests/kraken/driver.html?testName=imaging-darkroom) 09:24:47 INFO - PID 6613 | RSS: Main: 170430464 09:24:47 INFO - PID 6613 | 09:24:51 INFO - PID 6613 | Cycle 1(1): loaded http://localhost:47031/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47031/tests/kraken/driver.html?testName=imaging-desaturate) 09:24:51 INFO - PID 6613 | RSS: Main: 167575552 09:24:51 INFO - PID 6613 | 09:24:54 INFO - PID 6613 | Cycle 1(1): loaded http://localhost:47031/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47031/tests/kraken/driver.html?testName=json-parse-financial) 09:24:55 INFO - PID 6613 | RSS: Main: 168976384 09:24:55 INFO - PID 6613 | 09:24:57 INFO - PID 6613 | Cycle 1(1): loaded http://localhost:47031/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47031/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:24:57 INFO - PID 6613 | RSS: Main: 169013248 09:24:57 INFO - PID 6613 | 09:24:59 INFO - PID 6613 | Cycle 1(1): loaded http://localhost:47031/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47031/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:25:00 INFO - PID 6613 | RSS: Main: 169222144 09:25:00 INFO - PID 6613 | 09:25:02 INFO - PID 6613 | Cycle 1(1): loaded http://localhost:47031/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47031/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:25:02 INFO - PID 6613 | RSS: Main: 168914944 09:25:02 INFO - PID 6613 | 09:25:05 INFO - PID 6613 | Cycle 1(1): loaded http://localhost:47031/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47031/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:25:06 INFO - PID 6613 | RSS: Main: 169164800 09:25:06 INFO - PID 6613 | 09:25:09 INFO - PID 6613 | Cycle 1(1): loaded http://localhost:47031/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47031/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:25:10 INFO - PID 6613 | RSS: Main: 169107456 09:25:10 INFO - PID 6613 | 09:25:12 INFO - PID 6613 | Cycle 1(1): loaded http://localhost:47031/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47031/tests/kraken/driver.html?testName=ai-astar) 09:25:12 INFO - PID 6613 | RSS: Main: 170450944 09:25:12 INFO - PID 6613 | 09:25:12 INFO - PID 6613 | __start_tp_report 09:25:12 INFO - PID 6613 | _x_x_mozilla_page_load 09:25:12 INFO - PID 6613 | _x_x_mozilla_page_load_details 09:25:12 INFO - PID 6613 | |i|pagename|runs| 09:25:12 INFO - PID 6613 | |0;ai-astar;103;114;116;114;110;111;112;110;110;113 09:25:12 INFO - PID 6613 | |1;audio-beat-detection;157;131;126;179;123;127;123;122;144;130 09:25:12 INFO - PID 6613 | |2;audio-dft;164;165;164;167;164;165;167;171;163;165 09:25:12 INFO - PID 6613 | |3;audio-fft;77;75;75;112;74;74;75;75;96;75 09:25:12 INFO - PID 6613 | |4;audio-oscillator;83;85;114;84;83;85;101;87;83;103 09:25:12 INFO - PID 6613 | |5;imaging-gaussian-blur;114;115;117;114;114;114;114;114;114;116 09:25:12 INFO - PID 6613 | |6;imaging-darkroom;150;150;151;151;150;150;151;151;151;150 09:25:12 INFO - PID 6613 | |7;imaging-desaturate;95;102;95;94;94;95;94;95;95;95 09:25:12 INFO - PID 6613 | |8;json-parse-financial;57;55;56;56;59;59;60;57;56;57 09:25:12 INFO - PID 6613 | |9;json-stringify-tinderbox;56;56;56;57;56;56;56;57;56;56 09:25:12 INFO - PID 6613 | |10;stanford-crypto-aes;82;81;84;82;82;84;81;90;80;81 09:25:12 INFO - PID 6613 | |11;stanford-crypto-ccm;141;133;134;140;148;133;133;147;180;135 09:25:12 INFO - PID 6613 | |12;stanford-crypto-pbkdf2;187;197;196;195;201;188;193;188;197;204 09:25:12 INFO - PID 6613 | |13;stanford-crypto-sha256-iterative;75;77;76;74;76;76;74;73;75;73 09:25:12 INFO - PID 6613 | __end_tp_report 09:25:12 INFO - PID 6613 | __start_cc_report 09:25:12 INFO - PID 6613 | _x_x_mozilla_cycle_collect,789 09:25:12 INFO - PID 6613 | __end_cc_report 09:25:12 INFO - PID 6613 | __startTimestamp1495211112253__endTimestamp 09:25:12 INFO - PID 6613 | 09:25:12 INFO - PID 6613 | ------- Summary: start ------- 09:25:12 INFO - PID 6613 | Number of tests: 14 09:25:12 INFO - PID 6613 | 09:25:12 INFO - PID 6613 | [#0] ai-astar Cycles:10 Average:111.30 Median:112.50 stddev:3.56 (3.2%) stddev-sans-first:2.17 09:25:12 INFO - PID 6613 | Values: 103.0 114.0 116.0 114.0 110.0 111.0 112.0 110.0 110.0 113.0 09:25:12 INFO - PID 6613 | 09:25:12 INFO - PID 6613 | [#1] audio-beat-detection Cycles:10 Average:136.20 Median:130.50 stddev:18.65 (14.3%) stddev-sans-first:18.20 09:25:12 INFO - PID 6613 | Values: 157.0 131.0 126.0 179.0 123.0 127.0 123.0 122.0 144.0 130.0 09:25:12 INFO - PID 6613 | 09:25:12 INFO - PID 6613 | [#2] audio-dft Cycles:10 Average:165.50 Median:165.00 stddev:2.32 (1.4%) stddev-sans-first:2.40 09:25:12 INFO - PID 6613 | Values: 164.0 165.0 164.0 167.0 164.0 165.0 167.0 171.0 163.0 165.0 09:25:12 INFO - PID 6613 | 09:25:12 INFO - PID 6613 | [#3] audio-fft Cycles:10 Average:80.80 Median:75.00 stddev:12.82 (17.1%) stddev-sans-first:13.53 09:25:12 INFO - PID 6613 | Values: 77.0 75.0 75.0 112.0 74.0 74.0 75.0 75.0 96.0 75.0 09:25:12 INFO - PID 6613 | 09:25:12 INFO - PID 6613 | [#4] audio-oscillator Cycles:10 Average:90.80 Median:83.50 stddev:11.06 (13.2%) stddev-sans-first:11.37 09:25:12 INFO - PID 6613 | Values: 83.0 85.0 114.0 84.0 83.0 85.0 101.0 87.0 83.0 103.0 09:25:12 INFO - PID 6613 | 09:25:12 INFO - PID 6613 | [#5] imaging-gaussian-blur Cycles:10 Average:114.60 Median:114.00 stddev:1.07 (0.9%) stddev-sans-first:1.12 09:25:12 INFO - PID 6613 | Values: 114.0 115.0 117.0 114.0 114.0 114.0 114.0 114.0 114.0 116.0 09:25:12 INFO - PID 6613 | 09:25:12 INFO - PID 6613 | [#6] imaging-darkroom Cycles:10 Average:150.50 Median:151.00 stddev:0.53 (0.3%) stddev-sans-first:0.53 09:25:12 INFO - PID 6613 | Values: 150.0 150.0 151.0 151.0 150.0 150.0 151.0 151.0 151.0 150.0 09:25:12 INFO - PID 6613 | 09:25:12 INFO - PID 6613 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.00 stddev:2.37 (2.5%) stddev-sans-first:2.51 09:25:12 INFO - PID 6613 | Values: 95.0 102.0 95.0 94.0 94.0 95.0 94.0 95.0 95.0 95.0 09:25:12 INFO - PID 6613 | 09:25:12 INFO - PID 6613 | [#8] json-parse-financial Cycles:10 Average:57.20 Median:57.00 stddev:1.62 (2.8%) stddev-sans-first:1.72 09:25:12 INFO - PID 6613 | Values: 57.0 55.0 56.0 56.0 59.0 59.0 60.0 57.0 56.0 57.0 09:25:12 INFO - PID 6613 | 09:25:12 INFO - PID 6613 | [#9] json-stringify-tinderbox Cycles:10 Average:56.20 Median:56.00 stddev:0.42 (0.8%) stddev-sans-first:0.44 09:25:12 INFO - PID 6613 | Values: 56.0 56.0 56.0 57.0 56.0 56.0 56.0 57.0 56.0 56.0 09:25:12 INFO - PID 6613 | 09:25:12 INFO - PID 6613 | [#10] stanford-crypto-aes Cycles:10 Average:82.70 Median:82.00 stddev:2.87 (3.5%) stddev-sans-first:3.03 09:25:12 INFO - PID 6613 | Values: 82.0 81.0 84.0 82.0 82.0 84.0 81.0 90.0 80.0 81.0 09:25:12 INFO - PID 6613 | 09:25:12 INFO - PID 6613 | [#11] stanford-crypto-ccm Cycles:10 Average:142.40 Median:140.50 stddev:14.39 (10.2%) stddev-sans-first:15.26 09:25:12 INFO - PID 6613 | Values: 141.0 133.0 134.0 140.0 148.0 133.0 133.0 147.0 180.0 135.0 09:25:12 INFO - PID 6613 | 09:25:12 INFO - PID 6613 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:194.60 Median:196.50 stddev:5.68 (2.9%) stddev-sans-first:5.32 09:25:12 INFO - PID 6613 | Values: 187.0 197.0 196.0 195.0 201.0 188.0 193.0 188.0 197.0 204.0 09:25:12 INFO - PID 6613 | 09:25:12 INFO - PID 6613 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.90 Median:75.50 stddev:1.37 (1.8%) stddev-sans-first:1.45 09:25:12 INFO - PID 6613 | Values: 75.0 77.0 76.0 74.0 76.0 76.0 74.0 73.0 75.0 73.0 09:25:12 INFO - PID 6613 | -------- Summary: end -------- 09:25:12 INFO - PID 6613 | 09:25:13 INFO - TEST-INFO | 6613: exit 0 09:25:13 INFO - TEST-OK | kraken | took 62219ms 09:25:13 INFO - SUITE-END | took 1179s 09:25:13 INFO - Completed test suite (00:19:39) 09:25:13 INFO - javascript benchmark 09:25:13 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6803.015378132891, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2727.222741518667, 2741.533939230331, 2748.0519220868805, 2779.847108409038, 2785.86070696465, 5306.602004849642, 5331.92002119968, 5364.785408583652, 5380.515753582182, 5385.111456609659, 5333.973330133354, 5357.571394288458, 5382.085045542258, 5449.482299181582, 5452.182172674101, 4564.5435456454425, 4753.287006948951, 4766.332713420124, 4781.760911954406, 4800.015996720673, 4818.204996175627, 4840.9515904840855, 4862.902741945159, 4867.050925069613, 4867.3915760529935, 4707.552782485658, 4709.529047095298, 4804.375431193957, 4814.951850481485, 4817.879553011167, 4815.349927759743, 4820.204666230068, 4821.5178482151505, 4859.07677541266, 4878.414590249193, 4753.857384278477, 4773.856784296477, 4776.641751868624, 4792.544708252745, 4825.927611085802, 5265.526102650741, 5346.385165705916, 5390.5418039466695, 5391.487808658171, 5444.047291723932, 5763.6541807491685, 5812.564057695689, 5817.563682723812, 5824.767009319622, 5834.620749651302, 5877.412258774131, 5908.113782932552, 5935.9406405935815, 5943.910841337383, 5950.553708471839, 5286.392064912584, 5410.107332290128, 5416.647917885325, 5422.15956526735, 5436.70098144598, 5976.073708575178, 6030.7889223876955, 6114.633122012693, 6124.142620033199, 6141.477974372228, 5662.094064949588, 5663.348714897757, 5678.687672177987, 5678.716064196774, 5684.914726279109, 5690.943090569124, 5714.314282286152, 5776.797812076557, 5799.971000144972, 5822.272215973004, 5746.913796293059, 5844.736986835603, 5849.5027922626205, 5862.472377486047, 5911.9113213301835, 5668.631538949955, 5685.204071430003, 5736.770529178786, 5758.827235182951, 5776.306843178845, 4917.582005529499, 4950.158473059589, 4950.381202349707, 4955.033768415196, 4985.401751789808, 4200.306949353322, 4203.369494575777, 4212.705110642226, 4215.59951804578, 4248.4052232687445, 4817.397825271841, 4900.240462728283, 4901.681390709592, 4931.9753401232765, 4976.925346119811, 5876.618019828783, 5898.439648233411, 5930.229070220844, 5937.435943585352, 5970.671613061237, 4918.704877707349, 4925.38432695913, 4939.728314942641, 4946.455889852114, 4984.451710311862, 5045.091883460939, 5120.129577971679, 5149.382074151126, 5178.249153872743, 5202.687838729613, 5435.755391007335, 5448.482394172547, 5458.863528411822, 5492.1212605982855, 5505.201745746765, 5848.678322692293, 5892.793752218652, 5901.557383196192, 5907.232059832194, 5921.4966727826895, 5321.680699157908, 5358.517733404013, 5438.075527160471, 5445.346558413015, 5449.7002664852225, 5702.6293290935955, 5833.1250312451775, 5838.299404071538, 5838.737256823369, 5843.094320380348, 5929.584929055098, 5935.940640593539, 5940.584159108821, 5976.701164941648, 5997.520198384032, 5555.8888822222525, 5571.498565128995, 5653.349864765604, 5694.943050569441, 5791.362950075572, 5738.512226460798, 5741.62679425836, 5742.052561327501, 5743.712814359182, 5782.10377391505, 5517.282753242052, 5555.083411237262, 5585.357683866408, 5593.244911936999, 5669.574781891292, 5736.71316434185, 5753.683547404933, 5767.798127065533, 5782.277215348082, 5789.681567513659, 5580.107182850725, 5580.609357344947, 5587.078132108157, 5593.916091258553, 5599.832005039855], "value": 5285.247378796424, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [708.1679027143106, 725.8004048886555, 749.9925000749993, 1055.6674647486045, 1066.7386490309875, 31781.36437271256, 32691.346173076523, 32770.34459310818, 32803.67196328039, 32929.83535082324, 34520.1369965751, 34731.4790278146, 35012.82493587529, 35065.12337191572, 35095.82452087736, 6757.763478278249, 6905.689243984008, 6952.89570656438, 7118.07465029548, 7153.713851445936, 7038.366547010768, 7168.390686791629, 7169.211386747454, 7178.174509931347, 7180.31786980236, 7135.286471352849, 7138.464615153858, 7168.641567921609, 7173.85652286954, 7204.171520275157, 7037.824054398681, 7107.680154393013, 7108.964455177716, 7150.785476435715, 7161.606111663857, 7025.121859767529, 7079.858402831915, 7086.893696594555, 7104.964475177642, 7105.573665580082, 32361.190970225933, 32378.67621323804, 32407.351852963046, 32437.0, 32533.186670333194, 3047.3752880659413, 3064.540318952175, 3065.111117775842, 3087.598612180402, 3097.7676674249296, 24768.752312476823, 24782.132625358205, 24899.62650560243, 25002.4999500009, 25045.0, 3140.3876244132402, 3149.086764838194, 3154.1799132225556, 3159.873605055795, 3163.8734450621946, 132509.33745331308, 132970.33514832365, 147502.26248868686, 149997.0, 150017.0, 39009.0, 39129.0, 39134.804325978184, 39176.0, 39277.80361098176, 40838.38742418866, 40972.38541421822, 46422.767886161026, 46662.06675866464, 46820.7658961703, 12734.936325318315, 12826.486940522274, 12838.16551924122, 12858.0, 12883.677908052186, 10076.891541930381, 10118.241131914989, 10148.188144948386, 10156.136728378171, 10276.332038417479, 13138.357705286839, 13144.342782860818, 13165.802512962313, 13187.0, 13307.600771976857, 5652.037414474461, 5663.490285874291, 5687.516561092353, 5693.886122277531, 5725.2843394575675, 879.7448739865496, 909.1454033208763, 914.8307563100848, 921.203159267229, 938.5401153434905, 20541.691874621894, 21308.78691213068, 21615.459613509473, 21655.675164872224, 21790.564188716136, 971.582219645545, 982.9262805289488, 988.4267125067444, 1007.2345017786389, 1010.0, 11271.492782824793, 11365.715857103638, 11474.368909710047, 11475.311481311148, 11588.826167607493, 171905.0, 172635.0, 172825.0, 173633.13183434002, 173745.0, 39715.0, 39918.600813991485, 40072.39891401631, 40079.79960100181, 40130.39804402936, 1198.6164427383153, 1236.975260494785, 1251.9624411267675, 1258.1758947889148, 1258.3771033338373, 19669.0, 19749.40751777449, 20583.279585214445, 21474.677879831503, 21475.78524214738, 29240.0, 29382.706172937997, 29443.411131776815, 29459.410811784073, 29564.260893476974, 148273.0, 148458.0, 148796.0, 148906.0, 149391.25304373843, 28551.0, 29619.259518512208, 29701.851490742407, 30004.0, 30121.24696882508, 35924.10189745173, 36069.45895811512, 36147.27705445929, 36219.63780362268, 36268.45597315989, 26694.332641683337, 27517.587236191073, 27527.0, 27747.0, 28286.009989650265, 26889.462210756068, 27529.44941101127, 27729.306767330978, 28781.136565903056, 28806.71193288124, 29966.25084372908, 30076.24809379783, 30127.698723013367, 30247.546286805275, 30397.0, 25823.870880645478, 26329.21012369632, 26468.368035594078, 26971.325716857235, 27332.590011149452, 19891.21372136399, 22457.550848983257, 22578.0, 22677.773222268224, 22747.772522274565], "value": 14604.48990834198, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [416.91453252083323, 422.67665236094393, 423.7732812945074, 430.81690281630307, 440.7311539960626, 14158.221297828615, 14725.190114543695, 16291.348346066157, 16979.490615281546, 17097.48707538776, 18112.728309075374, 18140.909295453504, 18541.814581854178, 18551.907240463814, 18746.156422960965, 5465.781368745245, 5492.340919089705, 5520.558355331584, 5571.359293681217, 5650.7174641267975, 5474.42518535554, 5571.13647384656, 5582.441755824426, 5582.525485333731, 5583.5254003409755, 4961.3798275215595, 5456.563474921997, 5465.480779325958, 5482.17767334899, 5482.972585137069, 5411.458854114597, 5448.291722076145, 5448.727563621823, 5454.836354909339, 5474.589405794542, 5055.545000949932, 5065.594752419797, 5068.518490743373, 5115.130427827278, 5122.103631864409, 21792.237271695572, 22433.32700019002, 22467.213647522258, 22704.091836326526, 22761.658575121386, 1572.3239007226887, 1609.8873078884483, 1610.903345799244, 1611.8629916457114, 1615.7576363545445, 14292.428302867873, 14468.131912085204, 14888.106713597219, 15067.623309417242, 15163.62090947724, 2046.3963130876277, 2095.1409921931936, 2101.0965284927474, 2151.709519214902, 2152.6770984352315, 86681.0, 95422.52288738581, 95680.04319956781, 95789.521052395, 96356.51821740916, 17901.462956111336, 18303.0, 18418.907905460386, 18422.723659145122, 18589.749997500985, 33730.156746081055, 33765.324693505994, 33861.153471163416, 33902.83048584791, 34150.82924585411, 8935.910640893639, 9085.591148398338, 9257.120573545502, 9349.579268932914, 9532.428054316762, 7286.890696639554, 7309.963450182715, 7594.96202518995, 7616.9238307617325, 7627.046619172604, 9022.639094436281, 9469.573869175765, 9596.23230141587, 9607.637326935517, 9652.324337296322, 4046.676265898721, 4086.300754132771, 4112.547619761824, 4136.482939632546, 4171.5828417158045, 830.9709160179365, 866.7009881590841, 883.1036497954581, 897.0984160918235, 900.2168113741087, 17177.484675459757, 17466.476005719847, 17707.734383983992, 17745.11274436273, 17774.340808740937, 884.8805411269525, 888.9244414224863, 892.1123482135317, 902.2331018634239, 903.9141281578239, 9427.670031548863, 9632.855507167398, 9845.950770246103, 9898.653547125816, 9927.751806204902, 335592.0, 337500.0, 339710.0, 339877.0, 343908.0, 76433.61783191048, 78335.60832195917, 78547.60726196447, 80128.59935700284, 82675.5866220665, 1064.5635289531256, 1086.8532748079067, 1127.689885281554, 1128.0749785176076, 1129.768397478515, 17277.308907643554, 17650.382236621655, 18180.363687271412, 18222.908885455487, 18417.53956151107, 38299.042523937125, 38882.0, 38888.611113888495, 39782.80108599438, 39810.601893981846, 47264.29103563518, 47282.29076563785, 47473.0, 47510.0, 47513.28730068982, 8386.66453341884, 8472.322214222972, 8566.657333706582, 8687.916679161037, 8751.91248087511, 12760.106792524433, 13023.544175953795, 13621.659458513617, 13770.518031868836, 13827.723445531234, 10608.310459820086, 10722.356658600509, 10865.239433239914, 10918.0, 11064.0, 10872.891271087505, 11065.114790816877, 11089.611863584736, 11110.388928609003, 11489.253198542068, 10615.681529554126, 10714.30357026822, 10721.785564288826, 11314.660560183207, 11445.849367784363, 8090.514569125636, 8170.428070035278, 8198.795030124294, 8526.0, 8547.74356769298, 10053.246006549392, 10511.632092877018, 10885.619003334845, 10976.670699879016, 11280.605178818701], "value": 9538.077548391653, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1272.147661067085, 1323.3581712869263, 1338.4579245405607, 1343.946242150314, 1349.4399824073007, 10126.29115961883, 10443.947780261107, 10485.056344928955, 10506.422146781924, 10719.517621707022, 10556.261061725663, 10682.359058456497, 10730.892691073086, 10743.946280268588, 10746.892531074687, 2238.4292005538605, 2268.8411811173223, 2272.261515007621, 2273.227102785053, 2274.8748818814956, 2177.0638625391075, 2236.452069243038, 2237.1387015998876, 2237.8321625878125, 2245.9438514037197, 2191.736991561007, 2207.6798864164684, 2240.305505293364, 2251.583457060449, 2255.954880902381, 2177.738671359431, 2192.134107027723, 2221.2114699281683, 2236.1726161320253, 2237.7538470768204, 2029.2897485879823, 2159.255057005331, 2163.329367895957, 2180.226019762993, 2189.386971647941, 10353.171746260281, 10386.0, 10443.216758743125, 10451.268411211218, 10477.26659133861, 5751.3961034091235, 5945.881082378328, 5964.135200395962, 5990.460858522711, 5993.280806303272, 3459.498372735939, 3752.6434988676033, 3794.29805485986, 3794.4118661607495, 3843.6348546888003, 1149.408054851752, 1160.0893298760516, 1161.4657257661486, 1226.301008425198, 1230.4155526125107, 14558.92720536401, 14559.563213103624, 14568.49010284635, 14647.12117272967, 14717.337719802634, 4799.544043315879, 4805.8077676892535, 4981.402231732215, 4993.775280112331, 5004.049230646166, 10980.835287470694, 11001.0, 11061.72345691348, 11062.446877656084, 11080.61217857371, 5697.658140511582, 5709.685967271756, 5712.11462223356, 5733.913991290134, 5752.13717942312, 5235.476452354734, 5263.26314315996, 5268.157094864803, 5341.626086174008, 5358.5981051421295, 3857.8456861725776, 3917.5298964123917, 3958.148997965394, 3998.3802510610903, 4020.0552870075508, 1159.3913195572222, 1162.96511104667, 1163.0985985861025, 1164.895159435655, 1178.7465694875643, 690.3027941778739, 725.7423614616735, 726.2410780734145, 740.7037185125993, 744.6686224629988, 5589.636673616202, 5740.454656807597, 5746.856328591819, 5812.94187058124, 5855.326637436664, 537.5726297593422, 562.864912421016, 565.6379916853217, 567.7473524281737, 569.0951387294222, 3485.477178423206, 3498.930021399558, 3511.6839484446523, 3624.4019736743144, 4019.618136277049, 13114.540991065267, 13590.0, 13781.724365512835, 13816.93091534556, 13918.791218131737, 13403.458602260866, 13516.932415338057, 13648.863511364958, 13868.167909925436, 13888.097273677178, 7481.700731970769, 7515.098188217339, 7518.0, 7562.319391254813, 7620.657070431844, 5994.31065427464, 6021.969890150521, 6024.397560244116, 6071.696415179312, 6182.412670796267, 12038.518459261531, 12107.878921211028, 12124.696882578006, 12304.507819687471, 12638.873611264138, 12376.0, 12573.308468034345, 12625.305608191271, 12775.0, 12836.844683978487, 7389.298016688406, 7593.620318984139, 7596.126445458843, 7609.048868891388, 7620.5808680523105, 9468.384555004179, 9659.227261818896, 9815.95092024564, 9818.509074546388, 9829.066238707312, 8008.039035315799, 8084.272415482635, 8136.67453301885, 8269.29710974574, 8310.335173186251, 8129.959350203211, 8151.103378628465, 8191.631376588187, 8204.138565450781, 8454.873176902229, 7341.0, 7346.6693998769115, 7417.443691723034, 7448.553086814808, 7461.067366579177, 5282.630215884851, 5288.524032837063, 5335.119705248746, 5515.4760297771645, 5541.972290138524, 5410.47926496151, 5446.482584154499, 5453.26380938584, 5537.723113844372, 5591.8881622368135], "value": 4780.8813014089965, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [387.7150294533519, 387.8564930975536, 391.3425445251977, 396.831346677662, 398.03873645146973, 5501.039251738746, 5512.228288039678, 5551.639143455673, 5605.803796867111, 5713.914291285634, 5411.83764487065, 5480.88933300025, 5502.367227768807, 5506.476884695958, 5526.723663816803, 4033.0723933495315, 4126.112885729567, 4131.772752498611, 4138.296489596761, 4183.518895327031, 4129.97935010326, 4140.772257525835, 4145.668346532285, 4151.377293405983, 4157.711109556032, 4117.155983023488, 4125.401816736571, 4125.886010777103, 4129.607687269705, 4134.896627584304, 4031.657309128728, 4111.629953304202, 4119.402686610425, 4136.379543068534, 4137.262349813086, 3563.394222982099, 3573.5711714594413, 3576.517170182044, 3578.6421357864006, 3598.1364472526666, 5386.865328366822, 5392.946070539284, 5421.593380496479, 5438.075527160392, 5446.210299506589, 4710.222813235812, 4868.002059577813, 4888.755562221874, 4895.0, 4927.595635243938, 5834.970825145847, 5859.1797148399255, 5867.647941123546, 5869.0, 5869.50109240715, 4067.8983025424304, 4074.3073677474604, 4087.1621317629815, 4088.1414902870138, 4104.117614712851, 6007.545661244758, 6149.13912052313, 6195.380461953769, 6236.906446403353, 6281.089242059876, 4102.856400025985, 4149.439825623502, 4156.709030367906, 4162.084341444877, 4168.916621667549, 4213.304804707189, 4219.303814870574, 4224.809883555247, 4226.1758957003085, 4235.174141042467, 4747.145513807479, 4832.405306248929, 4876.805182730253, 4897.853064408074, 4902.460729319772, 5804.187413762077, 5850.8537286567325, 5856.0, 5881.794137205177, 5893.410658934073, 1437.4250299880132, 1446.3130013243624, 1456.6139972907188, 1457.358762144653, 1458.7017554376614, 967.583938906277, 972.5331840716495, 977.5161295158941, 983.4197823284296, 984.6159997600942, 4967.801287948441, 5029.2958985742025, 5042.7982880685095, 5051.974740126276, 5085.64400491962, 6081.604695694766, 6086.543509236825, 6102.603330783485, 6115.969420152871, 6133.1413602095745, 4895.701785473588, 5005.998800239967, 5010.974945125324, 5048.066107770074, 5067.214581739836, 3195.6644552322136, 3195.936081278408, 3205.4230238557284, 3206.502992036238, 3210.9036728898172, 5510.366307874646, 5557.663504742885, 5561.694106824163, 5564.527015203672, 5612.943870561324, 6108.0, 6201.379862013762, 6203.875922481616, 6228.377162283736, 6251.0, 5609.242752228479, 5643.915341269884, 5644.43555644424, 5652.247803181027, 5661.575381846378, 6119.328402958367, 6126.142340072304, 6150.569460137926, 6153.476954458921, 6174.413430724074, 5964.433378829004, 5965.822474796755, 5978.8206353809455, 5986.580939334205, 6012.0, 5607.579431542569, 5626.690532020778, 5640.407757185437, 5640.492355688008, 5645.71771411436, 4058.0869304406274, 4154.314538101179, 4171.97914010428, 4185.644220241192, 4187.078842654611, 6088.147659327787, 6116.633002019893, 6132.9080063799975, 6153.600015998945, 6163.568550201443, 5852.209951656472, 5892.175095486549, 5930.495907847881, 5931.851703707442, 5934.109883517507, 5731.398203188605, 5888.9366337227175, 5906.822795316148, 5956.74908269251, 5962.642241465526, 5804.506616937439, 5817.76728930838, 5818.040023396262, 5837.824865254049, 5855.414458554111, 5806.2451881255165, 5947.10793380979, 5963.642181469126, 5964.657951960774, 5964.970175149097, 5708.885822283614, 5725.2843394575675, 5737.196792449144, 5741.425857414392, 5763.971180144073], "value": 4375.320091531481, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [723.3200791256222, 725.6770737022025, 746.5595298773726, 747.1072068877693, 749.5877267502874, 12072.939635301811, 12567.183133096343, 13502.864971350284, 14484.0, 14488.927555362236, 14285.571432857005, 14720.926395368007, 14732.33704483298, 14767.113973161619, 15107.169105699182, 812.540914383373, 834.0366876257932, 834.3367023216557, 834.7495751274623, 836.7657056024323, 887.0375642427973, 901.0718959471754, 907.3920473282916, 907.718607231757, 908.3505293714992, 930.4789317981918, 933.2953620016877, 933.3093510801991, 934.6027938126304, 936.1153709744294, 926.0600490502146, 931.6226928094133, 932.2309094996655, 935.3218916285673, 936.2229349639816, 685.3044160177424, 686.5674624986277, 688.4733179117978, 689.9793006209821, 691.6991108867609, 12928.09503334767, 12959.0, 13591.932040339734, 15291.847081529153, 15509.510360168984, 14681.412743490248, 14788.18664973426, 14863.777043344358, 14915.552533424014, 15065.472708455152, 12731.681707957283, 12903.225806451643, 12907.0, 13044.08691391603, 13083.280419577015, 2827.9858600706866, 2836.4610723962587, 2848.2594525423333, 2856.228818219069, 2858.099698594936, 64491.03263451052, 64557.0, 64867.75554267172, 65656.67171664159, 66358.0, 10564.894351056544, 10583.523741431654, 10636.734081647866, 10683.091937185427, 10712.517936692868, 16099.839001609835, 16366.608838248882, 16385.91807040957, 16495.83504164943, 16521.91739041297, 5666.631668941505, 5793.652380857162, 5997.16039754426, 6044.455998960115, 6077.574569780073, 2788.0, 2831.2638713934525, 2842.445723083979, 2855.314724466113, 2868.3976364963173, 3467.514547963287, 3526.2242306692488, 3541.964580354215, 3543.114221444639, 3564.483149943244, 764.7361660227212, 779.4076501858628, 783.5416281475286, 785.2147852147853, 791.1179035375629, 569.4903061759702, 573.1860757724041, 592.2537602620642, 594.7264258441165, 606.6572386601556, 9884.357516761387, 10319.226058045677, 10966.0, 11315.773684526263, 11792.521061636224, 600.921880155577, 604.0908432808595, 609.7835268479714, 619.8078595635277, 620.2990620598785, 4511.368408422823, 4650.930236046462, 4716.056788642285, 4751.287306903992, 4809.0862736080035, 55759.0, 57126.42873571294, 57464.138037929464, 60051.699741501885, 60125.0, 53023.0, 53480.73259633677, 53562.46437535575, 53710.73144634252, 53909.730451347496, 47504.524954750705, 48176.75911620419, 48296.0, 48543.5145648539, 50057.24914126291, 9080.40977336471, 9101.06420115093, 9122.361434699507, 9168.31237657165, 9457.19613832832, 24652.630210547213, 24979.750202497744, 25649.358766030997, 25975.22074337773, 26487.867560662075, 30744.0, 30997.0, 31142.377152457277, 31301.217469563442, 31924.0, 12189.451474683483, 12303.44634491432, 12357.876421235673, 12410.193337433038, 12538.310392928477, 12875.420606072561, 13106.803397948848, 13188.472461101448, 13271.0, 13362.866371336162, 12407.93796031014, 12609.68475788076, 12767.233965962072, 12814.55149069778, 12885.935570322088, 11319.886801131883, 11478.770424591294, 11491.425428728697, 11548.016961835869, 11723.062155027748, 11084.168687348643, 11230.270032447865, 11332.490037948477, 11451.885481145415, 11491.253068550517, 8119.918800811916, 8411.074781773877, 8519.531425771394, 8525.0, 8725.91274087251, 10320.845187322346, 10431.634892778717, 10557.0, 10653.147748180281, 10688.305260158066], "value": 6436.449820093481, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1553.1000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 114.0, 116.0, 114.0, 110.0, 111.0, 112.0, 110.0, 110.0, 113.0], "value": 111.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 131.0, 126.0, 179.0, 123.0, 127.0, 123.0, 122.0, 144.0, 130.0], "value": 136.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 165.0, 164.0, 167.0, 164.0, 165.0, 167.0, 171.0, 163.0, 165.0], "value": 165.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 75.0, 75.0, 112.0, 74.0, 74.0, 75.0, 75.0, 96.0, 75.0], "value": 80.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 85.0, 114.0, 84.0, 83.0, 85.0, 101.0, 87.0, 83.0, 103.0], "value": 90.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 115.0, 117.0, 114.0, 114.0, 114.0, 114.0, 114.0, 114.0, 116.0], "value": 114.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 150.0, 151.0, 151.0, 150.0, 150.0, 151.0, 151.0, 151.0, 150.0], "value": 150.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 102.0, 95.0, 94.0, 94.0, 95.0, 94.0, 95.0, 95.0, 95.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 55.0, 56.0, 56.0, 59.0, 59.0, 60.0, 57.0, 56.0, 57.0], "value": 57.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 56.0, 57.0, 56.0, 56.0, 56.0, 57.0, 56.0, 56.0], "value": 56.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 81.0, 84.0, 82.0, 82.0, 84.0, 81.0, 90.0, 80.0, 81.0], "value": 82.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 133.0, 134.0, 140.0, 148.0, 133.0, 133.0, 147.0, 180.0, 135.0], "value": 142.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [187.0, 197.0, 196.0, 195.0, 201.0, 188.0, 193.0, 188.0, 197.0, 204.0], "value": 194.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 76.0, 74.0, 76.0, 76.0, 74.0, 73.0, 75.0, 73.0], "value": 74.9, "unit": "score"}]}]} 09:25:13 INFO - Return code: 0 09:25:13 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:25:13 INFO - # TBPL SUCCESS # 09:25:13 INFO - Running post-action listener: _resource_record_post_action 09:25:13 INFO - [mozharness: 2017-05-19 16:25:13.571364Z] Finished run-tests step (success) 09:25:13 INFO - Running post-run listener: _resource_record_post_run 09:25:13 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 4096; Write bytes: 418422784; Read time: 12; Write time: 273392 09:25:13 INFO - TinderboxPrint: CPU usage
13.3% 09:25:13 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 09:25:13 INFO - TinderboxPrint: I/O write bytes / time
418,422,784 / 273,392 09:25:13 INFO - TinderboxPrint: CPU idle
8,282.2 (86.7%) 09:25:13 INFO - TinderboxPrint: CPU user
1,214.9 (12.7%) 09:25:13 INFO - TinderboxPrint: Swap in / out
0 / 0 09:25:13 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 101453824; Read time: 0; Write time: 110032 09:25:13 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 0; Write bytes: 316960768; Read time: 0; Write time: 163360 09:25:14 INFO - Running post-run listener: _upload_blobber_files 09:25:14 INFO - Blob upload gear active. 09:25:14 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:25:14 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 09:25:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:25:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:25:14 INFO - (blobuploader) - INFO - Open directory for files ... 09:25:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:25:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:25:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:25:18 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:25:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:25:18 INFO - (blobuploader) - INFO - Done attempting. 09:25:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:25:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:25:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:25:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:25:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:25:19 INFO - (blobuploader) - INFO - Done attempting. 09:25:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 09:25:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:25:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:25:20 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 09:25:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:25:20 INFO - (blobuploader) - INFO - Done attempting. 09:25:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:25:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:25:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:25:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:25:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:25:21 INFO - (blobuploader) - INFO - Done attempting. 09:25:21 INFO - (blobuploader) - INFO - Iteration through files over. 09:25:21 INFO - Return code: 0 09:25:21 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:25:21 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:25:21 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ae70895f1936dae72a95567c4b96c00636a297e98dedf5810ba5f7818a64d47acff7ba11044db8756085cf97489b5120cc5428b65fb1649b922fafdbf14e850f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0cfce1605b1a1f924052e714deff9e2accac232759d0db1f4dc566723bd00192afa067aeb95d84adb0b6e87f3ca6137632ff147c256d26ee0e6e2ff33317eb80", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/78b402a71f18f27dbe31e13c54397ced46a2321c11ffa4d0cdf0d481df69a6caa64c1b8b6e08988a506366deffc9e1219866fbafa5b9e0f3670b215d6db41da5", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ece683d2eaec0b7249f419aa80ad5a2575d156d59bca517a42ca896717eea32ac3c13eb3017822a554a2120fbdccf96aba177040e3b65a2a58e410839c169232"} 09:25:21 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:25:21 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:25:21 INFO - Contents: 09:25:21 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ae70895f1936dae72a95567c4b96c00636a297e98dedf5810ba5f7818a64d47acff7ba11044db8756085cf97489b5120cc5428b65fb1649b922fafdbf14e850f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0cfce1605b1a1f924052e714deff9e2accac232759d0db1f4dc566723bd00192afa067aeb95d84adb0b6e87f3ca6137632ff147c256d26ee0e6e2ff33317eb80", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/78b402a71f18f27dbe31e13c54397ced46a2321c11ffa4d0cdf0d481df69a6caa64c1b8b6e08988a506366deffc9e1219866fbafa5b9e0f3670b215d6db41da5", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ece683d2eaec0b7249f419aa80ad5a2575d156d59bca517a42ca896717eea32ac3c13eb3017822a554a2120fbdccf96aba177040e3b65a2a58e410839c169232"} 09:25:21 INFO - Running post-run listener: copy_logs_to_upload_dir 09:25:21 INFO - Copying logs to upload dir... 09:25:21 INFO - mkdir: /builds/slave/test/build/upload/logs 09:25:21 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1252.871106 ========= master_lag: 0.38 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2017-05-19 09:25:20.248785) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-19 09:25:20.257270) ========= 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=32c5991c409366f7fec8a718000001d2-1495209716.159476-1249182171 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/ae70895f1936dae72a95567c4b96c00636a297e98dedf5810ba5f7818a64d47acff7ba11044db8756085cf97489b5120cc5428b65fb1649b922fafdbf14e850f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0cfce1605b1a1f924052e714deff9e2accac232759d0db1f4dc566723bd00192afa067aeb95d84adb0b6e87f3ca6137632ff147c256d26ee0e6e2ff33317eb80", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/78b402a71f18f27dbe31e13c54397ced46a2321c11ffa4d0cdf0d481df69a6caa64c1b8b6e08988a506366deffc9e1219866fbafa5b9e0f3670b215d6db41da5", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ece683d2eaec0b7249f419aa80ad5a2575d156d59bca517a42ca896717eea32ac3c13eb3017822a554a2120fbdccf96aba177040e3b65a2a58e410839c169232"} build_url:https://queue.taskcluster.net/v1/task/FzpKbT3fTzWzpvRwY_vjTw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011448 build_url: 'https://queue.taskcluster.net/v1/task/FzpKbT3fTzWzpvRwY_vjTw/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ae70895f1936dae72a95567c4b96c00636a297e98dedf5810ba5f7818a64d47acff7ba11044db8756085cf97489b5120cc5428b65fb1649b922fafdbf14e850f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0cfce1605b1a1f924052e714deff9e2accac232759d0db1f4dc566723bd00192afa067aeb95d84adb0b6e87f3ca6137632ff147c256d26ee0e6e2ff33317eb80", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/78b402a71f18f27dbe31e13c54397ced46a2321c11ffa4d0cdf0d481df69a6caa64c1b8b6e08988a506366deffc9e1219866fbafa5b9e0f3670b215d6db41da5", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ece683d2eaec0b7249f419aa80ad5a2575d156d59bca517a42ca896717eea32ac3c13eb3017822a554a2120fbdccf96aba177040e3b65a2a58e410839c169232"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-19 09:25:20.288114) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-19 09:25:20.288460) ========= 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=32c5991c409366f7fec8a718000001d2-1495209716.159476-1249182171 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-19 09:25:20.370468) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-19 09:25:20.370772) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-19 09:25:20.373213) ========= ========= Total master_lag: 0.54 =========