builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-050 starttime: 1494606155.55 results: success (0) revision: 1e2fe13035e13b7b4001ade3b48f226957cef5fc ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-12 09:22:35.546338) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-12 09:22:35.546778) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-12 09:22:35.547052) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-12 09:22:35.561518) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-12 09:22:35.561836) ========= 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=6dbc10da6d83fee962c624be000001a8-1494606154.832417-1631648225 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-12 09:22:35-- 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% 99.7M=0s 2017-05-12 09:22:35 (99.7 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.125691 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-12 09:22:35.701196) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-12 09:22:35.701503) ========= 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=6dbc10da6d83fee962c624be000001a8-1494606154.832417-1631648225 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020536 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-12 09:22:35.754411) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-12 09:22:35.757636) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 1e2fe13035e13b7b4001ade3b48f226957cef5fc --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 1e2fe13035e13b7b4001ade3b48f226957cef5fc --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=6dbc10da6d83fee962c624be000001a8-1494606154.832417-1631648225 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-12 09:22:35,857 truncating revision to first 12 chars 2017-05-12 09:22:35,857 Setting DEBUG logging. 2017-05-12 09:22:35,857 attempt 1/10 2017-05-12 09:22:35,857 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/1e2fe13035e1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-12 09:22:37,485 unpacking tar archive at: mozilla-central-1e2fe13035e1/testing/mozharness/ program finished with exit code 0 elapsedTime=1.911393 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-12 09:22:37.682099) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-12 09:22:37.682414) ========= script_repo_revision: 1e2fe13035e13b7b4001ade3b48f226957cef5fc ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-12 09:22:37.685827) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-12 09:22:37.686091) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-12 09:22:37.695607) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2017-05-12 09:22:37.695869) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=6dbc10da6d83fee962c624be000001a8-1494606154.832417-1631648225 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:22:37 INFO - MultiFileLogger online at 20170512 09:22:37 in /builds/slave/test 09:22:37 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --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:22:37 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:22:37 INFO - {'append_to_log': False, 09:22:37 INFO - 'base_work_dir': '/builds/slave/test', 09:22:37 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 09:22:37 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:22:37 INFO - 'branch': 'Firefox-Non-PGO', 09:22:37 INFO - 'buildbot_json_path': 'buildprops.json', 09:22:37 INFO - 'config_files': ('talos/linux_config.py',), 09:22:37 INFO - 'default_actions': ('clobber', 09:22:37 INFO - 'read-buildbot-config', 09:22:37 INFO - 'download-and-extract', 09:22:37 INFO - 'populate-webroot', 09:22:37 INFO - 'create-virtualenv', 09:22:37 INFO - 'install', 09:22:37 INFO - 'run-tests'), 09:22:37 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:22:37 INFO - 'download_minidump_stackwalk': True, 09:22:37 INFO - 'download_symbols': 'ondemand', 09:22:37 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:22:37 INFO - 'tooltool.py': '/tools/tooltool.py', 09:22:37 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:22:37 INFO - '/tools/misc-python/virtualenv.py')}, 09:22:37 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:22:37 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:22:37 INFO - 'gecko_profile': False, 09:22:37 INFO - 'gecko_profile_interval': 0, 09:22:37 INFO - 'installer_path': 'installer.exe', 09:22:37 INFO - 'log_level': 'info', 09:22:37 INFO - 'log_name': 'talos', 09:22:37 INFO - 'log_to_console': True, 09:22:37 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:22:37 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:22:37 INFO - 'opt_config_files': (), 09:22:37 INFO - 'pip_index': False, 09:22:37 INFO - 'suite': 'dromaeojs', 09:22:37 INFO - 'system_bits': '32', 09:22:37 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:22:37 INFO - 'title': 'talos-linux64-ix-050', 09:22:37 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:22:37 INFO - 'use_talos_json': True, 09:22:37 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:22:37 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:22:37 INFO - 'work_dir': 'build'} 09:22:37 INFO - [mozharness: 2017-05-12 16:22:37.900887Z] Running clobber step. 09:22:37 INFO - Running pre-action listener: _resource_record_pre_action 09:22:37 INFO - Running main action method: clobber 09:22:37 INFO - rmtree: /builds/slave/test/build 09:22:37 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:22:39 INFO - Running post-action listener: _resource_record_post_action 09:22:39 INFO - [mozharness: 2017-05-12 16:22:39.427248Z] Finished clobber step (success) 09:22:39 INFO - [mozharness: 2017-05-12 16:22:39.427348Z] Running read-buildbot-config step. 09:22:39 INFO - Running pre-action listener: _resource_record_pre_action 09:22:39 INFO - Running main action method: read_buildbot_config 09:22:39 INFO - Using buildbot properties: 09:22:39 INFO - { 09:22:39 INFO - "project": "", 09:22:39 INFO - "product": "firefox", 09:22:39 INFO - "who": "ryanvm@gmail.com", 09:22:39 INFO - "installer_path": "public/build/target.tar.bz2", 09:22:39 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 09:22:39 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 09:22:39 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 09:22:39 INFO - "stage_platform": "linux64", 09:22:39 INFO - "basedir": "/builds/slave/test", 09:22:39 INFO - "buildnumber": 598, 09:22:39 INFO - "platform": "ubuntu64_hw", 09:22:39 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 09:22:39 INFO - "slavebuilddir": "test", 09:22:39 INFO - "taskId": "JirmQPb2SgSqedRQDujrdg", 09:22:39 INFO - "branch": "mozilla-central", 09:22:39 INFO - "script_repo_revision": "production", 09:22:39 INFO - "revision": "1e2fe13035e13b7b4001ade3b48f226957cef5fc", 09:22:39 INFO - "slavename": "talos-linux64-ix-050", 09:22:39 INFO - "repo_path": "mozilla-central" 09:22:39 INFO - } 09:22:39 INFO - Finding installer, test and symbols from parent task. 09:22:39 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JirmQPb2SgSqedRQDujrdg'}, attempt #1 09:22:39 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JirmQPb2SgSqedRQDujrdg'}, attempt #1 09:22:40 INFO - Task dependencies: NtRFFEQ4TNiztEbolW4n4g 09:22:40 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NtRFFEQ4TNiztEbolW4n4g'}, attempt #1 09:22:40 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/NtRFFEQ4TNiztEbolW4n4g/artifacts/public/build/target.tar.bz2 09:22:40 INFO - Set test_url: https://queue.taskcluster.net/v1/task/NtRFFEQ4TNiztEbolW4n4g/artifacts/public/build/test_packages.json 09:22:40 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/NtRFFEQ4TNiztEbolW4n4g/artifacts/public/build/target.crashreporter-symbols.zip 09:22:40 INFO - Running post-action listener: _resource_record_post_action 09:22:40 INFO - [mozharness: 2017-05-12 16:22:40.798875Z] Finished read-buildbot-config step (success) 09:22:40 INFO - [mozharness: 2017-05-12 16:22:40.799092Z] Running download-and-extract step. 09:22:40 INFO - Running pre-action listener: _resource_record_pre_action 09:22:40 INFO - Running main action method: download_and_extract 09:22:40 INFO - mkdir: /builds/slave/test/build/tests 09:22:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:22:40 INFO - trying https://queue.taskcluster.net/v1/task/NtRFFEQ4TNiztEbolW4n4g/artifacts/public/build/target.test_packages.json 09:22:40 INFO - Downloading https://queue.taskcluster.net/v1/task/NtRFFEQ4TNiztEbolW4n4g/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 09:22:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NtRFFEQ4TNiztEbolW4n4g/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 09:22:41 INFO - Downloaded 986 bytes. 09:22:41 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 09:22:41 INFO - Using the following test package requirements: 09:22:41 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 09:22:41 INFO - u'common': [u'target.common.tests.zip'], 09:22:41 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 09:22:41 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 09:22:41 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 09:22:41 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 09:22:41 INFO - u'mozbase': [u'target.common.tests.zip'], 09:22:41 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 09:22:41 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 09:22:41 INFO - u'web-platform': [u'target.common.tests.zip', 09:22:41 INFO - u'target.web-platform.tests.zip'], 09:22:41 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 09:22:41 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 09:22:41 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NtRFFEQ4TNiztEbolW4n4g/artifacts/public/build/target.common.tests.zip 09:22:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NtRFFEQ4TNiztEbolW4n4g/artifacts/public/build/target.common.tests.zip'}, attempt #1 09:22:41 INFO - Fetch https://queue.taskcluster.net/v1/task/NtRFFEQ4TNiztEbolW4n4g/artifacts/public/build/target.common.tests.zip into memory 09:22:42 INFO - Content-Length response header: 62447304 09:22:42 INFO - Bytes received: 62447304 09:22:53 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 09:22:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NtRFFEQ4TNiztEbolW4n4g/artifacts/public/build/target.common.tests.zip 09:22:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NtRFFEQ4TNiztEbolW4n4g/artifacts/public/build/target.common.tests.zip'}, attempt #1 09:22:53 INFO - Fetch https://queue.taskcluster.net/v1/task/NtRFFEQ4TNiztEbolW4n4g/artifacts/public/build/target.common.tests.zip into memory 09:22:54 INFO - Content-Length response header: 62447304 09:22:54 INFO - Bytes received: 62447304 09:23:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NtRFFEQ4TNiztEbolW4n4g/artifacts/public/build/target.talos.tests.zip 09:23:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NtRFFEQ4TNiztEbolW4n4g/artifacts/public/build/target.talos.tests.zip'}, attempt #1 09:23:06 INFO - Fetch https://queue.taskcluster.net/v1/task/NtRFFEQ4TNiztEbolW4n4g/artifacts/public/build/target.talos.tests.zip into memory 09:23:07 INFO - Content-Length response header: 14409411 09:23:07 INFO - Bytes received: 14409411 09:23:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:23:07 INFO - trying https://queue.taskcluster.net/v1/task/NtRFFEQ4TNiztEbolW4n4g/artifacts/public/build/target.tar.bz2 09:23:07 INFO - Downloading https://queue.taskcluster.net/v1/task/NtRFFEQ4TNiztEbolW4n4g/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 09:23:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NtRFFEQ4TNiztEbolW4n4g/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 09:23:08 INFO - Downloaded 63521198 bytes. 09:23:08 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NtRFFEQ4TNiztEbolW4n4g/artifacts/public/build/target.tar.bz2 09:23:08 INFO - mkdir: /builds/slave/test/properties 09:23:08 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:23:08 INFO - Writing to file /builds/slave/test/properties/build_url 09:23:08 INFO - Contents: 09:23:08 INFO - build_url:https://queue.taskcluster.net/v1/task/NtRFFEQ4TNiztEbolW4n4g/artifacts/public/build/target.tar.bz2 09:23:08 INFO - Running post-action listener: _resource_record_post_action 09:23:08 INFO - Running post-action listener: set_extra_try_arguments 09:23:08 INFO - [mozharness: 2017-05-12 16:23:08.406420Z] Finished download-and-extract step (success) 09:23:08 INFO - [mozharness: 2017-05-12 16:23:08.406517Z] Running populate-webroot step. 09:23:08 INFO - Running pre-action listener: _resource_record_pre_action 09:23:08 INFO - Running main action method: populate_webroot 09:23:08 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:23:08 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:23:08 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:23:08 INFO - '--tppagecycles', 09:23:08 INFO - '7'], 09:23:08 INFO - 'tests': ['tsvgm']}}, 09:23:08 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:23:08 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:23:08 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:23:08 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:23:08 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:23:08 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:23:08 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 09:23:08 INFO - 'talos_options': ['--disable-e10s'], 09:23:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:23:08 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 09:23:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:23:08 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 09:23:08 INFO - 'talos_options': ['--disable-e10s'], 09:23:08 INFO - 'tests': ['damp', 'tps']}, 09:23:08 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 09:23:08 INFO - 'tests': ['damp', 'tps']}, 09:23:08 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:23:08 INFO - 'tests': ['dromaeo_dom']}, 09:23:08 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:23:08 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:23:08 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 09:23:08 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 09:23:08 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:23:08 INFO - 'tests': ['a11yr', 09:23:08 INFO - 'ts_paint', 09:23:08 INFO - 'tpaint', 09:23:08 INFO - 'sessionrestore', 09:23:08 INFO - 'sessionrestore_no_auto_restore', 09:23:08 INFO - 'tabpaint']}, 09:23:08 INFO - 'other-e10s': {'tests': ['a11yr', 09:23:08 INFO - 'ts_paint', 09:23:08 INFO - 'tpaint', 09:23:08 INFO - 'sessionrestore', 09:23:08 INFO - 'sessionrestore_no_auto_restore', 09:23:08 INFO - 'tabpaint']}, 09:23:08 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:23:08 INFO - 'ts_paint', 09:23:08 INFO - 'tpaint', 09:23:08 INFO - 'sessionrestore', 09:23:08 INFO - 'sessionrestore_no_auto_restore', 09:23:08 INFO - 'tabpaint']}, 09:23:08 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:23:08 INFO - 'ts_paint', 09:23:08 INFO - 'tpaint', 09:23:08 INFO - 'sessionrestore', 09:23:08 INFO - 'sessionrestore_no_auto_restore', 09:23:08 INFO - 'tabpaint']}, 09:23:08 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:23:08 INFO - 'tests': ['a11yr', 09:23:08 INFO - 'ts_paint', 09:23:08 INFO - 'tpaint', 09:23:08 INFO - 'sessionrestore', 09:23:08 INFO - 'sessionrestore_no_auto_restore', 09:23:08 INFO - 'tabpaint']}, 09:23:08 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:23:08 INFO - 'tests': ['a11yr', 09:23:08 INFO - 'ts_paint', 09:23:08 INFO - 'tpaint', 09:23:08 INFO - 'sessionrestore', 09:23:08 INFO - 'sessionrestore_no_auto_restore', 09:23:08 INFO - 'tabpaint']}, 09:23:08 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 09:23:08 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 09:23:08 INFO - 'bloom_basic_ref']}, 09:23:08 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:23:08 INFO - 'tests': ['tsvgx', 09:23:08 INFO - 'tsvgr_opacity', 09:23:08 INFO - 'tart', 09:23:08 INFO - 'tscrollx', 09:23:08 INFO - 'cart', 09:23:08 INFO - 'tsvg_static']}, 09:23:08 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:23:08 INFO - 'tsvgr_opacity', 09:23:08 INFO - 'tart', 09:23:08 INFO - 'tscrollx', 09:23:08 INFO - 'cart', 09:23:08 INFO - 'tsvg_static']}, 09:23:08 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 09:23:08 INFO - 'talos_options': ['--disable-e10s'], 09:23:08 INFO - 'tests': ['tp5o']}, 09:23:08 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 09:23:08 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 09:23:08 INFO - 'talos_options': ['--disable-e10s', 09:23:08 INFO - '--xperf_path', 09:23:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:23:08 INFO - 'tests': ['tp5n']}, 09:23:08 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 09:23:08 INFO - 'talos_options': ['--xperf_path', 09:23:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:23:08 INFO - 'tests': ['tp5n']}}, 09:23:08 INFO - 'talos.zip': {'path': '', 09:23:08 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:23:08 INFO - Running post-action listener: _resource_record_post_action 09:23:08 INFO - [mozharness: 2017-05-12 16:23:08.420128Z] Finished populate-webroot step (success) 09:23:08 INFO - [mozharness: 2017-05-12 16:23:08.420217Z] Running create-virtualenv step. 09:23:08 INFO - Running pre-action listener: _resource_record_pre_action 09:23:08 INFO - Running main action method: create_virtualenv 09:23:08 INFO - Creating virtualenv /builds/slave/test/build/venv 09:23:08 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:23:08 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:23:08 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:23:08 INFO - Using real prefix '/usr' 09:23:08 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:23:09 INFO - Installing distribute.............................................................................................................................................................................................done. 09:23:11 INFO - Installing pip.................done. 09:23:11 INFO - Return code: 0 09:23:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:23:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:23:11 INFO - Reading from file tmpfile_stdout 09:23:11 INFO - Output received: 09:23:11 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:23:11 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:23:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:23:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:23:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:23:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:23:11 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 0xf2f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12a1770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x129ea30>, '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 0x129f7f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x129fca0>, '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': '6dbc10da6d83fee962c624be000001a8-1494606154.832417-1631648225', '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:23:11 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:23:11 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:23:11 INFO - Using env: {'DISPLAY': ':0', 09:23:11 INFO - 'HOME': '/home/cltbld', 09:23:11 INFO - 'LANG': 'en_US.UTF-8', 09:23:11 INFO - 'LANGUAGE': 'en_US:en', 09:23:11 INFO - 'LOGNAME': 'cltbld', 09:23:11 INFO - 'MAIL': '/var/mail/cltbld', 09:23:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:23:11 INFO - 'MOZ_NO_REMOTE': '1', 09:23:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:23:11 INFO - 'NO_EM_RESTART': '1', 09:23:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:23:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:23:11 INFO - 'PWD': '/builds/slave/test', 09:23:11 INFO - 'SHELL': '/bin/bash', 09:23:11 INFO - 'SHLVL': '1', 09:23:11 INFO - 'TERM': 'linux', 09:23:11 INFO - 'TMOUT': '86400', 09:23:11 INFO - 'USER': 'cltbld', 09:23:11 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1494606154.832417-1631648225', 09:23:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:23:11 INFO - '_': '/tools/buildbot/bin/python'} 09:23:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:23:11 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:23:11 INFO - Cleaning up... 09:23:11 INFO - Return code: 0 09:23:11 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:23:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:23:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:23:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:23:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:23:11 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 0xf2f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12a1770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x129ea30>, '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 0x129f7f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x129fca0>, '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': '6dbc10da6d83fee962c624be000001a8-1494606154.832417-1631648225', '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:23:11 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:23:11 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:23:11 INFO - Using env: {'DISPLAY': ':0', 09:23:11 INFO - 'HOME': '/home/cltbld', 09:23:11 INFO - 'LANG': 'en_US.UTF-8', 09:23:11 INFO - 'LANGUAGE': 'en_US:en', 09:23:11 INFO - 'LOGNAME': 'cltbld', 09:23:11 INFO - 'MAIL': '/var/mail/cltbld', 09:23:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:23:11 INFO - 'MOZ_NO_REMOTE': '1', 09:23:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:23:11 INFO - 'NO_EM_RESTART': '1', 09:23:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:23:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:23:11 INFO - 'PWD': '/builds/slave/test', 09:23:11 INFO - 'SHELL': '/bin/bash', 09:23:11 INFO - 'SHLVL': '1', 09:23:11 INFO - 'TERM': 'linux', 09:23:11 INFO - 'TMOUT': '86400', 09:23:11 INFO - 'USER': 'cltbld', 09:23:11 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1494606154.832417-1631648225', 09:23:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:23:11 INFO - '_': '/tools/buildbot/bin/python'} 09:23:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:23:11 INFO - Downloading/unpacking psutil>=3.1.1 09:23:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:23:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:23:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:23:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:23:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:23:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:23:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:23:12 INFO - Installing collected packages: psutil 09:23:12 INFO - Running setup.py install for psutil 09:23:12 INFO - building 'psutil._psutil_linux' extension 09:23:12 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:23:13 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:23:13 INFO - building 'psutil._psutil_posix' extension 09:23:13 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:23:13 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:23:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:23:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:23:13 INFO - Successfully installed psutil 09:23:13 INFO - Cleaning up... 09:23:13 INFO - Return code: 0 09:23:13 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:23:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:23:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:23:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:23:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:23:13 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 0xf2f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12a1770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x129ea30>, '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 0x129f7f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x129fca0>, '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': '6dbc10da6d83fee962c624be000001a8-1494606154.832417-1631648225', '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:23:13 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:23:13 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:23:13 INFO - Using env: {'DISPLAY': ':0', 09:23:13 INFO - 'HOME': '/home/cltbld', 09:23:13 INFO - 'LANG': 'en_US.UTF-8', 09:23:13 INFO - 'LANGUAGE': 'en_US:en', 09:23:13 INFO - 'LOGNAME': 'cltbld', 09:23:13 INFO - 'MAIL': '/var/mail/cltbld', 09:23:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:23:13 INFO - 'MOZ_NO_REMOTE': '1', 09:23:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:23:13 INFO - 'NO_EM_RESTART': '1', 09:23:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:23:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:23:13 INFO - 'PWD': '/builds/slave/test', 09:23:13 INFO - 'SHELL': '/bin/bash', 09:23:13 INFO - 'SHLVL': '1', 09:23:13 INFO - 'TERM': 'linux', 09:23:13 INFO - 'TMOUT': '86400', 09:23:13 INFO - 'USER': 'cltbld', 09:23:13 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1494606154.832417-1631648225', 09:23:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:23:13 INFO - '_': '/tools/buildbot/bin/python'} 09:23:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:23:13 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:23:13 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:23:13 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:23:13 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:23:13 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:23:14 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:23:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:23:14 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:23:14 INFO - Installing collected packages: mozsystemmonitor 09:23:14 INFO - Running setup.py install for mozsystemmonitor 09:23:14 INFO - Successfully installed mozsystemmonitor 09:23:14 INFO - Cleaning up... 09:23:14 INFO - Return code: 0 09:23:14 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:23:14 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:23:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:23:14 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:23:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:23:14 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 0xf2f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12a1770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x129ea30>, '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 0x129f7f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x129fca0>, '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': '6dbc10da6d83fee962c624be000001a8-1494606154.832417-1631648225', '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:23:14 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:23:14 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:23:14 INFO - Using env: {'DISPLAY': ':0', 09:23:14 INFO - 'HOME': '/home/cltbld', 09:23:14 INFO - 'LANG': 'en_US.UTF-8', 09:23:14 INFO - 'LANGUAGE': 'en_US:en', 09:23:14 INFO - 'LOGNAME': 'cltbld', 09:23:14 INFO - 'MAIL': '/var/mail/cltbld', 09:23:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:23:14 INFO - 'MOZ_NO_REMOTE': '1', 09:23:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:23:14 INFO - 'NO_EM_RESTART': '1', 09:23:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:23:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:23:14 INFO - 'PWD': '/builds/slave/test', 09:23:14 INFO - 'SHELL': '/bin/bash', 09:23:14 INFO - 'SHLVL': '1', 09:23:14 INFO - 'TERM': 'linux', 09:23:14 INFO - 'TMOUT': '86400', 09:23:14 INFO - 'USER': 'cltbld', 09:23:14 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1494606154.832417-1631648225', 09:23:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:23:14 INFO - '_': '/tools/buildbot/bin/python'} 09:23:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:23:15 INFO - Downloading/unpacking jsonschema==2.5.1 09:23:15 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:23:15 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:23:15 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:23:15 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:23:16 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:23:16 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:23:16 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:23:16 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:23:16 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:23:16 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:23:16 INFO - Downloading functools32-3.2.3-2.tar.gz 09:23:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:23:16 INFO - warning: no files found matching '*.txt' 09:23:16 INFO - no previously-included directories found matching 'build' 09:23:16 INFO - no previously-included directories found matching 'dist' 09:23:16 INFO - no previously-included directories found matching '.git*' 09:23:16 INFO - Installing collected packages: jsonschema, functools32 09:23:16 INFO - Running setup.py install for functools32 09:23:16 INFO - warning: no files found matching '*.txt' 09:23:16 INFO - no previously-included directories found matching 'build' 09:23:16 INFO - no previously-included directories found matching 'dist' 09:23:16 INFO - no previously-included directories found matching '.git*' 09:23:16 INFO - Successfully installed jsonschema functools32 09:23:16 INFO - Cleaning up... 09:23:16 INFO - Return code: 0 09:23:16 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:23: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:23:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:23: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:23:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:23: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', '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 0xf2f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12a1770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x129ea30>, '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 0x129f7f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x129fca0>, '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': '6dbc10da6d83fee962c624be000001a8-1494606154.832417-1631648225', '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:23: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 09:23: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 functools32==3.2.3-2 09:23:16 INFO - Using env: {'DISPLAY': ':0', 09:23:16 INFO - 'HOME': '/home/cltbld', 09:23:16 INFO - 'LANG': 'en_US.UTF-8', 09:23:16 INFO - 'LANGUAGE': 'en_US:en', 09:23:16 INFO - 'LOGNAME': 'cltbld', 09:23:16 INFO - 'MAIL': '/var/mail/cltbld', 09:23:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:23:16 INFO - 'MOZ_NO_REMOTE': '1', 09:23:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:23:16 INFO - 'NO_EM_RESTART': '1', 09:23:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:23:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:23:16 INFO - 'PWD': '/builds/slave/test', 09:23:16 INFO - 'SHELL': '/bin/bash', 09:23:16 INFO - 'SHLVL': '1', 09:23:16 INFO - 'TERM': 'linux', 09:23:16 INFO - 'TMOUT': '86400', 09:23:16 INFO - 'USER': 'cltbld', 09:23:16 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1494606154.832417-1631648225', 09:23:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:23:16 INFO - '_': '/tools/buildbot/bin/python'} 09:23:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:23:16 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:23:16 INFO - Cleaning up... 09:23:16 INFO - Return code: 0 09:23:16 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:23: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:23:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:23: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:23:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:23: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', '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 0xf2f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12a1770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x129ea30>, '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 0x129f7f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x129fca0>, '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': '6dbc10da6d83fee962c624be000001a8-1494606154.832417-1631648225', '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:23: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:23: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 blobuploader==1.2.4 09:23:16 INFO - Using env: {'DISPLAY': ':0', 09:23:16 INFO - 'HOME': '/home/cltbld', 09:23:16 INFO - 'LANG': 'en_US.UTF-8', 09:23:16 INFO - 'LANGUAGE': 'en_US:en', 09:23:16 INFO - 'LOGNAME': 'cltbld', 09:23:16 INFO - 'MAIL': '/var/mail/cltbld', 09:23:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:23:16 INFO - 'MOZ_NO_REMOTE': '1', 09:23:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:23:16 INFO - 'NO_EM_RESTART': '1', 09:23:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:23:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:23:16 INFO - 'PWD': '/builds/slave/test', 09:23:16 INFO - 'SHELL': '/bin/bash', 09:23:16 INFO - 'SHLVL': '1', 09:23:16 INFO - 'TERM': 'linux', 09:23:16 INFO - 'TMOUT': '86400', 09:23:16 INFO - 'USER': 'cltbld', 09:23:16 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1494606154.832417-1631648225', 09:23:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:23:16 INFO - '_': '/tools/buildbot/bin/python'} 09:23:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:23:17 INFO - Downloading/unpacking blobuploader==1.2.4 09:23:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:23:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:23:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:23:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:23:18 INFO - Downloading blobuploader-1.2.4.tar.gz 09:23:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:23:18 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:23:18 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:23:18 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:23:18 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:23:18 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:23:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:23:18 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:23:18 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:23:18 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:23:18 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:23:18 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:23:18 INFO - Downloading docopt-0.6.1.tar.gz 09:23:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:23:18 INFO - Installing collected packages: blobuploader, requests, docopt 09:23:18 INFO - Running setup.py install for blobuploader 09:23:18 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:23:18 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:23:18 INFO - Running setup.py install for requests 09:23:19 INFO - Running setup.py install for docopt 09:23:19 INFO - Successfully installed blobuploader requests docopt 09:23:19 INFO - Cleaning up... 09:23:19 INFO - Return code: 0 09:23:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:23:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:23:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:23:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:23:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:23:19 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 0xf2f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12a1770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x129ea30>, '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 0x129f7f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x129fca0>, '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': '6dbc10da6d83fee962c624be000001a8-1494606154.832417-1631648225', '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:23:19 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:23:19 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:23:19 INFO - Using env: {'DISPLAY': ':0', 09:23:19 INFO - 'HOME': '/home/cltbld', 09:23:19 INFO - 'LANG': 'en_US.UTF-8', 09:23:19 INFO - 'LANGUAGE': 'en_US:en', 09:23:19 INFO - 'LOGNAME': 'cltbld', 09:23:19 INFO - 'MAIL': '/var/mail/cltbld', 09:23:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:23:19 INFO - 'MOZ_NO_REMOTE': '1', 09:23:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:23:19 INFO - 'NO_EM_RESTART': '1', 09:23:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:23:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:23:19 INFO - 'PWD': '/builds/slave/test', 09:23:19 INFO - 'SHELL': '/bin/bash', 09:23:19 INFO - 'SHLVL': '1', 09:23:19 INFO - 'TERM': 'linux', 09:23:19 INFO - 'TMOUT': '86400', 09:23:19 INFO - 'USER': 'cltbld', 09:23:19 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1494606154.832417-1631648225', 09:23:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:23:19 INFO - '_': '/tools/buildbot/bin/python'} 09:23:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:23:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:23:19 INFO - Running setup.py (path:/tmp/pip-Frg90G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:23:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:23:19 INFO - Running setup.py (path:/tmp/pip-REQxHr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:23:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:23:19 INFO - Running setup.py (path:/tmp/pip-PUAWQS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:23:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:23:19 INFO - Running setup.py (path:/tmp/pip-Cx5YS4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:23:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:23:19 INFO - Running setup.py (path:/tmp/pip-YsKcCY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:23:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:23:19 INFO - Running setup.py (path:/tmp/pip-H3VoIC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:23:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:23:19 INFO - Running setup.py (path:/tmp/pip-YDAxKU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:23:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:23:20 INFO - Running setup.py (path:/tmp/pip-gRht7r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:23:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:23:20 INFO - Running setup.py (path:/tmp/pip-64guLV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:23:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:23:20 INFO - Running setup.py (path:/tmp/pip-14kIkk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:23:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:23:20 INFO - Running setup.py (path:/tmp/pip-Tivvi1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:23:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:23:20 INFO - Running setup.py (path:/tmp/pip-RAwW2z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:23:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:23:20 INFO - Running setup.py (path:/tmp/pip-yYDmPA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:23:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:23:20 INFO - Running setup.py (path:/tmp/pip-a7ree7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:23:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:23:20 INFO - Running setup.py (path:/tmp/pip-Ix1DZW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:23:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:23:20 INFO - Running setup.py (path:/tmp/pip-DVdmCF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:23:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:23:20 INFO - Running setup.py (path:/tmp/pip-3ZN1PG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:23:20 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:23:20 INFO - Running setup.py install for manifestparser 09:23:20 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:23:20 INFO - Running setup.py install for mozcrash 09:23:21 INFO - Running setup.py install for mozdebug 09:23:21 INFO - Running setup.py install for mozdevice 09:23:21 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:23:21 INFO - Running setup.py install for mozfile 09:23:21 INFO - Running setup.py install for mozhttpd 09:23:21 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:23:21 INFO - Running setup.py install for mozinfo 09:23:21 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:23:21 INFO - Running setup.py install for mozInstall 09:23:21 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:23:21 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:23:21 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:23:21 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:23:21 INFO - Running setup.py install for mozleak 09:23:21 INFO - Running setup.py install for mozlog 09:23:21 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:23:21 INFO - Running setup.py install for moznetwork 09:23:21 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:23:21 INFO - Running setup.py install for mozprocess 09:23:22 INFO - Running setup.py install for mozprofile 09:23:22 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:23:22 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:23:22 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:23:22 INFO - Running setup.py install for mozrunner 09:23:22 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:23:22 INFO - Running setup.py install for mozscreenshot 09:23:22 INFO - Running setup.py install for moztest 09:23:22 INFO - Running setup.py install for mozversion 09:23:22 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:23:22 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:23:22 INFO - Cleaning up... 09:23:22 INFO - Return code: 0 09:23:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:23:22 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:23:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:23:22 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:23:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:23:22 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 0xf2f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12a1770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x129ea30>, '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 0x129f7f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x129fca0>, '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': '6dbc10da6d83fee962c624be000001a8-1494606154.832417-1631648225', '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:23:22 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:23:22 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:23:22 INFO - Using env: {'DISPLAY': ':0', 09:23:22 INFO - 'HOME': '/home/cltbld', 09:23:22 INFO - 'LANG': 'en_US.UTF-8', 09:23:22 INFO - 'LANGUAGE': 'en_US:en', 09:23:22 INFO - 'LOGNAME': 'cltbld', 09:23:22 INFO - 'MAIL': '/var/mail/cltbld', 09:23:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:23:22 INFO - 'MOZ_NO_REMOTE': '1', 09:23:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:23:22 INFO - 'NO_EM_RESTART': '1', 09:23:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:23:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:23:22 INFO - 'PWD': '/builds/slave/test', 09:23:22 INFO - 'SHELL': '/bin/bash', 09:23:22 INFO - 'SHLVL': '1', 09:23:22 INFO - 'TERM': 'linux', 09:23:22 INFO - 'TMOUT': '86400', 09:23:22 INFO - 'USER': 'cltbld', 09:23:22 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1494606154.832417-1631648225', 09:23:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:23:22 INFO - '_': '/tools/buildbot/bin/python'} 09:23:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:23:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:23:22 INFO - Running setup.py (path:/tmp/pip-0ROF0E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:23:22 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:23:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:23:22 INFO - Running setup.py (path:/tmp/pip-6Tm6E3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:23:22 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:23:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:23:22 INFO - Running setup.py (path:/tmp/pip-Mb5Lp4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:23:23 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:23:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:23:23 INFO - Running setup.py (path:/tmp/pip-UsxKFx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:23:23 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:23:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:23:23 INFO - Running setup.py (path:/tmp/pip-Xt8nk7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:23:23 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:23:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:23:23 INFO - Running setup.py (path:/tmp/pip-NrULph-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:23:23 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:23:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:23:23 INFO - Running setup.py (path:/tmp/pip-qxebCb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:23:23 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:23:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:23:23 INFO - Running setup.py (path:/tmp/pip-noKx6f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:23:23 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:23:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:23:23 INFO - Running setup.py (path:/tmp/pip-FbZZAi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:23:23 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:23:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:23:23 INFO - Running setup.py (path:/tmp/pip-sKkie3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:23:23 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:23:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:23:23 INFO - Running setup.py (path:/tmp/pip-64JbHg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:23:23 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:23:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:23:23 INFO - Running setup.py (path:/tmp/pip-LNK2zz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:23:23 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:23:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:23:23 INFO - Running setup.py (path:/tmp/pip-UIpaWP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:23:23 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:23:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:23:23 INFO - Running setup.py (path:/tmp/pip-0Yfixo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:23:23 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:23:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:23:23 INFO - Running setup.py (path:/tmp/pip-Zismr6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:23:23 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:23:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:23:23 INFO - Running setup.py (path:/tmp/pip-npMkJI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:23:24 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:23:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:23:24 INFO - Running setup.py (path:/tmp/pip-DPYd2U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:23:24 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:23:24 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:23:24 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:23:24 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:23:24 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:23:24 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:23:24 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:23:24 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:23:24 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:23:24 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:23:24 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:23:25 INFO - Downloading blessings-1.6.tar.gz 09:23:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:23:25 INFO - Installing collected packages: blessings 09:23:25 INFO - Running setup.py install for blessings 09:23:25 INFO - Successfully installed blessings 09:23:25 INFO - Cleaning up... 09:23:25 INFO - Return code: 0 09:23:25 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:23:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:23:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:23:25 INFO - Reading from file tmpfile_stdout 09:23:25 INFO - Current package versions: 09:23:25 INFO - argparse == 1.2.1 09:23:25 INFO - blessings == 1.6 09:23:25 INFO - blobuploader == 1.2.4 09:23:25 INFO - docopt == 0.6.1 09:23:25 INFO - functools32 == 3.2.3-2 09:23:25 INFO - jsonschema == 2.5.1 09:23:25 INFO - manifestparser == 1.1 09:23:25 INFO - mozInstall == 1.12 09:23:25 INFO - mozcrash == 1.0 09:23:25 INFO - mozdebug == 0.1 09:23:25 INFO - mozdevice == 0.50 09:23:25 INFO - mozfile == 1.2 09:23:25 INFO - mozhttpd == 0.7 09:23:25 INFO - mozinfo == 0.9 09:23:25 INFO - mozleak == 0.1 09:23:25 INFO - mozlog == 3.4 09:23:25 INFO - moznetwork == 0.27 09:23:25 INFO - mozprocess == 0.25 09:23:25 INFO - mozprofile == 0.28 09:23:25 INFO - mozrunner == 6.13 09:23:25 INFO - mozscreenshot == 0.1 09:23:25 INFO - mozsystemmonitor == 0.3 09:23:25 INFO - moztest == 0.8 09:23:25 INFO - mozversion == 1.4 09:23:25 INFO - psutil == 3.1.1 09:23:25 INFO - requests == 1.2.3 09:23:25 INFO - wsgiref == 0.1.2 09:23:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:23:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:23:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:23:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:23:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:23:25 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 0xf2f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12a1770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x129ea30>, '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 0x129f7f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x129fca0>, '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': '6dbc10da6d83fee962c624be000001a8-1494606154.832417-1631648225', '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:23:25 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:23:25 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:23:25 INFO - Using env: {'DISPLAY': ':0', 09:23:25 INFO - 'HOME': '/home/cltbld', 09:23:25 INFO - 'LANG': 'en_US.UTF-8', 09:23:25 INFO - 'LANGUAGE': 'en_US:en', 09:23:25 INFO - 'LOGNAME': 'cltbld', 09:23:25 INFO - 'MAIL': '/var/mail/cltbld', 09:23:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:23:25 INFO - 'MOZ_NO_REMOTE': '1', 09:23:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:23:25 INFO - 'NO_EM_RESTART': '1', 09:23:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:23:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:23:25 INFO - 'PWD': '/builds/slave/test', 09:23:25 INFO - 'SHELL': '/bin/bash', 09:23:25 INFO - 'SHLVL': '1', 09:23:25 INFO - 'TERM': 'linux', 09:23:25 INFO - 'TMOUT': '86400', 09:23:25 INFO - 'USER': 'cltbld', 09:23:25 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1494606154.832417-1631648225', 09:23:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:23:25 INFO - '_': '/tools/buildbot/bin/python'} 09:23:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:23:25 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:23:25 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:23:25 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:23:25 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:23:25 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:23:25 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:23:25 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:23:25 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:23:25 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:23:25 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:23:25 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:23:25 INFO - Cleaning up... 09:23:25 INFO - Return code: 0 09:23:25 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:23:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:23:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:23:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:23:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:23:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf2f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12a1770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x129ea30>, '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 0x129f7f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x129fca0>, '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': '6dbc10da6d83fee962c624be000001a8-1494606154.832417-1631648225', '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:23:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 09:23:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:23:25 INFO - Using env: {'DISPLAY': ':0', 09:23:25 INFO - 'HOME': '/home/cltbld', 09:23:25 INFO - 'LANG': 'en_US.UTF-8', 09:23:25 INFO - 'LANGUAGE': 'en_US:en', 09:23:25 INFO - 'LOGNAME': 'cltbld', 09:23:25 INFO - 'MAIL': '/var/mail/cltbld', 09:23:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:23:25 INFO - 'MOZ_NO_REMOTE': '1', 09:23:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:23:25 INFO - 'NO_EM_RESTART': '1', 09:23:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:23:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:23:25 INFO - 'PWD': '/builds/slave/test', 09:23:25 INFO - 'SHELL': '/bin/bash', 09:23:25 INFO - 'SHLVL': '1', 09:23:25 INFO - 'TERM': 'linux', 09:23:25 INFO - 'TMOUT': '86400', 09:23:25 INFO - 'USER': 'cltbld', 09:23:25 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1494606154.832417-1631648225', 09:23:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:23:25 INFO - '_': '/tools/buildbot/bin/python'} 09:23:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:23:26 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:23:26 INFO - Cleaning up... 09:23:26 INFO - Return code: 0 09:23:26 INFO - Running post-action listener: _resource_record_post_action 09:23:26 INFO - Running post-action listener: _start_resource_monitoring 09:23:26 INFO - Starting resource monitoring. 09:23:26 INFO - [mozharness: 2017-05-12 16:23:26.093826Z] Finished create-virtualenv step (success) 09:23:26 INFO - [mozharness: 2017-05-12 16:23:26.094335Z] Running install step. 09:23:26 INFO - Running pre-action listener: _resource_record_pre_action 09:23:26 INFO - Running main action method: install 09:23:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:23:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:23:26 INFO - Reading from file tmpfile_stdout 09:23:26 INFO - Detecting whether we're running mozinstall >=1.0... 09:23:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:23:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:23:26 INFO - Reading from file tmpfile_stdout 09:23:26 INFO - Output received: 09:23:26 INFO - Usage: mozinstall [options] installer 09:23:26 INFO - Options: 09:23:26 INFO - -h, --help show this help message and exit 09:23:26 INFO - -d DEST, --destination=DEST 09:23:26 INFO - Directory to install application into. [default: 09:23:26 INFO - "/builds/slave/test"] 09:23:26 INFO - --app=APP Application being installed. [default: firefox] 09:23:26 INFO - mkdir: /builds/slave/test/build/application 09:23:26 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:23:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 09:23:42 INFO - Reading from file tmpfile_stdout 09:23:42 INFO - Output received: 09:23:42 INFO - /builds/slave/test/build/application/firefox/firefox 09:23:42 INFO - Running post-action listener: _resource_record_post_action 09:23:42 INFO - [mozharness: 2017-05-12 16:23:42.947495Z] Finished install step (success) 09:23:42 INFO - [mozharness: 2017-05-12 16:23:42.947729Z] Running run-tests step. 09:23:42 INFO - Running pre-action listener: _resource_record_pre_action 09:23:42 INFO - Running main action method: run_tests 09:23:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:23:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:23:42 INFO - Python 2.7.3 09:23:42 INFO - Return code: 0 09:23:42 INFO - grabbing minidump binary from tooltool 09:23:42 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:23:42 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 0x129ea30>, '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 0x129f7f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x129fca0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:23:42 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:23:42 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:23:42 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:23:43 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:23:43 INFO - Return code: 0 09:23:43 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:23:43 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:23:43 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:23:43 INFO - ENV: RUST_BACKTRACE is now 1 09:23:43 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:23:43 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:23:43 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NtRFFEQ4TNiztEbolW4n4g/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-050', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 09:23:43 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 --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/NtRFFEQ4TNiztEbolW4n4g/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-050 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 09:23:43 INFO - Using env: {'DISPLAY': ':0', 09:23:43 INFO - 'HOME': '/home/cltbld', 09:23:43 INFO - 'LANG': 'en_US.UTF-8', 09:23:43 INFO - 'LANGUAGE': 'en_US:en', 09:23:43 INFO - 'LOGNAME': 'cltbld', 09:23:43 INFO - 'MAIL': '/var/mail/cltbld', 09:23:43 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:23:43 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:23:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:23:43 INFO - 'MOZ_NO_REMOTE': '1', 09:23:43 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:23:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:23:43 INFO - 'NO_EM_RESTART': '1', 09:23:43 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:23:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:23:43 INFO - 'PWD': '/builds/slave/test', 09:23:43 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:23:43 INFO - 'RUST_BACKTRACE': '1', 09:23:43 INFO - 'SHELL': '/bin/bash', 09:23:43 INFO - 'SHLVL': '1', 09:23:43 INFO - 'TERM': 'linux', 09:23:43 INFO - 'TMOUT': '86400', 09:23:43 INFO - 'USER': 'cltbld', 09:23:43 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1494606154.832417-1631648225', 09:23:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:23:43 INFO - '_': '/tools/buildbot/bin/python'} 09:23:43 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NtRFFEQ4TNiztEbolW4n4g/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-050', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 09:23:43 INFO - mozversion application_buildid: 20170512154902 09:23:43 INFO - mozversion application_changeset: 1e2fe13035e13b7b4001ade3b48f226957cef5fc 09:23:43 INFO - mozversion application_display_name: Nightly 09:23:43 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:23:43 INFO - mozversion application_name: Firefox 09:23:43 INFO - mozversion application_remotingname: firefox 09:23:43 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 09:23:43 INFO - mozversion application_vendor: Mozilla 09:23:43 INFO - mozversion application_version: 55.0a1 09:23:43 INFO - mozversion platform_buildid: 20170512154902 09:23:43 INFO - mozversion platform_changeset: 1e2fe13035e13b7b4001ade3b48f226957cef5fc 09:23:43 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 09:23:43 INFO - mozversion platform_version: 55.0a1 09:23:43 INFO - using testdate: 1494606223 09:23:43 INFO - actual date: 1494606223 09:23:43 INFO - starting webserver on 'localhost:36084' 09:23:43 INFO - SUITE-START | Running 2 tests 09:23:43 INFO - TEST-START | dromaeo_css 09:23:43 INFO - operating with platform_type : linux_ 09:23:43 INFO - Initialising browser for dromaeo_css test... 09:23:43 INFO - TEST-INFO | started process 12370 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppSxTNI/profile http://localhost:36084/getInfo.html) 09:23:47 INFO - PID 12370 | __metrics Screen width/height:1600/1200 09:23:47 INFO - PID 12370 | colorDepth:24 09:23:47 INFO - PID 12370 | Browser inner width/height: 1024/695 09:23:47 INFO - PID 12370 | __metrics 09:23:47 INFO - PID 12370 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:23:47 INFO - PID 12370 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:23:49 INFO - TEST-INFO | 12370: exit 0 09:23:49 INFO - Browser initialized. 09:23:49 INFO - Running cycle 1/1 for dromaeo_css test... 09:23:49 INFO - TEST-INFO | started process 12467 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppSxTNI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:24:00 INFO - PID 12467 | RSS: Main: 152186880 09:24:01 INFO - PID 12467 | 09:27:07 INFO - PID 12467 | Cycle 1(1): loaded http://localhost:36084/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36084/tests/dromaeo/cssquery-ext.html) 09:27:09 INFO - PID 12467 | RSS: Main: 235167744 09:27:09 INFO - PID 12467 | 09:30:11 INFO - PID 12467 | Cycle 1(1): loaded http://localhost:36084/tests/dromaeo/cssquery-ext.html (next: http://localhost:36084/tests/dromaeo/cssquery-jquery.html) 09:30:12 INFO - PID 12467 | RSS: Main: 233996288 09:30:12 INFO - PID 12467 | 09:33:13 INFO - PID 12467 | Cycle 1(1): loaded http://localhost:36084/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36084/tests/dromaeo/cssquery-mootools.html) 09:33:14 INFO - PID 12467 | RSS: Main: 183951360 09:33:14 INFO - PID 12467 | 09:36:16 INFO - PID 12467 | Cycle 1(1): loaded http://localhost:36084/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36084/tests/dromaeo/cssquery-prototype.html) 09:36:17 INFO - PID 12467 | RSS: Main: 223309824 09:36:17 INFO - PID 12467 | 09:39:20 INFO - PID 12467 | Cycle 1(1): loaded http://localhost:36084/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36084/tests/dromaeo/cssquery-yui.html) 09:39:20 INFO - PID 12467 | RSS: Main: 180613120 09:39:20 INFO - PID 12467 | 09:42:22 INFO - PID 12467 | Cycle 1(1): loaded http://localhost:36084/tests/dromaeo/cssquery-yui.html (next: http://localhost:36084/tests/dromaeo/cssquery-dojo.html) 09:42:23 INFO - PID 12467 | RSS: Main: 276205568 09:42:23 INFO - PID 12467 | 09:42:23 INFO - PID 12467 | __start_tp_report 09:42:23 INFO - PID 12467 | _x_x_mozilla_page_load 09:42:23 INFO - PID 12467 | _x_x_mozilla_page_load_details 09:42:23 INFO - PID 12467 | |i|pagename|runs| 09:42:23 INFO - PID 12467 | |0;dojo.html;2716.9320766980823;2719.796015298853;2758.4620998905207;2759.944801103978;2762.599423083652;5033.345665063546;5162.096633089213;5211.791528338867;5266.315379000729;5276.34045744282;5177.068127737006;5189.42916279209;5216.008958297921;5255.237990491377;5257.474252574741;4378.343248512717;4563.041761230129;4642.907141857161;4727.432708075035;4736.3369128322065;4685.999999999983;4731.148393289207;4733.290006499035;4741.9525804742025;4793.520647935196;4557.772111394417;4607.17070927233;4612.538746125394;4622.329762184498;4658.301254811805;4627.305904114376;4656.022235330584;4691;4711.481737008926;4713.929291060636;4593.242115051013;4611;4615.492295847454;4638.466576343696;4642.883927901796;5092.949070509285;5187.8184263550975;5193.143131383317;5195.090859099642;5249.973750131263;5576.302962129734;5595;5609;5686.829395118153;5687.573431992576;5612.989661860864;5680.0627896397455;5713.257276554063;5735.827925162252;5742.6841523716175;5253.264542963988;5260.00059988601;5260.868478288074;5266.789328426897;5307.01820163271;5654.547636189095;5722.7424765885635;5816.214811000461;5816.272965879265;5834.299884013861;5428.538574221236;5435.1303791393975;5453.972730136324;5522.392536820947;5537.086380747131;5660.688662123623;5663.66018038919;5663.830085097454;5664.376918538957;5696.3164420269;5558.555315574744;5600.299962504687;5614.9719251403485;5620.606557540933;5621.409751976065;5404.351477822686;5466.699331536804;5557.221988921554;5602.579806514527;5652.773889044474;4740.170470167707;4787.664863459524;4796.088743138793;4817.470078291385;4831.347768051339;4099.549049604541;4100.159467309194;4100.938485922714;4130.669546436278;4146.647534959502;4702;4765.904681906342;4771.594414474808;4832.565069143794;4840.201366774443;5687.51656109227;5688.601797874192;5726.885462290731;5727.799527016535;5751.913721294184;4811.230203167476;4811.4707382187935;4812.735299558558;4817.78319975602;4862.31927530139;4936.506349365107;5009.774560144875;5062.265971434122;5063.316452278968;5065.189569668835;5189.117849965591;5269.578433725216;5270.025045366619;5276.419593844751;5277.129273669955;5718.79984200551;5743.56923230751;5763.942360576509;5764.654120752768;5771.307443106686;5183.0670479314085;5254.97372513135;5286.841394758163;5294.629375943647;5305.018571564273;5595.804146854841;5602.85992850182;5610.4670056344585;5611.046122159161;5612.7754889803955;5568.610197286313;5697.971510142423;5707.086866101404;5715.028445164416;5752.338481074563;5416.052190866504;5443.101888188405;5472.644278121909;5533.7786488540005;5550.52820510245;5460.972695136499;5497.340319161726;5507.256520369859;5508.641938274;5516.393196748274;5382.892342153056;5383.192521121863;5393.164059570773;5400.351957764936;5446.645968012067;5402.459754024566;5441.401445840876;5497.615166938276;5520.171974203901;5530.308711411074;5402.108652072521;5403.675779453245;5404.8108316208745;5409.459054094559;5423.132298832168 09:42:23 INFO - PID 12467 | |1;ext.html;638.9456896163825;670.6981858163826;693.7190437872662;946.9715908522746;947.0198344713223;25145.874270628643;30695.846520767394;33799.155021124454;34040.48939265907;34098.65901340986;35134.64865351345;35363.46954795674;35419.64580354196;35474.11314717133;35496;6750.864982700331;6896.448284137282;6896.482763792736;6898.275681053467;6899.931000689979;5056.19100943849;5188.455212202721;6210;6841.486888483359;6866.862662746742;6853.109095817562;6897.689603967833;6944.270851560564;6946;6955.304469553055;6881.483888708367;6898.448124150081;6940.340667636567;6948.6525673716615;6961.825954351131;6841.2132604750595;6892.689828957709;6899.206591242021;6901.516893817435;6901.75843845463;30837.229069273224;30972.690273097433;31031.534526982112;31054;31055.223619409695;3048.7103725146076;3069.785115041948;3088.9536656950163;3091.2580980564726;3092.196029032445;23842;23863.30118831584;23871.04515819365;23904.641430378557;23917;2779.194033730216;2783.1650504848667;2787.888484460619;2793.329600895791;2794.2176190666646;136387.31806341003;136519;136975.31512342376;137001;137323;38994.22011559753;39034.41448378276;39052.21895562073;39089.41365879514;39141.41287880684;41147.7942610291;41165;41172.38241426381;41275.380869286986;41284.79357603253;12615.873841261653;12740.299283539494;12751.48994040228;12752.107352485236;12755.298458584866;10352.378857268588;10360.119389851796;10365;10368.688939331832;10370.896291036994;10039.34744241622;10255.487225638688;11681.707957301136;11858.644240672622;11902;4945.159322915113;4958.727270000112;4964.280179373971;4985.850424487271;5095.414027386824;881.3037700216757;894.9284057275403;896.6861598440494;913.196387179278;924.0436148586181;20420.183192672423;20572.79427205739;21151.471213219793;21251.362459126252;21331.253406130712;979.8775153105862;981.6809536900536;985.5959056786683;1005.6681295172575;1006.5168719014914;10806.783864322826;11130.276532025393;11206.607768728056;11254.324740515594;11326.603568875049;152953.23523382313;153977.23011384872;154333;154341;154450;38660.22679546449;38743;38865.222695545934;38888.22223555513;38909.221815564095;1204.391782150026;1248.6628610275175;1249.8500179978462;1250.606059091365;1255.334672623511;19528.707069393688;19784.90107549453;19977.30192933617;20417.285395011102;20782.896085520082;29279.85360073186;29348.266293342836;29349.26626834346;29471.705282946896;29504.557431638113;142351;142354.2882285582;143168;143640.28179859032;143865.28067359596;27738.306542336602;28804.42391152207;28883;28895.42209155847;28969.420611588073;30083.84958075283;30553.54169687412;33987.66012339944;34895.47656785201;35185.1203719909;26972.865135674198;27438.862805685843;27562.5865612012;27671.446571068867;28665.42669146647;26217.475650487264;26224;26920.461590768467;27138;27972.300692482037;29103.7089629101;29734.85132574323;29739.364334961785;29834.10497684986;31793.841030794698;34764;34894;35043.474347884294;35331.64668353284;35437.291254174255;25147.49705005926;27376.041838535555;27423.177304680892;27423.394777496105;27916.231308773054 09:42:23 INFO - PID 12467 | |2;jquery.html;402.6818813137621;411.2145801519099;414.49845686719067;418.9518205406379;428.36387963873653;15178.6964260715;16137.75793363099;16650.58373540662;16774.91612541937;16791.40481654244;16749.078800665957;16976.915115424406;17032.318707251696;17044;17240.482785516422;5218.347706536673;5237.13587258102;5425.945740542603;5426.810061647843;5427.158790387496;5251.396089449705;5358.4641535846295;5388.622796404254;5391.406945236021;5394.02907476654;5142.640015198937;5362.973185134068;5363.6245462817615;5371.946280537184;5372;5236.162214045753;5339.679619222859;5354.223637572531;5354.330708661418;5360.731963401834;4807.711537307738;4848;4850.2724591311235;4853.199222128344;4854.2718592211095;19163.80836191634;19164.904175479172;19168.520786980298;19458.61082778351;19524.609507809906;1646.415522489511;1681.5459825846954;1681.932722691091;1685.7218558937761;1687.0468185475168;13394;13513.527026554122;13807.309634518233;13912.652183695387;13914.93042534791;1985.553250518636;2000.779914209436;2004.1482369992696;2009.136071489259;2024.6153230886084;74418.62790686067;74886.62556687236;74982.62508687476;75978;76186;10291.43397113151;10308.278420510642;10362;10580.682579522627;10583.259171857895;14539.3457294422;14568.27158642085;14569.344379502947;14572.489962851248;14577.781333280009;6971.651417429108;7303;7315.670794814246;7411.110666720028;7442.479026468203;6605.867882642417;6760.18877734675;6880.69036893341;6886.793396198122;6908.516403851682;6481.48148148147;6618.815790789028;6635.8009259722285;6637.701303441357;6649.60102393858;1989.4727897107277;2000.5698774763205;2009.417268991976;2024.7772744998038;2025.2911480981538;857.6783706110209;896.5606852642288;902.4720538484928;902.5622573052065;927.7309580221795;16233.431829886133;16454.43682850127;16466.506004819876;16619.252133654016;17190.1404929753;870.3776799588325;879.7844528090659;880.8282384934876;896.1038961038961;912.5209265135857;8884.111588841064;8981.191692747683;9283.303752218611;9392.624295028123;9451.125038734086;339685;347267;349059;355773;356518;73767;73802.63098684473;74116;74365.25634743691;74778;1024.5901639344172;1033.379972016784;1035.896410358973;1036.0520124086527;1038.781855810273;14037.929810350883;14230.857691423367;14289.499867504588;14411.92794036023;14920.403183872957;37807.24385512329;37876.242475150895;38452.42321365238;38974.4153837687;39420.40869387019;45161.548384515736;45461.457800131044;45892.54107459016;46008.53991460043;46354.30468543042;7883.132855385788;7956.562389068657;7968.641411136628;7997.680092796223;8114.350851931713;10903.727406814576;11084.279521831055;11205.271657342573;11378.08975281992;11634.825477618011;10318.122959548522;10426.322289051188;10812;11095.389753563632;11594.88405115938;9873.605055797687;10383.688489345332;10467.842982355118;10723.839142412715;10993.780124397626;10838.512266947848;10888.945555272174;10900.236983411402;11281.830772538582;11314.377709225742;8025.317847982987;8136.83726325482;8145.877811832946;8233.423660343959;8269;10596.152307815202;10631.521581528696;10696.732581685521;10849.566017359217;10981.945090274497 09:42:23 INFO - PID 12467 | |3;mootools.html;1062.596213438893;1244.3902487780986;1300.8048792681097;1314.336260188604;1315.8815706586406;8472.322214222862;9927.702168934935;10395.532201050952;10473.84289235662;10478.161747060236;10238.897611023887;10357.274990750651;10370.53332600033;10374.688759337214;10377;2228.064213030527;2264.467850055236;2279.555486680098;2280.0309868305985;2284.5430913817304;1856.10906764753;1924.6631839428114;2169.7938695823873;2234.1733558583346;2259.559385919746;2245.8989345479495;2272.5909336319455;2274.9658755118685;2275.442516583431;2277.0095008671283;2189.35414052854;2206.8455208135438;2225.2545397291765;2226.832987525942;2229.7770222977733;2146.8711877287415;2158.784121587829;2159.362987918552;2177.0203408466095;2184.071769497973;9807.06832850878;9905.405675659411;9907.752306192402;9930.652427165014;9942.353747006493;5493.423190564973;5682.971585142089;5715.771369145229;5719.485246327808;5720.256366672306;3298.983505082459;3389.57630296213;3402.2515046689687;3416.5558477398026;3481.617022127564;1039.5322105052755;1051.3691784929058;1084.5173897615564;1099.2799716185912;1106.2201148190507;14943;14967.700645987128;14996.775048374284;15001.099934003994;15016.924915375463;4937.703737775673;5143.045642655841;5221.060209162311;5228.085085110167;5272.9736351318;12456.314902680258;12512.436940337706;12525.624231273076;12529.74940501185;12533.811992820116;5668.829935101953;5752.539796816244;5763.135529670583;5767.192593036978;5770.682612456355;4881.292212629149;5033.395992480926;5080.796768129233;5088.160453525201;5144.974275128675;3658.213484100931;3774.2074164425776;3776.905577360533;3785.375413056815;3809.2191100824266;1295.3587973952954;1340.7117469744053;1347.9865201347861;1348.629126990066;1351.040761059639;693.0989713372595;705.989410158848;714.0717067811823;714.6248219684603;717.2361435071632;5124.769385377667;5159.896802064013;5265.21021846726;5328.760205790749;5349.170878513836;831.5883637599427;838.7483754873635;844.6705784743955;849.7493239494364;852.0074113657644;3185.4266232077985;3206.8075915445147;3224.0650211438888;3234.5956755405573;3290.6544812794314;12721.93639031799;13295.268760218281;13305.334733263491;13311.134776239513;13322;13196.670083247996;13210.207387556586;13236.933815330862;13237.536686215935;13254.337283135805;7111.893321600181;7414.851702966019;7455.217202193691;7472.626368681545;7484.887726684104;5487.670739755627;5541.833744987657;5695.345035320991;5789.681567513659;5849.005669036189;11520.88479115198;11656.475458604213;11738.41307934617;11812.173147879566;12077.27536347822;12009.099317551043;12112.75774484523;12272.509099636272;12292.938535307623;12355.75288494243;9327.486988215713;9617.182539484222;9621.374610650286;9638.855417168888;9639.180669642878;9134.360594758304;9159.496227707274;9247.630094796403;9252.074792520694;9661.710148695269;7940.404469664913;8087.595620219083;8233.50598964064;8251.83496330082;8363.95818020906;8000.5599692017495;8097.190280972091;8099.878501822595;8189.140140285423;8338.791530211793;6906.343897329745;6978.302169782981;6994.5803251805055;7034.824129396601;7053.365197132282;5323.2547443358735;5331.280277162534;5405.837824865261;5477.643953143033;5516.61383703153;5178.482151784791;5207.505286997729;5226.790928362823;5372.4627537247525;5412.810551630674 09:42:23 INFO - PID 12467 | |4;prototype.html;373.86914579897024;392.9017745563609;395.503642928125;397.05698964958214;400.7275052963985;5338.225957236204;5378.811741589036;5409.242706021155;5417.7291135443265;5420.810271640494;5072.644914855961;5196.740162991854;5237.685738855671;5238.92141617876;5266.947330526694;4024.1750441159493;4029.435878976946;4033.636972672459;4047.736897101679;4051.7771522566245;4042.3128068228325;4044.2720310344125;4056.9188616227657;4060.695447841409;4065.166640838636;3906.5507466641275;3986.309241262151;3992.4610177626087;4010.598940105995;4024.1951609678035;3982.8605998789903;3996.540397854226;3999.840006399726;4002.0395105174694;4005.1989602079702;3506;3509.2455122148604;3511.806850623215;3523.594786599548;3536.3634545781747;4916.615441510864;5115.7442127893455;5140.460251673595;5155;5161;4680.391549098629;4699.553542413465;4701.694389864648;4710.976445117787;4713.407625805793;5589.882023595256;5593.888122237573;5601.383847776741;5604.1593760935775;5604.663720176803;3861.710371722104;3901.9269700832215;3929.685625149981;3937.1928754605237;3953.960460395388;5631.60578759487;5697.800576979786;5797.217375654275;5888.470037696585;5963.463288304073;4017.598240175959;4027.496562929634;4033.8184781684895;4035.1929614077303;4037.0916543778003;3866.8646597368956;4072.6334629883454;4078.2455245779624;4079.4696689430184;4091.263572556909;4532.9546704533195;4566.862994110182;4633.119707255611;4650.4186976627925;4656.580907718321;5528.364238112588;5575.944240557543;5579.721013949286;5588.161775733591;5604.663720176803;1389.5206153876895;1397.5457976157788;1408.830940287172;1409.3305679802013;1410.6473381654587;936.6347124621403;942.8491441369348;953.7758626722715;954.6944977607238;968.1238479176357;4907.435644900811;4920.753962301942;4929.482404347492;4958.355413796256;4967.329410529533;5674.2339784129435;5824.970875145597;5845.978641998748;5867.442592953748;5886.175935369051;4866.124097662384;4916.72957987307;4929.605631549467;4929.975350123226;4931.901361972812;3063.142320150317;3082.922926926845;3090.258337998864;3090.3201295714907;3107.440660681054;5205.817796377184;5361.490658387447;5370.91943620846;5382.78468861249;5403.162509810985;5887.970560147171;5898.292204935436;5913.379095194942;5919.200907877467;5928.79249226275;5283.973580132075;5345.86635334112;5353.2773075634295;5354.9196762048605;5360.946390536044;5614.185943038318;5741.741621626953;5759.39526349744;5783.768649253982;5791.739371728367;5412.621116521806;5583.8883222336135;5701.144828275792;5705.144228365778;5707.885842283048;5168.9483105168465;5329.307190065422;5383.865403364947;5392.164214546751;5397.433269506645;4028.597140285948;4043.4945631796027;4047.6761859050616;4052.756834589934;4052.8986775330854;5545.417731138173;5777.9133313001175;5864.32560255559;5878.529717622494;5880.8235752927485;5619.9719001406365;5621.381648018796;5639.4642508963225;5654.886902262014;5656.886862262814;5536.169574563848;5621.887562248814;5640.943590564042;5654.236678048575;5658.321001479684;5503.532199763065;5504.972475137599;5509.696966666872;5516.420775818642;5533.446655334435;5655.1517272409465;5663.915041274467;5666.4333566644655;5670.461306175906;5680.77276908919;5363.731813409392;5477.698726569917;5477.863053423696;5507.862303442446;5513.448655134454 09:42:23 INFO - PID 12467 | |5;yui.html;713.8001359619302;734.5152199548296;760.8364201696634;768.6848392159214;784.3529088501987;12942.288174150419;13421.261830599313;13449.798253026212;13469.528566500174;13503.527376541822;13382.130161539517;14947.103173809552;15149.318280677368;15329.923350383233;15352.385904563804;885.7298523950209;893.6604090445621;899.415380003;901.0493928905003;903.661127077346;910.8952470465915;915.3775432705758;916.665417122752;916.6974898283551;916.8899732032132;951.8191543606728;961.3847137831793;963.5375019990408;964.8311545479513;965.5075911285224;892.4243862708581;907.1925985872579;922.3589605224372;964.9758756031085;967.3228739882076;672.8385187555001;677.1467950382554;679.5548915460381;680.0173748932795;680.2415306932784;13719;13734.107283026571;13795;13818.170909745448;13823.654408639764;15350.232488375537;15855.682886342323;16133.757993630104;16152.111633860133;16168.919155404148;11809.114316426303;12009.63971080869;12015.579454719043;12022.69943251417;12059.155859089868;2924.7660187184974;2957.852107394643;3010.864511097006;3077.492213784723;3117.1272043827767;65887.67056164736;66177;67273.3272667272;69373;71891.64054179695;12491.312977786127;12597.11820172579;12698.873011269769;12758.489660413665;12795.680107997374;22059.558808824055;22417.32748017562;22560.210392636178;22882.31353059411;22889.198878039522;5949.077892926603;5976.850578735566;5986.3714309997695;5996.1005849122985;5998.400159984054;2961;3020.093971808493;3023.89416370426;3029.3941211757738;3030.818150910952;3716.349638813197;3720.6651401373465;3803.6386543278345;3814.237152569497;3815.4849095372324;702.034702284359;712.868119397913;715.6493318274113;717.1931576975902;717.4726575966661;589.8908701890164;599.9700014999232;601.6239850093691;603.4659326495995;615.689077016104;9353.766155846159;10295.330803497749;10337.689869303933;10569.682909512727;10832.72918177036;538.4104405675779;542.1921337207532;574.8850229954026;583.2621733507117;583.5244275915201;4395.472543294761;4452.243118669834;4459.6655250855665;4579.977100114478;4584.312353146988;60029;61272;62238;63044.05433918495;64048.35951640517;54542.72728636331;55402;57534.80814898138;57799.422005780245;59643.403565964654;50135.74932125316;50380.244296335586;50601.74699126481;51247.48752512502;53595.732021340424;9052.773680658036;9182.31132665066;9258.444493330422;9313.767155821159;9339.392939458914;25801;25965.74034259633;26170.607440888783;27046.323841904108;27537.724622753514;32415.675843241264;32561.55714842669;45138;45531.54468455406;46227.3065904005;14011.369488372844;14150.716985660023;14224.857751422353;14330.21183834899;14502.1298722077;13959;14645;14769;14882.479113231419;16147.111908845127;13422.463101475832;13749.931250343685;13884.305784710927;13944.860551394762;13971.650708732363;13442.260675662932;13496.730065398833;14452.277386130861;14886.25568721538;15087;13654.317284135952;13895.652608684864;14078.225697586322;14229.715405692035;14441.7833732492;10662.240730279727;10827.891721082688;10882.891171088188;10938.45307734626;11227.609005187667;11254.324740515594;11744.765104697688;11795.587154449553;11937.940310298392;12028.458719357475 09:42:23 INFO - PID 12467 | __end_tp_report 09:42:23 INFO - PID 12467 | __start_cc_report 09:42:23 INFO - PID 12467 | _x_x_mozilla_cycle_collect,1435 09:42:23 INFO - PID 12467 | __end_cc_report 09:42:23 INFO - PID 12467 | __startTimestamp1494607343121__endTimestamp 09:42:23 INFO - PID 12467 | 09:42:23 INFO - PID 12467 | ------- Summary: start ------- 09:42:23 INFO - PID 12467 | Number of tests: 6 09:42:23 INFO - PID 12467 | 09:42:23 INFO - PID 12467 | [#0] dojo.html Cycles:165 Average:5161.95 Median:5294.63 stddev:602.61 (11.4%) stddev-sans-first:573.12 09:42:23 INFO - PID 12467 | Values: 2716.9 2719.8 2758.5 2759.9 2762.6 5033.3 5162.1 5211.8 5266.3 5276.3 5177.1 5189.4 5216.0 5255.2 5257.5 4378.3 4563.0 4642.9 4727.4 4736.3 4686.0 4731.1 4733.3 4742.0 4793.5 4557.8 4607.2 4612.5 4622.3 4658.3 4627.3 4656.0 4691.0 4711.5 4713.9 4593.2 4611.0 4615.5 4638.5 4642.9 5092.9 5187.8 5193.1 5195.1 5250.0 5576.3 5595.0 5609.0 5686.8 5687.6 5613.0 5680.1 5713.3 5735.8 5742.7 5253.3 5260.0 5260.9 5266.8 5307.0 5654.5 5722.7 5816.2 5816.3 5834.3 5428.5 5435.1 5454.0 5522.4 5537.1 5660.7 5663.7 5663.8 5664.4 5696.3 5558.6 5600.3 5615.0 5620.6 5621.4 5404.4 5466.7 5557.2 5602.6 5652.8 4740.2 4787.7 4796.1 4817.5 4831.3 4099.5 4100.2 4100.9 4130.7 4146.6 4702.0 4765.9 4771.6 4832.6 4840.2 5687.5 5688.6 5726.9 5727.8 5751.9 4811.2 4811.5 4812.7 4817.8 4862.3 4936.5 5009.8 5062.3 5063.3 5065.2 5189.1 5269.6 5270.0 5276.4 5277.1 5718.8 5743.6 5763.9 5764.7 5771.3 5183.1 5255.0 5286.8 5294.6 5305.0 5595.8 5602.9 5610.5 5611.0 5612.8 5568.6 5698.0 5707.1 5715.0 5752.3 5416.1 5443.1 5472.6 5533.8 5550.5 5461.0 5497.3 5507.3 5508.6 5516.4 5382.9 5383.2 5393.2 5400.4 5446.6 5402.5 5441.4 5497.6 5520.2 5530.3 5402.1 5403.7 5404.8 5409.5 5423.1 09:42:23 INFO - PID 12467 | 09:42:23 INFO - PID 12467 | [#1] ext.html Cycles:180 Average:29093.94 Median:29786.73 stddev:37271.40 (125.1%) stddev-sans-first:37314.70 09:42:23 INFO - PID 12467 | Values: 638.9 670.7 693.7 947.0 947.0 25145.9 30695.8 33799.2 34040.5 34098.7 35134.6 35363.5 35419.6 35474.1 35496.0 6750.9 6896.4 6896.5 6898.3 6899.9 5056.2 5188.5 6210.0 6841.5 6866.9 6853.1 6897.7 6944.3 6946.0 6955.3 6881.5 6898.4 6940.3 6948.7 6961.8 6841.2 6892.7 6899.2 6901.5 6901.8 30837.2 30972.7 31031.5 31054.0 31055.2 3048.7 3069.8 3089.0 3091.3 3092.2 23842.0 23863.3 23871.0 23904.6 23917.0 2779.2 2783.2 2787.9 2793.3 2794.2 136387.3 136519.0 136975.3 137001.0 137323.0 38994.2 39034.4 39052.2 39089.4 39141.4 41147.8 41165.0 41172.4 41275.4 41284.8 12615.9 12740.3 12751.5 12752.1 12755.3 10352.4 10360.1 10365.0 10368.7 10370.9 10039.3 10255.5 11681.7 11858.6 11902.0 4945.2 4958.7 4964.3 4985.9 5095.4 881.3 894.9 896.7 913.2 924.0 20420.2 20572.8 21151.5 21251.4 21331.3 979.9 981.7 985.6 1005.7 1006.5 10806.8 11130.3 11206.6 11254.3 11326.6 152953.2 153977.2 154333.0 154341.0 154450.0 38660.2 38743.0 38865.2 38888.2 38909.2 1204.4 1248.7 1249.9 1250.6 1255.3 19528.7 19784.9 19977.3 20417.3 20782.9 29279.9 29348.3 29349.3 29471.7 29504.6 142351.0 142354.3 143168.0 143640.3 143865.3 27738.3 28804.4 28883.0 28895.4 28969.4 30083.8 30553.5 33987.7 34895.5 35185.1 26972.9 27438.9 27562.6 27671.4 28665.4 26217.5 26224.0 26920.5 27138.0 27972.3 29103.7 29734.9 29739.4 29834.1 31793.8 34764.0 34894.0 35043.5 35331.6 35437.3 25147.5 27376.0 27423.2 27423.4 27916.2 09:42:23 INFO - PID 12467 | 09:42:23 INFO - PID 12467 | [#2] jquery.html Cycles:180 Average:23367.36 Median:38164.33 stddev:57995.44 (152.0%) stddev-sans-first:58132.50 09:42:23 INFO - PID 12467 | Values: 402.7 411.2 414.5 419.0 428.4 15178.7 16137.8 16650.6 16774.9 16791.4 16749.1 16976.9 17032.3 17044.0 17240.5 5218.3 5237.1 5425.9 5426.8 5427.2 5251.4 5358.5 5388.6 5391.4 5394.0 5142.6 5363.0 5363.6 5371.9 5372.0 5236.2 5339.7 5354.2 5354.3 5360.7 4807.7 4848.0 4850.3 4853.2 4854.3 19163.8 19164.9 19168.5 19458.6 19524.6 1646.4 1681.5 1681.9 1685.7 1687.0 13394.0 13513.5 13807.3 13912.7 13914.9 1985.6 2000.8 2004.1 2009.1 2024.6 74418.6 74886.6 74982.6 75978.0 76186.0 10291.4 10308.3 10362.0 10580.7 10583.3 14539.3 14568.3 14569.3 14572.5 14577.8 6971.7 7303.0 7315.7 7411.1 7442.5 6605.9 6760.2 6880.7 6886.8 6908.5 6481.5 6618.8 6635.8 6637.7 6649.6 1989.5 2000.6 2009.4 2024.8 2025.3 857.7 896.6 902.5 902.6 927.7 16233.4 16454.4 16466.5 16619.3 17190.1 870.4 879.8 880.8 896.1 912.5 8884.1 8981.2 9283.3 9392.6 9451.1 339685.0 347267.0 349059.0 355773.0 356518.0 73767.0 73802.6 74116.0 74365.3 74778.0 1024.6 1033.4 1035.9 1036.1 1038.8 14037.9 14230.9 14289.5 14411.9 14920.4 37807.2 37876.2 38452.4 38974.4 39420.4 45161.5 45461.5 45892.5 46008.5 46354.3 7883.1 7956.6 7968.6 7997.7 8114.4 10903.7 11084.3 11205.3 11378.1 11634.8 10318.1 10426.3 10812.0 11095.4 11594.9 9873.6 10383.7 10467.8 10723.8 10993.8 10838.5 10888.9 10900.2 11281.8 11314.4 8025.3 8136.8 8145.9 8233.4 8269.0 10596.2 10631.5 10696.7 10849.6 10981.9 09:42:23 INFO - PID 12467 | 09:42:23 INFO - PID 12467 | [#3] mootools.html Cycles:180 Average:6318.62 Median:3781.14 stddev:4092.87 (108.2%) stddev-sans-first:4085.29 09:42:23 INFO - PID 12467 | Values: 1062.6 1244.4 1300.8 1314.3 1315.9 8472.3 9927.7 10395.5 10473.8 10478.2 10238.9 10357.3 10370.5 10374.7 10377.0 2228.1 2264.5 2279.6 2280.0 2284.5 1856.1 1924.7 2169.8 2234.2 2259.6 2245.9 2272.6 2275.0 2275.4 2277.0 2189.4 2206.8 2225.3 2226.8 2229.8 2146.9 2158.8 2159.4 2177.0 2184.1 9807.1 9905.4 9907.8 9930.7 9942.4 5493.4 5683.0 5715.8 5719.5 5720.3 3299.0 3389.6 3402.3 3416.6 3481.6 1039.5 1051.4 1084.5 1099.3 1106.2 14943.0 14967.7 14996.8 15001.1 15016.9 4937.7 5143.0 5221.1 5228.1 5273.0 12456.3 12512.4 12525.6 12529.7 12533.8 5668.8 5752.5 5763.1 5767.2 5770.7 4881.3 5033.4 5080.8 5088.2 5145.0 3658.2 3774.2 3776.9 3785.4 3809.2 1295.4 1340.7 1348.0 1348.6 1351.0 693.1 706.0 714.1 714.6 717.2 5124.8 5159.9 5265.2 5328.8 5349.2 831.6 838.7 844.7 849.7 852.0 3185.4 3206.8 3224.1 3234.6 3290.7 12721.9 13295.3 13305.3 13311.1 13322.0 13196.7 13210.2 13236.9 13237.5 13254.3 7111.9 7414.9 7455.2 7472.6 7484.9 5487.7 5541.8 5695.3 5789.7 5849.0 11520.9 11656.5 11738.4 11812.2 12077.3 12009.1 12112.8 12272.5 12292.9 12355.8 9327.5 9617.2 9621.4 9638.9 9639.2 9134.4 9159.5 9247.6 9252.1 9661.7 7940.4 8087.6 8233.5 8251.8 8364.0 8000.6 8097.2 8099.9 8189.1 8338.8 6906.3 6978.3 6994.6 7034.8 7053.4 5323.3 5331.3 5405.8 5477.6 5516.6 5178.5 5207.5 5226.8 5372.5 5412.8 09:42:23 INFO - PID 12467 | 09:42:23 INFO - PID 12467 | [#4] prototype.html Cycles:180 Average:4613.47 Median:5252.93 stddev:1356.37 (25.8%) stddev-sans-first:1322.32 09:42:23 INFO - PID 12467 | Values: 373.9 392.9 395.5 397.1 400.7 5338.2 5378.8 5409.2 5417.7 5420.8 5072.6 5196.7 5237.7 5238.9 5266.9 4024.2 4029.4 4033.6 4047.7 4051.8 4042.3 4044.3 4056.9 4060.7 4065.2 3906.6 3986.3 3992.5 4010.6 4024.2 3982.9 3996.5 3999.8 4002.0 4005.2 3506.0 3509.2 3511.8 3523.6 3536.4 4916.6 5115.7 5140.5 5155.0 5161.0 4680.4 4699.6 4701.7 4711.0 4713.4 5589.9 5593.9 5601.4 5604.2 5604.7 3861.7 3901.9 3929.7 3937.2 3954.0 5631.6 5697.8 5797.2 5888.5 5963.5 4017.6 4027.5 4033.8 4035.2 4037.1 3866.9 4072.6 4078.2 4079.5 4091.3 4533.0 4566.9 4633.1 4650.4 4656.6 5528.4 5575.9 5579.7 5588.2 5604.7 1389.5 1397.5 1408.8 1409.3 1410.6 936.6 942.8 953.8 954.7 968.1 4907.4 4920.8 4929.5 4958.4 4967.3 5674.2 5825.0 5846.0 5867.4 5886.2 4866.1 4916.7 4929.6 4930.0 4931.9 3063.1 3082.9 3090.3 3090.3 3107.4 5205.8 5361.5 5370.9 5382.8 5403.2 5888.0 5898.3 5913.4 5919.2 5928.8 5284.0 5345.9 5353.3 5354.9 5360.9 5614.2 5741.7 5759.4 5783.8 5791.7 5412.6 5583.9 5701.1 5705.1 5707.9 5168.9 5329.3 5383.9 5392.2 5397.4 4028.6 4043.5 4047.7 4052.8 4052.9 5545.4 5777.9 5864.3 5878.5 5880.8 5620.0 5621.4 5639.5 5654.9 5656.9 5536.2 5621.9 5640.9 5654.2 5658.3 5503.5 5505.0 5509.7 5516.4 5533.4 5655.2 5663.9 5666.4 5670.5 5680.8 5363.7 5477.7 5477.9 5507.9 5513.4 09:42:23 INFO - PID 12467 | 09:42:23 INFO - PID 12467 | [#5] yui.html Cycles:180 Average:15309.14 Median:18138.95 stddev:17948.26 (98.9%) stddev-sans-first:17965.14 09:42:23 INFO - PID 12467 | Values: 713.8 734.5 760.8 768.7 784.4 12942.3 13421.3 13449.8 13469.5 13503.5 13382.1 14947.1 15149.3 15329.9 15352.4 885.7 893.7 899.4 901.0 903.7 910.9 915.4 916.7 916.7 916.9 951.8 961.4 963.5 964.8 965.5 892.4 907.2 922.4 965.0 967.3 672.8 677.1 679.6 680.0 680.2 13719.0 13734.1 13795.0 13818.2 13823.7 15350.2 15855.7 16133.8 16152.1 16168.9 11809.1 12009.6 12015.6 12022.7 12059.2 2924.8 2957.9 3010.9 3077.5 3117.1 65887.7 66177.0 67273.3 69373.0 71891.6 12491.3 12597.1 12698.9 12758.5 12795.7 22059.6 22417.3 22560.2 22882.3 22889.2 5949.1 5976.9 5986.4 5996.1 5998.4 2961.0 3020.1 3023.9 3029.4 3030.8 3716.3 3720.7 3803.6 3814.2 3815.5 702.0 712.9 715.6 717.2 717.5 589.9 600.0 601.6 603.5 615.7 9353.8 10295.3 10337.7 10569.7 10832.7 538.4 542.2 574.9 583.3 583.5 4395.5 4452.2 4459.7 4580.0 4584.3 60029.0 61272.0 62238.0 63044.1 64048.4 54542.7 55402.0 57534.8 57799.4 59643.4 50135.7 50380.2 50601.7 51247.5 53595.7 9052.8 9182.3 9258.4 9313.8 9339.4 25801.0 25965.7 26170.6 27046.3 27537.7 32415.7 32561.6 45138.0 45531.5 46227.3 14011.4 14150.7 14224.9 14330.2 14502.1 13959.0 14645.0 14769.0 14882.5 16147.1 13422.5 13749.9 13884.3 13944.9 13971.7 13442.3 13496.7 14452.3 14886.3 15087.0 13654.3 13895.7 14078.2 14229.7 14441.8 10662.2 10827.9 10882.9 10938.5 11227.6 11254.3 11744.8 11795.6 11937.9 12028.5 09:42:23 INFO - PID 12467 | -------- Summary: end -------- 09:42:23 INFO - PID 12467 | 09:42:24 INFO - TEST-INFO | 12467: exit 0 09:42:24 INFO - TEST-OK | dromaeo_css | took 1120822ms 09:42:24 INFO - TEST-START | kraken 09:42:24 INFO - operating with platform_type : linux_ 09:42:24 INFO - Initialising browser for kraken test... 09:42:24 INFO - TEST-INFO | started process 12791 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyPsUsq/profile http://localhost:36084/getInfo.html) 09:42:27 INFO - PID 12791 | __metrics Screen width/height:1600/1200 09:42:27 INFO - PID 12791 | colorDepth:24 09:42:27 INFO - PID 12791 | Browser inner width/height: 1024/695 09:42:27 INFO - PID 12791 | __metrics 09:42:28 INFO - PID 12791 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:42:28 INFO - PID 12791 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:42:29 INFO - TEST-INFO | 12791: exit 0 09:42:29 INFO - Browser initialized. 09:42:29 INFO - Running cycle 1/1 for kraken test... 09:42:29 INFO - TEST-INFO | started process 12893 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyPsUsq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:42:41 INFO - PID 12893 | RSS: Main: 152616960 09:42:41 INFO - PID 12893 | 09:42:44 INFO - PID 12893 | Cycle 1(1): loaded http://localhost:36084/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36084/tests/kraken/driver.html?testName=audio-beat-detection) 09:42:45 INFO - PID 12893 | RSS: Main: 221634560 09:42:45 INFO - PID 12893 | 09:42:48 INFO - PID 12893 | Cycle 1(1): loaded http://localhost:36084/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36084/tests/kraken/driver.html?testName=audio-dft) 09:42:48 INFO - PID 12893 | RSS: Main: 182009856 09:42:48 INFO - PID 12893 | 09:42:51 INFO - PID 12893 | Cycle 1(1): loaded http://localhost:36084/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36084/tests/kraken/driver.html?testName=audio-fft) 09:42:52 INFO - PID 12893 | RSS: Main: 265752576 09:42:52 INFO - PID 12893 | 09:42:54 INFO - PID 12893 | Cycle 1(1): loaded http://localhost:36084/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36084/tests/kraken/driver.html?testName=audio-oscillator) 09:42:55 INFO - PID 12893 | RSS: Main: 176222208 09:42:55 INFO - PID 12893 | 09:42:57 INFO - PID 12893 | Cycle 1(1): loaded http://localhost:36084/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36084/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:42:57 INFO - PID 12893 | RSS: Main: 179052544 09:42:57 INFO - PID 12893 | 09:43:01 INFO - PID 12893 | Cycle 1(1): loaded http://localhost:36084/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36084/tests/kraken/driver.html?testName=imaging-darkroom) 09:43:01 INFO - PID 12893 | RSS: Main: 239636480 09:43:01 INFO - PID 12893 | 09:43:05 INFO - PID 12893 | Cycle 1(1): loaded http://localhost:36084/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36084/tests/kraken/driver.html?testName=imaging-desaturate) 09:43:05 INFO - PID 12893 | RSS: Main: 239058944 09:43:05 INFO - PID 12893 | 09:43:08 INFO - PID 12893 | Cycle 1(1): loaded http://localhost:36084/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36084/tests/kraken/driver.html?testName=json-parse-financial) 09:43:09 INFO - PID 12893 | RSS: Main: 236576768 09:43:09 INFO - PID 12893 | 09:43:10 INFO - PID 12893 | Cycle 1(1): loaded http://localhost:36084/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36084/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:43:11 INFO - PID 12893 | RSS: Main: 201662464 09:43:11 INFO - PID 12893 | 09:43:13 INFO - PID 12893 | Cycle 1(1): loaded http://localhost:36084/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36084/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:43:13 INFO - PID 12893 | RSS: Main: 206274560 09:43:13 INFO - PID 12893 | 09:43:15 INFO - PID 12893 | Cycle 1(1): loaded http://localhost:36084/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36084/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:43:16 INFO - PID 12893 | RSS: Main: 215547904 09:43:16 INFO - PID 12893 | 09:43:19 INFO - PID 12893 | Cycle 1(1): loaded http://localhost:36084/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36084/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:43:20 INFO - PID 12893 | RSS: Main: 225730560 09:43:20 INFO - PID 12893 | 09:43:23 INFO - PID 12893 | Cycle 1(1): loaded http://localhost:36084/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36084/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:43:23 INFO - PID 12893 | RSS: Main: 202989568 09:43:23 INFO - PID 12893 | 09:43:25 INFO - PID 12893 | Cycle 1(1): loaded http://localhost:36084/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36084/tests/kraken/driver.html?testName=ai-astar) 09:43:25 INFO - PID 12893 | RSS: Main: 270249984 09:43:25 INFO - PID 12893 | 09:43:25 INFO - PID 12893 | __start_tp_report 09:43:25 INFO - PID 12893 | _x_x_mozilla_page_load 09:43:25 INFO - PID 12893 | _x_x_mozilla_page_load_details 09:43:25 INFO - PID 12893 | |i|pagename|runs| 09:43:25 INFO - PID 12893 | |0;ai-astar;108;112;111;114;112;110;111;111;111;112 09:43:25 INFO - PID 12893 | |1;audio-beat-detection;148;123;122;184;121;122;123;122;144;124 09:43:25 INFO - PID 12893 | |2;audio-dft;162;162;161;163;162;162;162;161;164;162 09:43:25 INFO - PID 12893 | |3;audio-fft;75;75;75;117;75;77;74;74;102;78 09:43:25 INFO - PID 12893 | |4;audio-oscillator;83;83;115;83;82;82;98;84;83;104 09:43:25 INFO - PID 12893 | |5;imaging-gaussian-blur;114;113;113;113;113;113;113;113;114;113 09:43:25 INFO - PID 12893 | |6;imaging-darkroom;149;149;148;148;149;149;148;149;149;149 09:43:25 INFO - PID 12893 | |7;imaging-desaturate;93;93;93;93;93;94;94;94;95;93 09:43:25 INFO - PID 12893 | |8;json-parse-financial;53;53;52;53;55;54;54;53;54;55 09:43:25 INFO - PID 12893 | |9;json-stringify-tinderbox;55;56;55;55;55;55;55;56;57;56 09:43:25 INFO - PID 12893 | |10;stanford-crypto-aes;82;82;81;82;81;82;81;82;82;81 09:43:25 INFO - PID 12893 | |11;stanford-crypto-ccm;141;137;130;140;129;134;134;128;179;128 09:43:25 INFO - PID 12893 | |12;stanford-crypto-pbkdf2;181;191;189;189;190;188;193;190;196;187 09:43:25 INFO - PID 12893 | |13;stanford-crypto-sha256-iterative;74;72;71;72;74;71;72;74;71;71 09:43:25 INFO - PID 12893 | __end_tp_report 09:43:25 INFO - PID 12893 | __start_cc_report 09:43:25 INFO - PID 12893 | _x_x_mozilla_cycle_collect,2067 09:43:25 INFO - PID 12893 | __end_cc_report 09:43:25 INFO - PID 12893 | __startTimestamp1494607405939__endTimestamp 09:43:25 INFO - PID 12893 | 09:43:25 INFO - PID 12893 | ------- Summary: start ------- 09:43:25 INFO - PID 12893 | Number of tests: 14 09:43:25 INFO - PID 12893 | 09:43:25 INFO - PID 12893 | [#0] ai-astar Cycles:10 Average:111.20 Median:111.50 stddev:1.55 (1.4%) stddev-sans-first:1.13 09:43:25 INFO - PID 12893 | Values: 108.0 112.0 111.0 114.0 112.0 110.0 111.0 111.0 111.0 112.0 09:43:25 INFO - PID 12893 | 09:43:25 INFO - PID 12893 | [#1] audio-beat-detection Cycles:10 Average:133.30 Median:123.50 stddev:20.37 (16.5%) stddev-sans-first:20.90 09:43:25 INFO - PID 12893 | Values: 148.0 123.0 122.0 184.0 121.0 122.0 123.0 122.0 144.0 124.0 09:43:25 INFO - PID 12893 | 09:43:25 INFO - PID 12893 | [#2] audio-dft Cycles:10 Average:162.10 Median:162.00 stddev:0.88 (0.5%) stddev-sans-first:0.93 09:43:25 INFO - PID 12893 | Values: 162.0 162.0 161.0 163.0 162.0 162.0 162.0 161.0 164.0 162.0 09:43:25 INFO - PID 12893 | 09:43:25 INFO - PID 12893 | [#3] audio-fft Cycles:10 Average:82.20 Median:75.00 stddev:14.87 (19.8%) stddev-sans-first:15.54 09:43:25 INFO - PID 12893 | Values: 75.0 75.0 75.0 117.0 75.0 77.0 74.0 74.0 102.0 78.0 09:43:25 INFO - PID 12893 | 09:43:25 INFO - PID 12893 | [#4] audio-oscillator Cycles:10 Average:89.70 Median:83.00 stddev:11.76 (14.2%) stddev-sans-first:12.22 09:43:25 INFO - PID 12893 | Values: 83.0 83.0 115.0 83.0 82.0 82.0 98.0 84.0 83.0 104.0 09:43:25 INFO - PID 12893 | 09:43:25 INFO - PID 12893 | [#5] imaging-gaussian-blur Cycles:10 Average:113.20 Median:113.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 09:43:25 INFO - PID 12893 | Values: 114.0 113.0 113.0 113.0 113.0 113.0 113.0 113.0 114.0 113.0 09:43:25 INFO - PID 12893 | 09:43:25 INFO - PID 12893 | [#6] imaging-darkroom Cycles:10 Average:148.70 Median:149.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 09:43:25 INFO - PID 12893 | Values: 149.0 149.0 148.0 148.0 149.0 149.0 148.0 149.0 149.0 149.0 09:43:25 INFO - PID 12893 | 09:43:25 INFO - PID 12893 | [#7] imaging-desaturate Cycles:10 Average:93.50 Median:93.50 stddev:0.71 (0.8%) stddev-sans-first:0.73 09:43:25 INFO - PID 12893 | Values: 93.0 93.0 93.0 93.0 93.0 94.0 94.0 94.0 95.0 93.0 09:43:25 INFO - PID 12893 | 09:43:25 INFO - PID 12893 | [#8] json-parse-financial Cycles:10 Average:53.60 Median:54.00 stddev:0.97 (1.8%) stddev-sans-first:1.00 09:43:25 INFO - PID 12893 | Values: 53.0 53.0 52.0 53.0 55.0 54.0 54.0 53.0 54.0 55.0 09:43:25 INFO - PID 12893 | 09:43:25 INFO - PID 12893 | [#9] json-stringify-tinderbox Cycles:10 Average:55.50 Median:55.50 stddev:0.71 (1.3%) stddev-sans-first:0.73 09:43:25 INFO - PID 12893 | Values: 55.0 56.0 55.0 55.0 55.0 55.0 55.0 56.0 57.0 56.0 09:43:25 INFO - PID 12893 | 09:43:25 INFO - PID 12893 | [#10] stanford-crypto-aes Cycles:10 Average:81.60 Median:82.00 stddev:0.52 (0.6%) stddev-sans-first:0.53 09:43:25 INFO - PID 12893 | Values: 82.0 82.0 81.0 82.0 81.0 82.0 81.0 82.0 82.0 81.0 09:43:25 INFO - PID 12893 | 09:43:25 INFO - PID 12893 | [#11] stanford-crypto-ccm Cycles:10 Average:138.00 Median:135.50 stddev:15.17 (11.2%) stddev-sans-first:16.05 09:43:25 INFO - PID 12893 | Values: 141.0 137.0 130.0 140.0 129.0 134.0 134.0 128.0 179.0 128.0 09:43:25 INFO - PID 12893 | 09:43:25 INFO - PID 12893 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:189.40 Median:190.00 stddev:3.92 (2.1%) stddev-sans-first:2.74 09:43:25 INFO - PID 12893 | Values: 181.0 191.0 189.0 189.0 190.0 188.0 193.0 190.0 196.0 187.0 09:43:25 INFO - PID 12893 | 09:43:25 INFO - PID 12893 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.20 Median:72.00 stddev:1.32 (1.8%) stddev-sans-first:1.22 09:43:25 INFO - PID 12893 | Values: 74.0 72.0 71.0 72.0 74.0 71.0 72.0 74.0 71.0 71.0 09:43:25 INFO - PID 12893 | -------- Summary: end -------- 09:43:25 INFO - PID 12893 | 09:43:27 INFO - TEST-INFO | 12893: exit 0 09:43:27 INFO - TEST-OK | kraken | took 63156ms 09:43:27 INFO - SUITE-END | took 1183s 09:43:27 INFO - Completed test suite (00:19:44) 09:43:27 INFO - javascript benchmark 09:43:27 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6621.999172485712, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2716.9320766980823, 2719.796015298853, 2758.4620998905207, 2759.944801103978, 2762.599423083652, 5033.345665063546, 5162.096633089213, 5211.791528338867, 5266.315379000729, 5276.34045744282, 5177.068127737006, 5189.42916279209, 5216.008958297921, 5255.237990491377, 5257.474252574741, 4378.343248512717, 4563.041761230129, 4642.907141857161, 4727.432708075035, 4736.3369128322065, 4685.999999999983, 4731.148393289207, 4733.290006499035, 4741.9525804742025, 4793.520647935196, 4557.772111394417, 4607.17070927233, 4612.538746125394, 4622.329762184498, 4658.301254811805, 4627.305904114376, 4656.022235330584, 4691.0, 4711.481737008926, 4713.929291060636, 4593.242115051013, 4611.0, 4615.492295847454, 4638.466576343696, 4642.883927901796, 5092.949070509285, 5187.8184263550975, 5193.143131383317, 5195.090859099642, 5249.973750131263, 5576.302962129734, 5595.0, 5609.0, 5686.829395118153, 5687.573431992576, 5612.989661860864, 5680.0627896397455, 5713.257276554063, 5735.827925162252, 5742.6841523716175, 5253.264542963988, 5260.00059988601, 5260.868478288074, 5266.789328426897, 5307.01820163271, 5654.547636189095, 5722.7424765885635, 5816.214811000461, 5816.272965879265, 5834.299884013861, 5428.538574221236, 5435.1303791393975, 5453.972730136324, 5522.392536820947, 5537.086380747131, 5660.688662123623, 5663.66018038919, 5663.830085097454, 5664.376918538957, 5696.3164420269, 5558.555315574744, 5600.299962504687, 5614.9719251403485, 5620.606557540933, 5621.409751976065, 5404.351477822686, 5466.699331536804, 5557.221988921554, 5602.579806514527, 5652.773889044474, 4740.170470167707, 4787.664863459524, 4796.088743138793, 4817.470078291385, 4831.347768051339, 4099.549049604541, 4100.159467309194, 4100.938485922714, 4130.669546436278, 4146.647534959502, 4702.0, 4765.904681906342, 4771.594414474808, 4832.565069143794, 4840.201366774443, 5687.51656109227, 5688.601797874192, 5726.885462290731, 5727.799527016535, 5751.913721294184, 4811.230203167476, 4811.4707382187935, 4812.735299558558, 4817.78319975602, 4862.31927530139, 4936.506349365107, 5009.774560144875, 5062.265971434122, 5063.316452278968, 5065.189569668835, 5189.117849965591, 5269.578433725216, 5270.025045366619, 5276.419593844751, 5277.129273669955, 5718.79984200551, 5743.56923230751, 5763.942360576509, 5764.654120752768, 5771.307443106686, 5183.0670479314085, 5254.97372513135, 5286.841394758163, 5294.629375943647, 5305.018571564273, 5595.804146854841, 5602.85992850182, 5610.4670056344585, 5611.046122159161, 5612.7754889803955, 5568.610197286313, 5697.971510142423, 5707.086866101404, 5715.028445164416, 5752.338481074563, 5416.052190866504, 5443.101888188405, 5472.644278121909, 5533.7786488540005, 5550.52820510245, 5460.972695136499, 5497.340319161726, 5507.256520369859, 5508.641938274, 5516.393196748274, 5382.892342153056, 5383.192521121863, 5393.164059570773, 5400.351957764936, 5446.645968012067, 5402.459754024566, 5441.401445840876, 5497.615166938276, 5520.171974203901, 5530.308711411074, 5402.108652072521, 5403.675779453245, 5404.8108316208745, 5409.459054094559, 5423.132298832168], "value": 5118.667688760179, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [638.9456896163825, 670.6981858163826, 693.7190437872662, 946.9715908522746, 947.0198344713223, 25145.874270628643, 30695.846520767394, 33799.155021124454, 34040.48939265907, 34098.65901340986, 35134.64865351345, 35363.46954795674, 35419.64580354196, 35474.11314717133, 35496.0, 6750.864982700331, 6896.448284137282, 6896.482763792736, 6898.275681053467, 6899.931000689979, 5056.19100943849, 5188.455212202721, 6210.0, 6841.486888483359, 6866.862662746742, 6853.109095817562, 6897.689603967833, 6944.270851560564, 6946.0, 6955.304469553055, 6881.483888708367, 6898.448124150081, 6940.340667636567, 6948.6525673716615, 6961.825954351131, 6841.2132604750595, 6892.689828957709, 6899.206591242021, 6901.516893817435, 6901.75843845463, 30837.229069273224, 30972.690273097433, 31031.534526982112, 31054.0, 31055.223619409695, 3048.7103725146076, 3069.785115041948, 3088.9536656950163, 3091.2580980564726, 3092.196029032445, 23842.0, 23863.30118831584, 23871.04515819365, 23904.641430378557, 23917.0, 2779.194033730216, 2783.1650504848667, 2787.888484460619, 2793.329600895791, 2794.2176190666646, 136387.31806341003, 136519.0, 136975.31512342376, 137001.0, 137323.0, 38994.22011559753, 39034.41448378276, 39052.21895562073, 39089.41365879514, 39141.41287880684, 41147.7942610291, 41165.0, 41172.38241426381, 41275.380869286986, 41284.79357603253, 12615.873841261653, 12740.299283539494, 12751.48994040228, 12752.107352485236, 12755.298458584866, 10352.378857268588, 10360.119389851796, 10365.0, 10368.688939331832, 10370.896291036994, 10039.34744241622, 10255.487225638688, 11681.707957301136, 11858.644240672622, 11902.0, 4945.159322915113, 4958.727270000112, 4964.280179373971, 4985.850424487271, 5095.414027386824, 881.3037700216757, 894.9284057275403, 896.6861598440494, 913.196387179278, 924.0436148586181, 20420.183192672423, 20572.79427205739, 21151.471213219793, 21251.362459126252, 21331.253406130712, 979.8775153105862, 981.6809536900536, 985.5959056786683, 1005.6681295172575, 1006.5168719014914, 10806.783864322826, 11130.276532025393, 11206.607768728056, 11254.324740515594, 11326.603568875049, 152953.23523382313, 153977.23011384872, 154333.0, 154341.0, 154450.0, 38660.22679546449, 38743.0, 38865.222695545934, 38888.22223555513, 38909.221815564095, 1204.391782150026, 1248.6628610275175, 1249.8500179978462, 1250.606059091365, 1255.334672623511, 19528.707069393688, 19784.90107549453, 19977.30192933617, 20417.285395011102, 20782.896085520082, 29279.85360073186, 29348.266293342836, 29349.26626834346, 29471.705282946896, 29504.557431638113, 142351.0, 142354.2882285582, 143168.0, 143640.28179859032, 143865.28067359596, 27738.306542336602, 28804.42391152207, 28883.0, 28895.42209155847, 28969.420611588073, 30083.84958075283, 30553.54169687412, 33987.66012339944, 34895.47656785201, 35185.1203719909, 26972.865135674198, 27438.862805685843, 27562.5865612012, 27671.446571068867, 28665.42669146647, 26217.475650487264, 26224.0, 26920.461590768467, 27138.0, 27972.300692482037, 29103.7089629101, 29734.85132574323, 29739.364334961785, 29834.10497684986, 31793.841030794698, 34764.0, 34894.0, 35043.474347884294, 35331.64668353284, 35437.291254174255, 25147.49705005926, 27376.041838535555, 27423.177304680892, 27423.394777496105, 27916.231308773054], "value": 14222.951891294044, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [402.6818813137621, 411.2145801519099, 414.49845686719067, 418.9518205406379, 428.36387963873653, 15178.6964260715, 16137.75793363099, 16650.58373540662, 16774.91612541937, 16791.40481654244, 16749.078800665957, 16976.915115424406, 17032.318707251696, 17044.0, 17240.482785516422, 5218.347706536673, 5237.13587258102, 5425.945740542603, 5426.810061647843, 5427.158790387496, 5251.396089449705, 5358.4641535846295, 5388.622796404254, 5391.406945236021, 5394.02907476654, 5142.640015198937, 5362.973185134068, 5363.6245462817615, 5371.946280537184, 5372.0, 5236.162214045753, 5339.679619222859, 5354.223637572531, 5354.330708661418, 5360.731963401834, 4807.711537307738, 4848.0, 4850.2724591311235, 4853.199222128344, 4854.2718592211095, 19163.80836191634, 19164.904175479172, 19168.520786980298, 19458.61082778351, 19524.609507809906, 1646.415522489511, 1681.5459825846954, 1681.932722691091, 1685.7218558937761, 1687.0468185475168, 13394.0, 13513.527026554122, 13807.309634518233, 13912.652183695387, 13914.93042534791, 1985.553250518636, 2000.779914209436, 2004.1482369992696, 2009.136071489259, 2024.6153230886084, 74418.62790686067, 74886.62556687236, 74982.62508687476, 75978.0, 76186.0, 10291.43397113151, 10308.278420510642, 10362.0, 10580.682579522627, 10583.259171857895, 14539.3457294422, 14568.27158642085, 14569.344379502947, 14572.489962851248, 14577.781333280009, 6971.651417429108, 7303.0, 7315.670794814246, 7411.110666720028, 7442.479026468203, 6605.867882642417, 6760.18877734675, 6880.69036893341, 6886.793396198122, 6908.516403851682, 6481.48148148147, 6618.815790789028, 6635.8009259722285, 6637.701303441357, 6649.60102393858, 1989.4727897107277, 2000.5698774763205, 2009.417268991976, 2024.7772744998038, 2025.2911480981538, 857.6783706110209, 896.5606852642288, 902.4720538484928, 902.5622573052065, 927.7309580221795, 16233.431829886133, 16454.43682850127, 16466.506004819876, 16619.252133654016, 17190.1404929753, 870.3776799588325, 879.7844528090659, 880.8282384934876, 896.1038961038961, 912.5209265135857, 8884.111588841064, 8981.191692747683, 9283.303752218611, 9392.624295028123, 9451.125038734086, 339685.0, 347267.0, 349059.0, 355773.0, 356518.0, 73767.0, 73802.63098684473, 74116.0, 74365.25634743691, 74778.0, 1024.5901639344172, 1033.379972016784, 1035.896410358973, 1036.0520124086527, 1038.781855810273, 14037.929810350883, 14230.857691423367, 14289.499867504588, 14411.92794036023, 14920.403183872957, 37807.24385512329, 37876.242475150895, 38452.42321365238, 38974.4153837687, 39420.40869387019, 45161.548384515736, 45461.457800131044, 45892.54107459016, 46008.53991460043, 46354.30468543042, 7883.132855385788, 7956.562389068657, 7968.641411136628, 7997.680092796223, 8114.350851931713, 10903.727406814576, 11084.279521831055, 11205.271657342573, 11378.08975281992, 11634.825477618011, 10318.122959548522, 10426.322289051188, 10812.0, 11095.389753563632, 11594.88405115938, 9873.605055797687, 10383.688489345332, 10467.842982355118, 10723.839142412715, 10993.780124397626, 10838.512266947848, 10888.945555272174, 10900.236983411402, 11281.830772538582, 11314.377709225742, 8025.317847982987, 8136.83726325482, 8145.877811832946, 8233.423660343959, 8269.0, 10596.152307815202, 10631.521581528696, 10696.732581685521, 10849.566017359217, 10981.945090274497], "value": 8466.392559177515, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1062.596213438893, 1244.3902487780986, 1300.8048792681097, 1314.336260188604, 1315.8815706586406, 8472.322214222862, 9927.702168934935, 10395.532201050952, 10473.84289235662, 10478.161747060236, 10238.897611023887, 10357.274990750651, 10370.53332600033, 10374.688759337214, 10377.0, 2228.064213030527, 2264.467850055236, 2279.555486680098, 2280.0309868305985, 2284.5430913817304, 1856.10906764753, 1924.6631839428114, 2169.7938695823873, 2234.1733558583346, 2259.559385919746, 2245.8989345479495, 2272.5909336319455, 2274.9658755118685, 2275.442516583431, 2277.0095008671283, 2189.35414052854, 2206.8455208135438, 2225.2545397291765, 2226.832987525942, 2229.7770222977733, 2146.8711877287415, 2158.784121587829, 2159.362987918552, 2177.0203408466095, 2184.071769497973, 9807.06832850878, 9905.405675659411, 9907.752306192402, 9930.652427165014, 9942.353747006493, 5493.423190564973, 5682.971585142089, 5715.771369145229, 5719.485246327808, 5720.256366672306, 3298.983505082459, 3389.57630296213, 3402.2515046689687, 3416.5558477398026, 3481.617022127564, 1039.5322105052755, 1051.3691784929058, 1084.5173897615564, 1099.2799716185912, 1106.2201148190507, 14943.0, 14967.700645987128, 14996.775048374284, 15001.099934003994, 15016.924915375463, 4937.703737775673, 5143.045642655841, 5221.060209162311, 5228.085085110167, 5272.9736351318, 12456.314902680258, 12512.436940337706, 12525.624231273076, 12529.74940501185, 12533.811992820116, 5668.829935101953, 5752.539796816244, 5763.135529670583, 5767.192593036978, 5770.682612456355, 4881.292212629149, 5033.395992480926, 5080.796768129233, 5088.160453525201, 5144.974275128675, 3658.213484100931, 3774.2074164425776, 3776.905577360533, 3785.375413056815, 3809.2191100824266, 1295.3587973952954, 1340.7117469744053, 1347.9865201347861, 1348.629126990066, 1351.040761059639, 693.0989713372595, 705.989410158848, 714.0717067811823, 714.6248219684603, 717.2361435071632, 5124.769385377667, 5159.896802064013, 5265.21021846726, 5328.760205790749, 5349.170878513836, 831.5883637599427, 838.7483754873635, 844.6705784743955, 849.7493239494364, 852.0074113657644, 3185.4266232077985, 3206.8075915445147, 3224.0650211438888, 3234.5956755405573, 3290.6544812794314, 12721.93639031799, 13295.268760218281, 13305.334733263491, 13311.134776239513, 13322.0, 13196.670083247996, 13210.207387556586, 13236.933815330862, 13237.536686215935, 13254.337283135805, 7111.893321600181, 7414.851702966019, 7455.217202193691, 7472.626368681545, 7484.887726684104, 5487.670739755627, 5541.833744987657, 5695.345035320991, 5789.681567513659, 5849.005669036189, 11520.88479115198, 11656.475458604213, 11738.41307934617, 11812.173147879566, 12077.27536347822, 12009.099317551043, 12112.75774484523, 12272.509099636272, 12292.938535307623, 12355.75288494243, 9327.486988215713, 9617.182539484222, 9621.374610650286, 9638.855417168888, 9639.180669642878, 9134.360594758304, 9159.496227707274, 9247.630094796403, 9252.074792520694, 9661.710148695269, 7940.404469664913, 8087.595620219083, 8233.50598964064, 8251.83496330082, 8363.95818020906, 8000.5599692017495, 8097.190280972091, 8099.878501822595, 8189.140140285423, 8338.791530211793, 6906.343897329745, 6978.302169782981, 6994.5803251805055, 7034.824129396601, 7053.365197132282, 5323.2547443358735, 5331.280277162534, 5405.837824865261, 5477.643953143033, 5516.61383703153, 5178.482151784791, 5207.505286997729, 5226.790928362823, 5372.4627537247525, 5412.810551630674], "value": 4756.713554322918, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [373.86914579897024, 392.9017745563609, 395.503642928125, 397.05698964958214, 400.7275052963985, 5338.225957236204, 5378.811741589036, 5409.242706021155, 5417.7291135443265, 5420.810271640494, 5072.644914855961, 5196.740162991854, 5237.685738855671, 5238.92141617876, 5266.947330526694, 4024.1750441159493, 4029.435878976946, 4033.636972672459, 4047.736897101679, 4051.7771522566245, 4042.3128068228325, 4044.2720310344125, 4056.9188616227657, 4060.695447841409, 4065.166640838636, 3906.5507466641275, 3986.309241262151, 3992.4610177626087, 4010.598940105995, 4024.1951609678035, 3982.8605998789903, 3996.540397854226, 3999.840006399726, 4002.0395105174694, 4005.1989602079702, 3506.0, 3509.2455122148604, 3511.806850623215, 3523.594786599548, 3536.3634545781747, 4916.615441510864, 5115.7442127893455, 5140.460251673595, 5155.0, 5161.0, 4680.391549098629, 4699.553542413465, 4701.694389864648, 4710.976445117787, 4713.407625805793, 5589.882023595256, 5593.888122237573, 5601.383847776741, 5604.1593760935775, 5604.663720176803, 3861.710371722104, 3901.9269700832215, 3929.685625149981, 3937.1928754605237, 3953.960460395388, 5631.60578759487, 5697.800576979786, 5797.217375654275, 5888.470037696585, 5963.463288304073, 4017.598240175959, 4027.496562929634, 4033.8184781684895, 4035.1929614077303, 4037.0916543778003, 3866.8646597368956, 4072.6334629883454, 4078.2455245779624, 4079.4696689430184, 4091.263572556909, 4532.9546704533195, 4566.862994110182, 4633.119707255611, 4650.4186976627925, 4656.580907718321, 5528.364238112588, 5575.944240557543, 5579.721013949286, 5588.161775733591, 5604.663720176803, 1389.5206153876895, 1397.5457976157788, 1408.830940287172, 1409.3305679802013, 1410.6473381654587, 936.6347124621403, 942.8491441369348, 953.7758626722715, 954.6944977607238, 968.1238479176357, 4907.435644900811, 4920.753962301942, 4929.482404347492, 4958.355413796256, 4967.329410529533, 5674.2339784129435, 5824.970875145597, 5845.978641998748, 5867.442592953748, 5886.175935369051, 4866.124097662384, 4916.72957987307, 4929.605631549467, 4929.975350123226, 4931.901361972812, 3063.142320150317, 3082.922926926845, 3090.258337998864, 3090.3201295714907, 3107.440660681054, 5205.817796377184, 5361.490658387447, 5370.91943620846, 5382.78468861249, 5403.162509810985, 5887.970560147171, 5898.292204935436, 5913.379095194942, 5919.200907877467, 5928.79249226275, 5283.973580132075, 5345.86635334112, 5353.2773075634295, 5354.9196762048605, 5360.946390536044, 5614.185943038318, 5741.741621626953, 5759.39526349744, 5783.768649253982, 5791.739371728367, 5412.621116521806, 5583.8883222336135, 5701.144828275792, 5705.144228365778, 5707.885842283048, 5168.9483105168465, 5329.307190065422, 5383.865403364947, 5392.164214546751, 5397.433269506645, 4028.597140285948, 4043.4945631796027, 4047.6761859050616, 4052.756834589934, 4052.8986775330854, 5545.417731138173, 5777.9133313001175, 5864.32560255559, 5878.529717622494, 5880.8235752927485, 5619.9719001406365, 5621.381648018796, 5639.4642508963225, 5654.886902262014, 5656.886862262814, 5536.169574563848, 5621.887562248814, 5640.943590564042, 5654.236678048575, 5658.321001479684, 5503.532199763065, 5504.972475137599, 5509.696966666872, 5516.420775818642, 5533.446655334435, 5655.1517272409465, 5663.915041274467, 5666.4333566644655, 5670.461306175906, 5680.77276908919, 5363.731813409392, 5477.698726569917, 5477.863053423696, 5507.862303442446, 5513.448655134454], "value": 4200.961355584003, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [713.8001359619302, 734.5152199548296, 760.8364201696634, 768.6848392159214, 784.3529088501987, 12942.288174150419, 13421.261830599313, 13449.798253026212, 13469.528566500174, 13503.527376541822, 13382.130161539517, 14947.103173809552, 15149.318280677368, 15329.923350383233, 15352.385904563804, 885.7298523950209, 893.6604090445621, 899.415380003, 901.0493928905003, 903.661127077346, 910.8952470465915, 915.3775432705758, 916.665417122752, 916.6974898283551, 916.8899732032132, 951.8191543606728, 961.3847137831793, 963.5375019990408, 964.8311545479513, 965.5075911285224, 892.4243862708581, 907.1925985872579, 922.3589605224372, 964.9758756031085, 967.3228739882076, 672.8385187555001, 677.1467950382554, 679.5548915460381, 680.0173748932795, 680.2415306932784, 13719.0, 13734.107283026571, 13795.0, 13818.170909745448, 13823.654408639764, 15350.232488375537, 15855.682886342323, 16133.757993630104, 16152.111633860133, 16168.919155404148, 11809.114316426303, 12009.63971080869, 12015.579454719043, 12022.69943251417, 12059.155859089868, 2924.7660187184974, 2957.852107394643, 3010.864511097006, 3077.492213784723, 3117.1272043827767, 65887.67056164736, 66177.0, 67273.3272667272, 69373.0, 71891.64054179695, 12491.312977786127, 12597.11820172579, 12698.873011269769, 12758.489660413665, 12795.680107997374, 22059.558808824055, 22417.32748017562, 22560.210392636178, 22882.31353059411, 22889.198878039522, 5949.077892926603, 5976.850578735566, 5986.3714309997695, 5996.1005849122985, 5998.400159984054, 2961.0, 3020.093971808493, 3023.89416370426, 3029.3941211757738, 3030.818150910952, 3716.349638813197, 3720.6651401373465, 3803.6386543278345, 3814.237152569497, 3815.4849095372324, 702.034702284359, 712.868119397913, 715.6493318274113, 717.1931576975902, 717.4726575966661, 589.8908701890164, 599.9700014999232, 601.6239850093691, 603.4659326495995, 615.689077016104, 9353.766155846159, 10295.330803497749, 10337.689869303933, 10569.682909512727, 10832.72918177036, 538.4104405675779, 542.1921337207532, 574.8850229954026, 583.2621733507117, 583.5244275915201, 4395.472543294761, 4452.243118669834, 4459.6655250855665, 4579.977100114478, 4584.312353146988, 60029.0, 61272.0, 62238.0, 63044.05433918495, 64048.35951640517, 54542.72728636331, 55402.0, 57534.80814898138, 57799.422005780245, 59643.403565964654, 50135.74932125316, 50380.244296335586, 50601.74699126481, 51247.48752512502, 53595.732021340424, 9052.773680658036, 9182.31132665066, 9258.444493330422, 9313.767155821159, 9339.392939458914, 25801.0, 25965.74034259633, 26170.607440888783, 27046.323841904108, 27537.724622753514, 32415.675843241264, 32561.55714842669, 45138.0, 45531.54468455406, 46227.3065904005, 14011.369488372844, 14150.716985660023, 14224.857751422353, 14330.21183834899, 14502.1298722077, 13959.0, 14645.0, 14769.0, 14882.479113231419, 16147.111908845127, 13422.463101475832, 13749.931250343685, 13884.305784710927, 13944.860551394762, 13971.650708732363, 13442.260675662932, 13496.730065398833, 14452.277386130861, 14886.25568721538, 15087.0, 13654.317284135952, 13895.652608684864, 14078.225697586322, 14229.715405692035, 14441.7833732492, 10662.240730279727, 10827.891721082688, 10882.891171088188, 10938.45307734626, 11227.609005187667, 11254.324740515594, 11744.765104697688, 11795.587154449553, 11937.940310298392, 12028.458719357475], "value": 6845.460672220627, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1524.2, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 112.0, 111.0, 114.0, 112.0, 110.0, 111.0, 111.0, 111.0, 112.0], "value": 111.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 123.0, 122.0, 184.0, 121.0, 122.0, 123.0, 122.0, 144.0, 124.0], "value": 133.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 161.0, 163.0, 162.0, 162.0, 162.0, 161.0, 164.0, 162.0], "value": 162.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 117.0, 75.0, 77.0, 74.0, 74.0, 102.0, 78.0], "value": 82.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 115.0, 83.0, 82.0, 82.0, 98.0, 84.0, 83.0, 104.0], "value": 89.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 113.0, 113.0, 113.0, 113.0, 113.0, 113.0, 113.0, 114.0, 113.0], "value": 113.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 149.0, 148.0, 148.0, 149.0, 149.0, 148.0, 149.0, 149.0, 149.0], "value": 148.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 93.0, 93.0, 93.0, 94.0, 94.0, 94.0, 95.0, 93.0], "value": 93.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 53.0, 52.0, 53.0, 55.0, 54.0, 54.0, 53.0, 54.0, 55.0], "value": 53.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 56.0, 55.0, 55.0, 55.0, 55.0, 55.0, 56.0, 57.0, 56.0], "value": 55.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 81.0, 82.0, 81.0, 82.0, 81.0, 82.0, 82.0, 81.0], "value": 81.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 137.0, 130.0, 140.0, 129.0, 134.0, 134.0, 128.0, 179.0, 128.0], "value": 138.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [181.0, 191.0, 189.0, 189.0, 190.0, 188.0, 193.0, 190.0, 196.0, 187.0], "value": 189.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 72.0, 71.0, 72.0, 74.0, 71.0, 72.0, 74.0, 71.0, 71.0], "value": 72.2, "unit": "score"}]}]} 09:43:27 INFO - Return code: 0 09:43:27 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:43:27 INFO - # TBPL SUCCESS # 09:43:27 INFO - Running post-action listener: _resource_record_post_action 09:43:27 INFO - [mozharness: 2017-05-12 16:43:27.752184Z] Finished run-tests step (success) 09:43:27 INFO - Running post-run listener: _resource_record_post_run 09:43:27 INFO - Total resource usage - Wall time: 1201s; CPU: 13.0%; Read bytes: 24576; Write bytes: 364621824; Read time: 272; Write time: 273388 09:43:27 INFO - TinderboxPrint: CPU usage
12.9% 09:43:27 INFO - TinderboxPrint: I/O read bytes / time
24,576 / 272 09:43:27 INFO - TinderboxPrint: I/O write bytes / time
364,621,824 / 273,388 09:43:27 INFO - TinderboxPrint: CPU idle
8,347.5 (87.1%) 09:43:27 INFO - TinderboxPrint: CPU user
1,196.4 (12.5%) 09:43:27 INFO - TinderboxPrint: Swap in / out
0 / 0 09:43:27 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 4096; Write bytes: 111390720; Read time: 44; Write time: 131452 09:43:27 INFO - run-tests - Wall time: 1185s; CPU: 13.0%; Read bytes: 20480; Write bytes: 253231104; Read time: 228; Write time: 141936 09:43:28 INFO - Running post-run listener: _upload_blobber_files 09:43:28 INFO - Blob upload gear active. 09:43:28 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:43:28 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:43:28 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:43:28 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:43:28 INFO - (blobuploader) - INFO - Open directory for files ... 09:43:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:43:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:43:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:43:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:43:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:43:30 INFO - (blobuploader) - INFO - Done attempting. 09:43:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 09:43:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:43:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:43:30 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 09:43:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:43:30 INFO - (blobuploader) - INFO - Done attempting. 09:43:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:43:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:43:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:43:34 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:43:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:43:34 INFO - (blobuploader) - INFO - Done attempting. 09:43:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:43:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:43:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:43:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:43:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:43:35 INFO - (blobuploader) - INFO - Done attempting. 09:43:35 INFO - (blobuploader) - INFO - Iteration through files over. 09:43:35 INFO - Return code: 0 09:43:35 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:43:35 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:43:35 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1699b1aa1d84e393952d13032df966c49859da4571704fb9ee8634a1f2668692b909fc07b4cf8282603ee7ffc1461a2ea13e9ad4753612126f446260ba8b47fb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a7bbeace56dae10154863ce179c1b927b03b62e4a39d4de5f5fcc5c1c14e3bd515a25b342712c82ac446b81fae08c4cc492a86112138b686a4c00f25c2b395d8", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7041489425be430bb7db2403698bebd4fd465d54589aa3e4525ae071b096a3643bafee1c4ab74f55f56397f41f2ad978d00e58ce22aa12a731f374bafff722e2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/289d65b8f77c0a34cec67d2efecf236a78921662f39aff320ec755c69f81c5b45e0e4e8ca185cea60c3c10c95a6c7767472d99ce2dc7fcf9f1c32d60638f255e"} 09:43:35 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:43:35 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:43:35 INFO - Contents: 09:43:35 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1699b1aa1d84e393952d13032df966c49859da4571704fb9ee8634a1f2668692b909fc07b4cf8282603ee7ffc1461a2ea13e9ad4753612126f446260ba8b47fb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a7bbeace56dae10154863ce179c1b927b03b62e4a39d4de5f5fcc5c1c14e3bd515a25b342712c82ac446b81fae08c4cc492a86112138b686a4c00f25c2b395d8", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7041489425be430bb7db2403698bebd4fd465d54589aa3e4525ae071b096a3643bafee1c4ab74f55f56397f41f2ad978d00e58ce22aa12a731f374bafff722e2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/289d65b8f77c0a34cec67d2efecf236a78921662f39aff320ec755c69f81c5b45e0e4e8ca185cea60c3c10c95a6c7767472d99ce2dc7fcf9f1c32d60638f255e"} 09:43:35 INFO - Running post-run listener: copy_logs_to_upload_dir 09:43:35 INFO - Copying logs to upload dir... 09:43:35 INFO - mkdir: /builds/slave/test/build/upload/logs 09:43:35 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1257.302590 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2017-05-12 09:43:35.014885) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-12 09:43:35.018978) ========= 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=6dbc10da6d83fee962c624be000001a8-1494606154.832417-1631648225 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1699b1aa1d84e393952d13032df966c49859da4571704fb9ee8634a1f2668692b909fc07b4cf8282603ee7ffc1461a2ea13e9ad4753612126f446260ba8b47fb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a7bbeace56dae10154863ce179c1b927b03b62e4a39d4de5f5fcc5c1c14e3bd515a25b342712c82ac446b81fae08c4cc492a86112138b686a4c00f25c2b395d8", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7041489425be430bb7db2403698bebd4fd465d54589aa3e4525ae071b096a3643bafee1c4ab74f55f56397f41f2ad978d00e58ce22aa12a731f374bafff722e2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/289d65b8f77c0a34cec67d2efecf236a78921662f39aff320ec755c69f81c5b45e0e4e8ca185cea60c3c10c95a6c7767472d99ce2dc7fcf9f1c32d60638f255e"} build_url:https://queue.taskcluster.net/v1/task/NtRFFEQ4TNiztEbolW4n4g/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011320 build_url: 'https://queue.taskcluster.net/v1/task/NtRFFEQ4TNiztEbolW4n4g/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1699b1aa1d84e393952d13032df966c49859da4571704fb9ee8634a1f2668692b909fc07b4cf8282603ee7ffc1461a2ea13e9ad4753612126f446260ba8b47fb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a7bbeace56dae10154863ce179c1b927b03b62e4a39d4de5f5fcc5c1c14e3bd515a25b342712c82ac446b81fae08c4cc492a86112138b686a4c00f25c2b395d8", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7041489425be430bb7db2403698bebd4fd465d54589aa3e4525ae071b096a3643bafee1c4ab74f55f56397f41f2ad978d00e58ce22aa12a731f374bafff722e2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/289d65b8f77c0a34cec67d2efecf236a78921662f39aff320ec755c69f81c5b45e0e4e8ca185cea60c3c10c95a6c7767472d99ce2dc7fcf9f1c32d60638f255e"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-12 09:43:35.046931) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-12 09:43:35.047245) ========= 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=6dbc10da6d83fee962c624be000001a8-1494606154.832417-1631648225 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004394 ========= master_lag: 0.07 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-12 09:43:35.126340) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-12 09:43:35.129698) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-12 09:43:35.130034) ========= ========= Total master_lag: 0.17 =========