builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-027 starttime: 1495425742.77 results: success (0) revision: 9851fcb0bf4d855c36729d7de19f0fa5c9f69776 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-21 21:02:22.769061) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-21 21:02:22.769486) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-21 21:02:22.769766) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-21 21:02:22.804702) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-21 21:02:22.804983) ========= 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=1f5564757af27664ca02d71f000001b0-1495387086.920749-543998877 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-21 21:02:23-- 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% 85.9M=0s 2017-05-21 21:02:23 (85.9 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.127044 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-21 21:02:22.948551) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-21 21:02:22.951914) ========= 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=1f5564757af27664ca02d71f000001b0-1495387086.920749-543998877 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013809 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-21 21:02:23.004846) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-21 21:02:23.005260) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 9851fcb0bf4d855c36729d7de19f0fa5c9f69776 --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 9851fcb0bf4d855c36729d7de19f0fa5c9f69776 --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=1f5564757af27664ca02d71f000001b0-1495387086.920749-543998877 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-21 21:02:23,632 truncating revision to first 12 chars 2017-05-21 21:02:23,632 Setting DEBUG logging. 2017-05-21 21:02:23,632 attempt 1/10 2017-05-21 21:02:23,632 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/9851fcb0bf4d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-21 21:02:23,978 unpacking tar archive at: mozilla-central-9851fcb0bf4d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.724163 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-21 21:02:23.741314) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-21 21:02:23.744616) ========= script_repo_revision: 9851fcb0bf4d855c36729d7de19f0fa5c9f69776 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-21 21:02:23.744986) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-21 21:02:23.745241) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-21 21:02:23.757250) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2017-05-21 21:02:23.757525) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=1f5564757af27664ca02d71f000001b0-1495387086.920749-543998877 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 21:02:24 INFO - MultiFileLogger online at 20170521 21:02:24 in /builds/slave/test 21:02:24 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 21:02:24 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:02:24 INFO - {'append_to_log': False, 21:02:24 INFO - 'base_work_dir': '/builds/slave/test', 21:02:24 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 21:02:24 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:02:24 INFO - 'branch': 'Firefox-Non-PGO', 21:02:24 INFO - 'buildbot_json_path': 'buildprops.json', 21:02:24 INFO - 'config_files': ('talos/linux_config.py',), 21:02:24 INFO - 'default_actions': ('clobber', 21:02:24 INFO - 'read-buildbot-config', 21:02:24 INFO - 'download-and-extract', 21:02:24 INFO - 'populate-webroot', 21:02:24 INFO - 'create-virtualenv', 21:02:24 INFO - 'install', 21:02:24 INFO - 'run-tests'), 21:02:24 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:02:24 INFO - 'download_minidump_stackwalk': True, 21:02:24 INFO - 'download_symbols': 'ondemand', 21:02:24 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:02:24 INFO - 'tooltool.py': '/tools/tooltool.py', 21:02:24 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:02:24 INFO - '/tools/misc-python/virtualenv.py')}, 21:02:24 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:02:24 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:02:24 INFO - 'gecko_profile': False, 21:02:24 INFO - 'gecko_profile_interval': 0, 21:02:24 INFO - 'installer_path': 'installer.exe', 21:02:24 INFO - 'log_level': 'info', 21:02:24 INFO - 'log_name': 'talos', 21:02:24 INFO - 'log_to_console': True, 21:02:24 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 21:02:24 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 21:02:24 INFO - 'opt_config_files': (), 21:02:24 INFO - 'pip_index': False, 21:02:24 INFO - 'suite': 'dromaeojs-e10s', 21:02:24 INFO - 'system_bits': '32', 21:02:24 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:02:24 INFO - 'title': 'talos-linux64-ix-027', 21:02:24 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:02:24 INFO - 'use_talos_json': True, 21:02:24 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:02:24 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:02:24 INFO - 'work_dir': 'build'} 21:02:24 INFO - [mozharness: 2017-05-22 04:02:24.487409Z] Running clobber step. 21:02:24 INFO - Running pre-action listener: _resource_record_pre_action 21:02:24 INFO - Running main action method: clobber 21:02:24 INFO - rmtree: /builds/slave/test/build 21:02:24 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:02:25 INFO - Running post-action listener: _resource_record_post_action 21:02:25 INFO - [mozharness: 2017-05-22 04:02:25.511553Z] Finished clobber step (success) 21:02:25 INFO - [mozharness: 2017-05-22 04:02:25.511654Z] Running read-buildbot-config step. 21:02:25 INFO - Running pre-action listener: _resource_record_pre_action 21:02:25 INFO - Running main action method: read_buildbot_config 21:02:25 INFO - Using buildbot properties: 21:02:25 INFO - { 21:02:25 INFO - "project": "", 21:02:25 INFO - "product": "firefox", 21:02:25 INFO - "who": "ihsiao@mozilla.com", 21:02:25 INFO - "installer_path": "public/build/target.tar.bz2", 21:02:25 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 21:02:25 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 21:02:25 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 21:02:25 INFO - "stage_platform": "linux64", 21:02:25 INFO - "basedir": "/builds/slave/test", 21:02:25 INFO - "buildnumber": 621, 21:02:25 INFO - "platform": "ubuntu64_hw", 21:02:25 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 21:02:25 INFO - "slavebuilddir": "test", 21:02:25 INFO - "taskId": "Mp2NNGJMSS-FqzgD9yaWXQ", 21:02:25 INFO - "branch": "mozilla-central", 21:02:25 INFO - "script_repo_revision": "production", 21:02:25 INFO - "revision": "9851fcb0bf4d855c36729d7de19f0fa5c9f69776", 21:02:25 INFO - "slavename": "talos-linux64-ix-027", 21:02:25 INFO - "repo_path": "mozilla-central" 21:02:25 INFO - } 21:02:25 INFO - Finding installer, test and symbols from parent task. 21:02:25 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Mp2NNGJMSS-FqzgD9yaWXQ'}, attempt #1 21:02:25 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Mp2NNGJMSS-FqzgD9yaWXQ'}, attempt #1 21:02:26 INFO - Task dependencies: FSfiA2TOTQKNqkDonq3I0g 21:02:26 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FSfiA2TOTQKNqkDonq3I0g'}, attempt #1 21:02:26 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/FSfiA2TOTQKNqkDonq3I0g/artifacts/public/build/target.tar.bz2 21:02:26 INFO - Set test_url: https://queue.taskcluster.net/v1/task/FSfiA2TOTQKNqkDonq3I0g/artifacts/public/build/test_packages.json 21:02:26 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/FSfiA2TOTQKNqkDonq3I0g/artifacts/public/build/target.crashreporter-symbols.zip 21:02:26 INFO - Running post-action listener: _resource_record_post_action 21:02:26 INFO - [mozharness: 2017-05-22 04:02:26.870329Z] Finished read-buildbot-config step (success) 21:02:26 INFO - [mozharness: 2017-05-22 04:02:26.870549Z] Running download-and-extract step. 21:02:26 INFO - Running pre-action listener: _resource_record_pre_action 21:02:26 INFO - Running main action method: download_and_extract 21:02:26 INFO - mkdir: /builds/slave/test/build/tests 21:02:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:02:26 INFO - trying https://queue.taskcluster.net/v1/task/FSfiA2TOTQKNqkDonq3I0g/artifacts/public/build/target.test_packages.json 21:02:26 INFO - Downloading https://queue.taskcluster.net/v1/task/FSfiA2TOTQKNqkDonq3I0g/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 21:02:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FSfiA2TOTQKNqkDonq3I0g/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 21:02:27 INFO - Downloaded 986 bytes. 21:02:27 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 21:02:27 INFO - Using the following test package requirements: 21:02:27 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 21:02:27 INFO - u'common': [u'target.common.tests.zip'], 21:02:27 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 21:02:27 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 21:02:27 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 21:02:27 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 21:02:27 INFO - u'mozbase': [u'target.common.tests.zip'], 21:02:27 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 21:02:27 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 21:02:27 INFO - u'web-platform': [u'target.common.tests.zip', 21:02:27 INFO - u'target.web-platform.tests.zip'], 21:02:27 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 21:02:27 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 21:02:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FSfiA2TOTQKNqkDonq3I0g/artifacts/public/build/target.common.tests.zip 21:02:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FSfiA2TOTQKNqkDonq3I0g/artifacts/public/build/target.common.tests.zip'}, attempt #1 21:02:27 INFO - Fetch https://queue.taskcluster.net/v1/task/FSfiA2TOTQKNqkDonq3I0g/artifacts/public/build/target.common.tests.zip into memory 21:02:29 INFO - Content-Length response header: 63520794 21:02:29 INFO - Bytes received: 63520794 21:02:40 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 21:02:40 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FSfiA2TOTQKNqkDonq3I0g/artifacts/public/build/target.common.tests.zip 21:02:40 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FSfiA2TOTQKNqkDonq3I0g/artifacts/public/build/target.common.tests.zip'}, attempt #1 21:02:40 INFO - Fetch https://queue.taskcluster.net/v1/task/FSfiA2TOTQKNqkDonq3I0g/artifacts/public/build/target.common.tests.zip into memory 21:02:41 INFO - Content-Length response header: 63520794 21:02:41 INFO - Bytes received: 63520794 21:02:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FSfiA2TOTQKNqkDonq3I0g/artifacts/public/build/target.talos.tests.zip 21:02:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FSfiA2TOTQKNqkDonq3I0g/artifacts/public/build/target.talos.tests.zip'}, attempt #1 21:02:53 INFO - Fetch https://queue.taskcluster.net/v1/task/FSfiA2TOTQKNqkDonq3I0g/artifacts/public/build/target.talos.tests.zip into memory 21:02:54 INFO - Content-Length response header: 14410000 21:02:54 INFO - Bytes received: 14410000 21:02:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:02:54 INFO - trying https://queue.taskcluster.net/v1/task/FSfiA2TOTQKNqkDonq3I0g/artifacts/public/build/target.tar.bz2 21:02:54 INFO - Downloading https://queue.taskcluster.net/v1/task/FSfiA2TOTQKNqkDonq3I0g/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 21:02:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FSfiA2TOTQKNqkDonq3I0g/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 21:02:56 INFO - Downloaded 54985866 bytes. 21:02:56 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/FSfiA2TOTQKNqkDonq3I0g/artifacts/public/build/target.tar.bz2 21:02:56 INFO - mkdir: /builds/slave/test/properties 21:02:56 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:02:56 INFO - Writing to file /builds/slave/test/properties/build_url 21:02:56 INFO - Contents: 21:02:56 INFO - build_url:https://queue.taskcluster.net/v1/task/FSfiA2TOTQKNqkDonq3I0g/artifacts/public/build/target.tar.bz2 21:02:56 INFO - Running post-action listener: _resource_record_post_action 21:02:56 INFO - Running post-action listener: set_extra_try_arguments 21:02:56 INFO - [mozharness: 2017-05-22 04:02:56.424407Z] Finished download-and-extract step (success) 21:02:56 INFO - [mozharness: 2017-05-22 04:02:56.424559Z] Running populate-webroot step. 21:02:56 INFO - Running pre-action listener: _resource_record_pre_action 21:02:56 INFO - Running main action method: populate_webroot 21:02:56 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:02:56 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:02:56 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:02:56 INFO - '--tppagecycles', 21:02:56 INFO - '7'], 21:02:56 INFO - 'tests': ['tsvgm']}}, 21:02:56 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 21:02:56 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:02:56 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 21:02:56 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 21:02:56 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:02:56 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 21:02:56 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 21:02:56 INFO - 'talos_options': ['--disable-e10s'], 21:02:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:02:56 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 21:02:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:02:56 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 21:02:56 INFO - 'talos_options': ['--disable-e10s'], 21:02:56 INFO - 'tests': ['damp', 'tps']}, 21:02:56 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 21:02:56 INFO - 'tests': ['damp', 'tps']}, 21:02:56 INFO - 'g3': {'talos_options': ['--disable-e10s'], 21:02:56 INFO - 'tests': ['dromaeo_dom']}, 21:02:56 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:02:56 INFO - 'g4': {'talos_options': ['--disable-e10s'], 21:02:56 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 21:02:56 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 21:02:56 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 21:02:56 INFO - 'tests': ['ts_paint', 'tp5o']}, 21:02:56 INFO - 'other': {'talos_options': ['--disable-e10s'], 21:02:56 INFO - 'tests': ['a11yr', 21:02:56 INFO - 'ts_paint', 21:02:56 INFO - 'tpaint', 21:02:56 INFO - 'sessionrestore', 21:02:56 INFO - 'sessionrestore_no_auto_restore', 21:02:56 INFO - 'tabpaint']}, 21:02:56 INFO - 'other-e10s': {'tests': ['a11yr', 21:02:56 INFO - 'ts_paint', 21:02:56 INFO - 'tpaint', 21:02:56 INFO - 'sessionrestore', 21:02:56 INFO - 'sessionrestore_no_auto_restore', 21:02:56 INFO - 'tabpaint']}, 21:02:56 INFO - 'other-e10s_l64': {'tests': ['a11yr', 21:02:56 INFO - 'ts_paint', 21:02:56 INFO - 'tpaint', 21:02:56 INFO - 'sessionrestore', 21:02:56 INFO - 'sessionrestore_no_auto_restore', 21:02:56 INFO - 'tabpaint']}, 21:02:56 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 21:02:56 INFO - 'ts_paint', 21:02:56 INFO - 'tpaint', 21:02:56 INFO - 'sessionrestore', 21:02:56 INFO - 'sessionrestore_no_auto_restore', 21:02:56 INFO - 'tabpaint']}, 21:02:56 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 21:02:56 INFO - 'tests': ['a11yr', 21:02:56 INFO - 'ts_paint', 21:02:56 INFO - 'tpaint', 21:02:56 INFO - 'sessionrestore', 21:02:56 INFO - 'sessionrestore_no_auto_restore', 21:02:56 INFO - 'tabpaint']}, 21:02:56 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 21:02:56 INFO - 'tests': ['a11yr', 21:02:56 INFO - 'ts_paint', 21:02:56 INFO - 'tpaint', 21:02:56 INFO - 'sessionrestore', 21:02:56 INFO - 'sessionrestore_no_auto_restore', 21:02:56 INFO - 'tabpaint']}, 21:02:56 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 21:02:56 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 21:02:56 INFO - 'bloom_basic_ref']}, 21:02:56 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 21:02:56 INFO - 'tests': ['tsvgx', 21:02:56 INFO - 'tsvgr_opacity', 21:02:56 INFO - 'tart', 21:02:56 INFO - 'tscrollx', 21:02:56 INFO - 'cart', 21:02:56 INFO - 'tsvg_static']}, 21:02:56 INFO - 'svgr-e10s': {'tests': ['tsvgx', 21:02:56 INFO - 'tsvgr_opacity', 21:02:56 INFO - 'tart', 21:02:56 INFO - 'tscrollx', 21:02:56 INFO - 'cart', 21:02:56 INFO - 'tsvg_static']}, 21:02:56 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 21:02:56 INFO - 'talos_options': ['--disable-e10s'], 21:02:56 INFO - 'tests': ['tp5o']}, 21:02:56 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 21:02:56 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 21:02:56 INFO - 'talos_options': ['--disable-e10s', 21:02:56 INFO - '--xperf_path', 21:02:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:02:56 INFO - 'tests': ['tp5n']}, 21:02:56 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 21:02:56 INFO - 'talos_options': ['--xperf_path', 21:02:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:02:56 INFO - 'tests': ['tp5n']}}, 21:02:56 INFO - 'talos.zip': {'path': '', 21:02:56 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:02:56 INFO - Running post-action listener: _resource_record_post_action 21:02:56 INFO - [mozharness: 2017-05-22 04:02:56.446623Z] Finished populate-webroot step (success) 21:02:56 INFO - [mozharness: 2017-05-22 04:02:56.446712Z] Running create-virtualenv step. 21:02:56 INFO - Running pre-action listener: _resource_record_pre_action 21:02:56 INFO - Running main action method: create_virtualenv 21:02:56 INFO - Creating virtualenv /builds/slave/test/build/venv 21:02:56 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 21:02:56 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:02:56 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:02:56 INFO - Using real prefix '/usr' 21:02:56 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:02:57 INFO - Installing distribute.............................................................................................................................................................................................done. 21:02:59 INFO - Installing pip.................done. 21:02:59 INFO - Return code: 0 21:02:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 21:02:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 21:02:59 INFO - Reading from file tmpfile_stdout 21:02:59 INFO - Output received: 21:02:59 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) 21:02:59 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:02:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:02:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:02:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:02:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:02:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15d41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17a1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19475c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19447a0>, '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 0x19456a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1945b30>, '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': '1f5564757af27664ca02d71f000001b0-1495387086.920749-543998877', '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 21:02:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 21:02:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 21:02:59 INFO - Using env: {'DISPLAY': ':0', 21:02:59 INFO - 'HOME': '/home/cltbld', 21:02:59 INFO - 'LANG': 'en_US.UTF-8', 21:02:59 INFO - 'LANGUAGE': 'en_US:en', 21:02:59 INFO - 'LOGNAME': 'cltbld', 21:02:59 INFO - 'MAIL': '/var/mail/cltbld', 21:02:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:02:59 INFO - 'MOZ_NO_REMOTE': '1', 21:02:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:02:59 INFO - 'NO_EM_RESTART': '1', 21:02:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:02:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:02:59 INFO - 'PWD': '/builds/slave/test', 21:02:59 INFO - 'SHELL': '/bin/bash', 21:02:59 INFO - 'SHLVL': '1', 21:02:59 INFO - 'TERM': 'linux', 21:02:59 INFO - 'TMOUT': '86400', 21:02:59 INFO - 'USER': 'cltbld', 21:02:59 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1495387086.920749-543998877', 21:02:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:02:59 INFO - '_': '/tools/buildbot/bin/python'} 21:02:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:02:59 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 21:02:59 INFO - Cleaning up... 21:02:59 INFO - Return code: 0 21:02:59 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 21:02:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:02:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:02:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:02:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:02:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x15d41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17a1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19475c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19447a0>, '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 0x19456a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1945b30>, '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': '1f5564757af27664ca02d71f000001b0-1495387086.920749-543998877', '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 21:02:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 21:02:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 21:02:59 INFO - Using env: {'DISPLAY': ':0', 21:02:59 INFO - 'HOME': '/home/cltbld', 21:02:59 INFO - 'LANG': 'en_US.UTF-8', 21:02:59 INFO - 'LANGUAGE': 'en_US:en', 21:02:59 INFO - 'LOGNAME': 'cltbld', 21:02:59 INFO - 'MAIL': '/var/mail/cltbld', 21:02:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:02:59 INFO - 'MOZ_NO_REMOTE': '1', 21:02:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:02:59 INFO - 'NO_EM_RESTART': '1', 21:02:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:02:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:02:59 INFO - 'PWD': '/builds/slave/test', 21:02:59 INFO - 'SHELL': '/bin/bash', 21:02:59 INFO - 'SHLVL': '1', 21:02:59 INFO - 'TERM': 'linux', 21:02:59 INFO - 'TMOUT': '86400', 21:02:59 INFO - 'USER': 'cltbld', 21:02:59 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1495387086.920749-543998877', 21:02:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:02:59 INFO - '_': '/tools/buildbot/bin/python'} 21:02:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:02:59 INFO - Downloading/unpacking psutil>=3.1.1 21:02:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:02:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:02:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:02:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:03:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:03:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:03:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:03:00 INFO - Installing collected packages: psutil 21:03:00 INFO - Running setup.py install for psutil 21:03:00 INFO - building 'psutil._psutil_linux' extension 21:03:00 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 21:03:01 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 21:03:01 INFO - building 'psutil._psutil_posix' extension 21:03:01 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 21:03:01 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 21:03:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:03:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:03:01 INFO - Successfully installed psutil 21:03:01 INFO - Cleaning up... 21:03:01 INFO - Return code: 0 21:03:01 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 21:03:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:03:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:03:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:03:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:03:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15d41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17a1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19475c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19447a0>, '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 0x19456a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1945b30>, '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': '1f5564757af27664ca02d71f000001b0-1495387086.920749-543998877', '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 21:03:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 21:03:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 21:03:01 INFO - Using env: {'DISPLAY': ':0', 21:03:01 INFO - 'HOME': '/home/cltbld', 21:03:01 INFO - 'LANG': 'en_US.UTF-8', 21:03:01 INFO - 'LANGUAGE': 'en_US:en', 21:03:01 INFO - 'LOGNAME': 'cltbld', 21:03:01 INFO - 'MAIL': '/var/mail/cltbld', 21:03:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:03:01 INFO - 'MOZ_NO_REMOTE': '1', 21:03:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:03:01 INFO - 'NO_EM_RESTART': '1', 21:03:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:03:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:03:01 INFO - 'PWD': '/builds/slave/test', 21:03:01 INFO - 'SHELL': '/bin/bash', 21:03:01 INFO - 'SHLVL': '1', 21:03:01 INFO - 'TERM': 'linux', 21:03:01 INFO - 'TMOUT': '86400', 21:03:01 INFO - 'USER': 'cltbld', 21:03:01 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1495387086.920749-543998877', 21:03:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:03:01 INFO - '_': '/tools/buildbot/bin/python'} 21:03:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:03:01 INFO - Downloading/unpacking mozsystemmonitor==0.3 21:03:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:03:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:03:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:03:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:03:02 INFO - Downloading mozsystemmonitor-0.3.tar.gz 21:03:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:03:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 21:03:02 INFO - Installing collected packages: mozsystemmonitor 21:03:02 INFO - Running setup.py install for mozsystemmonitor 21:03:02 INFO - Successfully installed mozsystemmonitor 21:03:02 INFO - Cleaning up... 21:03:02 INFO - Return code: 0 21:03:02 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 21:03:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:03:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:03:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:03:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:03:02 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 0x15d41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17a1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19475c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19447a0>, '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 0x19456a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1945b30>, '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': '1f5564757af27664ca02d71f000001b0-1495387086.920749-543998877', '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 21:03:02 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 21:03:02 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 21:03:02 INFO - Using env: {'DISPLAY': ':0', 21:03:02 INFO - 'HOME': '/home/cltbld', 21:03:02 INFO - 'LANG': 'en_US.UTF-8', 21:03:02 INFO - 'LANGUAGE': 'en_US:en', 21:03:02 INFO - 'LOGNAME': 'cltbld', 21:03:02 INFO - 'MAIL': '/var/mail/cltbld', 21:03:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:03:02 INFO - 'MOZ_NO_REMOTE': '1', 21:03:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:03:02 INFO - 'NO_EM_RESTART': '1', 21:03:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:03:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:03:02 INFO - 'PWD': '/builds/slave/test', 21:03:02 INFO - 'SHELL': '/bin/bash', 21:03:02 INFO - 'SHLVL': '1', 21:03:02 INFO - 'TERM': 'linux', 21:03:02 INFO - 'TMOUT': '86400', 21:03:02 INFO - 'USER': 'cltbld', 21:03:02 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1495387086.920749-543998877', 21:03:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:03:02 INFO - '_': '/tools/buildbot/bin/python'} 21:03:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:03:03 INFO - Downloading/unpacking jsonschema==2.5.1 21:03:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:03:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:03:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:03:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:03:04 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:03:04 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 21:03:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:03:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:03:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:03:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:03:04 INFO - Downloading functools32-3.2.3-2.tar.gz 21:03:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:03:04 INFO - warning: no files found matching '*.txt' 21:03:04 INFO - no previously-included directories found matching 'build' 21:03:04 INFO - no previously-included directories found matching 'dist' 21:03:04 INFO - no previously-included directories found matching '.git*' 21:03:04 INFO - Installing collected packages: jsonschema, functools32 21:03:04 INFO - Running setup.py install for functools32 21:03:04 INFO - warning: no files found matching '*.txt' 21:03:04 INFO - no previously-included directories found matching 'build' 21:03:04 INFO - no previously-included directories found matching 'dist' 21:03:04 INFO - no previously-included directories found matching '.git*' 21:03:04 INFO - Successfully installed jsonschema functools32 21:03:04 INFO - Cleaning up... 21:03:04 INFO - Return code: 0 21:03:04 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 21:03:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:03:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:03:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:03:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:03:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x15d41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17a1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19475c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19447a0>, '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 0x19456a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1945b30>, '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': '1f5564757af27664ca02d71f000001b0-1495387086.920749-543998877', '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 21:03:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 21:03:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 21:03:04 INFO - Using env: {'DISPLAY': ':0', 21:03:04 INFO - 'HOME': '/home/cltbld', 21:03:04 INFO - 'LANG': 'en_US.UTF-8', 21:03:04 INFO - 'LANGUAGE': 'en_US:en', 21:03:04 INFO - 'LOGNAME': 'cltbld', 21:03:04 INFO - 'MAIL': '/var/mail/cltbld', 21:03:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:03:04 INFO - 'MOZ_NO_REMOTE': '1', 21:03:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:03:04 INFO - 'NO_EM_RESTART': '1', 21:03:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:03:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:03:04 INFO - 'PWD': '/builds/slave/test', 21:03:04 INFO - 'SHELL': '/bin/bash', 21:03:04 INFO - 'SHLVL': '1', 21:03:04 INFO - 'TERM': 'linux', 21:03:04 INFO - 'TMOUT': '86400', 21:03:04 INFO - 'USER': 'cltbld', 21:03:04 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1495387086.920749-543998877', 21:03:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:03:04 INFO - '_': '/tools/buildbot/bin/python'} 21:03:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:03:04 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 21:03:04 INFO - Cleaning up... 21:03:04 INFO - Return code: 0 21:03:04 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:03:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:03:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:03:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:03:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:03:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x15d41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17a1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19475c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19447a0>, '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 0x19456a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1945b30>, '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': '1f5564757af27664ca02d71f000001b0-1495387086.920749-543998877', '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 21:03:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 21:03:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 21:03:04 INFO - Using env: {'DISPLAY': ':0', 21:03:04 INFO - 'HOME': '/home/cltbld', 21:03:04 INFO - 'LANG': 'en_US.UTF-8', 21:03:04 INFO - 'LANGUAGE': 'en_US:en', 21:03:04 INFO - 'LOGNAME': 'cltbld', 21:03:04 INFO - 'MAIL': '/var/mail/cltbld', 21:03:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:03:04 INFO - 'MOZ_NO_REMOTE': '1', 21:03:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:03:04 INFO - 'NO_EM_RESTART': '1', 21:03:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:03:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:03:04 INFO - 'PWD': '/builds/slave/test', 21:03:04 INFO - 'SHELL': '/bin/bash', 21:03:04 INFO - 'SHLVL': '1', 21:03:04 INFO - 'TERM': 'linux', 21:03:04 INFO - 'TMOUT': '86400', 21:03:04 INFO - 'USER': 'cltbld', 21:03:04 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1495387086.920749-543998877', 21:03:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:03:04 INFO - '_': '/tools/buildbot/bin/python'} 21:03:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:03:04 INFO - Downloading/unpacking blobuploader==1.2.4 21:03:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:03:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:03:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:03:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:03:06 INFO - Downloading blobuploader-1.2.4.tar.gz 21:03:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:03:06 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:03:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:03:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:03:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:03:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:03:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:03:06 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:03:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:03:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:03:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:03:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:03:06 INFO - Downloading docopt-0.6.1.tar.gz 21:03:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:03:06 INFO - Installing collected packages: blobuploader, requests, docopt 21:03:06 INFO - Running setup.py install for blobuploader 21:03:06 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:03:06 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:03:06 INFO - Running setup.py install for requests 21:03:07 INFO - Running setup.py install for docopt 21:03:07 INFO - Successfully installed blobuploader requests docopt 21:03:07 INFO - Cleaning up... 21:03:07 INFO - Return code: 0 21:03:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:03: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')]} 21:03:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:03: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')]} 21:03:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:03:07 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 0x15d41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17a1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19475c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19447a0>, '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 0x19456a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1945b30>, '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': '1f5564757af27664ca02d71f000001b0-1495387086.920749-543998877', '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 21:03:07 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 21:03:07 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 21:03:07 INFO - Using env: {'DISPLAY': ':0', 21:03:07 INFO - 'HOME': '/home/cltbld', 21:03:07 INFO - 'LANG': 'en_US.UTF-8', 21:03:07 INFO - 'LANGUAGE': 'en_US:en', 21:03:07 INFO - 'LOGNAME': 'cltbld', 21:03:07 INFO - 'MAIL': '/var/mail/cltbld', 21:03:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:03:07 INFO - 'MOZ_NO_REMOTE': '1', 21:03:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:03:07 INFO - 'NO_EM_RESTART': '1', 21:03:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:03:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:03:07 INFO - 'PWD': '/builds/slave/test', 21:03:07 INFO - 'SHELL': '/bin/bash', 21:03:07 INFO - 'SHLVL': '1', 21:03:07 INFO - 'TERM': 'linux', 21:03:07 INFO - 'TMOUT': '86400', 21:03:07 INFO - 'USER': 'cltbld', 21:03:07 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1495387086.920749-543998877', 21:03:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:03:07 INFO - '_': '/tools/buildbot/bin/python'} 21:03:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:03:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:03:07 INFO - Running setup.py (path:/tmp/pip-hHRhyz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:03:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:03:07 INFO - Running setup.py (path:/tmp/pip-qkmFIf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:03:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:03:07 INFO - Running setup.py (path:/tmp/pip-NwvZQr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:03:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:03:07 INFO - Running setup.py (path:/tmp/pip-DQwFgd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:03:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:03:07 INFO - Running setup.py (path:/tmp/pip-tyUrB8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:03:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:03:07 INFO - Running setup.py (path:/tmp/pip-1BM5Pk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:03:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:03:07 INFO - Running setup.py (path:/tmp/pip-3WSqST-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:03:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:03:07 INFO - Running setup.py (path:/tmp/pip-jMsy8r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:03:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:03:08 INFO - Running setup.py (path:/tmp/pip-JNJq0L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:03:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:03:08 INFO - Running setup.py (path:/tmp/pip-tPTGdA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:03:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:03:08 INFO - Running setup.py (path:/tmp/pip-IstZQN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:03:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:03:08 INFO - Running setup.py (path:/tmp/pip-LJl3jD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:03:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:03:08 INFO - Running setup.py (path:/tmp/pip-pziYzH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:03:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:03:08 INFO - Running setup.py (path:/tmp/pip-olSyox-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:03:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:03:08 INFO - Running setup.py (path:/tmp/pip-mlVJdi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:03:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:03:08 INFO - Running setup.py (path:/tmp/pip-zEUfB6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:03:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:03:08 INFO - Running setup.py (path:/tmp/pip-M4qRMc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:03:08 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:03:08 INFO - Running setup.py install for manifestparser 21:03:08 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:03:08 INFO - Running setup.py install for mozcrash 21:03:08 INFO - Running setup.py install for mozdebug 21:03:09 INFO - Running setup.py install for mozdevice 21:03:09 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:03:09 INFO - Running setup.py install for mozfile 21:03:09 INFO - Running setup.py install for mozhttpd 21:03:09 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:03:09 INFO - Running setup.py install for mozinfo 21:03:09 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:03:09 INFO - Running setup.py install for mozInstall 21:03:09 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:03:09 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:03:09 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:03:09 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:03:09 INFO - Running setup.py install for mozleak 21:03:09 INFO - Running setup.py install for mozlog 21:03:09 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:03:09 INFO - Running setup.py install for moznetwork 21:03:09 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:03:09 INFO - Running setup.py install for mozprocess 21:03:09 INFO - Running setup.py install for mozprofile 21:03:10 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:03:10 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:03:10 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:03:10 INFO - Running setup.py install for mozrunner 21:03:10 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:03:10 INFO - Running setup.py install for mozscreenshot 21:03:10 INFO - Running setup.py install for moztest 21:03:10 INFO - Running setup.py install for mozversion 21:03:10 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:03:10 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:03:10 INFO - Cleaning up... 21:03:10 INFO - Return code: 0 21:03:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:03:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:03:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:03:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:03:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:03:10 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 0x15d41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17a1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19475c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19447a0>, '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 0x19456a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1945b30>, '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': '1f5564757af27664ca02d71f000001b0-1495387086.920749-543998877', '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 21:03:10 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 21:03:10 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 21:03:10 INFO - Using env: {'DISPLAY': ':0', 21:03:10 INFO - 'HOME': '/home/cltbld', 21:03:10 INFO - 'LANG': 'en_US.UTF-8', 21:03:10 INFO - 'LANGUAGE': 'en_US:en', 21:03:10 INFO - 'LOGNAME': 'cltbld', 21:03:10 INFO - 'MAIL': '/var/mail/cltbld', 21:03:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:03:10 INFO - 'MOZ_NO_REMOTE': '1', 21:03:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:03:10 INFO - 'NO_EM_RESTART': '1', 21:03:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:03:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:03:10 INFO - 'PWD': '/builds/slave/test', 21:03:10 INFO - 'SHELL': '/bin/bash', 21:03:10 INFO - 'SHLVL': '1', 21:03:10 INFO - 'TERM': 'linux', 21:03:10 INFO - 'TMOUT': '86400', 21:03:10 INFO - 'USER': 'cltbld', 21:03:10 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1495387086.920749-543998877', 21:03:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:03:10 INFO - '_': '/tools/buildbot/bin/python'} 21:03:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:03:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:03:10 INFO - Running setup.py (path:/tmp/pip-nUA22k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:03:10 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)) 21:03:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:03:10 INFO - Running setup.py (path:/tmp/pip-sFGTol-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:03:10 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)) 21:03:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:03:10 INFO - Running setup.py (path:/tmp/pip-oa0wsi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:03:10 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)) 21:03:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:03:10 INFO - Running setup.py (path:/tmp/pip-XOAfO9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:03:11 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)) 21:03:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:03:11 INFO - Running setup.py (path:/tmp/pip-sFgeUZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:03:11 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)) 21:03:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:03:11 INFO - Running setup.py (path:/tmp/pip-pOISCd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:03:11 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)) 21:03:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:03:11 INFO - Running setup.py (path:/tmp/pip-HEH1FF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:03:11 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)) 21:03:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:03:11 INFO - Running setup.py (path:/tmp/pip-ul2CoP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:03:11 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)) 21:03:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:03:11 INFO - Running setup.py (path:/tmp/pip-YJANU6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:03:11 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)) 21:03:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:03:11 INFO - Running setup.py (path:/tmp/pip-6Ppyib-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:03:11 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)) 21:03:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:03:11 INFO - Running setup.py (path:/tmp/pip-n4tVkK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:03:11 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)) 21:03:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:03:11 INFO - Running setup.py (path:/tmp/pip-l0pXIL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:03:11 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)) 21:03:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:03:11 INFO - Running setup.py (path:/tmp/pip-CWhbdr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:03:11 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)) 21:03:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:03:11 INFO - Running setup.py (path:/tmp/pip-9i_l8_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:03:11 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)) 21:03:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:03:11 INFO - Running setup.py (path:/tmp/pip-TgPm_p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:03:11 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)) 21:03:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:03:11 INFO - Running setup.py (path:/tmp/pip-sU8Fuh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:03:11 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)) 21:03:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:03:11 INFO - Running setup.py (path:/tmp/pip-Z0d_fu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:03:11 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)) 21:03:11 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)) 21:03:11 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)) 21:03:11 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)) 21:03:11 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)) 21:03:11 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)) 21:03:11 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:03: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 21:03: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 21:03: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 21:03: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 21:03:13 INFO - Downloading blessings-1.6.tar.gz 21:03:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:03:13 INFO - Installing collected packages: blessings 21:03:13 INFO - Running setup.py install for blessings 21:03:13 INFO - Successfully installed blessings 21:03:13 INFO - Cleaning up... 21:03:13 INFO - Return code: 0 21:03:13 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:03:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:03:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:03:13 INFO - Reading from file tmpfile_stdout 21:03:13 INFO - Current package versions: 21:03:13 INFO - argparse == 1.2.1 21:03:13 INFO - blessings == 1.6 21:03:13 INFO - blobuploader == 1.2.4 21:03:13 INFO - docopt == 0.6.1 21:03:13 INFO - functools32 == 3.2.3-2 21:03:13 INFO - jsonschema == 2.5.1 21:03:13 INFO - manifestparser == 1.1 21:03:13 INFO - mozInstall == 1.12 21:03:13 INFO - mozcrash == 1.0 21:03:13 INFO - mozdebug == 0.1 21:03:13 INFO - mozdevice == 0.50 21:03:13 INFO - mozfile == 1.2 21:03:13 INFO - mozhttpd == 0.7 21:03:13 INFO - mozinfo == 0.9 21:03:13 INFO - mozleak == 0.1 21:03:13 INFO - mozlog == 3.4 21:03:13 INFO - moznetwork == 0.27 21:03:13 INFO - mozprocess == 0.25 21:03:13 INFO - mozprofile == 0.28 21:03:13 INFO - mozrunner == 6.13 21:03:13 INFO - mozscreenshot == 0.1 21:03:13 INFO - mozsystemmonitor == 0.3 21:03:13 INFO - moztest == 0.8 21:03:13 INFO - mozversion == 1.4 21:03:13 INFO - psutil == 3.1.1 21:03:13 INFO - requests == 1.2.3 21:03:13 INFO - wsgiref == 0.1.2 21:03:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:03: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')]} 21:03:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:03: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')]} 21:03:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:03:13 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 0x15d41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17a1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19475c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19447a0>, '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 0x19456a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1945b30>, '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': '1f5564757af27664ca02d71f000001b0-1495387086.920749-543998877', '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 21:03:13 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 21:03:13 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 21:03:13 INFO - Using env: {'DISPLAY': ':0', 21:03:13 INFO - 'HOME': '/home/cltbld', 21:03:13 INFO - 'LANG': 'en_US.UTF-8', 21:03:13 INFO - 'LANGUAGE': 'en_US:en', 21:03:13 INFO - 'LOGNAME': 'cltbld', 21:03:13 INFO - 'MAIL': '/var/mail/cltbld', 21:03:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:03:13 INFO - 'MOZ_NO_REMOTE': '1', 21:03:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:03:13 INFO - 'NO_EM_RESTART': '1', 21:03:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:03:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:03:13 INFO - 'PWD': '/builds/slave/test', 21:03:13 INFO - 'SHELL': '/bin/bash', 21:03:13 INFO - 'SHLVL': '1', 21:03:13 INFO - 'TERM': 'linux', 21:03:13 INFO - 'TMOUT': '86400', 21:03:13 INFO - 'USER': 'cltbld', 21:03:13 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1495387086.920749-543998877', 21:03:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:03:13 INFO - '_': '/tools/buildbot/bin/python'} 21:03:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:03:13 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)) 21:03:13 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)) 21:03:13 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)) 21:03:13 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)) 21:03:13 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)) 21:03:13 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)) 21:03:13 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)) 21:03:13 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)) 21:03:13 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)) 21:03:13 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)) 21:03:13 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)) 21:03:13 INFO - Cleaning up... 21:03:13 INFO - Return code: 0 21:03:13 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:03: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')]} 21:03:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:03: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')]} 21:03:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:03: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15d41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17a1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19475c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19447a0>, '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 0x19456a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1945b30>, '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': '1f5564757af27664ca02d71f000001b0-1495387086.920749-543998877', '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 21:03: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', 'jsonschema'] in /builds/slave/test/build 21:03: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 jsonschema 21:03:13 INFO - Using env: {'DISPLAY': ':0', 21:03:13 INFO - 'HOME': '/home/cltbld', 21:03:13 INFO - 'LANG': 'en_US.UTF-8', 21:03:13 INFO - 'LANGUAGE': 'en_US:en', 21:03:13 INFO - 'LOGNAME': 'cltbld', 21:03:13 INFO - 'MAIL': '/var/mail/cltbld', 21:03:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:03:13 INFO - 'MOZ_NO_REMOTE': '1', 21:03:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:03:13 INFO - 'NO_EM_RESTART': '1', 21:03:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:03:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:03:13 INFO - 'PWD': '/builds/slave/test', 21:03:13 INFO - 'SHELL': '/bin/bash', 21:03:13 INFO - 'SHLVL': '1', 21:03:13 INFO - 'TERM': 'linux', 21:03:13 INFO - 'TMOUT': '86400', 21:03:13 INFO - 'USER': 'cltbld', 21:03:13 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1495387086.920749-543998877', 21:03:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:03:13 INFO - '_': '/tools/buildbot/bin/python'} 21:03:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:03:13 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 21:03:13 INFO - Cleaning up... 21:03:13 INFO - Return code: 0 21:03:13 INFO - Running post-action listener: _resource_record_post_action 21:03:13 INFO - Running post-action listener: _start_resource_monitoring 21:03:13 INFO - Starting resource monitoring. 21:03:13 INFO - [mozharness: 2017-05-22 04:03:13.980467Z] Finished create-virtualenv step (success) 21:03:13 INFO - [mozharness: 2017-05-22 04:03:13.980996Z] Running install step. 21:03:13 INFO - Running pre-action listener: _resource_record_pre_action 21:03:13 INFO - Running main action method: install 21:03:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:03:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:03:14 INFO - Reading from file tmpfile_stdout 21:03:14 INFO - Detecting whether we're running mozinstall >=1.0... 21:03:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:03:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:03:14 INFO - Reading from file tmpfile_stdout 21:03:14 INFO - Output received: 21:03:14 INFO - Usage: mozinstall [options] installer 21:03:14 INFO - Options: 21:03:14 INFO - -h, --help show this help message and exit 21:03:14 INFO - -d DEST, --destination=DEST 21:03:14 INFO - Directory to install application into. [default: 21:03:14 INFO - "/builds/slave/test"] 21:03:14 INFO - --app=APP Application being installed. [default: firefox] 21:03:14 INFO - mkdir: /builds/slave/test/build/application 21:03:14 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'] 21:03:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 21:03:29 INFO - Reading from file tmpfile_stdout 21:03:29 INFO - Output received: 21:03:29 INFO - /builds/slave/test/build/application/firefox/firefox 21:03:29 INFO - Running post-action listener: _resource_record_post_action 21:03:29 INFO - [mozharness: 2017-05-22 04:03:29.962487Z] Finished install step (success) 21:03:29 INFO - [mozharness: 2017-05-22 04:03:29.962756Z] Running run-tests step. 21:03:29 INFO - Running pre-action listener: _resource_record_pre_action 21:03:29 INFO - Running main action method: run_tests 21:03:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:03:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:03:29 INFO - Python 2.7.3 21:03:29 INFO - Return code: 0 21:03:29 INFO - grabbing minidump binary from tooltool 21:03:29 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')]} 21:03:29 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 0x19447a0>, '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 0x19456a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1945b30>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:03:29 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 21:03:29 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 21:03:29 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 21:03:30 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:03:30 INFO - Return code: 0 21:03:30 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 21:03:30 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:03:30 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:03:30 INFO - ENV: RUST_BACKTRACE is now 1 21:03:30 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 21:03:30 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:03:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FSfiA2TOTQKNqkDonq3I0g/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-027', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 21:03:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/FSfiA2TOTQKNqkDonq3I0g/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-027 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 21:03:30 INFO - Using env: {'DISPLAY': ':0', 21:03:30 INFO - 'HOME': '/home/cltbld', 21:03:30 INFO - 'LANG': 'en_US.UTF-8', 21:03:30 INFO - 'LANGUAGE': 'en_US:en', 21:03:30 INFO - 'LOGNAME': 'cltbld', 21:03:30 INFO - 'MAIL': '/var/mail/cltbld', 21:03:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:03:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 21:03:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:03:30 INFO - 'MOZ_NO_REMOTE': '1', 21:03:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:03:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:03:30 INFO - 'NO_EM_RESTART': '1', 21:03:30 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:03:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:03:30 INFO - 'PWD': '/builds/slave/test', 21:03:30 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:03:30 INFO - 'RUST_BACKTRACE': '1', 21:03:30 INFO - 'SHELL': '/bin/bash', 21:03:30 INFO - 'SHLVL': '1', 21:03:30 INFO - 'TERM': 'linux', 21:03:30 INFO - 'TMOUT': '86400', 21:03:30 INFO - 'USER': 'cltbld', 21:03:30 INFO - 'XDG_SESSION_COOKIE': '1f5564757af27664ca02d71f000001b0-1495387086.920749-543998877', 21:03:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:03:30 INFO - '_': '/tools/buildbot/bin/python'} 21:03:30 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FSfiA2TOTQKNqkDonq3I0g/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-027', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 21:03:30 INFO - mozversion application_buildid: 20170522033059 21:03:30 INFO - mozversion application_changeset: 9851fcb0bf4d855c36729d7de19f0fa5c9f69776 21:03:30 INFO - mozversion application_display_name: Nightly 21:03:30 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:03:30 INFO - mozversion application_name: Firefox 21:03:30 INFO - mozversion application_remotingname: firefox 21:03:30 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 21:03:30 INFO - mozversion application_vendor: Mozilla 21:03:30 INFO - mozversion application_version: 55.0a1 21:03:30 INFO - mozversion platform_buildid: 20170522033059 21:03:30 INFO - mozversion platform_changeset: 9851fcb0bf4d855c36729d7de19f0fa5c9f69776 21:03:30 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 21:03:30 INFO - mozversion platform_version: 55.0a1 21:03:30 INFO - using testdate: 1495425810 21:03:30 INFO - actual date: 1495425810 21:03:30 INFO - starting webserver on 'localhost:53624' 21:03:30 INFO - SUITE-START | Running 2 tests 21:03:30 INFO - TEST-START | dromaeo_css 21:03:30 INFO - operating with platform_type : linux_ 21:03:30 INFO - Initialising browser for dromaeo_css test... 21:03:30 INFO - TEST-INFO | started process 22840 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRCHYCV/profile http://localhost:53624/getInfo.html) 21:03:30 INFO - PID 22840 | JavaScript warning: resource://gre/modules/addons/XPIProvider.jsm, line 2978: String.localeCompare is deprecated; use String.prototype.localeCompare instead 21:03:34 INFO - PID 22840 | __metrics Screen width/height:1600/1200 21:03:34 INFO - PID 22840 | colorDepth:24 21:03:34 INFO - PID 22840 | Browser inner width/height: 1024/695 21:03:34 INFO - PID 22840 | __metrics 21:03:36 INFO - TEST-INFO | 22840: exit 0 21:03:36 INFO - Browser initialized. 21:03:36 INFO - Running cycle 1/1 for dromaeo_css test... 21:03:36 INFO - TEST-INFO | started process 23001 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRCHYCV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:03:47 INFO - PID 23001 | RSS: Main: 167518208 21:03:47 INFO - PID 23001 | 21:06:52 INFO - PID 23001 | Cycle 1(1): loaded http://localhost:53624/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53624/tests/dromaeo/cssquery-ext.html) 21:06:54 INFO - PID 23001 | RSS: Main: 169816064 21:06:54 INFO - PID 23001 | 21:09:56 INFO - PID 23001 | Cycle 1(1): loaded http://localhost:53624/tests/dromaeo/cssquery-ext.html (next: http://localhost:53624/tests/dromaeo/cssquery-jquery.html) 21:09:56 INFO - PID 23001 | RSS: Main: 169066496 21:09:56 INFO - PID 23001 | 21:12:58 INFO - PID 23001 | Cycle 1(1): loaded http://localhost:53624/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53624/tests/dromaeo/cssquery-mootools.html) 21:12:59 INFO - PID 23001 | RSS: Main: 170827776 21:12:59 INFO - PID 23001 | 21:16:01 INFO - PID 23001 | Cycle 1(1): loaded http://localhost:53624/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53624/tests/dromaeo/cssquery-prototype.html) 21:16:01 INFO - PID 23001 | RSS: Main: 168886272 21:16:01 INFO - PID 23001 | 21:19:04 INFO - PID 23001 | Cycle 1(1): loaded http://localhost:53624/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53624/tests/dromaeo/cssquery-yui.html) 21:19:05 INFO - PID 23001 | RSS: Main: 168497152 21:19:05 INFO - PID 23001 | 21:22:06 INFO - PID 23001 | Cycle 1(1): loaded http://localhost:53624/tests/dromaeo/cssquery-yui.html (next: http://localhost:53624/tests/dromaeo/cssquery-dojo.html) 21:22:07 INFO - PID 23001 | RSS: Main: 171806720 21:22:07 INFO - PID 23001 | 21:22:07 INFO - PID 23001 | __start_tp_report 21:22:07 INFO - PID 23001 | _x_x_mozilla_page_load 21:22:07 INFO - PID 23001 | _x_x_mozilla_page_load_details 21:22:07 INFO - PID 23001 | |i|pagename|runs| 21:22:07 INFO - PID 23001 | |0;dojo.html;2693.1785805329373;2705.4453836963426;2717.008291973429;2737.27462222511;2743.465024320258;5079.339685840845;5172.896542069166;5217;5232.34595675541;5267.473252674736;5219.634625576211;5222.451642577532;5276.868078298045;5286.471352864712;5327.041132596131;4401.427814384126;4624.468186158601;4691.7888695008805;4733.029728905566;4744.85765427036;4739.241721324589;4773.880652983686;4795.352627395309;4795.8561243162585;4816.662833601649;4621.3299071634765;4664.207084795559;4688.578027977498;4702.8118875244945;4730.432348118248;4716.882077948045;4720.079584480994;4720.291956206596;4752.287156926454;4770.594499467549;4653.092646933849;4680.4149481314835;4689.929651055203;4691.225947718623;4720.929186062212;5165.793368265265;5259.474052594748;5267.078261304295;5267.26258323835;5282.31329927107;5568.276124103881;5661.433856614347;5686.260786097822;5700.2589663343915;5724.39893811148;5615.494605485526;5620.325560932673;5627.324721033502;5631.324241091054;5636.633618814764;5208.244804503326;5215.973920130375;5219.5041471060185;5247.606429517801;5258.50044245796;5690.2887139107615;5755.827325180251;5770.422957704196;5780.612652963258;5814.098814683731;5582.7766889323975;5596.888062238732;5597.496225339739;5606.411326810626;5609.887802244014;5534.1975413564805;5612.579056570774;5629.802956896489;5661.943380566224;5707.058335374617;5528.5024347808085;5589.776408943678;5593.776248950077;5594.412586678422;5634.943650563442;5473.562115030788;5575.776968921197;5598.3282006159525;5640.379558248589;5673.06394444912;4647.58171764536;4687.437507499122;4698.130845793539;4710.528947105262;4728.243481043017;4029.798510074543;4040.5353384361174;4047.372657238133;4074.409210664496;4101.1387608601935;4660.161170989187;4709.411323584552;4715.339852420664;4732.858014259577;4791.880202994953;5512.779488820483;5594.664320140723;5605.635633683797;5611.6071874969175;5614.494695477427;4625.283081122364;4648.721076735406;4670.065986802653;4673.158831410379;4682.765861706901;4939.086269040239;4995.525425084611;5002.499750025041;5017.799288028438;5019.623528235324;5124.897502050013;5226.503482169188;5235.790568377222;5265.894682106336;5267.394249661338;5636.746346414503;5640.576956728344;5652.802151924663;5658.377578466283;5698.971505142447;5164.638475306842;5222.294990176278;5249.95000999794;5335.919961200662;5352;5617.578681598815;5657.43425657431;5663.037283661705;5667.744951477111;5686.744096515749;5709.172170035405;5748.195252664546;5750.166225897138;5751.482366587027;5764.19301297827;5438.83683489496;5484.698341591091;5533.170024496197;5540.91688624679;5563.833085007456;5479.369872464558;5485.533729632866;5500.202470641814;5511.22842802;5538.612297139322;5347.919781203207;5385.784568617368;5388.030154572215;5420.566354691694;5460.726963651881;5380.73096345189;5459.754311056092;5467.289252397163;5512.200730893917;5523.254360661259;5383.5423988961375;5400.324959380077;5423.538999184956;5443.945560544502;5449.918251226156 21:22:07 INFO - PID 23001 | |1;ext.html;654.9050387693785;697.6511744127936;726.6257877193246;1159.4898244772305;1210.9576164834232;35377.646223537755;36162.276754464925;36172.276554468895;36450;36455.81772091139;34131;34201.31597368051;34279.485807712845;34385.48421773675;34387.656123438755;6586;6706.2287836898895;6936.132983377078;7031.367176954073;7100.360967512923;7018.227994920555;7072.752453664123;7099.680514376865;7111.080008397729;7151.427885769126;7013.649317534128;7062.223155452896;7075.893861592081;7088.220295767462;7122.537035092729;7042.436605071582;7044.859102817915;7079.61062141582;7119.92880071203;7123.928760712379;6995.510314278003;7056.647167641649;7120;7126.35862772353;7133.928660713378;33012.6698733012;33078.1883539897;33123.3375332492;33265.168370790685;33402.33195336104;3022.455957927572;3061.755059595227;3067.2025273428844;3075.354175623122;3094.4739394303024;24633.137840175506;24644.876775616187;24698.876505617536;24727.87636061808;24770.876145619157;3129.2489802447476;3148.464760990637;3159.7788154829173;3166.667499912522;3179.0780673604627;148224.258878706;148518;148836.99999999892;150436;155617;40548.1890362197;40673;40733.79633101816;40932.795336023126;40994.1801163975;41753.48437281258;42221.788891055345;42284.57715422868;44491.33263001058;45304.54695453069;11786.116041296937;11867.109966752529;11985.700357491132;12019.699507512381;12032.518699251932;9786.951065244628;9812.95093524542;9850.162736167505;9864.408135511749;9869.21046316293;12846.229226246269;12970.546030889062;13011.544595939096;13041.413136408695;13130.146540474838;5330.493603107699;5372.140457526777;5470.425605311465;5560.888782224414;5591.133374326986;856.1609622569916;904.6969265296068;919.7470695558775;920.59953920045;956.1585804492141;21277;21388.78611213899;21869.890650546964;21917.561648766936;22161.778382216293;984.9655262065793;985.2955137077024;994.4282037828277;999.6657804027677;1004.5077911823154;11221.775564488664;11600.187986841009;11678.182527223184;11710.824337634942;11800.70498237551;165852;167463.1626841858;168849;169198;189393;46299.074018519445;46759.532404676196;46903.296450553265;46939;47075.293870591966;1210.352461433129;1260.9369531523387;1261.0542093429929;1261.344101067458;1269.5366191340095;24768.380790480383;25240.368990775376;26353;26403.735962640898;26677.86661066682;31419.84290078535;38508.614913850506;39247.41128883126;39307.80346098251;39618.60381396265;176155;178075.06949026888;178309;178355;178708.10645946686;30843.845780770953;30898.227544311572;31345.05964821059;31431.528527071656;31491;37174.442383363734;37610.2477950434;38360.2327953445;38577.22845543017;38628.613713863626;28481.85759071274;28829.693624510408;29114.7088529112;29216.269593259487;29318.41363172682;27612;28148.43703125967;28323.858380707963;29056.41887162287;29689.109326720234;31609.20976975502;31639.841800791768;32135.839320803247;32140.517892232103;32172;26938;28003;28330.150095497167;28409.28976775597;29389.853050734608;22019.889900551036;22432.102715891833;22591.774082258966;22763;22873.428164296027 21:22:07 INFO - PID 23001 | |2;jquery.html;405.86403554809135;410.0875551897029;415.14894466343986;420.57521902878085;437.6455071392173;16882.831171688296;17520.561985950357;17545.21046552905;17596.384126555575;18258.634827303445;17291.654166916687;17583.29666813329;17648.558786030357;17654.911725441354;17965.10174491277;5307.283516725241;5492.5605951523785;5533.723313834313;5573.27547418835;5575.749091290902;5349.973250133763;5525.585581081435;5528.585356098289;5535.6955367454775;5536.667799931997;4781.545753153445;4847.030593881238;5403.78384864605;5437.8368648940595;5479.04116779562;5491.36849262332;5491.835244942638;5513.751881165317;5528.474794894479;5537.36320323164;4877.244027175793;4897.681650692729;4919.581835543983;4961.18140506816;4999.875003124915;22074.33776986693;22433.32700019002;22588.77411225883;22731;22788.948994590402;1599.09651047158;1615.814181369146;1616.458486407055;1616.9272382742688;1627.4059968111553;15058.623534411618;15553.91122621417;15627.531174064796;16214.51356459308;16749.581260468465;2107.5784843031456;2140.668196429556;2146.399008277685;2153.23560136151;2292.942676433086;91329.54335228281;92819;93691.53154234185;95097.52451237768;96003.51998240034;10845;10976.890231097746;10994;11361.091112710963;11581.88418115825;14734.557963261119;14801.555953321418;14802.777958330633;14870.925645371704;14897.553073407815;6646.933530664632;6936.890097584464;7054.858902821915;7058.11773528309;7059.082319298458;6215.943289640772;6371.362863713684;6761.715274097905;6772.221194562689;6777.966110169417;6792.660366981631;7019.964900175569;7038.472114591426;7064.788056358318;7084.326988936043;1943.1353047893551;1960.696092105726;1961.0978949683306;2097.370788763365;2282.7374851891914;848.7029539661193;872.7469033980202;884.39860894591;884.5179377239419;899.595182168027;17425.65148697019;17521.29914803419;17748.201330940137;18119.12413421433;18320.816791831912;856.9871451928226;866.1208872993916;871.4422769427572;873.8514452543083;884.2616415293173;9524.8571271431;9931.553080111413;9991.750206244757;10025.949870250603;10049.547770350351;353029;355231;357072;359694;360173;70387;70861;71603.6419817908;71657.64171179215;73486.63256683682;1040.666986564292;1069.8555694981233;1069.893010698924;1070.1652710885521;1077.5905156040653;15125.848741512884;15194;15378.307976140877;15512.293647698518;15590.84409155894;37860.81069594635;37977.43033854439;38002.429963550014;38494;38802.80598596989;46197;46249.306260406796;48114.75942620265;48587;48774;8090.959545202236;8177.100518943031;8200.630971606412;8264.21489958453;8379.874301885355;12877.484900603871;13118.278494682883;13244.404001819748;13245.933770331087;13706;10883.564657413615;11505.712357191138;11554.248973816675;11737.061035117;11960.282383057045;10731.40977246259;11154;11160.55357785712;11190.594022285248;11414.771704566028;11934.343611101473;11946;12142.939285303517;12191.207571507824;12267.693307667023;8369.0375606806;8393.412461127662;8395.32837373021;8436.662533498591;8477.152284771473;11222.55109795599;11273.774524509628;11484.138689598147;11668.649940501798;11782.057435405319 21:22:07 INFO - PID 23001 | |3;mootools.html;1239.4236679943826;1296.7212049409375;1301.0827366706474;1302.8176055352253;1308.9280089595072;9552.379095358805;9932.553035113418;9943.10512053915;9986.850197247039;10108.696739097839;9878.901210987888;9945.254105942047;9962.501874906262;10011.549480273387;10042.046005629472;2226.6326056200705;2257.5146343536135;2267.5691618592496;2276.226083131735;2279.509905370345;2164;2204.801567858892;2209.9889500552476;2216.3794137641407;2223.0885337011828;2214.523877366366;2223.3330000999636;2253.425376528991;2262.909483620653;2263.4567703751145;2081.4856554866788;2099.8530102892805;2103.2848831397323;2118.7881211878844;2121.819645330149;2063.226290141197;2124.915003399862;2131.989340053305;2207.6798864164607;2216.0803266644325;9659.951700241523;9806.607735690564;9861.309708320421;9874.456904870229;9877.851832222523;5082.08522465956;5153.433122356538;5247.134222853225;5249.68501889884;5253.763580638881;3162.177833763215;3357.7649564530493;3415.419378705626;3441.500982357544;3459.377312083824;1114.153243534911;1124.3872089711126;1148.0585919545977;1150.4362862197547;1161.506359797083;13433.194008359433;13533.458661653522;13542.59372218835;13558.389872455764;13568.864311356958;4521.131057594054;4575.679702420799;4641.396618439581;4701.106789709944;4777.904441911142;10130.949345253373;10167.237457190593;10178.338408003456;10225.233107516966;10234.48827558619;5325.281087053276;5332.306800116037;5346.4118946915805;5364.517193452608;5365.382980957162;4696.0842635686395;4730.787114579852;4872.512748725099;4875.609951203895;4890.168671325812;3631.891043268706;3743;3764.4353346997623;3833.5399752029375;3862.3627101528496;991.1476130527741;993.3046867192994;1007.0584003956325;1007.1036777268237;1009.8232809258498;690.3407246079981;702.6205848841671;707.5118168463744;722.6531264992727;725.582789895812;5049.116404629175;5134.332536770271;5139.486051394905;5199.63602547818;5306.787728490817;543.1255678357841;555.4001678187548;556.7967691792467;557.1058451185788;558.4750334685383;3323.601167859824;3567.571891373052;3593;3617.4031284838234;3691.9077023074638;11694.70763230926;11932.28406295625;11934.761304773856;11947.283163010246;12002;11713.648590542298;11874.1094417919;11943.880561194277;11977.940110299392;11984.820227696591;6515.446187074057;6811.897821532681;6906.171259448798;6920.342567456084;6984.79045628632;5405.7836986677685;5436.945630543644;5438.23864658956;5554.861128471821;5687.8862422752145;10289.228307876789;10551.78896422052;10581.52383142745;10744.462776861283;10744.83882741775;10835.837462437912;10921;10921.399323037309;10937.289076210021;10943.671689849318;6946.895796563157;7000.0199972004975;7057.717691292496;7060.329268719669;7084.64576771149;8674.78313042179;8682.262007729414;8711.607977641148;8785.380297697986;8830.116988301119;7669.693212271447;7721.459497835098;7731.613419328898;7741.458097933316;7825.960870195612;7426.183119856703;7452;7483.32650061497;7618.5809780462605;7718.884216736866;6458.806235812933;6536;6555.672216389257;6601.570897891622;6628.304028077176;4709.5290470954005;4784.40194975628;4879.048585525788;5025.145725226647;5066.341375621146;5217.765200566059;5223.347081614798;5314.3091398117995;5357.062514060101;5408.648437851527 21:22:07 INFO - PID 23001 | |4;prototype.html;377.24174409437023;386.69837526729145;397.2313573235787;398.9940150897737;399.38095951275534;5323.973380133094;5445.264889239947;5453.400125986143;5465.6447330923465;5487.533559647425;5261.526462618363;5290.523852853243;5321.414644389124;5333.306670132887;5334.253204551366;4049.6557792587664;4055.2497787909183;4063.1264278180183;4067.7355971861807;4073.9185216295805;3894.987303301148;4026.758394496325;4055.229506393776;4060.736052156615;4088.5911408859174;4017.5781542938007;4021.2158629067344;4026.557078721353;4029.053172504474;4039.7778122203267;4004.379321205218;4009.558948515661;4028.295048366524;4045.745818796168;4051.9797401012806;3528.735344849121;3535.487354333633;3543.291341731664;3547.5565554305713;3568.982155089234;5223.190405487156;5238.114278859607;5250.527452529291;5251.553617942442;5314.256004159421;4728.40894888139;4738.407699037621;4742.430908290993;4746.359241502422;4762.214234651313;5517.586181036399;5653.434656534355;5671.716414179275;5678.290213723285;5685.630434021776;3902.824372903226;3911.471951286568;3922.6466868930174;3933.3509970854775;3951.308521008812;5860.648361098348;5978.372270911578;5999.76000959961;6002.429769171922;6040.879182416327;4011.4183443400543;4015.8554811878475;4022.7988600569856;4027.35562310029;4039.2325458162854;4084.0402505411203;4093.836246550164;4094.263032654091;4094.5905409458815;4099.200655872136;4663.883402914887;4706.482286948433;4711.81152753886;4714.888173805272;4716.716996980193;5659.660420374791;5666.065099258659;5681.659100453903;5712.742926568314;5719.656820590778;1389.5275606293908;1413.9646508837156;1420.4673247532176;1421.6019514535947;1425.1591560979073;893.4415990006246;946.8674385586023;952.8713623660717;954.9618015279311;963.633819148733;4829.082474329936;4853.325602667145;4858.368412106474;4865.854024379274;4889.902201955941;5893.440123188376;5895.4399332063385;5900.940990590125;5928.851778705567;5942.494887934487;4732.2428411454;4756.857294281177;4791.209450440708;4848.418189817245;4861.927071093936;3083.444979903639;3087.7684173686616;3103.3172702005522;3110.8755649773757;3111.346617210366;5468.28912241414;5481.506664400223;5497.8075767347955;5512.889742205133;5539.473749993744;5869.941300586939;5998.1602575639445;6049.364816694272;6052.969735151296;6068.726907289182;5487.64330318528;5492.670439773627;5513.09034009384;5526.447355264441;5550.389457159628;5697.601167918372;5830.47525722687;5843.970780146072;5855.209546711139;5916.26046744157;5758.71206439668;5781.94218057814;5790.392008839011;5790.710464476843;5819.388964158702;5319.38827034896;5503.394626590992;5540.473655002768;5545.279113715191;5560.443955604407;4046.684827431038;4060.7969601520394;4075.735077219971;4079.7756123413496;4093.2808220546844;5877.382874798084;5940.6435613863305;5951.345352011362;5970.74614330978;5977.193078934462;5728.713564321684;5731.197632331394;5740.712964351682;5742.794013257263;5772.3650398456975;5693.857653558529;5708.514776244066;5714.79998200061;5748.540116790563;5753.769849205984;5442.972785136049;5573.860653483695;5641.435856414326;5650.039493286069;5658.292713410824;5739.62692424991;5755.798267264837;5779.450952159538;5785.247917770831;5785.508231800344;5431.945680543144;5578.442155784389;5580.972095139498;5588.804391846266;5609.158626206102 21:22:07 INFO - PID 23001 | |5;yui.html;736.9668364923579;739.71890681541;742.4134933402612;762.039829814434;767.9808004799879;13495.1228170169;13916.512922047717;13962;14932.253387330644;15127.84872151278;15309;15778.132202728846;15850.682986340265;15903.92048039761;15908.125053122103;890.5903284489143;897.2463130969984;905.597009330848;906.7461110888929;907.0249481807051;899.1817446124029;908.1372695938851;909.4225167018958;914.3279689428265;915.3135148638521;958.9232861371073;963.7590602349412;965.9565319560637;966.6665000574826;968.6464440479209;949.7198326493666;949.8812648418948;950.230313446104;950.3442624589046;951.6764300137952;705.4814711187273;705.675389320913;706.1244057368878;706.3325157725951;706.4313227851577;13046.347682615926;13186.604401867959;13256.3371831409;13286.468541258339;13293.468261269538;14933.328000240015;15553;15670.216489175496;16201.675966480605;16414.589635259093;12261.386930653433;12475.126741128124;12581.308028058453;12590;12701.110922235448;2891.277180704824;2900.521413966714;2901.50674385355;2924.926876828075;2925.9414811703646;71008;71095.64452177758;71671.28328716698;72569.46874781243;73710.26289737088;12060.095492838072;12320.322382268881;12467.563635272903;12468.688282793002;12492.188007779465;20929.26747563828;23078.769212307663;23127.3061808146;23371.182008629617;23375.41561460977;6088.299845517734;6218.875622487525;6312.779052733133;6325.936740632626;6334.968325158345;2860.2134413036165;2905.404392099657;2910.3015276333526;2923.0353983185496;2936.0898121582377;3528.6824185822884;3549.254656522108;3632.3098611263777;3645.872394466181;3660.450932360114;727.752564128199;742.3912391838749;744.5644298085572;745.9552426854406;748.3713680508399;559.7517535894978;580.9302883653988;595.1935127901718;620.2587907450643;630.7413960276265;9917.702468925943;10326.948365258277;10557.63048293306;10801.945990269998;10902.890971090346;611.9449249567472;617.0836308082494;622.1662971618053;634.6445990245477;638.9041643753474;4257.467816522934;4510.526394728572;4621.815127394933;4653;4721.95278047222;61053.38946610477;62761;63117;65763.34236657667;66738.33261667419;50500;54090;54773;54837.1774423384;55150;44522.3216517525;44589.55410445919;45046.32430513545;45089;45126.774366127305;9873.555689993824;10430;10487;10601.310914790514;10829.18781091437;24877.626835597843;25180.11869584556;25516.744832551438;25550.488990220463;26302.079427219956;29418.970336038135;29666.110016699535;29981.100566983027;30093.548596771503;30540.08379748611;13093.952483801464;13189.868101318863;13210.537631182862;13256.867431325563;13448.93275533616;15512.146831923901;15636.843631563539;15831.525054248392;15836.60408489797;15946.840531595;14102.929485352508;14415.621422465596;14531.564053078424;14766.261686915826;14881.181535015678;14136.858631413554;14227;14415.639609009859;14612.92693536568;14813.925930370278;13901.513447029305;13939.233342166279;14098.083624564371;14114.858851411354;14173.291335433394;9913.65302214419;10017.098461138532;10035.448050357008;10114.393136411838;10203.38779673222;10737.14102871784;11105;11276.404203782968;11317.830232546683;11352.375619341015 21:22:07 INFO - PID 23001 | __end_tp_report 21:22:07 INFO - PID 23001 | __start_cc_report 21:22:07 INFO - PID 23001 | _x_x_mozilla_cycle_collect,288 21:22:07 INFO - PID 23001 | __end_cc_report 21:22:07 INFO - PID 23001 | __startTimestamp1495426927000__endTimestamp 21:22:07 INFO - PID 23001 | 21:22:07 INFO - PID 23001 | ------- Summary: start ------- 21:22:07 INFO - PID 23001 | Number of tests: 6 21:22:07 INFO - PID 23001 | 21:22:07 INFO - PID 23001 | [#0] dojo.html Cycles:165 Average:5158.27 Median:5327.04 stddev:607.59 (11.4%) stddev-sans-first:577.87 21:22:07 INFO - PID 23001 | Values: 2693.2 2705.4 2717.0 2737.3 2743.5 5079.3 5172.9 5217.0 5232.3 5267.5 5219.6 5222.5 5276.9 5286.5 5327.0 4401.4 4624.5 4691.8 4733.0 4744.9 4739.2 4773.9 4795.4 4795.9 4816.7 4621.3 4664.2 4688.6 4702.8 4730.4 4716.9 4720.1 4720.3 4752.3 4770.6 4653.1 4680.4 4689.9 4691.2 4720.9 5165.8 5259.5 5267.1 5267.3 5282.3 5568.3 5661.4 5686.3 5700.3 5724.4 5615.5 5620.3 5627.3 5631.3 5636.6 5208.2 5216.0 5219.5 5247.6 5258.5 5690.3 5755.8 5770.4 5780.6 5814.1 5582.8 5596.9 5597.5 5606.4 5609.9 5534.2 5612.6 5629.8 5661.9 5707.1 5528.5 5589.8 5593.8 5594.4 5634.9 5473.6 5575.8 5598.3 5640.4 5673.1 4647.6 4687.4 4698.1 4710.5 4728.2 4029.8 4040.5 4047.4 4074.4 4101.1 4660.2 4709.4 4715.3 4732.9 4791.9 5512.8 5594.7 5605.6 5611.6 5614.5 4625.3 4648.7 4670.1 4673.2 4682.8 4939.1 4995.5 5002.5 5017.8 5019.6 5124.9 5226.5 5235.8 5265.9 5267.4 5636.7 5640.6 5652.8 5658.4 5699.0 5164.6 5222.3 5250.0 5335.9 5352.0 5617.6 5657.4 5663.0 5667.7 5686.7 5709.2 5748.2 5750.2 5751.5 5764.2 5438.8 5484.7 5533.2 5540.9 5563.8 5479.4 5485.5 5500.2 5511.2 5538.6 5347.9 5385.8 5388.0 5420.6 5460.7 5380.7 5459.8 5467.3 5512.2 5523.3 5383.5 5400.3 5423.5 5443.9 5449.9 21:22:07 INFO - PID 23001 | 21:22:07 INFO - PID 23001 | [#1] ext.html Cycles:180 Average:31986.65 Median:17657.46 stddev:43219.07 (244.8%) stddev-sans-first:43276.28 21:22:07 INFO - PID 23001 | Values: 654.9 697.7 726.6 1159.5 1211.0 35377.6 36162.3 36172.3 36450.0 36455.8 34131.0 34201.3 34279.5 34385.5 34387.7 6586.0 6706.2 6936.1 7031.4 7100.4 7018.2 7072.8 7099.7 7111.1 7151.4 7013.6 7062.2 7075.9 7088.2 7122.5 7042.4 7044.9 7079.6 7119.9 7123.9 6995.5 7056.6 7120.0 7126.4 7133.9 33012.7 33078.2 33123.3 33265.2 33402.3 3022.5 3061.8 3067.2 3075.4 3094.5 24633.1 24644.9 24698.9 24727.9 24770.9 3129.2 3148.5 3159.8 3166.7 3179.1 148224.3 148518.0 148837.0 150436.0 155617.0 40548.2 40673.0 40733.8 40932.8 40994.2 41753.5 42221.8 42284.6 44491.3 45304.5 11786.1 11867.1 11985.7 12019.7 12032.5 9787.0 9813.0 9850.2 9864.4 9869.2 12846.2 12970.5 13011.5 13041.4 13130.1 5330.5 5372.1 5470.4 5560.9 5591.1 856.2 904.7 919.7 920.6 956.2 21277.0 21388.8 21869.9 21917.6 22161.8 985.0 985.3 994.4 999.7 1004.5 11221.8 11600.2 11678.2 11710.8 11800.7 165852.0 167463.2 168849.0 169198.0 189393.0 46299.1 46759.5 46903.3 46939.0 47075.3 1210.4 1260.9 1261.1 1261.3 1269.5 24768.4 25240.4 26353.0 26403.7 26677.9 31419.8 38508.6 39247.4 39307.8 39618.6 176155.0 178075.1 178309.0 178355.0 178708.1 30843.8 30898.2 31345.1 31431.5 31491.0 37174.4 37610.2 38360.2 38577.2 38628.6 28481.9 28829.7 29114.7 29216.3 29318.4 27612.0 28148.4 28323.9 29056.4 29689.1 31609.2 31639.8 32135.8 32140.5 32172.0 26938.0 28003.0 28330.2 28409.3 29389.9 22019.9 22432.1 22591.8 22763.0 22873.4 21:22:07 INFO - PID 23001 | 21:22:07 INFO - PID 23001 | [#2] jquery.html Cycles:180 Average:24533.20 Median:359933.50 stddev:59558.68 (16.5%) stddev-sans-first:59698.20 21:22:07 INFO - PID 23001 | Values: 405.9 410.1 415.1 420.6 437.6 16882.8 17520.6 17545.2 17596.4 18258.6 17291.7 17583.3 17648.6 17654.9 17965.1 5307.3 5492.6 5533.7 5573.3 5575.7 5350.0 5525.6 5528.6 5535.7 5536.7 4781.5 4847.0 5403.8 5437.8 5479.0 5491.4 5491.8 5513.8 5528.5 5537.4 4877.2 4897.7 4919.6 4961.2 4999.9 22074.3 22433.3 22588.8 22731.0 22788.9 1599.1 1615.8 1616.5 1616.9 1627.4 15058.6 15553.9 15627.5 16214.5 16749.6 2107.6 2140.7 2146.4 2153.2 2292.9 91329.5 92819.0 93691.5 95097.5 96003.5 10845.0 10976.9 10994.0 11361.1 11581.9 14734.6 14801.6 14802.8 14870.9 14897.6 6646.9 6936.9 7054.9 7058.1 7059.1 6215.9 6371.4 6761.7 6772.2 6778.0 6792.7 7020.0 7038.5 7064.8 7084.3 1943.1 1960.7 1961.1 2097.4 2282.7 848.7 872.7 884.4 884.5 899.6 17425.7 17521.3 17748.2 18119.1 18320.8 857.0 866.1 871.4 873.9 884.3 9524.9 9931.6 9991.8 10025.9 10049.5 353029.0 355231.0 357072.0 359694.0 360173.0 70387.0 70861.0 71603.6 71657.6 73486.6 1040.7 1069.9 1069.9 1070.2 1077.6 15125.8 15194.0 15378.3 15512.3 15590.8 37860.8 37977.4 38002.4 38494.0 38802.8 46197.0 46249.3 48114.8 48587.0 48774.0 8091.0 8177.1 8200.6 8264.2 8379.9 12877.5 13118.3 13244.4 13245.9 13706.0 10883.6 11505.7 11554.2 11737.1 11960.3 10731.4 11154.0 11160.6 11190.6 11414.8 11934.3 11946.0 12142.9 12191.2 12267.7 8369.0 8393.4 8395.3 8436.7 8477.2 11222.6 11273.8 11484.1 11668.6 11782.1 21:22:07 INFO - PID 23001 | 21:22:07 INFO - PID 23001 | [#3] mootools.html Cycles:180 Average:5842.94 Median:4705.32 stddev:3640.99 (77.4%) stddev-sans-first:3634.77 21:22:07 INFO - PID 23001 | Values: 1239.4 1296.7 1301.1 1302.8 1308.9 9552.4 9932.6 9943.1 9986.9 10108.7 9878.9 9945.3 9962.5 10011.5 10042.0 2226.6 2257.5 2267.6 2276.2 2279.5 2164.0 2204.8 2210.0 2216.4 2223.1 2214.5 2223.3 2253.4 2262.9 2263.5 2081.5 2099.9 2103.3 2118.8 2121.8 2063.2 2124.9 2132.0 2207.7 2216.1 9660.0 9806.6 9861.3 9874.5 9877.9 5082.1 5153.4 5247.1 5249.7 5253.8 3162.2 3357.8 3415.4 3441.5 3459.4 1114.2 1124.4 1148.1 1150.4 1161.5 13433.2 13533.5 13542.6 13558.4 13568.9 4521.1 4575.7 4641.4 4701.1 4777.9 10130.9 10167.2 10178.3 10225.2 10234.5 5325.3 5332.3 5346.4 5364.5 5365.4 4696.1 4730.8 4872.5 4875.6 4890.2 3631.9 3743.0 3764.4 3833.5 3862.4 991.1 993.3 1007.1 1007.1 1009.8 690.3 702.6 707.5 722.7 725.6 5049.1 5134.3 5139.5 5199.6 5306.8 543.1 555.4 556.8 557.1 558.5 3323.6 3567.6 3593.0 3617.4 3691.9 11694.7 11932.3 11934.8 11947.3 12002.0 11713.6 11874.1 11943.9 11977.9 11984.8 6515.4 6811.9 6906.2 6920.3 6984.8 5405.8 5436.9 5438.2 5554.9 5687.9 10289.2 10551.8 10581.5 10744.5 10744.8 10835.8 10921.0 10921.4 10937.3 10943.7 6946.9 7000.0 7057.7 7060.3 7084.6 8674.8 8682.3 8711.6 8785.4 8830.1 7669.7 7721.5 7731.6 7741.5 7826.0 7426.2 7452.0 7483.3 7618.6 7718.9 6458.8 6536.0 6555.7 6601.6 6628.3 4709.5 4784.4 4879.0 5025.1 5066.3 5217.8 5223.3 5314.3 5357.1 5408.6 21:22:07 INFO - PID 23001 | 21:22:07 INFO - PID 23001 | [#4] prototype.html Cycles:180 Average:4678.63 Median:5333.78 stddev:1395.14 (26.2%) stddev-sans-first:1361.19 21:22:07 INFO - PID 23001 | Values: 377.2 386.7 397.2 399.0 399.4 5324.0 5445.3 5453.4 5465.6 5487.5 5261.5 5290.5 5321.4 5333.3 5334.3 4049.7 4055.2 4063.1 4067.7 4073.9 3895.0 4026.8 4055.2 4060.7 4088.6 4017.6 4021.2 4026.6 4029.1 4039.8 4004.4 4009.6 4028.3 4045.7 4052.0 3528.7 3535.5 3543.3 3547.6 3569.0 5223.2 5238.1 5250.5 5251.6 5314.3 4728.4 4738.4 4742.4 4746.4 4762.2 5517.6 5653.4 5671.7 5678.3 5685.6 3902.8 3911.5 3922.6 3933.4 3951.3 5860.6 5978.4 5999.8 6002.4 6040.9 4011.4 4015.9 4022.8 4027.4 4039.2 4084.0 4093.8 4094.3 4094.6 4099.2 4663.9 4706.5 4711.8 4714.9 4716.7 5659.7 5666.1 5681.7 5712.7 5719.7 1389.5 1414.0 1420.5 1421.6 1425.2 893.4 946.9 952.9 955.0 963.6 4829.1 4853.3 4858.4 4865.9 4889.9 5893.4 5895.4 5900.9 5928.9 5942.5 4732.2 4756.9 4791.2 4848.4 4861.9 3083.4 3087.8 3103.3 3110.9 3111.3 5468.3 5481.5 5497.8 5512.9 5539.5 5869.9 5998.2 6049.4 6053.0 6068.7 5487.6 5492.7 5513.1 5526.4 5550.4 5697.6 5830.5 5844.0 5855.2 5916.3 5758.7 5781.9 5790.4 5790.7 5819.4 5319.4 5503.4 5540.5 5545.3 5560.4 4046.7 4060.8 4075.7 4079.8 4093.3 5877.4 5940.6 5951.3 5970.7 5977.2 5728.7 5731.2 5740.7 5742.8 5772.4 5693.9 5708.5 5714.8 5748.5 5753.8 5443.0 5573.9 5641.4 5650.0 5658.3 5739.6 5755.8 5779.5 5785.2 5785.5 5431.9 5578.4 5581.0 5588.8 5609.2 21:22:07 INFO - PID 23001 | 21:22:07 INFO - PID 23001 | [#5] yui.html Cycles:180 Average:14952.39 Median:2931.02 stddev:17509.42 (597.4%) stddev-sans-first:17526.00 21:22:07 INFO - PID 23001 | Values: 737.0 739.7 742.4 762.0 768.0 13495.1 13916.5 13962.0 14932.3 15127.8 15309.0 15778.1 15850.7 15903.9 15908.1 890.6 897.2 905.6 906.7 907.0 899.2 908.1 909.4 914.3 915.3 958.9 963.8 966.0 966.7 968.6 949.7 949.9 950.2 950.3 951.7 705.5 705.7 706.1 706.3 706.4 13046.3 13186.6 13256.3 13286.5 13293.5 14933.3 15553.0 15670.2 16201.7 16414.6 12261.4 12475.1 12581.3 12590.0 12701.1 2891.3 2900.5 2901.5 2924.9 2925.9 71008.0 71095.6 71671.3 72569.5 73710.3 12060.1 12320.3 12467.6 12468.7 12492.2 20929.3 23078.8 23127.3 23371.2 23375.4 6088.3 6218.9 6312.8 6325.9 6335.0 2860.2 2905.4 2910.3 2923.0 2936.1 3528.7 3549.3 3632.3 3645.9 3660.5 727.8 742.4 744.6 746.0 748.4 559.8 580.9 595.2 620.3 630.7 9917.7 10326.9 10557.6 10801.9 10902.9 611.9 617.1 622.2 634.6 638.9 4257.5 4510.5 4621.8 4653.0 4722.0 61053.4 62761.0 63117.0 65763.3 66738.3 50500.0 54090.0 54773.0 54837.2 55150.0 44522.3 44589.6 45046.3 45089.0 45126.8 9873.6 10430.0 10487.0 10601.3 10829.2 24877.6 25180.1 25516.7 25550.5 26302.1 29419.0 29666.1 29981.1 30093.5 30540.1 13094.0 13189.9 13210.5 13256.9 13448.9 15512.1 15636.8 15831.5 15836.6 15946.8 14102.9 14415.6 14531.6 14766.3 14881.2 14136.9 14227.0 14415.6 14612.9 14813.9 13901.5 13939.2 14098.1 14114.9 14173.3 9913.7 10017.1 10035.4 10114.4 10203.4 10737.1 11105.0 11276.4 11317.8 11352.4 21:22:07 INFO - PID 23001 | -------- Summary: end -------- 21:22:07 INFO - PID 23001 | 21:22:07 INFO - TEST-INFO | 23001: exit 0 21:22:07 INFO - TEST-OK | dromaeo_css | took 1117675ms 21:22:07 INFO - TEST-START | kraken 21:22:07 INFO - operating with platform_type : linux_ 21:22:07 INFO - Initialising browser for kraken test... 21:22:07 INFO - TEST-INFO | started process 23402 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFwjTLZ/profile http://localhost:53624/getInfo.html) 21:22:08 INFO - PID 23402 | JavaScript warning: resource://gre/modules/addons/XPIProvider.jsm, line 2978: String.localeCompare is deprecated; use String.prototype.localeCompare instead 21:22:11 INFO - PID 23402 | __metrics Screen width/height:1600/1200 21:22:11 INFO - PID 23402 | colorDepth:24 21:22:11 INFO - PID 23402 | Browser inner width/height: 1024/695 21:22:11 INFO - PID 23402 | __metrics 21:22:13 INFO - TEST-INFO | 23402: exit 0 21:22:13 INFO - Browser initialized. 21:22:13 INFO - Running cycle 1/1 for kraken test... 21:22:13 INFO - TEST-INFO | started process 23568 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFwjTLZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:22:25 INFO - PID 23568 | RSS: Main: 167469056 21:22:25 INFO - PID 23568 | 21:22:28 INFO - PID 23568 | Cycle 1(1): loaded http://localhost:53624/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53624/tests/kraken/driver.html?testName=audio-beat-detection) 21:22:29 INFO - PID 23568 | RSS: Main: 171761664 21:22:29 INFO - PID 23568 | 21:22:31 INFO - PID 23568 | Cycle 1(1): loaded http://localhost:53624/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53624/tests/kraken/driver.html?testName=audio-dft) 21:22:32 INFO - PID 23568 | RSS: Main: 170074112 21:22:32 INFO - PID 23568 | 21:22:35 INFO - PID 23568 | Cycle 1(1): loaded http://localhost:53624/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53624/tests/kraken/driver.html?testName=audio-fft) 21:22:35 INFO - PID 23568 | RSS: Main: 165949440 21:22:35 INFO - PID 23568 | 21:22:38 INFO - PID 23568 | Cycle 1(1): loaded http://localhost:53624/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53624/tests/kraken/driver.html?testName=audio-oscillator) 21:22:38 INFO - PID 23568 | RSS: Main: 166273024 21:22:38 INFO - PID 23568 | 21:22:40 INFO - PID 23568 | Cycle 1(1): loaded http://localhost:53624/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53624/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:22:41 INFO - PID 23568 | RSS: Main: 166584320 21:22:41 INFO - PID 23568 | 21:22:44 INFO - PID 23568 | Cycle 1(1): loaded http://localhost:53624/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53624/tests/kraken/driver.html?testName=imaging-darkroom) 21:22:45 INFO - PID 23568 | RSS: Main: 171515904 21:22:45 INFO - PID 23568 | 21:22:48 INFO - PID 23568 | Cycle 1(1): loaded http://localhost:53624/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53624/tests/kraken/driver.html?testName=imaging-desaturate) 21:22:49 INFO - PID 23568 | RSS: Main: 168574976 21:22:49 INFO - PID 23568 | 21:22:52 INFO - PID 23568 | Cycle 1(1): loaded http://localhost:53624/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53624/tests/kraken/driver.html?testName=json-parse-financial) 21:22:52 INFO - PID 23568 | RSS: Main: 169635840 21:22:52 INFO - PID 23568 | 21:22:54 INFO - PID 23568 | Cycle 1(1): loaded http://localhost:53624/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53624/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:22:55 INFO - PID 23568 | RSS: Main: 169865216 21:22:55 INFO - PID 23568 | 21:22:56 INFO - PID 23568 | Cycle 1(1): loaded http://localhost:53624/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53624/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:22:57 INFO - PID 23568 | RSS: Main: 170012672 21:22:57 INFO - PID 23568 | 21:22:59 INFO - PID 23568 | Cycle 1(1): loaded http://localhost:53624/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53624/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:23:00 INFO - PID 23568 | RSS: Main: 169467904 21:23:00 INFO - PID 23568 | 21:23:02 INFO - PID 23568 | Cycle 1(1): loaded http://localhost:53624/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53624/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:23:03 INFO - PID 23568 | RSS: Main: 169414656 21:23:03 INFO - PID 23568 | 21:23:06 INFO - PID 23568 | Cycle 1(1): loaded http://localhost:53624/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53624/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:23:07 INFO - PID 23568 | RSS: Main: 169988096 21:23:07 INFO - PID 23568 | 21:23:09 INFO - PID 23568 | Cycle 1(1): loaded http://localhost:53624/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53624/tests/kraken/driver.html?testName=ai-astar) 21:23:09 INFO - PID 23568 | RSS: Main: 171065344 21:23:09 INFO - PID 23568 | 21:23:09 INFO - PID 23568 | __start_tp_report 21:23:09 INFO - PID 23568 | _x_x_mozilla_page_load 21:23:09 INFO - PID 23568 | _x_x_mozilla_page_load_details 21:23:09 INFO - PID 23568 | |i|pagename|runs| 21:23:09 INFO - PID 23568 | |0;ai-astar;105;113;113;113;117;113;111;112;113;114 21:23:09 INFO - PID 23568 | |1;audio-beat-detection;156;133;125;173;127;130;125;122;152;123 21:23:09 INFO - PID 23568 | |2;audio-dft;164;163;164;168;164;166;168;167;164;164 21:23:09 INFO - PID 23568 | |3;audio-fft;77;76;75;103;75;75;75;75;98;78 21:23:09 INFO - PID 23568 | |4;audio-oscillator;83;83;104;84;84;84;99;84;83;106 21:23:09 INFO - PID 23568 | |5;imaging-gaussian-blur;114;115;114;114;114;114;113;114;115;118 21:23:09 INFO - PID 23568 | |6;imaging-darkroom;151;150;151;159;149;150;150;151;152;150 21:23:09 INFO - PID 23568 | |7;imaging-desaturate;96;95;95;94;95;95;94;96;94;95 21:23:09 INFO - PID 23568 | |8;json-parse-financial;54;53;54;55;58;55;55;56;55;55 21:23:09 INFO - PID 23568 | |9;json-stringify-tinderbox;57;56;57;57;57;57;56;60;56;56 21:23:09 INFO - PID 23568 | |10;stanford-crypto-aes;83;81;81;92;91;82;84;84;81;82 21:23:09 INFO - PID 23568 | |11;stanford-crypto-ccm;136;141;134;142;134;134;148;141;188;141 21:23:09 INFO - PID 23568 | |12;stanford-crypto-pbkdf2;185;194;192;195;196;196;186;189;208;195 21:23:09 INFO - PID 23568 | |13;stanford-crypto-sha256-iterative;75;74;75;73;74;72;73;76;72;73 21:23:09 INFO - PID 23568 | __end_tp_report 21:23:09 INFO - PID 23568 | __start_cc_report 21:23:09 INFO - PID 23568 | _x_x_mozilla_cycle_collect,750 21:23:09 INFO - PID 23568 | __end_cc_report 21:23:09 INFO - PID 23568 | __startTimestamp1495426989542__endTimestamp 21:23:09 INFO - PID 23568 | 21:23:09 INFO - PID 23568 | ------- Summary: start ------- 21:23:09 INFO - PID 23568 | Number of tests: 14 21:23:09 INFO - PID 23568 | 21:23:09 INFO - PID 23568 | [#0] ai-astar Cycles:10 Average:112.40 Median:113.00 stddev:3.03 (2.7%) stddev-sans-first:1.64 21:23:09 INFO - PID 23568 | Values: 105.0 113.0 113.0 113.0 117.0 113.0 111.0 112.0 113.0 114.0 21:23:09 INFO - PID 23568 | 21:23:09 INFO - PID 23568 | [#1] audio-beat-detection Cycles:10 Average:136.60 Median:131.50 stddev:17.49 (13.3%) stddev-sans-first:17.09 21:23:09 INFO - PID 23568 | Values: 156.0 133.0 125.0 173.0 127.0 130.0 125.0 122.0 152.0 123.0 21:23:09 INFO - PID 23568 | 21:23:09 INFO - PID 23568 | [#2] audio-dft Cycles:10 Average:165.20 Median:165.00 stddev:1.87 (1.1%) stddev-sans-first:1.94 21:23:09 INFO - PID 23568 | Values: 164.0 163.0 164.0 168.0 164.0 166.0 168.0 167.0 164.0 164.0 21:23:09 INFO - PID 23568 | 21:23:09 INFO - PID 23568 | [#3] audio-fft Cycles:10 Average:80.70 Median:75.50 stddev:10.55 (14.0%) stddev-sans-first:11.11 21:23:09 INFO - PID 23568 | Values: 77.0 76.0 75.0 103.0 75.0 75.0 75.0 75.0 98.0 78.0 21:23:09 INFO - PID 23568 | 21:23:09 INFO - PID 23568 | [#4] audio-oscillator Cycles:10 Average:89.40 Median:84.00 stddev:9.55 (11.4%) stddev-sans-first:9.84 21:23:09 INFO - PID 23568 | Values: 83.0 83.0 104.0 84.0 84.0 84.0 99.0 84.0 83.0 106.0 21:23:09 INFO - PID 23568 | 21:23:09 INFO - PID 23568 | [#5] imaging-gaussian-blur Cycles:10 Average:114.50 Median:114.00 stddev:1.35 (1.2%) stddev-sans-first:1.42 21:23:09 INFO - PID 23568 | Values: 114.0 115.0 114.0 114.0 114.0 114.0 113.0 114.0 115.0 118.0 21:23:09 INFO - PID 23568 | 21:23:09 INFO - PID 23568 | [#6] imaging-darkroom Cycles:10 Average:151.30 Median:151.00 stddev:2.83 (1.9%) stddev-sans-first:3.00 21:23:09 INFO - PID 23568 | Values: 151.0 150.0 151.0 159.0 149.0 150.0 150.0 151.0 152.0 150.0 21:23:09 INFO - PID 23568 | 21:23:09 INFO - PID 23568 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.74 (0.8%) stddev-sans-first:0.67 21:23:09 INFO - PID 23568 | Values: 96.0 95.0 95.0 94.0 95.0 95.0 94.0 96.0 94.0 95.0 21:23:09 INFO - PID 23568 | 21:23:09 INFO - PID 23568 | [#8] json-parse-financial Cycles:10 Average:55.00 Median:55.00 stddev:1.33 (2.4%) stddev-sans-first:1.36 21:23:09 INFO - PID 23568 | Values: 54.0 53.0 54.0 55.0 58.0 55.0 55.0 56.0 55.0 55.0 21:23:09 INFO - PID 23568 | 21:23:09 INFO - PID 23568 | [#9] json-stringify-tinderbox Cycles:10 Average:56.90 Median:57.00 stddev:1.20 (2.1%) stddev-sans-first:1.27 21:23:09 INFO - PID 23568 | Values: 57.0 56.0 57.0 57.0 57.0 57.0 56.0 60.0 56.0 56.0 21:23:09 INFO - PID 23568 | 21:23:09 INFO - PID 23568 | [#10] stanford-crypto-aes Cycles:10 Average:84.10 Median:83.50 stddev:4.07 (4.9%) stddev-sans-first:4.29 21:23:09 INFO - PID 23568 | Values: 83.0 81.0 81.0 92.0 91.0 82.0 84.0 84.0 81.0 82.0 21:23:09 INFO - PID 23568 | 21:23:09 INFO - PID 23568 | [#11] stanford-crypto-ccm Cycles:10 Average:143.90 Median:141.00 stddev:16.15 (11.5%) stddev-sans-first:16.87 21:23:09 INFO - PID 23568 | Values: 136.0 141.0 134.0 142.0 134.0 134.0 148.0 141.0 188.0 141.0 21:23:09 INFO - PID 23568 | 21:23:09 INFO - PID 23568 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:193.60 Median:195.00 stddev:6.48 (3.3%) stddev-sans-first:6.09 21:23:09 INFO - PID 23568 | Values: 185.0 194.0 192.0 195.0 196.0 196.0 186.0 189.0 208.0 195.0 21:23:09 INFO - PID 23568 | 21:23:09 INFO - PID 23568 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.70 Median:74.00 stddev:1.34 (1.8%) stddev-sans-first:1.33 21:23:09 INFO - PID 23568 | Values: 75.0 74.0 75.0 73.0 74.0 72.0 73.0 76.0 72.0 73.0 21:23:09 INFO - PID 23568 | -------- Summary: end -------- 21:23:09 INFO - PID 23568 | 21:23:10 INFO - TEST-INFO | 23568: exit 0 21:23:10 INFO - TEST-OK | kraken | took 62721ms 21:23:10 INFO - SUITE-END | took 1180s 21:23:10 INFO - Completed test suite (00:19:40) 21:23:10 INFO - javascript benchmark 21:23:10 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6668.013946705071, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2693.1785805329373, 2705.4453836963426, 2717.008291973429, 2737.27462222511, 2743.465024320258, 5079.339685840845, 5172.896542069166, 5217.0, 5232.34595675541, 5267.473252674736, 5219.634625576211, 5222.451642577532, 5276.868078298045, 5286.471352864712, 5327.041132596131, 4401.427814384126, 4624.468186158601, 4691.7888695008805, 4733.029728905566, 4744.85765427036, 4739.241721324589, 4773.880652983686, 4795.352627395309, 4795.8561243162585, 4816.662833601649, 4621.3299071634765, 4664.207084795559, 4688.578027977498, 4702.8118875244945, 4730.432348118248, 4716.882077948045, 4720.079584480994, 4720.291956206596, 4752.287156926454, 4770.594499467549, 4653.092646933849, 4680.4149481314835, 4689.929651055203, 4691.225947718623, 4720.929186062212, 5165.793368265265, 5259.474052594748, 5267.078261304295, 5267.26258323835, 5282.31329927107, 5568.276124103881, 5661.433856614347, 5686.260786097822, 5700.2589663343915, 5724.39893811148, 5615.494605485526, 5620.325560932673, 5627.324721033502, 5631.324241091054, 5636.633618814764, 5208.244804503326, 5215.973920130375, 5219.5041471060185, 5247.606429517801, 5258.50044245796, 5690.2887139107615, 5755.827325180251, 5770.422957704196, 5780.612652963258, 5814.098814683731, 5582.7766889323975, 5596.888062238732, 5597.496225339739, 5606.411326810626, 5609.887802244014, 5534.1975413564805, 5612.579056570774, 5629.802956896489, 5661.943380566224, 5707.058335374617, 5528.5024347808085, 5589.776408943678, 5593.776248950077, 5594.412586678422, 5634.943650563442, 5473.562115030788, 5575.776968921197, 5598.3282006159525, 5640.379558248589, 5673.06394444912, 4647.58171764536, 4687.437507499122, 4698.130845793539, 4710.528947105262, 4728.243481043017, 4029.798510074543, 4040.5353384361174, 4047.372657238133, 4074.409210664496, 4101.1387608601935, 4660.161170989187, 4709.411323584552, 4715.339852420664, 4732.858014259577, 4791.880202994953, 5512.779488820483, 5594.664320140723, 5605.635633683797, 5611.6071874969175, 5614.494695477427, 4625.283081122364, 4648.721076735406, 4670.065986802653, 4673.158831410379, 4682.765861706901, 4939.086269040239, 4995.525425084611, 5002.499750025041, 5017.799288028438, 5019.623528235324, 5124.897502050013, 5226.503482169188, 5235.790568377222, 5265.894682106336, 5267.394249661338, 5636.746346414503, 5640.576956728344, 5652.802151924663, 5658.377578466283, 5698.971505142447, 5164.638475306842, 5222.294990176278, 5249.95000999794, 5335.919961200662, 5352.0, 5617.578681598815, 5657.43425657431, 5663.037283661705, 5667.744951477111, 5686.744096515749, 5709.172170035405, 5748.195252664546, 5750.166225897138, 5751.482366587027, 5764.19301297827, 5438.83683489496, 5484.698341591091, 5533.170024496197, 5540.91688624679, 5563.833085007456, 5479.369872464558, 5485.533729632866, 5500.202470641814, 5511.22842802, 5538.612297139322, 5347.919781203207, 5385.784568617368, 5388.030154572215, 5420.566354691694, 5460.726963651881, 5380.73096345189, 5459.754311056092, 5467.289252397163, 5512.200730893917, 5523.254360661259, 5383.5423988961375, 5400.324959380077, 5423.538999184956, 5443.945560544502, 5449.918251226156], "value": 5114.000912354787, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [654.9050387693785, 697.6511744127936, 726.6257877193246, 1159.4898244772305, 1210.9576164834232, 35377.646223537755, 36162.276754464925, 36172.276554468895, 36450.0, 36455.81772091139, 34131.0, 34201.31597368051, 34279.485807712845, 34385.48421773675, 34387.656123438755, 6586.0, 6706.2287836898895, 6936.132983377078, 7031.367176954073, 7100.360967512923, 7018.227994920555, 7072.752453664123, 7099.680514376865, 7111.080008397729, 7151.427885769126, 7013.649317534128, 7062.223155452896, 7075.893861592081, 7088.220295767462, 7122.537035092729, 7042.436605071582, 7044.859102817915, 7079.61062141582, 7119.92880071203, 7123.928760712379, 6995.510314278003, 7056.647167641649, 7120.0, 7126.35862772353, 7133.928660713378, 33012.6698733012, 33078.1883539897, 33123.3375332492, 33265.168370790685, 33402.33195336104, 3022.455957927572, 3061.755059595227, 3067.2025273428844, 3075.354175623122, 3094.4739394303024, 24633.137840175506, 24644.876775616187, 24698.876505617536, 24727.87636061808, 24770.876145619157, 3129.2489802447476, 3148.464760990637, 3159.7788154829173, 3166.667499912522, 3179.0780673604627, 148224.258878706, 148518.0, 148836.99999999892, 150436.0, 155617.0, 40548.1890362197, 40673.0, 40733.79633101816, 40932.795336023126, 40994.1801163975, 41753.48437281258, 42221.788891055345, 42284.57715422868, 44491.33263001058, 45304.54695453069, 11786.116041296937, 11867.109966752529, 11985.700357491132, 12019.699507512381, 12032.518699251932, 9786.951065244628, 9812.95093524542, 9850.162736167505, 9864.408135511749, 9869.21046316293, 12846.229226246269, 12970.546030889062, 13011.544595939096, 13041.413136408695, 13130.146540474838, 5330.493603107699, 5372.140457526777, 5470.425605311465, 5560.888782224414, 5591.133374326986, 856.1609622569916, 904.6969265296068, 919.7470695558775, 920.59953920045, 956.1585804492141, 21277.0, 21388.78611213899, 21869.890650546964, 21917.561648766936, 22161.778382216293, 984.9655262065793, 985.2955137077024, 994.4282037828277, 999.6657804027677, 1004.5077911823154, 11221.775564488664, 11600.187986841009, 11678.182527223184, 11710.824337634942, 11800.70498237551, 165852.0, 167463.1626841858, 168849.0, 169198.0, 189393.0, 46299.074018519445, 46759.532404676196, 46903.296450553265, 46939.0, 47075.293870591966, 1210.352461433129, 1260.9369531523387, 1261.0542093429929, 1261.344101067458, 1269.5366191340095, 24768.380790480383, 25240.368990775376, 26353.0, 26403.735962640898, 26677.86661066682, 31419.84290078535, 38508.614913850506, 39247.41128883126, 39307.80346098251, 39618.60381396265, 176155.0, 178075.06949026888, 178309.0, 178355.0, 178708.10645946686, 30843.845780770953, 30898.227544311572, 31345.05964821059, 31431.528527071656, 31491.0, 37174.442383363734, 37610.2477950434, 38360.2327953445, 38577.22845543017, 38628.613713863626, 28481.85759071274, 28829.693624510408, 29114.7088529112, 29216.269593259487, 29318.41363172682, 27612.0, 28148.43703125967, 28323.858380707963, 29056.41887162287, 29689.109326720234, 31609.20976975502, 31639.841800791768, 32135.839320803247, 32140.517892232103, 32172.0, 26938.0, 28003.0, 28330.150095497167, 28409.28976775597, 29389.853050734608, 22019.889900551036, 22432.102715891833, 22591.774082258966, 22763.0, 22873.428164296027], "value": 15084.369490491235, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [405.86403554809135, 410.0875551897029, 415.14894466343986, 420.57521902878085, 437.6455071392173, 16882.831171688296, 17520.561985950357, 17545.21046552905, 17596.384126555575, 18258.634827303445, 17291.654166916687, 17583.29666813329, 17648.558786030357, 17654.911725441354, 17965.10174491277, 5307.283516725241, 5492.5605951523785, 5533.723313834313, 5573.27547418835, 5575.749091290902, 5349.973250133763, 5525.585581081435, 5528.585356098289, 5535.6955367454775, 5536.667799931997, 4781.545753153445, 4847.030593881238, 5403.78384864605, 5437.8368648940595, 5479.04116779562, 5491.36849262332, 5491.835244942638, 5513.751881165317, 5528.474794894479, 5537.36320323164, 4877.244027175793, 4897.681650692729, 4919.581835543983, 4961.18140506816, 4999.875003124915, 22074.33776986693, 22433.32700019002, 22588.77411225883, 22731.0, 22788.948994590402, 1599.09651047158, 1615.814181369146, 1616.458486407055, 1616.9272382742688, 1627.4059968111553, 15058.623534411618, 15553.91122621417, 15627.531174064796, 16214.51356459308, 16749.581260468465, 2107.5784843031456, 2140.668196429556, 2146.399008277685, 2153.23560136151, 2292.942676433086, 91329.54335228281, 92819.0, 93691.53154234185, 95097.52451237768, 96003.51998240034, 10845.0, 10976.890231097746, 10994.0, 11361.091112710963, 11581.88418115825, 14734.557963261119, 14801.555953321418, 14802.777958330633, 14870.925645371704, 14897.553073407815, 6646.933530664632, 6936.890097584464, 7054.858902821915, 7058.11773528309, 7059.082319298458, 6215.943289640772, 6371.362863713684, 6761.715274097905, 6772.221194562689, 6777.966110169417, 6792.660366981631, 7019.964900175569, 7038.472114591426, 7064.788056358318, 7084.326988936043, 1943.1353047893551, 1960.696092105726, 1961.0978949683306, 2097.370788763365, 2282.7374851891914, 848.7029539661193, 872.7469033980202, 884.39860894591, 884.5179377239419, 899.595182168027, 17425.65148697019, 17521.29914803419, 17748.201330940137, 18119.12413421433, 18320.816791831912, 856.9871451928226, 866.1208872993916, 871.4422769427572, 873.8514452543083, 884.2616415293173, 9524.8571271431, 9931.553080111413, 9991.750206244757, 10025.949870250603, 10049.547770350351, 353029.0, 355231.0, 357072.0, 359694.0, 360173.0, 70387.0, 70861.0, 71603.6419817908, 71657.64171179215, 73486.63256683682, 1040.666986564292, 1069.8555694981233, 1069.893010698924, 1070.1652710885521, 1077.5905156040653, 15125.848741512884, 15194.0, 15378.307976140877, 15512.293647698518, 15590.84409155894, 37860.81069594635, 37977.43033854439, 38002.429963550014, 38494.0, 38802.80598596989, 46197.0, 46249.306260406796, 48114.75942620265, 48587.0, 48774.0, 8090.959545202236, 8177.100518943031, 8200.630971606412, 8264.21489958453, 8379.874301885355, 12877.484900603871, 13118.278494682883, 13244.404001819748, 13245.933770331087, 13706.0, 10883.564657413615, 11505.712357191138, 11554.248973816675, 11737.061035117, 11960.282383057045, 10731.40977246259, 11154.0, 11160.55357785712, 11190.594022285248, 11414.771704566028, 11934.343611101473, 11946.0, 12142.939285303517, 12191.207571507824, 12267.693307667023, 8369.0375606806, 8393.412461127662, 8395.32837373021, 8436.662533498591, 8477.152284771473, 11222.55109795599, 11273.774524509628, 11484.138689598147, 11668.649940501798, 11782.057435405319], "value": 8840.127426331577, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1239.4236679943826, 1296.7212049409375, 1301.0827366706474, 1302.8176055352253, 1308.9280089595072, 9552.379095358805, 9932.553035113418, 9943.10512053915, 9986.850197247039, 10108.696739097839, 9878.901210987888, 9945.254105942047, 9962.501874906262, 10011.549480273387, 10042.046005629472, 2226.6326056200705, 2257.5146343536135, 2267.5691618592496, 2276.226083131735, 2279.509905370345, 2164.0, 2204.801567858892, 2209.9889500552476, 2216.3794137641407, 2223.0885337011828, 2214.523877366366, 2223.3330000999636, 2253.425376528991, 2262.909483620653, 2263.4567703751145, 2081.4856554866788, 2099.8530102892805, 2103.2848831397323, 2118.7881211878844, 2121.819645330149, 2063.226290141197, 2124.915003399862, 2131.989340053305, 2207.6798864164607, 2216.0803266644325, 9659.951700241523, 9806.607735690564, 9861.309708320421, 9874.456904870229, 9877.851832222523, 5082.08522465956, 5153.433122356538, 5247.134222853225, 5249.68501889884, 5253.763580638881, 3162.177833763215, 3357.7649564530493, 3415.419378705626, 3441.500982357544, 3459.377312083824, 1114.153243534911, 1124.3872089711126, 1148.0585919545977, 1150.4362862197547, 1161.506359797083, 13433.194008359433, 13533.458661653522, 13542.59372218835, 13558.389872455764, 13568.864311356958, 4521.131057594054, 4575.679702420799, 4641.396618439581, 4701.106789709944, 4777.904441911142, 10130.949345253373, 10167.237457190593, 10178.338408003456, 10225.233107516966, 10234.48827558619, 5325.281087053276, 5332.306800116037, 5346.4118946915805, 5364.517193452608, 5365.382980957162, 4696.0842635686395, 4730.787114579852, 4872.512748725099, 4875.609951203895, 4890.168671325812, 3631.891043268706, 3743.0, 3764.4353346997623, 3833.5399752029375, 3862.3627101528496, 991.1476130527741, 993.3046867192994, 1007.0584003956325, 1007.1036777268237, 1009.8232809258498, 690.3407246079981, 702.6205848841671, 707.5118168463744, 722.6531264992727, 725.582789895812, 5049.116404629175, 5134.332536770271, 5139.486051394905, 5199.63602547818, 5306.787728490817, 543.1255678357841, 555.4001678187548, 556.7967691792467, 557.1058451185788, 558.4750334685383, 3323.601167859824, 3567.571891373052, 3593.0, 3617.4031284838234, 3691.9077023074638, 11694.70763230926, 11932.28406295625, 11934.761304773856, 11947.283163010246, 12002.0, 11713.648590542298, 11874.1094417919, 11943.880561194277, 11977.940110299392, 11984.820227696591, 6515.446187074057, 6811.897821532681, 6906.171259448798, 6920.342567456084, 6984.79045628632, 5405.7836986677685, 5436.945630543644, 5438.23864658956, 5554.861128471821, 5687.8862422752145, 10289.228307876789, 10551.78896422052, 10581.52383142745, 10744.462776861283, 10744.83882741775, 10835.837462437912, 10921.0, 10921.399323037309, 10937.289076210021, 10943.671689849318, 6946.895796563157, 7000.0199972004975, 7057.717691292496, 7060.329268719669, 7084.64576771149, 8674.78313042179, 8682.262007729414, 8711.607977641148, 8785.380297697986, 8830.116988301119, 7669.693212271447, 7721.459497835098, 7731.613419328898, 7741.458097933316, 7825.960870195612, 7426.183119856703, 7452.0, 7483.32650061497, 7618.5809780462605, 7718.884216736866, 6458.806235812933, 6536.0, 6555.672216389257, 6601.570897891622, 6628.304028077176, 4709.5290470954005, 4784.40194975628, 4879.048585525788, 5025.145725226647, 5066.341375621146, 5217.765200566059, 5223.347081614798, 5314.3091398117995, 5357.062514060101, 5408.648437851527], "value": 4446.5255628276, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [377.24174409437023, 386.69837526729145, 397.2313573235787, 398.9940150897737, 399.38095951275534, 5323.973380133094, 5445.264889239947, 5453.400125986143, 5465.6447330923465, 5487.533559647425, 5261.526462618363, 5290.523852853243, 5321.414644389124, 5333.306670132887, 5334.253204551366, 4049.6557792587664, 4055.2497787909183, 4063.1264278180183, 4067.7355971861807, 4073.9185216295805, 3894.987303301148, 4026.758394496325, 4055.229506393776, 4060.736052156615, 4088.5911408859174, 4017.5781542938007, 4021.2158629067344, 4026.557078721353, 4029.053172504474, 4039.7778122203267, 4004.379321205218, 4009.558948515661, 4028.295048366524, 4045.745818796168, 4051.9797401012806, 3528.735344849121, 3535.487354333633, 3543.291341731664, 3547.5565554305713, 3568.982155089234, 5223.190405487156, 5238.114278859607, 5250.527452529291, 5251.553617942442, 5314.256004159421, 4728.40894888139, 4738.407699037621, 4742.430908290993, 4746.359241502422, 4762.214234651313, 5517.586181036399, 5653.434656534355, 5671.716414179275, 5678.290213723285, 5685.630434021776, 3902.824372903226, 3911.471951286568, 3922.6466868930174, 3933.3509970854775, 3951.308521008812, 5860.648361098348, 5978.372270911578, 5999.76000959961, 6002.429769171922, 6040.879182416327, 4011.4183443400543, 4015.8554811878475, 4022.7988600569856, 4027.35562310029, 4039.2325458162854, 4084.0402505411203, 4093.836246550164, 4094.263032654091, 4094.5905409458815, 4099.200655872136, 4663.883402914887, 4706.482286948433, 4711.81152753886, 4714.888173805272, 4716.716996980193, 5659.660420374791, 5666.065099258659, 5681.659100453903, 5712.742926568314, 5719.656820590778, 1389.5275606293908, 1413.9646508837156, 1420.4673247532176, 1421.6019514535947, 1425.1591560979073, 893.4415990006246, 946.8674385586023, 952.8713623660717, 954.9618015279311, 963.633819148733, 4829.082474329936, 4853.325602667145, 4858.368412106474, 4865.854024379274, 4889.902201955941, 5893.440123188376, 5895.4399332063385, 5900.940990590125, 5928.851778705567, 5942.494887934487, 4732.2428411454, 4756.857294281177, 4791.209450440708, 4848.418189817245, 4861.927071093936, 3083.444979903639, 3087.7684173686616, 3103.3172702005522, 3110.8755649773757, 3111.346617210366, 5468.28912241414, 5481.506664400223, 5497.8075767347955, 5512.889742205133, 5539.473749993744, 5869.941300586939, 5998.1602575639445, 6049.364816694272, 6052.969735151296, 6068.726907289182, 5487.64330318528, 5492.670439773627, 5513.09034009384, 5526.447355264441, 5550.389457159628, 5697.601167918372, 5830.47525722687, 5843.970780146072, 5855.209546711139, 5916.26046744157, 5758.71206439668, 5781.94218057814, 5790.392008839011, 5790.710464476843, 5819.388964158702, 5319.38827034896, 5503.394626590992, 5540.473655002768, 5545.279113715191, 5560.443955604407, 4046.684827431038, 4060.7969601520394, 4075.735077219971, 4079.7756123413496, 4093.2808220546844, 5877.382874798084, 5940.6435613863305, 5951.345352011362, 5970.74614330978, 5977.193078934462, 5728.713564321684, 5731.197632331394, 5740.712964351682, 5742.794013257263, 5772.3650398456975, 5693.857653558529, 5708.514776244066, 5714.79998200061, 5748.540116790563, 5753.769849205984, 5442.972785136049, 5573.860653483695, 5641.435856414326, 5650.039493286069, 5658.292713410824, 5739.62692424991, 5755.798267264837, 5779.450952159538, 5785.247917770831, 5785.508231800344, 5431.945680543144, 5578.442155784389, 5580.972095139498, 5588.804391846266, 5609.158626206102], "value": 4251.669579252245, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [736.9668364923579, 739.71890681541, 742.4134933402612, 762.039829814434, 767.9808004799879, 13495.1228170169, 13916.512922047717, 13962.0, 14932.253387330644, 15127.84872151278, 15309.0, 15778.132202728846, 15850.682986340265, 15903.92048039761, 15908.125053122103, 890.5903284489143, 897.2463130969984, 905.597009330848, 906.7461110888929, 907.0249481807051, 899.1817446124029, 908.1372695938851, 909.4225167018958, 914.3279689428265, 915.3135148638521, 958.9232861371073, 963.7590602349412, 965.9565319560637, 966.6665000574826, 968.6464440479209, 949.7198326493666, 949.8812648418948, 950.230313446104, 950.3442624589046, 951.6764300137952, 705.4814711187273, 705.675389320913, 706.1244057368878, 706.3325157725951, 706.4313227851577, 13046.347682615926, 13186.604401867959, 13256.3371831409, 13286.468541258339, 13293.468261269538, 14933.328000240015, 15553.0, 15670.216489175496, 16201.675966480605, 16414.589635259093, 12261.386930653433, 12475.126741128124, 12581.308028058453, 12590.0, 12701.110922235448, 2891.277180704824, 2900.521413966714, 2901.50674385355, 2924.926876828075, 2925.9414811703646, 71008.0, 71095.64452177758, 71671.28328716698, 72569.46874781243, 73710.26289737088, 12060.095492838072, 12320.322382268881, 12467.563635272903, 12468.688282793002, 12492.188007779465, 20929.26747563828, 23078.769212307663, 23127.3061808146, 23371.182008629617, 23375.41561460977, 6088.299845517734, 6218.875622487525, 6312.779052733133, 6325.936740632626, 6334.968325158345, 2860.2134413036165, 2905.404392099657, 2910.3015276333526, 2923.0353983185496, 2936.0898121582377, 3528.6824185822884, 3549.254656522108, 3632.3098611263777, 3645.872394466181, 3660.450932360114, 727.752564128199, 742.3912391838749, 744.5644298085572, 745.9552426854406, 748.3713680508399, 559.7517535894978, 580.9302883653988, 595.1935127901718, 620.2587907450643, 630.7413960276265, 9917.702468925943, 10326.948365258277, 10557.63048293306, 10801.945990269998, 10902.890971090346, 611.9449249567472, 617.0836308082494, 622.1662971618053, 634.6445990245477, 638.9041643753474, 4257.467816522934, 4510.526394728572, 4621.815127394933, 4653.0, 4721.95278047222, 61053.38946610477, 62761.0, 63117.0, 65763.34236657667, 66738.33261667419, 50500.0, 54090.0, 54773.0, 54837.1774423384, 55150.0, 44522.3216517525, 44589.55410445919, 45046.32430513545, 45089.0, 45126.774366127305, 9873.555689993824, 10430.0, 10487.0, 10601.310914790514, 10829.18781091437, 24877.626835597843, 25180.11869584556, 25516.744832551438, 25550.488990220463, 26302.079427219956, 29418.970336038135, 29666.110016699535, 29981.100566983027, 30093.548596771503, 30540.08379748611, 13093.952483801464, 13189.868101318863, 13210.537631182862, 13256.867431325563, 13448.93275533616, 15512.146831923901, 15636.843631563539, 15831.525054248392, 15836.60408489797, 15946.840531595, 14102.929485352508, 14415.621422465596, 14531.564053078424, 14766.261686915826, 14881.181535015678, 14136.858631413554, 14227.0, 14415.639609009859, 14612.92693536568, 14813.925930370278, 13901.513447029305, 13939.233342166279, 14098.083624564371, 14114.858851411354, 14173.291335433394, 9913.65302214419, 10017.098461138532, 10035.448050357008, 10114.393136411838, 10203.38779673222, 10737.14102871784, 11105.0, 11276.404203782968, 11317.830232546683, 11352.375619341015], "value": 6817.366519190736, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1552.1999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 113.0, 113.0, 113.0, 117.0, 113.0, 111.0, 112.0, 113.0, 114.0], "value": 112.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 133.0, 125.0, 173.0, 127.0, 130.0, 125.0, 122.0, 152.0, 123.0], "value": 136.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 163.0, 164.0, 168.0, 164.0, 166.0, 168.0, 167.0, 164.0, 164.0], "value": 165.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 75.0, 103.0, 75.0, 75.0, 75.0, 75.0, 98.0, 78.0], "value": 80.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 104.0, 84.0, 84.0, 84.0, 99.0, 84.0, 83.0, 106.0], "value": 89.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 115.0, 114.0, 114.0, 114.0, 114.0, 113.0, 114.0, 115.0, 118.0], "value": 114.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 150.0, 151.0, 159.0, 149.0, 150.0, 150.0, 151.0, 152.0, 150.0], "value": 151.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 94.0, 95.0, 95.0, 94.0, 96.0, 94.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 54.0, 55.0, 58.0, 55.0, 55.0, 56.0, 55.0, 55.0], "value": 55.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 56.0, 57.0, 57.0, 57.0, 57.0, 56.0, 60.0, 56.0, 56.0], "value": 56.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 81.0, 81.0, 92.0, 91.0, 82.0, 84.0, 84.0, 81.0, 82.0], "value": 84.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 141.0, 134.0, 142.0, 134.0, 134.0, 148.0, 141.0, 188.0, 141.0], "value": 143.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 194.0, 192.0, 195.0, 196.0, 196.0, 186.0, 189.0, 208.0, 195.0], "value": 193.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 75.0, 73.0, 74.0, 72.0, 73.0, 76.0, 72.0, 73.0], "value": 73.7, "unit": "score"}]}]} 21:23:10 INFO - Return code: 0 21:23:10 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 21:23:10 INFO - # TBPL SUCCESS # 21:23:10 INFO - Running post-action listener: _resource_record_post_action 21:23:10 INFO - [mozharness: 2017-05-22 04:23:10.862935Z] Finished run-tests step (success) 21:23:10 INFO - Running post-run listener: _resource_record_post_run 21:23:10 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 4096; Write bytes: 402890752; Read time: 16; Write time: 256780 21:23:10 INFO - TinderboxPrint: CPU usage
13.3% 21:23:10 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 21:23:10 INFO - TinderboxPrint: I/O write bytes / time
402,890,752 / 256,780 21:23:10 INFO - TinderboxPrint: CPU idle
8,276.8 (86.7%) 21:23:10 INFO - TinderboxPrint: CPU user
1,213.2 (12.7%) 21:23:10 INFO - TinderboxPrint: Swap in / out
0 / 0 21:23:10 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 94023680; Read time: 0; Write time: 58708 21:23:10 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 4096; Write bytes: 304439296; Read time: 16; Write time: 181676 21:23:11 INFO - Running post-run listener: _upload_blobber_files 21:23:11 INFO - Blob upload gear active. 21:23:11 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 21:23:11 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 21:23:11 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'] 21:23:11 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 21:23:11 INFO - (blobuploader) - INFO - Open directory for files ... 21:23:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 21:23:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:23:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:23:12 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 21:23:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:23:12 INFO - (blobuploader) - INFO - Done attempting. 21:23:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 21:23:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:23:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:23:16 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 21:23:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:23:16 INFO - (blobuploader) - INFO - Done attempting. 21:23:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 21:23:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:23:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:23:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 21:23:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:23:17 INFO - (blobuploader) - INFO - Done attempting. 21:23:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 21:23:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:23:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:23:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 21:23:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:23:17 INFO - (blobuploader) - INFO - Done attempting. 21:23:17 INFO - (blobuploader) - INFO - Iteration through files over. 21:23:17 INFO - Return code: 0 21:23:17 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 21:23:17 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 21:23:17 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a0f269b560c5e2a873d944465b5d963b7405b4541588c699fed0e3fe59b3cc91ec4e382ce7cf30dab9edc98bba28761a6ed56a4183a8e9519dd66fce15e277c5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a0ceb54b2e97dcd1ac1559f97efaf6ca70735fd5ae82ec411c258d0fb6da2a9c855902f49a0706f121893a32775568a888dc090b953a46b0d4c7ee27d12e621a", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5e17ba6080f5eaec644038acc2c711f10a61f3524cee10cb89e8baa12de3556a3fa35e2d5ebd2373983191fcd2044cdfe79693355235100c7332c0a84f1af4a0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/adb691d4f92384f9de2dd4a7af534bd3d63b7ed215b04f7c670e7138bf898e69b1666050a3b63a42f8c2118299ce570e95c1fb5eca1d8380ca45e118e303276e"} 21:23:17 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 21:23:17 INFO - Writing to file /builds/slave/test/properties/blobber_files 21:23:17 INFO - Contents: 21:23:17 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a0f269b560c5e2a873d944465b5d963b7405b4541588c699fed0e3fe59b3cc91ec4e382ce7cf30dab9edc98bba28761a6ed56a4183a8e9519dd66fce15e277c5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a0ceb54b2e97dcd1ac1559f97efaf6ca70735fd5ae82ec411c258d0fb6da2a9c855902f49a0706f121893a32775568a888dc090b953a46b0d4c7ee27d12e621a", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5e17ba6080f5eaec644038acc2c711f10a61f3524cee10cb89e8baa12de3556a3fa35e2d5ebd2373983191fcd2044cdfe79693355235100c7332c0a84f1af4a0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/adb691d4f92384f9de2dd4a7af534bd3d63b7ed215b04f7c670e7138bf898e69b1666050a3b63a42f8c2118299ce570e95c1fb5eca1d8380ca45e118e303276e"} 21:23:17 INFO - Running post-run listener: copy_logs_to_upload_dir 21:23:17 INFO - Copying logs to upload dir... 21:23:17 INFO - mkdir: /builds/slave/test/build/upload/logs 21:23:17 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1253.583933 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2017-05-21 21:23:17.368837) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-21 21:23:17.376166) ========= 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=1f5564757af27664ca02d71f000001b0-1495387086.920749-543998877 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/a0f269b560c5e2a873d944465b5d963b7405b4541588c699fed0e3fe59b3cc91ec4e382ce7cf30dab9edc98bba28761a6ed56a4183a8e9519dd66fce15e277c5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a0ceb54b2e97dcd1ac1559f97efaf6ca70735fd5ae82ec411c258d0fb6da2a9c855902f49a0706f121893a32775568a888dc090b953a46b0d4c7ee27d12e621a", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5e17ba6080f5eaec644038acc2c711f10a61f3524cee10cb89e8baa12de3556a3fa35e2d5ebd2373983191fcd2044cdfe79693355235100c7332c0a84f1af4a0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/adb691d4f92384f9de2dd4a7af534bd3d63b7ed215b04f7c670e7138bf898e69b1666050a3b63a42f8c2118299ce570e95c1fb5eca1d8380ca45e118e303276e"} build_url:https://queue.taskcluster.net/v1/task/FSfiA2TOTQKNqkDonq3I0g/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011228 build_url: 'https://queue.taskcluster.net/v1/task/FSfiA2TOTQKNqkDonq3I0g/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a0f269b560c5e2a873d944465b5d963b7405b4541588c699fed0e3fe59b3cc91ec4e382ce7cf30dab9edc98bba28761a6ed56a4183a8e9519dd66fce15e277c5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a0ceb54b2e97dcd1ac1559f97efaf6ca70735fd5ae82ec411c258d0fb6da2a9c855902f49a0706f121893a32775568a888dc090b953a46b0d4c7ee27d12e621a", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5e17ba6080f5eaec644038acc2c711f10a61f3524cee10cb89e8baa12de3556a3fa35e2d5ebd2373983191fcd2044cdfe79693355235100c7332c0a84f1af4a0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/adb691d4f92384f9de2dd4a7af534bd3d63b7ed215b04f7c670e7138bf898e69b1666050a3b63a42f8c2118299ce570e95c1fb5eca1d8380ca45e118e303276e"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-21 21:23:17.404835) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-21 21:23:17.405229) ========= 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=1f5564757af27664ca02d71f000001b0-1495387086.920749-543998877 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004349 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-21 21:23:17.485524) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-21 21:23:17.485915) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-21 21:23:17.486247) ========= ========= Total master_lag: 0.19 =========