builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-076 starttime: 1494862900.01 results: success (0) revision: 0f4df67c5f162e00d6f52825badf468aefbfba19 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-15 08:41:40.007966) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-15 08:41:40.008525) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-15 08:41:40.008831) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-15 08:41:40.027509) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-15 08:41:40.027805) ========= 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=9bfb7e13875ed353a705960e000001c0-1494861795.280042-2121079661 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-15 08:41:41-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 220M=0s 2017-05-15 08:41:41 (220 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.120039 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-15 08:41:40.165540) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-15 08:41:40.165848) ========= 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=9bfb7e13875ed353a705960e000001c0-1494861795.280042-2121079661 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017331 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-15 08:41:40.215215) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-15 08:41:40.218602) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 0f4df67c5f162e00d6f52825badf468aefbfba19 --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 0f4df67c5f162e00d6f52825badf468aefbfba19 --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=9bfb7e13875ed353a705960e000001c0-1494861795.280042-2121079661 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-15 08:41:42,011 truncating revision to first 12 chars 2017-05-15 08:41:42,011 Setting DEBUG logging. 2017-05-15 08:41:42,011 attempt 1/10 2017-05-15 08:41:42,011 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/0f4df67c5f16?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-15 08:41:42,475 unpacking tar archive at: mozilla-central-0f4df67c5f16/testing/mozharness/ program finished with exit code 0 elapsedTime=0.779495 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-15 08:41:41.011907) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-15 08:41:41.012221) ========= script_repo_revision: 0f4df67c5f162e00d6f52825badf468aefbfba19 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-15 08:41:41.015661) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-15 08:41:41.015992) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-15 08:41:41.026668) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2017-05-15 08:41:41.027050) ========= /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=9bfb7e13875ed353a705960e000001c0-1494861795.280042-2121079661 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:41:42 INFO - MultiFileLogger online at 20170515 08:41:42 in /builds/slave/test 08:41:42 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 08:41:42 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:41:42 INFO - {'append_to_log': False, 08:41:42 INFO - 'base_work_dir': '/builds/slave/test', 08:41:42 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 08:41:42 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:41:42 INFO - 'branch': 'Firefox-Non-PGO', 08:41:42 INFO - 'buildbot_json_path': 'buildprops.json', 08:41:42 INFO - 'config_files': ('talos/linux_config.py',), 08:41:42 INFO - 'default_actions': ('clobber', 08:41:42 INFO - 'read-buildbot-config', 08:41:42 INFO - 'download-and-extract', 08:41:42 INFO - 'populate-webroot', 08:41:42 INFO - 'create-virtualenv', 08:41:42 INFO - 'install', 08:41:42 INFO - 'run-tests'), 08:41:42 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:41:42 INFO - 'download_minidump_stackwalk': True, 08:41:42 INFO - 'download_symbols': 'ondemand', 08:41:42 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:41:42 INFO - 'tooltool.py': '/tools/tooltool.py', 08:41:42 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:41:42 INFO - '/tools/misc-python/virtualenv.py')}, 08:41:42 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:41:42 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:41:42 INFO - 'gecko_profile': False, 08:41:42 INFO - 'gecko_profile_interval': 0, 08:41:42 INFO - 'installer_path': 'installer.exe', 08:41:42 INFO - 'log_level': 'info', 08:41:42 INFO - 'log_name': 'talos', 08:41:42 INFO - 'log_to_console': True, 08:41:42 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:41:42 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:41:42 INFO - 'opt_config_files': (), 08:41:42 INFO - 'pip_index': False, 08:41:42 INFO - 'suite': 'dromaeojs-e10s', 08:41:42 INFO - 'system_bits': '32', 08:41:42 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:41:42 INFO - 'title': 'talos-linux64-ix-076', 08:41:42 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:41:42 INFO - 'use_talos_json': True, 08:41:42 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:41:42 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:41:42 INFO - 'work_dir': 'build'} 08:41:42 INFO - [mozharness: 2017-05-15 15:41:42.920187Z] Running clobber step. 08:41:42 INFO - Running pre-action listener: _resource_record_pre_action 08:41:42 INFO - Running main action method: clobber 08:41:42 INFO - rmtree: /builds/slave/test/build 08:41:42 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:41:43 INFO - Running post-action listener: _resource_record_post_action 08:41:43 INFO - [mozharness: 2017-05-15 15:41:43.929419Z] Finished clobber step (success) 08:41:43 INFO - [mozharness: 2017-05-15 15:41:43.929519Z] Running read-buildbot-config step. 08:41:43 INFO - Running pre-action listener: _resource_record_pre_action 08:41:43 INFO - Running main action method: read_buildbot_config 08:41:43 INFO - Using buildbot properties: 08:41:43 INFO - { 08:41:43 INFO - "project": "", 08:41:43 INFO - "product": "firefox", 08:41:43 INFO - "who": "ffxbld@noreply.mozilla.org", 08:41:43 INFO - "installer_path": "public/build/target.tar.bz2", 08:41:43 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 08:41:43 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 08:41:43 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 08:41:43 INFO - "stage_platform": "linux64", 08:41:43 INFO - "basedir": "/builds/slave/test", 08:41:43 INFO - "buildnumber": 604, 08:41:43 INFO - "platform": "ubuntu64_hw", 08:41:43 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 08:41:43 INFO - "slavebuilddir": "test", 08:41:43 INFO - "taskId": "FcROz1MtQP2i3N_CZlnamw", 08:41:43 INFO - "branch": "mozilla-central", 08:41:43 INFO - "script_repo_revision": "production", 08:41:43 INFO - "revision": "0f4df67c5f162e00d6f52825badf468aefbfba19", 08:41:43 INFO - "slavename": "talos-linux64-ix-076", 08:41:43 INFO - "repo_path": "mozilla-central" 08:41:43 INFO - } 08:41:43 INFO - Finding installer, test and symbols from parent task. 08:41:43 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FcROz1MtQP2i3N_CZlnamw'}, attempt #1 08:41:44 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FcROz1MtQP2i3N_CZlnamw'}, attempt #1 08:41:44 INFO - Task dependencies: BlNALE4CQSCZx5ZxLH6NPA 08:41:44 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BlNALE4CQSCZx5ZxLH6NPA'}, attempt #1 08:41:45 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/BlNALE4CQSCZx5ZxLH6NPA/artifacts/public/build/target.tar.bz2 08:41:45 INFO - Set test_url: https://queue.taskcluster.net/v1/task/BlNALE4CQSCZx5ZxLH6NPA/artifacts/public/build/test_packages.json 08:41:45 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/BlNALE4CQSCZx5ZxLH6NPA/artifacts/public/build/target.crashreporter-symbols.zip 08:41:45 INFO - Running post-action listener: _resource_record_post_action 08:41:45 INFO - [mozharness: 2017-05-15 15:41:45.284277Z] Finished read-buildbot-config step (success) 08:41:45 INFO - [mozharness: 2017-05-15 15:41:45.284497Z] Running download-and-extract step. 08:41:45 INFO - Running pre-action listener: _resource_record_pre_action 08:41:45 INFO - Running main action method: download_and_extract 08:41:45 INFO - mkdir: /builds/slave/test/build/tests 08:41:45 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')]} 08:41:45 INFO - trying https://queue.taskcluster.net/v1/task/BlNALE4CQSCZx5ZxLH6NPA/artifacts/public/build/target.test_packages.json 08:41:45 INFO - Downloading https://queue.taskcluster.net/v1/task/BlNALE4CQSCZx5ZxLH6NPA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 08:41:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BlNALE4CQSCZx5ZxLH6NPA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 08:41:45 INFO - Downloaded 986 bytes. 08:41:45 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 08:41:45 INFO - Using the following test package requirements: 08:41:45 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 08:41:45 INFO - u'common': [u'target.common.tests.zip'], 08:41:45 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 08:41:45 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 08:41:45 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 08:41:45 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 08:41:45 INFO - u'mozbase': [u'target.common.tests.zip'], 08:41:45 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 08:41:45 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 08:41:45 INFO - u'web-platform': [u'target.common.tests.zip', 08:41:45 INFO - u'target.web-platform.tests.zip'], 08:41:45 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 08:41:45 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 08:41:45 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BlNALE4CQSCZx5ZxLH6NPA/artifacts/public/build/target.common.tests.zip 08:41:45 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BlNALE4CQSCZx5ZxLH6NPA/artifacts/public/build/target.common.tests.zip'}, attempt #1 08:41:45 INFO - Fetch https://queue.taskcluster.net/v1/task/BlNALE4CQSCZx5ZxLH6NPA/artifacts/public/build/target.common.tests.zip into memory 08:41:47 INFO - Content-Length response header: 62448341 08:41:47 INFO - Bytes received: 62448341 08:41:58 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 08:41:58 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BlNALE4CQSCZx5ZxLH6NPA/artifacts/public/build/target.common.tests.zip 08:41:58 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BlNALE4CQSCZx5ZxLH6NPA/artifacts/public/build/target.common.tests.zip'}, attempt #1 08:41:58 INFO - Fetch https://queue.taskcluster.net/v1/task/BlNALE4CQSCZx5ZxLH6NPA/artifacts/public/build/target.common.tests.zip into memory 08:41:59 INFO - Content-Length response header: 62448341 08:41:59 INFO - Bytes received: 62448341 08:42:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BlNALE4CQSCZx5ZxLH6NPA/artifacts/public/build/target.talos.tests.zip 08:42:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BlNALE4CQSCZx5ZxLH6NPA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 08:42:11 INFO - Fetch https://queue.taskcluster.net/v1/task/BlNALE4CQSCZx5ZxLH6NPA/artifacts/public/build/target.talos.tests.zip into memory 08:42:13 INFO - Content-Length response header: 14410013 08:42:13 INFO - Bytes received: 14410013 08:42: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')]} 08:42:13 INFO - trying https://queue.taskcluster.net/v1/task/BlNALE4CQSCZx5ZxLH6NPA/artifacts/public/build/target.tar.bz2 08:42:13 INFO - Downloading https://queue.taskcluster.net/v1/task/BlNALE4CQSCZx5ZxLH6NPA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 08:42:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BlNALE4CQSCZx5ZxLH6NPA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 08:42:15 INFO - Downloaded 63345412 bytes. 08:42:15 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/BlNALE4CQSCZx5ZxLH6NPA/artifacts/public/build/target.tar.bz2 08:42:15 INFO - mkdir: /builds/slave/test/properties 08:42:15 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:42:15 INFO - Writing to file /builds/slave/test/properties/build_url 08:42:15 INFO - Contents: 08:42:15 INFO - build_url:https://queue.taskcluster.net/v1/task/BlNALE4CQSCZx5ZxLH6NPA/artifacts/public/build/target.tar.bz2 08:42:15 INFO - Running post-action listener: _resource_record_post_action 08:42:15 INFO - Running post-action listener: set_extra_try_arguments 08:42:15 INFO - [mozharness: 2017-05-15 15:42:15.707351Z] Finished download-and-extract step (success) 08:42:15 INFO - [mozharness: 2017-05-15 15:42:15.707449Z] Running populate-webroot step. 08:42:15 INFO - Running pre-action listener: _resource_record_pre_action 08:42:15 INFO - Running main action method: populate_webroot 08:42:15 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:42:15 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:42:15 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:42:15 INFO - '--tppagecycles', 08:42:15 INFO - '7'], 08:42:15 INFO - 'tests': ['tsvgm']}}, 08:42:15 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:42:15 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:42:15 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:42:15 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:42:15 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:42:15 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:42:15 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 08:42:15 INFO - 'talos_options': ['--disable-e10s'], 08:42:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:42:15 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 08:42:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:42:15 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 08:42:15 INFO - 'talos_options': ['--disable-e10s'], 08:42:15 INFO - 'tests': ['damp', 'tps']}, 08:42:15 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 08:42:15 INFO - 'tests': ['damp', 'tps']}, 08:42:15 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:42:15 INFO - 'tests': ['dromaeo_dom']}, 08:42:15 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:42:15 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:42:15 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 08:42:15 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 08:42:15 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:42:15 INFO - 'tests': ['a11yr', 08:42:15 INFO - 'ts_paint', 08:42:15 INFO - 'tpaint', 08:42:15 INFO - 'sessionrestore', 08:42:15 INFO - 'sessionrestore_no_auto_restore', 08:42:15 INFO - 'tabpaint']}, 08:42:15 INFO - 'other-e10s': {'tests': ['a11yr', 08:42:15 INFO - 'ts_paint', 08:42:15 INFO - 'tpaint', 08:42:15 INFO - 'sessionrestore', 08:42:15 INFO - 'sessionrestore_no_auto_restore', 08:42:15 INFO - 'tabpaint']}, 08:42:15 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:42:15 INFO - 'ts_paint', 08:42:15 INFO - 'tpaint', 08:42:15 INFO - 'sessionrestore', 08:42:15 INFO - 'sessionrestore_no_auto_restore', 08:42:15 INFO - 'tabpaint']}, 08:42:15 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:42:15 INFO - 'ts_paint', 08:42:15 INFO - 'tpaint', 08:42:15 INFO - 'sessionrestore', 08:42:15 INFO - 'sessionrestore_no_auto_restore', 08:42:15 INFO - 'tabpaint']}, 08:42:15 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:42:15 INFO - 'tests': ['a11yr', 08:42:15 INFO - 'ts_paint', 08:42:15 INFO - 'tpaint', 08:42:15 INFO - 'sessionrestore', 08:42:15 INFO - 'sessionrestore_no_auto_restore', 08:42:15 INFO - 'tabpaint']}, 08:42:15 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:42:15 INFO - 'tests': ['a11yr', 08:42:15 INFO - 'ts_paint', 08:42:15 INFO - 'tpaint', 08:42:15 INFO - 'sessionrestore', 08:42:15 INFO - 'sessionrestore_no_auto_restore', 08:42:15 INFO - 'tabpaint']}, 08:42:15 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 08:42:15 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 08:42:15 INFO - 'bloom_basic_ref']}, 08:42:15 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:42:15 INFO - 'tests': ['tsvgx', 08:42:15 INFO - 'tsvgr_opacity', 08:42:15 INFO - 'tart', 08:42:15 INFO - 'tscrollx', 08:42:15 INFO - 'cart', 08:42:15 INFO - 'tsvg_static']}, 08:42:15 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:42:15 INFO - 'tsvgr_opacity', 08:42:15 INFO - 'tart', 08:42:15 INFO - 'tscrollx', 08:42:15 INFO - 'cart', 08:42:15 INFO - 'tsvg_static']}, 08:42:15 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 08:42:15 INFO - 'talos_options': ['--disable-e10s'], 08:42:15 INFO - 'tests': ['tp5o']}, 08:42:15 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 08:42:15 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 08:42:15 INFO - 'talos_options': ['--disable-e10s', 08:42:15 INFO - '--xperf_path', 08:42:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:42:15 INFO - 'tests': ['tp5n']}, 08:42:15 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 08:42:15 INFO - 'talos_options': ['--xperf_path', 08:42:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:42:15 INFO - 'tests': ['tp5n']}}, 08:42:15 INFO - 'talos.zip': {'path': '', 08:42:15 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:42:15 INFO - Running post-action listener: _resource_record_post_action 08:42:15 INFO - [mozharness: 2017-05-15 15:42:15.723423Z] Finished populate-webroot step (success) 08:42:15 INFO - [mozharness: 2017-05-15 15:42:15.723513Z] Running create-virtualenv step. 08:42:15 INFO - Running pre-action listener: _resource_record_pre_action 08:42:15 INFO - Running main action method: create_virtualenv 08:42:15 INFO - Creating virtualenv /builds/slave/test/build/venv 08:42:15 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 08:42:15 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:42:15 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:42:15 INFO - Using real prefix '/usr' 08:42:15 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:42:16 INFO - Installing distribute.............................................................................................................................................................................................done. 08:42:18 INFO - Installing pip.................done. 08:42:18 INFO - Return code: 0 08:42:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:42:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:42:18 INFO - Reading from file tmpfile_stdout 08:42:18 INFO - Output received: 08:42:18 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) 08:42:18 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:42:18 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')]} 08:42:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:42:18 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')]} 08:42:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:42:18 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 0x22351f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2402a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25a85c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a57a0>, '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 0x25a66a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25a6b30>, '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': '9bfb7e13875ed353a705960e000001c0-1494861795.280042-2121079661', '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 08:42:18 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 08:42:18 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 08:42:18 INFO - Using env: {'DISPLAY': ':0', 08:42:18 INFO - 'HOME': '/home/cltbld', 08:42:18 INFO - 'LANG': 'en_US.UTF-8', 08:42:18 INFO - 'LANGUAGE': 'en_US:en', 08:42:18 INFO - 'LOGNAME': 'cltbld', 08:42:18 INFO - 'MAIL': '/var/mail/cltbld', 08:42:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:42:18 INFO - 'MOZ_NO_REMOTE': '1', 08:42:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:42:18 INFO - 'NO_EM_RESTART': '1', 08:42:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:42:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:42:18 INFO - 'PWD': '/builds/slave/test', 08:42:18 INFO - 'SHELL': '/bin/bash', 08:42:18 INFO - 'SHLVL': '1', 08:42:18 INFO - 'TERM': 'linux', 08:42:18 INFO - 'TMOUT': '86400', 08:42:18 INFO - 'USER': 'cltbld', 08:42:18 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1494861795.280042-2121079661', 08:42:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:42:18 INFO - '_': '/tools/buildbot/bin/python'} 08:42:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:42:18 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 08:42:18 INFO - Cleaning up... 08:42:18 INFO - Return code: 0 08:42:18 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:42:18 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')]} 08:42:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:42:18 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')]} 08:42:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:42:18 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 0x22351f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2402a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25a85c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a57a0>, '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 0x25a66a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25a6b30>, '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': '9bfb7e13875ed353a705960e000001c0-1494861795.280042-2121079661', '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 08:42:18 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 08:42:18 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 08:42:18 INFO - Using env: {'DISPLAY': ':0', 08:42:18 INFO - 'HOME': '/home/cltbld', 08:42:18 INFO - 'LANG': 'en_US.UTF-8', 08:42:18 INFO - 'LANGUAGE': 'en_US:en', 08:42:18 INFO - 'LOGNAME': 'cltbld', 08:42:18 INFO - 'MAIL': '/var/mail/cltbld', 08:42:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:42:18 INFO - 'MOZ_NO_REMOTE': '1', 08:42:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:42:18 INFO - 'NO_EM_RESTART': '1', 08:42:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:42:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:42:18 INFO - 'PWD': '/builds/slave/test', 08:42:18 INFO - 'SHELL': '/bin/bash', 08:42:18 INFO - 'SHLVL': '1', 08:42:18 INFO - 'TERM': 'linux', 08:42:18 INFO - 'TMOUT': '86400', 08:42:18 INFO - 'USER': 'cltbld', 08:42:18 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1494861795.280042-2121079661', 08:42:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:42:18 INFO - '_': '/tools/buildbot/bin/python'} 08:42:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:42:18 INFO - Downloading/unpacking psutil>=3.1.1 08:42:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:42:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:42:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:42:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:42:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:42:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:42:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:42:20 INFO - Installing collected packages: psutil 08:42:20 INFO - Running setup.py install for psutil 08:42:20 INFO - building 'psutil._psutil_linux' extension 08:42:20 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 08:42:20 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 08:42:20 INFO - building 'psutil._psutil_posix' extension 08:42:20 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 08:42:20 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 08:42:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:42:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:42:20 INFO - Successfully installed psutil 08:42:20 INFO - Cleaning up... 08:42:20 INFO - Return code: 0 08:42:20 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:42:20 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')]} 08:42:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:42:20 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')]} 08:42:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:42:20 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 0x22351f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2402a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25a85c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a57a0>, '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 0x25a66a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25a6b30>, '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': '9bfb7e13875ed353a705960e000001c0-1494861795.280042-2121079661', '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 08:42:20 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 08:42:20 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 08:42:20 INFO - Using env: {'DISPLAY': ':0', 08:42:20 INFO - 'HOME': '/home/cltbld', 08:42:20 INFO - 'LANG': 'en_US.UTF-8', 08:42:20 INFO - 'LANGUAGE': 'en_US:en', 08:42:20 INFO - 'LOGNAME': 'cltbld', 08:42:20 INFO - 'MAIL': '/var/mail/cltbld', 08:42:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:42:20 INFO - 'MOZ_NO_REMOTE': '1', 08:42:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:42:20 INFO - 'NO_EM_RESTART': '1', 08:42:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:42:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:42:20 INFO - 'PWD': '/builds/slave/test', 08:42:20 INFO - 'SHELL': '/bin/bash', 08:42:20 INFO - 'SHLVL': '1', 08:42:20 INFO - 'TERM': 'linux', 08:42:20 INFO - 'TMOUT': '86400', 08:42:20 INFO - 'USER': 'cltbld', 08:42:20 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1494861795.280042-2121079661', 08:42:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:42:20 INFO - '_': '/tools/buildbot/bin/python'} 08:42:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:42:20 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:42:20 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 08:42:20 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 08:42:20 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 08:42:20 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 08:42:21 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:42:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:42:22 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:42:22 INFO - Installing collected packages: mozsystemmonitor 08:42:22 INFO - Running setup.py install for mozsystemmonitor 08:42:22 INFO - Successfully installed mozsystemmonitor 08:42:22 INFO - Cleaning up... 08:42:22 INFO - Return code: 0 08:42:22 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:42:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:42:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:42:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:42:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:42:22 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 0x22351f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2402a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25a85c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a57a0>, '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 0x25a66a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25a6b30>, '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': '9bfb7e13875ed353a705960e000001c0-1494861795.280042-2121079661', '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 08:42:22 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 08:42:22 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 08:42:22 INFO - Using env: {'DISPLAY': ':0', 08:42:22 INFO - 'HOME': '/home/cltbld', 08:42:22 INFO - 'LANG': 'en_US.UTF-8', 08:42:22 INFO - 'LANGUAGE': 'en_US:en', 08:42:22 INFO - 'LOGNAME': 'cltbld', 08:42:22 INFO - 'MAIL': '/var/mail/cltbld', 08:42:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:42:22 INFO - 'MOZ_NO_REMOTE': '1', 08:42:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:42:22 INFO - 'NO_EM_RESTART': '1', 08:42:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:42:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:42:22 INFO - 'PWD': '/builds/slave/test', 08:42:22 INFO - 'SHELL': '/bin/bash', 08:42:22 INFO - 'SHLVL': '1', 08:42:22 INFO - 'TERM': 'linux', 08:42:22 INFO - 'TMOUT': '86400', 08:42:22 INFO - 'USER': 'cltbld', 08:42:22 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1494861795.280042-2121079661', 08:42:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:42:22 INFO - '_': '/tools/buildbot/bin/python'} 08:42:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:42:22 INFO - Downloading/unpacking jsonschema==2.5.1 08:42:22 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 08:42:22 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 08:42:22 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 08:42:22 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 08:42:23 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:42:23 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:42:23 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 08:42:23 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 08:42:23 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 08:42:23 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 08:42:23 INFO - Downloading functools32-3.2.3-2.tar.gz 08:42:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:42:23 INFO - warning: no files found matching '*.txt' 08:42:23 INFO - no previously-included directories found matching 'build' 08:42:23 INFO - no previously-included directories found matching 'dist' 08:42:23 INFO - no previously-included directories found matching '.git*' 08:42:23 INFO - Installing collected packages: jsonschema, functools32 08:42:23 INFO - Running setup.py install for functools32 08:42:23 INFO - warning: no files found matching '*.txt' 08:42:23 INFO - no previously-included directories found matching 'build' 08:42:23 INFO - no previously-included directories found matching 'dist' 08:42:23 INFO - no previously-included directories found matching '.git*' 08:42:23 INFO - Successfully installed jsonschema functools32 08:42:23 INFO - Cleaning up... 08:42:23 INFO - Return code: 0 08:42:23 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:42:23 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')]} 08:42:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:42:23 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')]} 08:42:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:42:23 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 0x22351f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2402a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25a85c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a57a0>, '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 0x25a66a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25a6b30>, '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': '9bfb7e13875ed353a705960e000001c0-1494861795.280042-2121079661', '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 08:42:23 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 08:42:23 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 08:42:23 INFO - Using env: {'DISPLAY': ':0', 08:42:23 INFO - 'HOME': '/home/cltbld', 08:42:23 INFO - 'LANG': 'en_US.UTF-8', 08:42:23 INFO - 'LANGUAGE': 'en_US:en', 08:42:23 INFO - 'LOGNAME': 'cltbld', 08:42:23 INFO - 'MAIL': '/var/mail/cltbld', 08:42:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:42:23 INFO - 'MOZ_NO_REMOTE': '1', 08:42:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:42:23 INFO - 'NO_EM_RESTART': '1', 08:42:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:42:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:42:23 INFO - 'PWD': '/builds/slave/test', 08:42:23 INFO - 'SHELL': '/bin/bash', 08:42:23 INFO - 'SHLVL': '1', 08:42:23 INFO - 'TERM': 'linux', 08:42:23 INFO - 'TMOUT': '86400', 08:42:23 INFO - 'USER': 'cltbld', 08:42:23 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1494861795.280042-2121079661', 08:42:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:42:23 INFO - '_': '/tools/buildbot/bin/python'} 08:42:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:42:24 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:42:24 INFO - Cleaning up... 08:42:24 INFO - Return code: 0 08:42:24 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:42:24 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')]} 08:42:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:42:24 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')]} 08:42:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:42:24 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 0x22351f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2402a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25a85c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a57a0>, '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 0x25a66a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25a6b30>, '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': '9bfb7e13875ed353a705960e000001c0-1494861795.280042-2121079661', '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 08:42:24 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 08:42:24 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 08:42:24 INFO - Using env: {'DISPLAY': ':0', 08:42:24 INFO - 'HOME': '/home/cltbld', 08:42:24 INFO - 'LANG': 'en_US.UTF-8', 08:42:24 INFO - 'LANGUAGE': 'en_US:en', 08:42:24 INFO - 'LOGNAME': 'cltbld', 08:42:24 INFO - 'MAIL': '/var/mail/cltbld', 08:42:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:42:24 INFO - 'MOZ_NO_REMOTE': '1', 08:42:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:42:24 INFO - 'NO_EM_RESTART': '1', 08:42:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:42:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:42:24 INFO - 'PWD': '/builds/slave/test', 08:42:24 INFO - 'SHELL': '/bin/bash', 08:42:24 INFO - 'SHLVL': '1', 08:42:24 INFO - 'TERM': 'linux', 08:42:24 INFO - 'TMOUT': '86400', 08:42:24 INFO - 'USER': 'cltbld', 08:42:24 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1494861795.280042-2121079661', 08:42:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:42:24 INFO - '_': '/tools/buildbot/bin/python'} 08:42:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:42:24 INFO - Downloading/unpacking blobuploader==1.2.4 08:42:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:42:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:42:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:42:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:42:25 INFO - Downloading blobuploader-1.2.4.tar.gz 08:42:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:42:25 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:42:25 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 08:42:25 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 08:42:25 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 08:42:25 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 08:42:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:42:25 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:42:25 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 08:42:25 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 08:42:25 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 08:42:25 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 08:42:25 INFO - Downloading docopt-0.6.1.tar.gz 08:42:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:42:25 INFO - Installing collected packages: blobuploader, requests, docopt 08:42:25 INFO - Running setup.py install for blobuploader 08:42:26 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:42:26 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:42:26 INFO - Running setup.py install for requests 08:42:26 INFO - Running setup.py install for docopt 08:42:26 INFO - Successfully installed blobuploader requests docopt 08:42:26 INFO - Cleaning up... 08:42:26 INFO - Return code: 0 08:42:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:42: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')]} 08:42:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:42: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')]} 08:42:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:42:26 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 0x22351f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2402a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25a85c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a57a0>, '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 0x25a66a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25a6b30>, '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': '9bfb7e13875ed353a705960e000001c0-1494861795.280042-2121079661', '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 08:42:26 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 08:42:26 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 08:42:26 INFO - Using env: {'DISPLAY': ':0', 08:42:26 INFO - 'HOME': '/home/cltbld', 08:42:26 INFO - 'LANG': 'en_US.UTF-8', 08:42:26 INFO - 'LANGUAGE': 'en_US:en', 08:42:26 INFO - 'LOGNAME': 'cltbld', 08:42:26 INFO - 'MAIL': '/var/mail/cltbld', 08:42:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:42:26 INFO - 'MOZ_NO_REMOTE': '1', 08:42:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:42:26 INFO - 'NO_EM_RESTART': '1', 08:42:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:42:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:42:26 INFO - 'PWD': '/builds/slave/test', 08:42:26 INFO - 'SHELL': '/bin/bash', 08:42:26 INFO - 'SHLVL': '1', 08:42:26 INFO - 'TERM': 'linux', 08:42:26 INFO - 'TMOUT': '86400', 08:42:26 INFO - 'USER': 'cltbld', 08:42:26 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1494861795.280042-2121079661', 08:42:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:42:26 INFO - '_': '/tools/buildbot/bin/python'} 08:42:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:42:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:42:26 INFO - Running setup.py (path:/tmp/pip-opHHWU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:42:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:42:26 INFO - Running setup.py (path:/tmp/pip-fUCtba-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:42:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:42:26 INFO - Running setup.py (path:/tmp/pip-FpLDXz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:42:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:42:26 INFO - Running setup.py (path:/tmp/pip-NWMueC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:42:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:42:27 INFO - Running setup.py (path:/tmp/pip-nAEAnS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:42:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:42:27 INFO - Running setup.py (path:/tmp/pip-HN_sTF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:42:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:42:27 INFO - Running setup.py (path:/tmp/pip-gR8RNi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:42:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:42:27 INFO - Running setup.py (path:/tmp/pip-4zLpY5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:42:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:42:27 INFO - Running setup.py (path:/tmp/pip-rmPmr6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:42:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:42:27 INFO - Running setup.py (path:/tmp/pip-O7FVEC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:42:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:42:27 INFO - Running setup.py (path:/tmp/pip-tRjgxy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:42:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:42:27 INFO - Running setup.py (path:/tmp/pip-voZkbE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:42:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:42:27 INFO - Running setup.py (path:/tmp/pip-NXTATE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:42:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:42:27 INFO - Running setup.py (path:/tmp/pip-MrKykF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:42:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:42:27 INFO - Running setup.py (path:/tmp/pip-WRb24m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:42:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:42:27 INFO - Running setup.py (path:/tmp/pip-_Zjb4q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:42:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:42:27 INFO - Running setup.py (path:/tmp/pip-o46VtI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:42:27 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:42:27 INFO - Running setup.py install for manifestparser 08:42:28 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:42:28 INFO - Running setup.py install for mozcrash 08:42:28 INFO - Running setup.py install for mozdebug 08:42:28 INFO - Running setup.py install for mozdevice 08:42:28 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:42:28 INFO - Running setup.py install for mozfile 08:42:28 INFO - Running setup.py install for mozhttpd 08:42:28 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:42:28 INFO - Running setup.py install for mozinfo 08:42:28 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:42:28 INFO - Running setup.py install for mozInstall 08:42:28 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:42:28 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:42:28 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:42:28 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:42:28 INFO - Running setup.py install for mozleak 08:42:28 INFO - Running setup.py install for mozlog 08:42:28 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:42:29 INFO - Running setup.py install for moznetwork 08:42:29 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:42:29 INFO - Running setup.py install for mozprocess 08:42:29 INFO - Running setup.py install for mozprofile 08:42:29 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:42:29 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:42:29 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:42:29 INFO - Running setup.py install for mozrunner 08:42:29 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:42:29 INFO - Running setup.py install for mozscreenshot 08:42:29 INFO - Running setup.py install for moztest 08:42:29 INFO - Running setup.py install for mozversion 08:42:29 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:42:29 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:42:29 INFO - Cleaning up... 08:42:29 INFO - Return code: 0 08:42:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:42: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')]} 08:42:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:42: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')]} 08:42:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:42:29 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 0x22351f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2402a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25a85c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a57a0>, '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 0x25a66a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25a6b30>, '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': '9bfb7e13875ed353a705960e000001c0-1494861795.280042-2121079661', '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 08:42:29 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 08:42:29 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 08:42:29 INFO - Using env: {'DISPLAY': ':0', 08:42:29 INFO - 'HOME': '/home/cltbld', 08:42:29 INFO - 'LANG': 'en_US.UTF-8', 08:42:29 INFO - 'LANGUAGE': 'en_US:en', 08:42:29 INFO - 'LOGNAME': 'cltbld', 08:42:29 INFO - 'MAIL': '/var/mail/cltbld', 08:42:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:42:29 INFO - 'MOZ_NO_REMOTE': '1', 08:42:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:42:29 INFO - 'NO_EM_RESTART': '1', 08:42:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:42:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:42:29 INFO - 'PWD': '/builds/slave/test', 08:42:29 INFO - 'SHELL': '/bin/bash', 08:42:29 INFO - 'SHLVL': '1', 08:42:29 INFO - 'TERM': 'linux', 08:42:29 INFO - 'TMOUT': '86400', 08:42:29 INFO - 'USER': 'cltbld', 08:42:29 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1494861795.280042-2121079661', 08:42:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:42:29 INFO - '_': '/tools/buildbot/bin/python'} 08:42:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:42:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:42:30 INFO - Running setup.py (path:/tmp/pip-Whx9K6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:42:30 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)) 08:42:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:42:30 INFO - Running setup.py (path:/tmp/pip-fpO5sg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:42:30 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)) 08:42:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:42:30 INFO - Running setup.py (path:/tmp/pip-MGXQ8d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:42:30 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)) 08:42:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:42:30 INFO - Running setup.py (path:/tmp/pip-vLQIqC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:42:30 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)) 08:42:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:42:30 INFO - Running setup.py (path:/tmp/pip-AKyNRz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:42:30 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)) 08:42:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:42:30 INFO - Running setup.py (path:/tmp/pip-ftKq2M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:42:30 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)) 08:42:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:42:30 INFO - Running setup.py (path:/tmp/pip-JHyVNq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:42:30 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)) 08:42:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:42:30 INFO - Running setup.py (path:/tmp/pip-pkVdVc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:42:30 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)) 08:42:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:42:30 INFO - Running setup.py (path:/tmp/pip-L3tNbo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:42:30 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)) 08:42:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:42:30 INFO - Running setup.py (path:/tmp/pip-odOqAV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:42:30 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)) 08:42:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:42:30 INFO - Running setup.py (path:/tmp/pip-7jXmnA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:42:30 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)) 08:42:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:42:30 INFO - Running setup.py (path:/tmp/pip-pXzU9b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:42:30 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)) 08:42:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:42:30 INFO - Running setup.py (path:/tmp/pip-sph6V8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:42:30 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)) 08:42:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:42:30 INFO - Running setup.py (path:/tmp/pip-BLiBtE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:42:31 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)) 08:42:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:42:31 INFO - Running setup.py (path:/tmp/pip-CrOkBe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:42:31 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)) 08:42:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:42:31 INFO - Running setup.py (path:/tmp/pip-gxQKqq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:42:31 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)) 08:42:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:42:31 INFO - Running setup.py (path:/tmp/pip-94alaV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:42:31 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)) 08:42:31 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)) 08:42:31 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)) 08:42:31 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)) 08:42:31 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)) 08:42:31 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)) 08:42:31 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:42:31 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 08:42:31 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 08:42:31 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 08:42:31 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 08:42:32 INFO - Downloading blessings-1.6.tar.gz 08:42:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:42:32 INFO - Installing collected packages: blessings 08:42:32 INFO - Running setup.py install for blessings 08:42:32 INFO - Successfully installed blessings 08:42:32 INFO - Cleaning up... 08:42:32 INFO - Return code: 0 08:42:32 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:42:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:42:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:42:32 INFO - Reading from file tmpfile_stdout 08:42:32 INFO - Current package versions: 08:42:32 INFO - argparse == 1.2.1 08:42:32 INFO - blessings == 1.6 08:42:32 INFO - blobuploader == 1.2.4 08:42:32 INFO - docopt == 0.6.1 08:42:32 INFO - functools32 == 3.2.3-2 08:42:32 INFO - jsonschema == 2.5.1 08:42:32 INFO - manifestparser == 1.1 08:42:32 INFO - mozInstall == 1.12 08:42:32 INFO - mozcrash == 1.0 08:42:32 INFO - mozdebug == 0.1 08:42:32 INFO - mozdevice == 0.50 08:42:32 INFO - mozfile == 1.2 08:42:32 INFO - mozhttpd == 0.7 08:42:32 INFO - mozinfo == 0.9 08:42:32 INFO - mozleak == 0.1 08:42:32 INFO - mozlog == 3.4 08:42:32 INFO - moznetwork == 0.27 08:42:32 INFO - mozprocess == 0.25 08:42:32 INFO - mozprofile == 0.28 08:42:32 INFO - mozrunner == 6.13 08:42:32 INFO - mozscreenshot == 0.1 08:42:32 INFO - mozsystemmonitor == 0.3 08:42:32 INFO - moztest == 0.8 08:42:32 INFO - mozversion == 1.4 08:42:32 INFO - psutil == 3.1.1 08:42:32 INFO - requests == 1.2.3 08:42:32 INFO - wsgiref == 0.1.2 08:42:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:42:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:42:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:42:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:42:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:42:32 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 0x22351f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2402a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25a85c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a57a0>, '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 0x25a66a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25a6b30>, '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': '9bfb7e13875ed353a705960e000001c0-1494861795.280042-2121079661', '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 08:42:32 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 08:42:32 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 08:42:32 INFO - Using env: {'DISPLAY': ':0', 08:42:32 INFO - 'HOME': '/home/cltbld', 08:42:32 INFO - 'LANG': 'en_US.UTF-8', 08:42:32 INFO - 'LANGUAGE': 'en_US:en', 08:42:32 INFO - 'LOGNAME': 'cltbld', 08:42:32 INFO - 'MAIL': '/var/mail/cltbld', 08:42:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:42:32 INFO - 'MOZ_NO_REMOTE': '1', 08:42:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:42:32 INFO - 'NO_EM_RESTART': '1', 08:42:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:42:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:42:32 INFO - 'PWD': '/builds/slave/test', 08:42:32 INFO - 'SHELL': '/bin/bash', 08:42:32 INFO - 'SHLVL': '1', 08:42:32 INFO - 'TERM': 'linux', 08:42:32 INFO - 'TMOUT': '86400', 08:42:32 INFO - 'USER': 'cltbld', 08:42:32 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1494861795.280042-2121079661', 08:42:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:42:32 INFO - '_': '/tools/buildbot/bin/python'} 08:42:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:42:33 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)) 08:42:33 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)) 08:42:33 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)) 08:42:33 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)) 08:42:33 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)) 08:42:33 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)) 08:42:33 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)) 08:42:33 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)) 08:42:33 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)) 08:42:33 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)) 08:42:33 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)) 08:42:33 INFO - Cleaning up... 08:42:33 INFO - Return code: 0 08:42:33 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:42:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:42:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:42:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:42:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:42:33 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 0x22351f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2402a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25a85c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a57a0>, '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 0x25a66a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25a6b30>, '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': '9bfb7e13875ed353a705960e000001c0-1494861795.280042-2121079661', '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 08:42:33 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 08:42:33 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 08:42:33 INFO - Using env: {'DISPLAY': ':0', 08:42:33 INFO - 'HOME': '/home/cltbld', 08:42:33 INFO - 'LANG': 'en_US.UTF-8', 08:42:33 INFO - 'LANGUAGE': 'en_US:en', 08:42:33 INFO - 'LOGNAME': 'cltbld', 08:42:33 INFO - 'MAIL': '/var/mail/cltbld', 08:42:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:42:33 INFO - 'MOZ_NO_REMOTE': '1', 08:42:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:42:33 INFO - 'NO_EM_RESTART': '1', 08:42:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:42:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:42:33 INFO - 'PWD': '/builds/slave/test', 08:42:33 INFO - 'SHELL': '/bin/bash', 08:42:33 INFO - 'SHLVL': '1', 08:42:33 INFO - 'TERM': 'linux', 08:42:33 INFO - 'TMOUT': '86400', 08:42:33 INFO - 'USER': 'cltbld', 08:42:33 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1494861795.280042-2121079661', 08:42:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:42:33 INFO - '_': '/tools/buildbot/bin/python'} 08:42:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:42:33 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:42:33 INFO - Cleaning up... 08:42:33 INFO - Return code: 0 08:42:33 INFO - Running post-action listener: _resource_record_post_action 08:42:33 INFO - Running post-action listener: _start_resource_monitoring 08:42:33 INFO - Starting resource monitoring. 08:42:33 INFO - [mozharness: 2017-05-15 15:42:33.306981Z] Finished create-virtualenv step (success) 08:42:33 INFO - [mozharness: 2017-05-15 15:42:33.307486Z] Running install step. 08:42:33 INFO - Running pre-action listener: _resource_record_pre_action 08:42:33 INFO - Running main action method: install 08:42:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:42:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:42:33 INFO - Reading from file tmpfile_stdout 08:42:33 INFO - Detecting whether we're running mozinstall >=1.0... 08:42:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:42:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:42:33 INFO - Reading from file tmpfile_stdout 08:42:33 INFO - Output received: 08:42:33 INFO - Usage: mozinstall [options] installer 08:42:33 INFO - Options: 08:42:33 INFO - -h, --help show this help message and exit 08:42:33 INFO - -d DEST, --destination=DEST 08:42:33 INFO - Directory to install application into. [default: 08:42:33 INFO - "/builds/slave/test"] 08:42:33 INFO - --app=APP Application being installed. [default: firefox] 08:42:33 INFO - mkdir: /builds/slave/test/build/application 08:42:33 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'] 08:42:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 08:42:49 INFO - Reading from file tmpfile_stdout 08:42:49 INFO - Output received: 08:42:49 INFO - /builds/slave/test/build/application/firefox/firefox 08:42:49 INFO - Running post-action listener: _resource_record_post_action 08:42:49 INFO - [mozharness: 2017-05-15 15:42:49.440719Z] Finished install step (success) 08:42:49 INFO - [mozharness: 2017-05-15 15:42:49.440994Z] Running run-tests step. 08:42:49 INFO - Running pre-action listener: _resource_record_pre_action 08:42:49 INFO - Running main action method: run_tests 08:42:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:42:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:42:49 INFO - Python 2.7.3 08:42:49 INFO - Return code: 0 08:42:49 INFO - grabbing minidump binary from tooltool 08:42:49 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')]} 08:42:49 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 0x25a57a0>, '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 0x25a66a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25a6b30>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:42:49 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 08:42:49 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 08:42:49 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 08:42:49 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:42:49 INFO - Return code: 0 08:42:49 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:42:49 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:42:49 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:42:49 INFO - ENV: RUST_BACKTRACE is now 1 08:42:49 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:42:49 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:42:49 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/BlNALE4CQSCZx5ZxLH6NPA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-076', '--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 08:42:49 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/BlNALE4CQSCZx5ZxLH6NPA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-076 --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 08:42:49 INFO - Using env: {'DISPLAY': ':0', 08:42:49 INFO - 'HOME': '/home/cltbld', 08:42:49 INFO - 'LANG': 'en_US.UTF-8', 08:42:49 INFO - 'LANGUAGE': 'en_US:en', 08:42:49 INFO - 'LOGNAME': 'cltbld', 08:42:49 INFO - 'MAIL': '/var/mail/cltbld', 08:42:49 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:42:49 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:42:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:42:49 INFO - 'MOZ_NO_REMOTE': '1', 08:42:49 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:42:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:42:49 INFO - 'NO_EM_RESTART': '1', 08:42:49 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:42:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:42:49 INFO - 'PWD': '/builds/slave/test', 08:42:49 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:42:49 INFO - 'RUST_BACKTRACE': '1', 08:42:49 INFO - 'SHELL': '/bin/bash', 08:42:49 INFO - 'SHLVL': '1', 08:42:49 INFO - 'TERM': 'linux', 08:42:49 INFO - 'TMOUT': '86400', 08:42:49 INFO - 'USER': 'cltbld', 08:42:49 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1494861795.280042-2121079661', 08:42:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:42:49 INFO - '_': '/tools/buildbot/bin/python'} 08:42:49 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/BlNALE4CQSCZx5ZxLH6NPA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-076', '--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 08:42:49 INFO - mozversion application_buildid: 20170515151228 08:42:49 INFO - mozversion application_changeset: 0f4df67c5f162e00d6f52825badf468aefbfba19 08:42:49 INFO - mozversion application_display_name: Nightly 08:42:49 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:42:49 INFO - mozversion application_name: Firefox 08:42:49 INFO - mozversion application_remotingname: firefox 08:42:49 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 08:42:49 INFO - mozversion application_vendor: Mozilla 08:42:49 INFO - mozversion application_version: 55.0a1 08:42:49 INFO - mozversion platform_buildid: 20170515151228 08:42:49 INFO - mozversion platform_changeset: 0f4df67c5f162e00d6f52825badf468aefbfba19 08:42:49 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 08:42:49 INFO - mozversion platform_version: 55.0a1 08:42:49 INFO - using testdate: 1494862969 08:42:49 INFO - actual date: 1494862969 08:42:49 INFO - starting webserver on 'localhost:47009' 08:42:49 INFO - SUITE-START | Running 2 tests 08:42:49 INFO - TEST-START | dromaeo_css 08:42:49 INFO - operating with platform_type : linux_ 08:42:49 INFO - Initialising browser for dromaeo_css test... 08:42:49 INFO - TEST-INFO | started process 12117 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp20_987/profile http://localhost:47009/getInfo.html) 08:42:50 INFO - PID 12117 | JavaScript warning: resource://gre/modules/addons/XPIProvider.jsm, line 2932: String.localeCompare is deprecated; use String.prototype.localeCompare instead 08:42:53 INFO - PID 12117 | __metrics Screen width/height:1600/1200 08:42:53 INFO - PID 12117 | colorDepth:24 08:42:53 INFO - PID 12117 | Browser inner width/height: 1024/695 08:42:53 INFO - PID 12117 | __metrics 08:42:55 INFO - TEST-INFO | 12117: exit 0 08:42:55 INFO - Browser initialized. 08:42:55 INFO - Running cycle 1/1 for dromaeo_css test... 08:42:55 INFO - TEST-INFO | started process 12288 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp20_987/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:43:07 INFO - PID 12288 | RSS: Main: 161533952 08:43:07 INFO - PID 12288 | 08:46:12 INFO - PID 12288 | Cycle 1(1): loaded http://localhost:47009/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47009/tests/dromaeo/cssquery-ext.html) 08:46:15 INFO - PID 12288 | RSS: Main: 168251392 08:46:15 INFO - PID 12288 | 08:49:17 INFO - PID 12288 | Cycle 1(1): loaded http://localhost:47009/tests/dromaeo/cssquery-ext.html (next: http://localhost:47009/tests/dromaeo/cssquery-jquery.html) 08:49:18 INFO - PID 12288 | RSS: Main: 167313408 08:49:18 INFO - PID 12288 | 08:52:19 INFO - PID 12288 | Cycle 1(1): loaded http://localhost:47009/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47009/tests/dromaeo/cssquery-mootools.html) 08:52:20 INFO - PID 12288 | RSS: Main: 169512960 08:52:20 INFO - PID 12288 | 08:55:22 INFO - PID 12288 | Cycle 1(1): loaded http://localhost:47009/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47009/tests/dromaeo/cssquery-prototype.html) 08:55:22 INFO - PID 12288 | RSS: Main: 167284736 08:55:22 INFO - PID 12288 | 08:58:25 INFO - PID 12288 | Cycle 1(1): loaded http://localhost:47009/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47009/tests/dromaeo/cssquery-yui.html) 08:58:26 INFO - PID 12288 | RSS: Main: 168022016 08:58:26 INFO - PID 12288 | 09:01:28 INFO - PID 12288 | Cycle 1(1): loaded http://localhost:47009/tests/dromaeo/cssquery-yui.html (next: http://localhost:47009/tests/dromaeo/cssquery-dojo.html) 09:01:28 INFO - PID 12288 | RSS: Main: 175738880 09:01:28 INFO - PID 12288 | 09:01:28 INFO - PID 12288 | __start_tp_report 09:01:28 INFO - PID 12288 | _x_x_mozilla_page_load 09:01:28 INFO - PID 12288 | _x_x_mozilla_page_load_details 09:01:28 INFO - PID 12288 | |i|pagename|runs| 09:01:28 INFO - PID 12288 | |0;dojo.html;2727.1136880513827;2730.890764369425;2732.863356832158;2759;2763.2953596832804;5300.2314664373735;5307.283516725241;5358.571314294857;5358.6516876403;5363.624546281757;5318.069337865868;5419.756110975006;5425.02349577076;5446.863828404292;5455;4685.976570117145;4764.690295130823;4773.737444440554;4806.951930480703;4852.344933433994;4772.57046865782;4816.651337625471;4860.854174374756;4887.315775791392;4912.091263116335;4759.571638552547;4798.856034318976;4811.422629284508;4871.780769865347;4875.195592727214;4777.952220477786;4788.521147885219;4794.592459640935;4840.080384726926;4847.878803029917;4696.201645720235;4760.666753327268;4761.857144285677;4774.307725379836;4803.015381846713;5226.764795584208;5270.868228294285;5342.198670199462;5352.759125839347;5381.273528073699;5733.770649174028;5747.2241247431475;5748.42515748426;5748.856278593027;5754.395788442237;5766.163906233614;5791.536677065825;5803.88392232153;5806.738696758656;5810.796622118248;5303.071962406563;5365.54392876602;5368.141097424472;5368.221607866915;5372.059889519319;5934.970325148347;5935.584509084322;5939.2575928009;5945.227120474311;5946.524278057745;5611.7474713637985;5653.858653533694;5664.830055098354;5669.461401166883;5670.489655930986;5754.223179870748;5755.884882302331;5770.105633626795;5771.249737534094;5787.421257874179;5781.1328300754385;5788.5369170466265;5789.1026890831145;5793.217915581343;5801.187833703285;5766.423357664284;5785.363610002981;5796.130580412888;5796.5072968797285;5804.448577385142;4785.377900872864;4853.514648535118;4854.417469903634;4858.7570621469495;4868.586170175575;3315.6850099240532;4216.620504154641;4241.27898257297;4270.743755374688;4301.376300436419;4983.426905905867;4993.750312484434;4993.950060499348;4996.3504744383;5044.470330615232;5861.765529378862;5878.588498805043;5878.706064696748;5890.175375447441;5891.911621325684;4883.267509873547;4944.456109827916;4962.6774259673;5000.97480016603;5034.421041580192;5223.5559977402345;5223.869403264949;5224.52979231871;5228.9738551307;5262.184361423985;5418.674879507243;5419.539339156216;5426.972865135807;5427.240186373831;5478.589105817159;5709.22925405065;5764.711764411846;5815.621984570989;5817.825465236049;5862.208601838697;5374.3013408256675;5397.190421436816;5399.244105825266;5408.78364865401;5409.702466364388;5675.375708672125;5699.287589051369;5704.458076482728;5717.313922329347;5729.140628905698;5825;5825.970870145622;5829.300483941955;5835.3581106077445;5851.912221316598;5604.075327570905;5647.068233741386;5674.602777805679;5693.715314234355;5719.714014299351;5695.686737229492;5698.430156984268;5716.314042314949;5717.342505611908;5743.1385292206505;5572.972135139298;5577.442255774552;5580.525655319343;5616.241807356118;5640.661560306395;5716.657000579979;5719.113537401709;5727.284089488814;5732.082866741302;5736.741846616829;5429.864253393696;5453.454654534515;5465.617406781487;5505.394406615349;5511.614187006871 09:01:28 INFO - PID 12288 | |1;ext.html;713.6217804563581;728.62111701915;1034.2346663469036;1055.3984228989475;1127.042014287855;30118;32765.67234327656;32901.17747056325;33020.17449563762;33041.5043774343;30131.548026779616;30266.848665756694;30376.848115759447;30492.847535762347;30569.235769105784;6288.842778930518;6326.525510586713;6432.614043157402;6450.387213214737;6932;6750.56121352113;6982.476314276424;6985.231624521324;7003.264657210996;7017.684204210797;7004.4396448284015;7041.894371584431;7072.787816365491;7073.610951397671;7097.21930587635;6977.441804655616;6979.651017449158;7006.439484841226;7025.332593403618;7036.542624729427;6848.246692863781;6862.897056544156;6918.619475928822;6919.20429150644;6921.792346229621;30599.541006884916;30925.690743092506;31151.22121946947;31190.37619247625;31241.062768116994;2823.71762823718;2841.801073924826;2843.289177705574;2851.1446566030318;2855.671597766242;23554.29337119889;23640.40898977522;23809.404764880845;23830.880845595835;23853.761462385326;3002.519596864513;3023.8790448382038;3045.269135407508;3078.5382192671054;3084.9691503085132;132726;132818.33590832082;133227;134017.32991335078;134435.6556434433;36403.817980909924;38353.80823095867;38407.61592384096;38582.22835543274;38603.420948685794;39808.80095599504;39858.800705996866;39920.80039599841;39937.60062399397;40086.198276034316;11916.285022898654;12037.337946412856;12073.637790866289;12078.637640870787;12095.637130886087;9422.481763503074;9457.148856602938;9472.621095156117;9473.47895865734;9476.620935162655;11941.283522988648;11978.880211197777;11979.161458697981;12091.939540302417;12241.877581224073;5098.388193416739;5106.795728170906;5119.257707632372;5141.948580514222;5181.689098654093;872.2237208884098;898.0390981649572;906.8911730592239;913.7258822353267;943.4056544377136;20078.69881951772;20754.792452075286;21466.677999830015;21844.12623495074;21894.343169704935;973.6077409304621;976.5215044628081;979.4319294808994;994.7015895231401;996.3025881882711;10816.296940698829;11397.715057123638;11403.42982850854;11455.828162577567;11582.305061696325;182673.086634566;183651;183758;185816;186129;40267.39598906019;40395.79802100971;40742.59257407388;40840.79579602083;40849.387259191135;1158.1603337580354;1212.3271584270815;1216.8843959823803;1222.3032871263295;1232.06363163996;19617.31339403114;19621.901890490455;20057.498562536053;20197.869330253834;20978.68531972052;29258.122256332343;29325.85337073301;29352.85323573454;29363.265918352212;29384.706152938197;158768;159478.2026089862;159715.20142399214;159728;159936.20031899767;28806.855965720875;29146.27134321659;29356.55965160567;30488.23779405444;30531.084067478012;36291;36355.818220908724;36492.63507364999;36493;36619.26761464809;26854;27448.862755686092;28123.296917577223;28126.85936570304;28474;27270.318242044108;27535;28067.859660701564;28517.287067823472;28691.426171476036;30046.098617041524;30062.398752025274;30227;30346.69653303439;30394.544081838347;26805.731942681105;26881;27126.25290574181;27679.30801729973;29163.270918227216;20386.490337741674;22925.312240632808;22957;23100.768992309862;23311.650325244795 09:01:28 INFO - PID 12288 | |2;jquery.html;411.7694091308865;420.46390851664125;421.3889859703429;429.3666841408921;442.67021069303377;11886.227395219305;13521.391537380818;16962.321507139714;17643.824111659913;17664.73502897456;18506.167222474985;18509.2596296148;18536;18677.533061673465;18799;5230.450802665713;5383.407825139231;5459.563234941215;5461.644993075457;5475.370332411784;5198.2722418861385;5437.728113594305;5442.183672449125;5461.69960652164;5468.890622187554;5241.9213711794355;5299.231611416361;5369.167778994262;5433.809816656418;5435.2934118564535;5346.331708536433;5346.91979620306;5360.2763626910455;5361.0618141825025;5384.596155288349;4658.487566367697;4842.370491836074;4870.829520966749;4880.194767863299;4882.316475693406;20872.37382878516;21013.159473621035;21025.158993640234;21122.89438552813;21218.151273949024;1611.927463264156;1629.714799910011;1632.314427940268;1635.2232689472523;1636.075617276235;13836;14327.78508322376;14483.203423811687;14555.70888582233;14572.927135364362;2010.6280338137492;2013.285283724286;2080.44868109951;2088.9268875589282;2090.1012564597218;79663.6016819918;80233;81226.18773812304;81982.59008704919;83561;10353.482325883675;10666.973275077711;10822.40476773785;11106.389148596743;11671.066314694805;15068;15121.924390378197;15134.545963621109;15166.469173578871;15170.620734481727;6809.489288303397;6887.758928437481;7013.789586312419;7162.856742865113;7193.748218812317;6270.404311590391;6272.717727702265;6408.327125651739;6477.740890364333;6483.578567393104;6642.070110184578;6711.194656641234;6866.6566671667215;6873.656317184121;6875.759348422781;2010.2963962612969;2041.5916816636732;2056.239191499155;2056.4036429435596;2061.701053347256;863.2489733931394;896.2650626486219;897.761089696228;899.5142622983516;922.7139586728135;16020.679586408207;16213.189340532927;16416.261268242717;16431.1784410779;16809.663806724042;870.0951010948669;881.4755220643707;886.3219636977717;894.9686760963335;904.7602385367883;8945.821083578292;8959.462432253955;9161;9313.487758173365;9368.90631093694;355221;359877;363226;364189;369924;75564.62217688876;75986.15017961794;76416;76779.23220767833;77009;1038.5430410619151;1044.102072217892;1066.386827574148;1067.4662668665667;1070.7055559721139;14242.501512447014;14268.501807310498;14298.499552516028;14488.637784055061;15160.696786063996;37631.62368376281;37651;37708.811455942545;37736.433953491265;37820.810895945346;46742;48860;50612.74693626508;51043;54327.45672543224;7515.736949206752;7871.48835325702;7938.880916786368;8072.556009419538;8096.352291816758;11135.33188008722;11453.713657158638;11704.239224450383;11874.406279686154;12104.152709310616;9623.278254130828;9735.318527702993;9939.30424870281;10071.496425178859;10214.233932454947;9089.318301127574;9213.723588292361;9307.488088155216;9422.670206542738;9481.857772133562;9218.723438296862;10046.598136074768;10104.343217690826;10252.38485690861;10631.627893023708;8036.799080023046;8130.583302626319;8230.341572674051;8333.499990000377;8530.317574594143;9973.850392244267;9993.550290236812;10060.899391005996;10216.591336346462;10301.845472317771 09:01:28 INFO - PID 12288 | |3;mootools.html;1248.5754843353259;1264.1530174782895;1280.91033627646;1295.423536526245;1314.717335772809;9861.60553577857;10333.483325833717;10360.378377297358;10384.792304153922;10436.634717784878;10425.947870260658;10550.997655222742;10553.6306229282;10608;10627.734306642318;2277.191596983068;2294.4149241943283;2296.1619009061737;2316.177756896303;2318.188633978111;2169.9132034718673;2196.5606878624258;2218.977810221901;2220.4226901005773;2221.3669104305277;2181.6727490876337;2197.241951526729;2232.2968264996475;2233.0955962834996;2241.2491815241833;2022.6573191638704;2083.2396175395947;2117.8517503774665;2119.586680597284;2125.436759258798;2034.6235946349973;2180.967285490719;2189.2884812436023;2191.430228140679;2220.844540882139;10111.191104711605;10138.03688649577;10185.694429167137;10256.43589602579;10264.076233139054;5685.886282274331;5900.64596124234;5902.144189092601;5926.703664816785;5946.70266486674;3220.91947701307;3257.5234795205893;3377.392069427502;3427.5886893572683;3438.8452519636676;1087.0325410384764;1120.3445984099312;1132.8527291452142;1133.076542617772;1133.9433028348549;15056.849431505763;15060.397584096623;15107.924460377737;15137.621559461102;15238.466653667068;4610.907781844345;4755.881102972453;4942.110420124341;4947.109520286383;5020.723860187652;10836.783264334827;10846.45767711627;10859.18556108295;10860.076893463985;10863.891361086446;5639.6334238274385;5653.378128405872;5653.9151912721345;5666.093425052054;5671.461211184931;5014.197728363444;5123.769430375642;5250.553702935217;5253.975474782381;5259.0796610593;3670.9816450917574;3735.8879233623034;3793.6206379362393;3834;3865.6520913117956;1095.46322302073;1096.336716286635;1100.1968562949091;1114.2311804854623;1119.4290911635126;704.9823754406181;717.6806321187127;720.5676594043532;732.7984804178786;741.5773009384599;5504.752286147133;5589.860253493695;5624.409437009055;5687.118496632946;5734.713264336767;531.8085489223877;554.3458718711878;556.6743455078824;557.7796770275719;558.4750334685383;3312.7681062325405;3361.2941582026215;3386.8645254189555;3636.745427820027;3723.422869455239;12875.291858947849;13775.173489590657;13860.306984650728;13864.653383665287;13864.722705545833;13440.731185376238;13486.460541578423;13514.256715880721;13599.184048957095;13668.794968075486;7665.156832748393;7898.486598371088;7944.205579442125;7993.880091798627;8077.35381169505;5413.106837371947;5433.157860531624;5707.372189059117;5718.971405142947;5992.221011268507;11459.828102578302;11887.762244754884;11892.702682432662;11956.34240116802;12268.141230113806;11928.821067683819;11992.460339284578;12035.157538972187;12192.329421881881;12198.268103913793;7985.840283194188;8313.168683131638;8313.41806073569;8353.95823020881;8420.747377578682;9197.264218862341;9210.861837072584;9231.676891308773;9303.209227215762;9373.531323433665;7812.648430820513;7982.521048737094;8113.5131892086665;8190.180981901762;8223.917760822555;7499.5875226863045;7662.6934922604705;7670.463067585216;7733.883991740241;7735.419843511647;7066.328698773608;7199.172095209118;7205.279472052753;7214.098237720285;7214.639268036683;5050.166722490748;5284.154535274338;5336;5490;5592.273004509388;5387.218853266333;5439.945600543944;5454.990826697073;5500.972495137498;5569.415211402745 09:01:28 INFO - PID 12288 | |4;prototype.html;368.73819588092454;379.48579674540997;385.93632050711625;386.43773309834177;390.9315869722798;5468.535174510162;5610.382857885635;5654.519365853907;5673.716314184295;5689.402612725667;5396.082665946788;5445.782168713246;5497.367802702691;5504.091824848895;5519.668819870811;4094.6928980326447;4095.9385609215888;4124.855630052949;4128.710990230685;4135.813888375031;4072.696737044147;4090.8772736817796;4099.118689481761;4129.752214867118;4149.107941792514;4070.613291737295;4074.6740260779216;4081;4089.1208390196102;4101.753894766309;4082.7340825841648;4083.938740918874;4084.346504559286;4103.507579090498;4115.36211887158;3564.8395822188063;3570.80360580168;3572.071261472036;3577.3560759063357;3578.58846232684;5268.473152684739;5381.704006279653;5382.273393091961;5386.757595908154;5430.266913966603;4802.903941921142;4837.346958160639;4838.201696720037;4842.806287748486;4852.320675105488;5756.222909907151;5761.3950535194035;5817.243758311435;5839.751695597183;5862.325832529271;3959.425883246942;3963.1875465529783;3976.170961357779;3988.282109220339;3994.720369574131;5997.6701281429505;6106.45041946227;6145.385461453863;6161.383861613803;6205.906911396378;4088.7955602220363;4117.855875044359;4119.134981653826;4125.339945608688;4127.7936103194725;4149.33610622299;4162.958370416318;4166.395872598457;4178.561251068655;4179.644730197967;4722.338872557844;4752.976235118802;4811.6767888830855;4846.903061938741;4857.417109946829;5857.121431785266;5858.53131749459;5866.658672582258;5870.26621672291;5901.114832775118;1425.8075159853288;1430.1204759073303;1430.928453577317;1432.9355179016968;1434.6700258940293;922.3589605224305;956.3592393096642;957.7892863570004;959.5586030426082;963.4989805301204;5058.519440653132;5075.213341932006;5079.212722028092;5082.110630639697;5089.160288552347;5997;6017.578769486182;6045.21412216409;6058.757649694051;6071.51427885768;4924.8276310328965;5036.622253331015;5057.924131138036;5105.770240339194;5119.692818430832;3187.0240450920114;3210.3097833965808;3224.4357237483346;3228.4188846007946;3245.123816569513;5477.863053423696;5646.096624540136;5652.152177173375;5652.660840349592;5657.377688454267;6261.436470717566;6295.98528470885;6298.330942300294;6304.968475157595;6312.747490100344;5624.268845050199;5653.152027195872;5661.235733176051;5667.2349232854685;5667.979763642502;5913.733881975408;6080.270367555921;6103.633781973096;6117.296510901303;6139.465133716571;5994.100884867305;6002.369751176238;6005.438585967592;6020.127081573235;6028.0355143176885;5450.400455949922;5612.775488980558;5637.633553818989;5642.802501912413;5664.405237450009;4569.451665800125;4625.884352891205;4628.861134165981;4631.791569379453;4648.814047438064;5839.0949402842625;6018.668973206516;6138.416850399205;6142;6188.783392581238;5853.326867410132;5864.589478736448;5872.941270587239;5875.294964604275;5875.529957603467;5856.12158176277;5878.941210587839;5891.675957822361;5892.911606325994;5920.851978700567;5548.639338442988;5745.621050947826;5824.184614153937;5829.242198514166;5847.210626565529;5903.793367232126;5940.405959404025;5951.345352011189;5959;5964;5508.504234618904;5687.971560142173;5735.87772524152;5756.683382414008;5767.394423585463 09:01:28 INFO - PID 12288 | |5;yui.html;615.2555407956372;621.4717490133385;627.9905801412979;628.3716283716284;629.1600713048081;12095.153339266244;12488.063395245348;12499.187552809073;13928.303584820744;14911.7017659647;14637.194954277511;14773.852261477383;15007.474738384159;15010.849891501082;15203.391864325413;872.3631748823378;886.8935727712684;886.9246114080311;889.0176355127588;891.7057371067532;864.6195673903494;881.8060026794095;897.7082448204327;897.7710683775628;904.6336233825278;934.392644780891;934.8691183234318;937.1237892570434;937.2642475656611;938.6433155400972;927.4435338796735;928.0858354520825;928.2295694573488;931.1805611062222;933.3932943586655;686.0943554508051;694.1150033707014;695.4644923408947;696.4184905603777;696.4393663101201;12115.39423028845;12434.564790232298;12501.062420318513;12532.060095492783;12880.871191288155;14702.4854130106;14852.331645075998;15339.233038348038;15359.232038398035;15384.230788460643;11627.76744465106;11741.236819606698;11775.823362649568;11776.352300623463;11784.587539436165;2813.6201612782215;2905.970940290591;2911.970880291191;2928.3411232472736;2931.062060140756;61564;62944;63129;63367.683161584355;64041.67979160074;12017.098717596215;12356.691082722824;12359.62921112368;12477.376131193585;12654.873451265554;18901.62196756057;19967.500812479513;19992.300269490497;20096.59806803885;20121.49696257576;6090.421409966046;6098.207233059674;6175.876482470326;6184.628922264678;6232.657203853741;2948.88204471823;3003.834789086621;3013.0960711786374;3013.4575776360466;3020.6073210482937;3296.3901678189613;3375.8987230383127;3401.931961360759;3404.14896275931;3408.0457471907907;734.9485536012535;736.7458226911707;740.2412527159597;741.2328240271294;742.6286856571714;592.3424998251937;607.7325976570384;610.71906922816;614.2874265851591;629.8551333193391;9460.243180545678;9487.715368538955;9515.23878089751;9631.807363852684;9894.80210395788;598.9041753319448;605.8424809549549;610.996945015281;611.9479844213203;622.4988883948465;4205.137946720914;4271.508776490681;4291.249031419489;4319.568043195718;4326.6538676905775;62885.68557157185;62929.68535157386;63324.36675633277;64043;64128;57000;57307.426925731044;57788;57974;58004.4199557999;52423;52796.73601632044;52863.73568132135;52958.73520632449;53007;8650.870236946577;8773.736787896374;8809.735707928772;8812.823743525221;9013.774655633662;26832.19503414901;27248.455030898873;27801.721982779913;27895.860520697268;28294;32471.837640811646;32574.34851303008;33087;33241;33391.49912751359;10319.329243599143;10486.895131048592;10574.41840698769;10606.840897386392;10612.151027917593;12020.459079341275;12029.278243305429;12427.875721242672;12441.502339906303;12532.185407948455;11593.188476806543;11827.763444730885;13023.413946372246;13520.459181632625;13647.590572282847;13225.074244803156;13449.327533623475;13554.72890542164;13558.186508809504;13711;13899.791503127664;13959.651008724457;14242;14319.785203221752;14433.566992990227;9904.207663387057;10013.098821106136;10041.196704263788;10185.185185185019;10501.947490262806;11219.419533507176;11660.358680272666;11681.182317237712;11789.410529473664;12097.879021210027 09:01:28 INFO - PID 12288 | __end_tp_report 09:01:28 INFO - PID 12288 | __start_cc_report 09:01:28 INFO - PID 12288 | _x_x_mozilla_cycle_collect,283 09:01:28 INFO - PID 12288 | __end_cc_report 09:01:28 INFO - PID 12288 | __startTimestamp1494864088543__endTimestamp 09:01:28 INFO - PID 12288 | 09:01:28 INFO - PID 12288 | ------- Summary: start ------- 09:01:28 INFO - PID 12288 | Number of tests: 6 09:01:28 INFO - PID 12288 | 09:01:28 INFO - PID 12288 | [#0] dojo.html Cycles:165 Average:5303.18 Median:5429.86 stddev:635.30 (11.7%) stddev-sans-first:604.26 09:01:28 INFO - PID 12288 | Values: 2727.1 2730.9 2732.9 2759.0 2763.3 5300.2 5307.3 5358.6 5358.7 5363.6 5318.1 5419.8 5425.0 5446.9 5455.0 4686.0 4764.7 4773.7 4807.0 4852.3 4772.6 4816.7 4860.9 4887.3 4912.1 4759.6 4798.9 4811.4 4871.8 4875.2 4778.0 4788.5 4794.6 4840.1 4847.9 4696.2 4760.7 4761.9 4774.3 4803.0 5226.8 5270.9 5342.2 5352.8 5381.3 5733.8 5747.2 5748.4 5748.9 5754.4 5766.2 5791.5 5803.9 5806.7 5810.8 5303.1 5365.5 5368.1 5368.2 5372.1 5935.0 5935.6 5939.3 5945.2 5946.5 5611.7 5653.9 5664.8 5669.5 5670.5 5754.2 5755.9 5770.1 5771.2 5787.4 5781.1 5788.5 5789.1 5793.2 5801.2 5766.4 5785.4 5796.1 5796.5 5804.4 4785.4 4853.5 4854.4 4858.8 4868.6 3315.7 4216.6 4241.3 4270.7 4301.4 4983.4 4993.8 4994.0 4996.4 5044.5 5861.8 5878.6 5878.7 5890.2 5891.9 4883.3 4944.5 4962.7 5001.0 5034.4 5223.6 5223.9 5224.5 5229.0 5262.2 5418.7 5419.5 5427.0 5427.2 5478.6 5709.2 5764.7 5815.6 5817.8 5862.2 5374.3 5397.2 5399.2 5408.8 5409.7 5675.4 5699.3 5704.5 5717.3 5729.1 5825.0 5826.0 5829.3 5835.4 5851.9 5604.1 5647.1 5674.6 5693.7 5719.7 5695.7 5698.4 5716.3 5717.3 5743.1 5573.0 5577.4 5580.5 5616.2 5640.7 5716.7 5719.1 5727.3 5732.1 5736.7 5429.9 5453.5 5465.6 5505.4 5511.6 09:01:28 INFO - PID 12288 | 09:01:28 INFO - PID 12288 | [#1] ext.html Cycles:180 Average:30018.44 Median:30179.27 stddev:41437.52 (137.3%) stddev-sans-first:41495.34 09:01:28 INFO - PID 12288 | Values: 713.6 728.6 1034.2 1055.4 1127.0 30118.0 32765.7 32901.2 33020.2 33041.5 30131.5 30266.8 30376.8 30492.8 30569.2 6288.8 6326.5 6432.6 6450.4 6932.0 6750.6 6982.5 6985.2 7003.3 7017.7 7004.4 7041.9 7072.8 7073.6 7097.2 6977.4 6979.7 7006.4 7025.3 7036.5 6848.2 6862.9 6918.6 6919.2 6921.8 30599.5 30925.7 31151.2 31190.4 31241.1 2823.7 2841.8 2843.3 2851.1 2855.7 23554.3 23640.4 23809.4 23830.9 23853.8 3002.5 3023.9 3045.3 3078.5 3085.0 132726.0 132818.3 133227.0 134017.3 134435.7 36403.8 38353.8 38407.6 38582.2 38603.4 39808.8 39858.8 39920.8 39937.6 40086.2 11916.3 12037.3 12073.6 12078.6 12095.6 9422.5 9457.1 9472.6 9473.5 9476.6 11941.3 11978.9 11979.2 12091.9 12241.9 5098.4 5106.8 5119.3 5141.9 5181.7 872.2 898.0 906.9 913.7 943.4 20078.7 20754.8 21466.7 21844.1 21894.3 973.6 976.5 979.4 994.7 996.3 10816.3 11397.7 11403.4 11455.8 11582.3 182673.1 183651.0 183758.0 185816.0 186129.0 40267.4 40395.8 40742.6 40840.8 40849.4 1158.2 1212.3 1216.9 1222.3 1232.1 19617.3 19621.9 20057.5 20197.9 20978.7 29258.1 29325.9 29352.9 29363.3 29384.7 158768.0 159478.2 159715.2 159728.0 159936.2 28806.9 29146.3 29356.6 30488.2 30531.1 36291.0 36355.8 36492.6 36493.0 36619.3 26854.0 27448.9 28123.3 28126.9 28474.0 27270.3 27535.0 28067.9 28517.3 28691.4 30046.1 30062.4 30227.0 30346.7 30394.5 26805.7 26881.0 27126.3 27679.3 29163.3 20386.5 22925.3 22957.0 23100.8 23311.7 09:01:28 INFO - PID 12288 | 09:01:28 INFO - PID 12288 | [#2] jquery.html Cycles:180 Average:24070.56 Median:25792.19 stddev:60275.64 (233.7%) stddev-sans-first:60418.55 09:01:28 INFO - PID 12288 | Values: 411.8 420.5 421.4 429.4 442.7 11886.2 13521.4 16962.3 17643.8 17664.7 18506.2 18509.3 18536.0 18677.5 18799.0 5230.5 5383.4 5459.6 5461.6 5475.4 5198.3 5437.7 5442.2 5461.7 5468.9 5241.9 5299.2 5369.2 5433.8 5435.3 5346.3 5346.9 5360.3 5361.1 5384.6 4658.5 4842.4 4870.8 4880.2 4882.3 20872.4 21013.2 21025.2 21122.9 21218.2 1611.9 1629.7 1632.3 1635.2 1636.1 13836.0 14327.8 14483.2 14555.7 14572.9 2010.6 2013.3 2080.4 2088.9 2090.1 79663.6 80233.0 81226.2 81982.6 83561.0 10353.5 10667.0 10822.4 11106.4 11671.1 15068.0 15121.9 15134.5 15166.5 15170.6 6809.5 6887.8 7013.8 7162.9 7193.7 6270.4 6272.7 6408.3 6477.7 6483.6 6642.1 6711.2 6866.7 6873.7 6875.8 2010.3 2041.6 2056.2 2056.4 2061.7 863.2 896.3 897.8 899.5 922.7 16020.7 16213.2 16416.3 16431.2 16809.7 870.1 881.5 886.3 895.0 904.8 8945.8 8959.5 9161.0 9313.5 9368.9 355221.0 359877.0 363226.0 364189.0 369924.0 75564.6 75986.2 76416.0 76779.2 77009.0 1038.5 1044.1 1066.4 1067.5 1070.7 14242.5 14268.5 14298.5 14488.6 15160.7 37631.6 37651.0 37708.8 37736.4 37820.8 46742.0 48860.0 50612.7 51043.0 54327.5 7515.7 7871.5 7938.9 8072.6 8096.4 11135.3 11453.7 11704.2 11874.4 12104.2 9623.3 9735.3 9939.3 10071.5 10214.2 9089.3 9213.7 9307.5 9422.7 9481.9 9218.7 10046.6 10104.3 10252.4 10631.6 8036.8 8130.6 8230.3 8333.5 8530.3 9973.9 9993.6 10060.9 10216.6 10301.8 09:01:28 INFO - PID 12288 | 09:01:28 INFO - PID 12288 | [#3] mootools.html Cycles:180 Average:6292.93 Median:3433.22 stddev:4083.42 (118.9%) stddev-sans-first:4077.29 09:01:28 INFO - PID 12288 | Values: 1248.6 1264.2 1280.9 1295.4 1314.7 9861.6 10333.5 10360.4 10384.8 10436.6 10425.9 10551.0 10553.6 10608.0 10627.7 2277.2 2294.4 2296.2 2316.2 2318.2 2169.9 2196.6 2219.0 2220.4 2221.4 2181.7 2197.2 2232.3 2233.1 2241.2 2022.7 2083.2 2117.9 2119.6 2125.4 2034.6 2181.0 2189.3 2191.4 2220.8 10111.2 10138.0 10185.7 10256.4 10264.1 5685.9 5900.6 5902.1 5926.7 5946.7 3220.9 3257.5 3377.4 3427.6 3438.8 1087.0 1120.3 1132.9 1133.1 1133.9 15056.8 15060.4 15107.9 15137.6 15238.5 4610.9 4755.9 4942.1 4947.1 5020.7 10836.8 10846.5 10859.2 10860.1 10863.9 5639.6 5653.4 5653.9 5666.1 5671.5 5014.2 5123.8 5250.6 5254.0 5259.1 3671.0 3735.9 3793.6 3834.0 3865.7 1095.5 1096.3 1100.2 1114.2 1119.4 705.0 717.7 720.6 732.8 741.6 5504.8 5589.9 5624.4 5687.1 5734.7 531.8 554.3 556.7 557.8 558.5 3312.8 3361.3 3386.9 3636.7 3723.4 12875.3 13775.2 13860.3 13864.7 13864.7 13440.7 13486.5 13514.3 13599.2 13668.8 7665.2 7898.5 7944.2 7993.9 8077.4 5413.1 5433.2 5707.4 5719.0 5992.2 11459.8 11887.8 11892.7 11956.3 12268.1 11928.8 11992.5 12035.2 12192.3 12198.3 7985.8 8313.2 8313.4 8354.0 8420.7 9197.3 9210.9 9231.7 9303.2 9373.5 7812.6 7982.5 8113.5 8190.2 8223.9 7499.6 7662.7 7670.5 7733.9 7735.4 7066.3 7199.2 7205.3 7214.1 7214.6 5050.2 5284.2 5336.0 5490.0 5592.3 5387.2 5439.9 5455.0 5501.0 5569.4 09:01:28 INFO - PID 12288 | 09:01:28 INFO - PID 12288 | [#4] prototype.html Cycles:180 Average:4815.67 Median:5500.73 stddev:1443.84 (26.2%) stddev-sans-first:1408.79 09:01:28 INFO - PID 12288 | Values: 368.7 379.5 385.9 386.4 390.9 5468.5 5610.4 5654.5 5673.7 5689.4 5396.1 5445.8 5497.4 5504.1 5519.7 4094.7 4095.9 4124.9 4128.7 4135.8 4072.7 4090.9 4099.1 4129.8 4149.1 4070.6 4074.7 4081.0 4089.1 4101.8 4082.7 4083.9 4084.3 4103.5 4115.4 3564.8 3570.8 3572.1 3577.4 3578.6 5268.5 5381.7 5382.3 5386.8 5430.3 4802.9 4837.3 4838.2 4842.8 4852.3 5756.2 5761.4 5817.2 5839.8 5862.3 3959.4 3963.2 3976.2 3988.3 3994.7 5997.7 6106.5 6145.4 6161.4 6205.9 4088.8 4117.9 4119.1 4125.3 4127.8 4149.3 4163.0 4166.4 4178.6 4179.6 4722.3 4753.0 4811.7 4846.9 4857.4 5857.1 5858.5 5866.7 5870.3 5901.1 1425.8 1430.1 1430.9 1432.9 1434.7 922.4 956.4 957.8 959.6 963.5 5058.5 5075.2 5079.2 5082.1 5089.2 5997.0 6017.6 6045.2 6058.8 6071.5 4924.8 5036.6 5057.9 5105.8 5119.7 3187.0 3210.3 3224.4 3228.4 3245.1 5477.9 5646.1 5652.2 5652.7 5657.4 6261.4 6296.0 6298.3 6305.0 6312.7 5624.3 5653.2 5661.2 5667.2 5668.0 5913.7 6080.3 6103.6 6117.3 6139.5 5994.1 6002.4 6005.4 6020.1 6028.0 5450.4 5612.8 5637.6 5642.8 5664.4 4569.5 4625.9 4628.9 4631.8 4648.8 5839.1 6018.7 6138.4 6142.0 6188.8 5853.3 5864.6 5872.9 5875.3 5875.5 5856.1 5878.9 5891.7 5892.9 5920.9 5548.6 5745.6 5824.2 5829.2 5847.2 5903.8 5940.4 5951.3 5959.0 5964.0 5508.5 5688.0 5735.9 5756.7 5767.4 09:01:28 INFO - PID 12288 | 09:01:28 INFO - PID 12288 | [#5] yui.html Cycles:180 Average:14644.20 Median:3388.92 stddev:17536.58 (517.5%) stddev-sans-first:17554.13 09:01:28 INFO - PID 12288 | Values: 615.3 621.5 628.0 628.4 629.2 12095.2 12488.1 12499.2 13928.3 14911.7 14637.2 14773.9 15007.5 15010.8 15203.4 872.4 886.9 886.9 889.0 891.7 864.6 881.8 897.7 897.8 904.6 934.4 934.9 937.1 937.3 938.6 927.4 928.1 928.2 931.2 933.4 686.1 694.1 695.5 696.4 696.4 12115.4 12434.6 12501.1 12532.1 12880.9 14702.5 14852.3 15339.2 15359.2 15384.2 11627.8 11741.2 11775.8 11776.4 11784.6 2813.6 2906.0 2912.0 2928.3 2931.1 61564.0 62944.0 63129.0 63367.7 64041.7 12017.1 12356.7 12359.6 12477.4 12654.9 18901.6 19967.5 19992.3 20096.6 20121.5 6090.4 6098.2 6175.9 6184.6 6232.7 2948.9 3003.8 3013.1 3013.5 3020.6 3296.4 3375.9 3401.9 3404.1 3408.0 734.9 736.7 740.2 741.2 742.6 592.3 607.7 610.7 614.3 629.9 9460.2 9487.7 9515.2 9631.8 9894.8 598.9 605.8 611.0 611.9 622.5 4205.1 4271.5 4291.2 4319.6 4326.7 62885.7 62929.7 63324.4 64043.0 64128.0 57000.0 57307.4 57788.0 57974.0 58004.4 52423.0 52796.7 52863.7 52958.7 53007.0 8650.9 8773.7 8809.7 8812.8 9013.8 26832.2 27248.5 27801.7 27895.9 28294.0 32471.8 32574.3 33087.0 33241.0 33391.5 10319.3 10486.9 10574.4 10606.8 10612.2 12020.5 12029.3 12427.9 12441.5 12532.2 11593.2 11827.8 13023.4 13520.5 13647.6 13225.1 13449.3 13554.7 13558.2 13711.0 13899.8 13959.7 14242.0 14319.8 14433.6 9904.2 10013.1 10041.2 10185.2 10501.9 11219.4 11660.4 11681.2 11789.4 12097.9 09:01:28 INFO - PID 12288 | -------- Summary: end -------- 09:01:28 INFO - PID 12288 | 09:01:29 INFO - TEST-INFO | 12288: exit 0 09:01:29 INFO - TEST-OK | dromaeo_css | took 1119698ms 09:01:29 INFO - TEST-START | kraken 09:01:29 INFO - operating with platform_type : linux_ 09:01:29 INFO - Initialising browser for kraken test... 09:01:29 INFO - TEST-INFO | started process 12702 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjmQkSP/profile http://localhost:47009/getInfo.html) 09:01:29 INFO - PID 12702 | JavaScript warning: resource://gre/modules/addons/XPIProvider.jsm, line 2932: String.localeCompare is deprecated; use String.prototype.localeCompare instead 09:01:33 INFO - PID 12702 | __metrics Screen width/height:1600/1200 09:01:33 INFO - PID 12702 | colorDepth:24 09:01:33 INFO - PID 12702 | Browser inner width/height: 1024/695 09:01:33 INFO - PID 12702 | __metrics 09:01:35 INFO - TEST-INFO | 12702: exit 0 09:01:35 INFO - Browser initialized. 09:01:35 INFO - Running cycle 1/1 for kraken test... 09:01:35 INFO - TEST-INFO | started process 12871 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjmQkSP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:01:47 INFO - PID 12871 | RSS: Main: 161366016 09:01:47 INFO - PID 12871 | 09:01:49 INFO - PID 12871 | Cycle 1(1): loaded http://localhost:47009/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47009/tests/kraken/driver.html?testName=audio-beat-detection) 09:01:50 INFO - PID 12871 | RSS: Main: 167251968 09:01:50 INFO - PID 12871 | 09:01:53 INFO - PID 12871 | Cycle 1(1): loaded http://localhost:47009/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47009/tests/kraken/driver.html?testName=audio-dft) 09:01:54 INFO - PID 12871 | RSS: Main: 165937152 09:01:54 INFO - PID 12871 | 09:01:57 INFO - PID 12871 | Cycle 1(1): loaded http://localhost:47009/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47009/tests/kraken/driver.html?testName=audio-fft) 09:01:57 INFO - PID 12871 | RSS: Main: 161472512 09:01:57 INFO - PID 12871 | 09:01:59 INFO - PID 12871 | Cycle 1(1): loaded http://localhost:47009/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47009/tests/kraken/driver.html?testName=audio-oscillator) 09:02:00 INFO - PID 12871 | RSS: Main: 161988608 09:02:00 INFO - PID 12871 | 09:02:02 INFO - PID 12871 | Cycle 1(1): loaded http://localhost:47009/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47009/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:02:03 INFO - PID 12871 | RSS: Main: 162922496 09:02:03 INFO - PID 12871 | 09:02:06 INFO - PID 12871 | Cycle 1(1): loaded http://localhost:47009/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47009/tests/kraken/driver.html?testName=imaging-darkroom) 09:02:06 INFO - PID 12871 | RSS: Main: 167124992 09:02:06 INFO - PID 12871 | 09:02:10 INFO - PID 12871 | Cycle 1(1): loaded http://localhost:47009/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47009/tests/kraken/driver.html?testName=imaging-desaturate) 09:02:11 INFO - PID 12871 | RSS: Main: 164331520 09:02:11 INFO - PID 12871 | 09:02:13 INFO - PID 12871 | Cycle 1(1): loaded http://localhost:47009/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47009/tests/kraken/driver.html?testName=json-parse-financial) 09:02:14 INFO - PID 12871 | RSS: Main: 165171200 09:02:14 INFO - PID 12871 | 09:02:16 INFO - PID 12871 | Cycle 1(1): loaded http://localhost:47009/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47009/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:02:16 INFO - PID 12871 | RSS: Main: 165179392 09:02:16 INFO - PID 12871 | 09:02:18 INFO - PID 12871 | Cycle 1(1): loaded http://localhost:47009/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47009/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:02:19 INFO - PID 12871 | RSS: Main: 165314560 09:02:19 INFO - PID 12871 | 09:02:21 INFO - PID 12871 | Cycle 1(1): loaded http://localhost:47009/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47009/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:02:21 INFO - PID 12871 | RSS: Main: 165232640 09:02:21 INFO - PID 12871 | 09:02:24 INFO - PID 12871 | Cycle 1(1): loaded http://localhost:47009/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47009/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:02:25 INFO - PID 12871 | RSS: Main: 165752832 09:02:25 INFO - PID 12871 | 09:02:28 INFO - PID 12871 | Cycle 1(1): loaded http://localhost:47009/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47009/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:02:29 INFO - PID 12871 | RSS: Main: 165134336 09:02:29 INFO - PID 12871 | 09:02:30 INFO - PID 12871 | Cycle 1(1): loaded http://localhost:47009/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47009/tests/kraken/driver.html?testName=ai-astar) 09:02:31 INFO - PID 12871 | RSS: Main: 166703104 09:02:31 INFO - PID 12871 | 09:02:31 INFO - PID 12871 | __start_tp_report 09:02:31 INFO - PID 12871 | _x_x_mozilla_page_load 09:02:31 INFO - PID 12871 | _x_x_mozilla_page_load_details 09:02:31 INFO - PID 12871 | |i|pagename|runs| 09:02:31 INFO - PID 12871 | |0;ai-astar;106;113;111;111;115;112;110;113;113;112 09:02:31 INFO - PID 12871 | |1;audio-beat-detection;157;121;123;188;129;123;127;125;151;124 09:02:31 INFO - PID 12871 | |2;audio-dft;164;165;165;165;165;166;166;169;165;165 09:02:31 INFO - PID 12871 | |3;audio-fft;75;75;75;117;75;76;75;84;101;77 09:02:31 INFO - PID 12871 | |4;audio-oscillator;86;82;100;84;83;84;111;84;88;110 09:02:31 INFO - PID 12871 | |5;imaging-gaussian-blur;113;114;114;114;114;115;114;113;114;115 09:02:31 INFO - PID 12871 | |6;imaging-darkroom;150;150;150;151;150;151;151;149;151;151 09:02:31 INFO - PID 12871 | |7;imaging-desaturate;95;95;94;96;95;95;94;95;94;94 09:02:31 INFO - PID 12871 | |8;json-parse-financial;53;55;55;54;57;57;55;55;56;57 09:02:31 INFO - PID 12871 | |9;json-stringify-tinderbox;55;55;55;55;55;55;55;57;55;55 09:02:31 INFO - PID 12871 | |10;stanford-crypto-aes;83;81;84;83;84;82;81;83;82;84 09:02:31 INFO - PID 12871 | |11;stanford-crypto-ccm;144;134;141;132;131;135;132;132;181;133 09:02:31 INFO - PID 12871 | |12;stanford-crypto-pbkdf2;187;200;197;192;195;197;195;198;189;194 09:02:31 INFO - PID 12871 | |13;stanford-crypto-sha256-iterative;76;73;74;72;76;73;72;72;76;71 09:02:31 INFO - PID 12871 | __end_tp_report 09:02:31 INFO - PID 12871 | __start_cc_report 09:02:31 INFO - PID 12871 | _x_x_mozilla_cycle_collect,786 09:02:31 INFO - PID 12871 | __end_cc_report 09:02:31 INFO - PID 12871 | __startTimestamp1494864151233__endTimestamp 09:02:31 INFO - PID 12871 | 09:02:31 INFO - PID 12871 | ------- Summary: start ------- 09:02:31 INFO - PID 12871 | Number of tests: 14 09:02:31 INFO - PID 12871 | 09:02:31 INFO - PID 12871 | [#0] ai-astar Cycles:10 Average:111.60 Median:112.50 stddev:2.41 (2.1%) stddev-sans-first:1.48 09:02:31 INFO - PID 12871 | Values: 106.0 113.0 111.0 111.0 115.0 112.0 110.0 113.0 113.0 112.0 09:02:31 INFO - PID 12871 | 09:02:31 INFO - PID 12871 | [#1] audio-beat-detection Cycles:10 Average:136.80 Median:128.00 stddev:21.91 (17.1%) stddev-sans-first:21.99 09:02:31 INFO - PID 12871 | Values: 157.0 121.0 123.0 188.0 129.0 123.0 127.0 125.0 151.0 124.0 09:02:31 INFO - PID 12871 | 09:02:31 INFO - PID 12871 | [#2] audio-dft Cycles:10 Average:165.50 Median:165.00 stddev:1.35 (0.8%) stddev-sans-first:1.32 09:02:31 INFO - PID 12871 | Values: 164.0 165.0 165.0 165.0 165.0 166.0 166.0 169.0 165.0 165.0 09:02:31 INFO - PID 12871 | 09:02:31 INFO - PID 12871 | [#3] audio-fft Cycles:10 Average:83.00 Median:75.00 stddev:14.48 (19.3%) stddev-sans-first:15.06 09:02:31 INFO - PID 12871 | Values: 75.0 75.0 75.0 117.0 75.0 76.0 75.0 84.0 101.0 77.0 09:02:31 INFO - PID 12871 | 09:02:31 INFO - PID 12871 | [#4] audio-oscillator Cycles:10 Average:91.20 Median:84.00 stddev:11.39 (13.6%) stddev-sans-first:11.92 09:02:31 INFO - PID 12871 | Values: 86.0 82.0 100.0 84.0 83.0 84.0 111.0 84.0 88.0 110.0 09:02:31 INFO - PID 12871 | 09:02:31 INFO - PID 12871 | [#5] imaging-gaussian-blur Cycles:10 Average:114.00 Median:114.00 stddev:0.67 (0.6%) stddev-sans-first:0.60 09:02:31 INFO - PID 12871 | Values: 113.0 114.0 114.0 114.0 114.0 115.0 114.0 113.0 114.0 115.0 09:02:31 INFO - PID 12871 | 09:02:31 INFO - PID 12871 | [#6] imaging-darkroom Cycles:10 Average:150.40 Median:151.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 09:02:31 INFO - PID 12871 | Values: 150.0 150.0 150.0 151.0 150.0 151.0 151.0 149.0 151.0 151.0 09:02:31 INFO - PID 12871 | 09:02:31 INFO - PID 12871 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 09:02:31 INFO - PID 12871 | Values: 95.0 95.0 94.0 96.0 95.0 95.0 94.0 95.0 94.0 94.0 09:02:31 INFO - PID 12871 | 09:02:31 INFO - PID 12871 | [#8] json-parse-financial Cycles:10 Average:55.40 Median:55.50 stddev:1.35 (2.4%) stddev-sans-first:1.12 09:02:31 INFO - PID 12871 | Values: 53.0 55.0 55.0 54.0 57.0 57.0 55.0 55.0 56.0 57.0 09:02:31 INFO - PID 12871 | 09:02:31 INFO - PID 12871 | [#9] json-stringify-tinderbox Cycles:10 Average:55.20 Median:55.00 stddev:0.63 (1.1%) stddev-sans-first:0.67 09:02:31 INFO - PID 12871 | Values: 55.0 55.0 55.0 55.0 55.0 55.0 55.0 57.0 55.0 55.0 09:02:31 INFO - PID 12871 | 09:02:31 INFO - PID 12871 | [#10] stanford-crypto-aes Cycles:10 Average:82.70 Median:83.00 stddev:1.16 (1.4%) stddev-sans-first:1.22 09:02:31 INFO - PID 12871 | Values: 83.0 81.0 84.0 83.0 84.0 82.0 81.0 83.0 82.0 84.0 09:02:31 INFO - PID 12871 | 09:02:31 INFO - PID 12871 | [#11] stanford-crypto-ccm Cycles:10 Average:139.50 Median:134.50 stddev:15.20 (11.3%) stddev-sans-first:16.03 09:02:31 INFO - PID 12871 | Values: 144.0 134.0 141.0 132.0 131.0 135.0 132.0 132.0 181.0 133.0 09:02:31 INFO - PID 12871 | 09:02:31 INFO - PID 12871 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:194.40 Median:196.00 stddev:4.06 (2.1%) stddev-sans-first:3.31 09:02:31 INFO - PID 12871 | Values: 187.0 200.0 197.0 192.0 195.0 197.0 195.0 198.0 189.0 194.0 09:02:31 INFO - PID 12871 | 09:02:31 INFO - PID 12871 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.50 Median:73.50 stddev:1.90 (2.6%) stddev-sans-first:1.79 09:02:31 INFO - PID 12871 | Values: 76.0 73.0 74.0 72.0 76.0 73.0 72.0 72.0 76.0 71.0 09:02:31 INFO - PID 12871 | -------- Summary: end -------- 09:02:31 INFO - PID 12871 | 09:02:32 INFO - TEST-INFO | 12871: exit 0 09:02:32 INFO - TEST-OK | kraken | took 62901ms 09:02:32 INFO - SUITE-END | took 1182s 09:02:32 INFO - Completed test suite (00:19:42) 09:02:32 INFO - javascript benchmark 09:02:32 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6637.559011862944, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2727.1136880513827, 2730.890764369425, 2732.863356832158, 2759.0, 2763.2953596832804, 5300.2314664373735, 5307.283516725241, 5358.571314294857, 5358.6516876403, 5363.624546281757, 5318.069337865868, 5419.756110975006, 5425.02349577076, 5446.863828404292, 5455.0, 4685.976570117145, 4764.690295130823, 4773.737444440554, 4806.951930480703, 4852.344933433994, 4772.57046865782, 4816.651337625471, 4860.854174374756, 4887.315775791392, 4912.091263116335, 4759.571638552547, 4798.856034318976, 4811.422629284508, 4871.780769865347, 4875.195592727214, 4777.952220477786, 4788.521147885219, 4794.592459640935, 4840.080384726926, 4847.878803029917, 4696.201645720235, 4760.666753327268, 4761.857144285677, 4774.307725379836, 4803.015381846713, 5226.764795584208, 5270.868228294285, 5342.198670199462, 5352.759125839347, 5381.273528073699, 5733.770649174028, 5747.2241247431475, 5748.42515748426, 5748.856278593027, 5754.395788442237, 5766.163906233614, 5791.536677065825, 5803.88392232153, 5806.738696758656, 5810.796622118248, 5303.071962406563, 5365.54392876602, 5368.141097424472, 5368.221607866915, 5372.059889519319, 5934.970325148347, 5935.584509084322, 5939.2575928009, 5945.227120474311, 5946.524278057745, 5611.7474713637985, 5653.858653533694, 5664.830055098354, 5669.461401166883, 5670.489655930986, 5754.223179870748, 5755.884882302331, 5770.105633626795, 5771.249737534094, 5787.421257874179, 5781.1328300754385, 5788.5369170466265, 5789.1026890831145, 5793.217915581343, 5801.187833703285, 5766.423357664284, 5785.363610002981, 5796.130580412888, 5796.5072968797285, 5804.448577385142, 4785.377900872864, 4853.514648535118, 4854.417469903634, 4858.7570621469495, 4868.586170175575, 3315.6850099240532, 4216.620504154641, 4241.27898257297, 4270.743755374688, 4301.376300436419, 4983.426905905867, 4993.750312484434, 4993.950060499348, 4996.3504744383, 5044.470330615232, 5861.765529378862, 5878.588498805043, 5878.706064696748, 5890.175375447441, 5891.911621325684, 4883.267509873547, 4944.456109827916, 4962.6774259673, 5000.97480016603, 5034.421041580192, 5223.5559977402345, 5223.869403264949, 5224.52979231871, 5228.9738551307, 5262.184361423985, 5418.674879507243, 5419.539339156216, 5426.972865135807, 5427.240186373831, 5478.589105817159, 5709.22925405065, 5764.711764411846, 5815.621984570989, 5817.825465236049, 5862.208601838697, 5374.3013408256675, 5397.190421436816, 5399.244105825266, 5408.78364865401, 5409.702466364388, 5675.375708672125, 5699.287589051369, 5704.458076482728, 5717.313922329347, 5729.140628905698, 5825.0, 5825.970870145622, 5829.300483941955, 5835.3581106077445, 5851.912221316598, 5604.075327570905, 5647.068233741386, 5674.602777805679, 5693.715314234355, 5719.714014299351, 5695.686737229492, 5698.430156984268, 5716.314042314949, 5717.342505611908, 5743.1385292206505, 5572.972135139298, 5577.442255774552, 5580.525655319343, 5616.241807356118, 5640.661560306395, 5716.657000579979, 5719.113537401709, 5727.284089488814, 5732.082866741302, 5736.741846616829, 5429.864253393696, 5453.454654534515, 5465.617406781487, 5505.394406615349, 5511.614187006871], "value": 5255.837954615804, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [713.6217804563581, 728.62111701915, 1034.2346663469036, 1055.3984228989475, 1127.042014287855, 30118.0, 32765.67234327656, 32901.17747056325, 33020.17449563762, 33041.5043774343, 30131.548026779616, 30266.848665756694, 30376.848115759447, 30492.847535762347, 30569.235769105784, 6288.842778930518, 6326.525510586713, 6432.614043157402, 6450.387213214737, 6932.0, 6750.56121352113, 6982.476314276424, 6985.231624521324, 7003.264657210996, 7017.684204210797, 7004.4396448284015, 7041.894371584431, 7072.787816365491, 7073.610951397671, 7097.21930587635, 6977.441804655616, 6979.651017449158, 7006.439484841226, 7025.332593403618, 7036.542624729427, 6848.246692863781, 6862.897056544156, 6918.619475928822, 6919.20429150644, 6921.792346229621, 30599.541006884916, 30925.690743092506, 31151.22121946947, 31190.37619247625, 31241.062768116994, 2823.71762823718, 2841.801073924826, 2843.289177705574, 2851.1446566030318, 2855.671597766242, 23554.29337119889, 23640.40898977522, 23809.404764880845, 23830.880845595835, 23853.761462385326, 3002.519596864513, 3023.8790448382038, 3045.269135407508, 3078.5382192671054, 3084.9691503085132, 132726.0, 132818.33590832082, 133227.0, 134017.32991335078, 134435.6556434433, 36403.817980909924, 38353.80823095867, 38407.61592384096, 38582.22835543274, 38603.420948685794, 39808.80095599504, 39858.800705996866, 39920.80039599841, 39937.60062399397, 40086.198276034316, 11916.285022898654, 12037.337946412856, 12073.637790866289, 12078.637640870787, 12095.637130886087, 9422.481763503074, 9457.148856602938, 9472.621095156117, 9473.47895865734, 9476.620935162655, 11941.283522988648, 11978.880211197777, 11979.161458697981, 12091.939540302417, 12241.877581224073, 5098.388193416739, 5106.795728170906, 5119.257707632372, 5141.948580514222, 5181.689098654093, 872.2237208884098, 898.0390981649572, 906.8911730592239, 913.7258822353267, 943.4056544377136, 20078.69881951772, 20754.792452075286, 21466.677999830015, 21844.12623495074, 21894.343169704935, 973.6077409304621, 976.5215044628081, 979.4319294808994, 994.7015895231401, 996.3025881882711, 10816.296940698829, 11397.715057123638, 11403.42982850854, 11455.828162577567, 11582.305061696325, 182673.086634566, 183651.0, 183758.0, 185816.0, 186129.0, 40267.39598906019, 40395.79802100971, 40742.59257407388, 40840.79579602083, 40849.387259191135, 1158.1603337580354, 1212.3271584270815, 1216.8843959823803, 1222.3032871263295, 1232.06363163996, 19617.31339403114, 19621.901890490455, 20057.498562536053, 20197.869330253834, 20978.68531972052, 29258.122256332343, 29325.85337073301, 29352.85323573454, 29363.265918352212, 29384.706152938197, 158768.0, 159478.2026089862, 159715.20142399214, 159728.0, 159936.20031899767, 28806.855965720875, 29146.27134321659, 29356.55965160567, 30488.23779405444, 30531.084067478012, 36291.0, 36355.818220908724, 36492.63507364999, 36493.0, 36619.26761464809, 26854.0, 27448.862755686092, 28123.296917577223, 28126.85936570304, 28474.0, 27270.318242044108, 27535.0, 28067.859660701564, 28517.287067823472, 28691.426171476036, 30046.098617041524, 30062.398752025274, 30227.0, 30346.69653303439, 30394.544081838347, 26805.731942681105, 26881.0, 27126.25290574181, 27679.30801729973, 29163.270918227216, 20386.490337741674, 22925.312240632808, 22957.0, 23100.768992309862, 23311.650325244795], "value": 14279.087981350867, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [411.7694091308865, 420.46390851664125, 421.3889859703429, 429.3666841408921, 442.67021069303377, 11886.227395219305, 13521.391537380818, 16962.321507139714, 17643.824111659913, 17664.73502897456, 18506.167222474985, 18509.2596296148, 18536.0, 18677.533061673465, 18799.0, 5230.450802665713, 5383.407825139231, 5459.563234941215, 5461.644993075457, 5475.370332411784, 5198.2722418861385, 5437.728113594305, 5442.183672449125, 5461.69960652164, 5468.890622187554, 5241.9213711794355, 5299.231611416361, 5369.167778994262, 5433.809816656418, 5435.2934118564535, 5346.331708536433, 5346.91979620306, 5360.2763626910455, 5361.0618141825025, 5384.596155288349, 4658.487566367697, 4842.370491836074, 4870.829520966749, 4880.194767863299, 4882.316475693406, 20872.37382878516, 21013.159473621035, 21025.158993640234, 21122.89438552813, 21218.151273949024, 1611.927463264156, 1629.714799910011, 1632.314427940268, 1635.2232689472523, 1636.075617276235, 13836.0, 14327.78508322376, 14483.203423811687, 14555.70888582233, 14572.927135364362, 2010.6280338137492, 2013.285283724286, 2080.44868109951, 2088.9268875589282, 2090.1012564597218, 79663.6016819918, 80233.0, 81226.18773812304, 81982.59008704919, 83561.0, 10353.482325883675, 10666.973275077711, 10822.40476773785, 11106.389148596743, 11671.066314694805, 15068.0, 15121.924390378197, 15134.545963621109, 15166.469173578871, 15170.620734481727, 6809.489288303397, 6887.758928437481, 7013.789586312419, 7162.856742865113, 7193.748218812317, 6270.404311590391, 6272.717727702265, 6408.327125651739, 6477.740890364333, 6483.578567393104, 6642.070110184578, 6711.194656641234, 6866.6566671667215, 6873.656317184121, 6875.759348422781, 2010.2963962612969, 2041.5916816636732, 2056.239191499155, 2056.4036429435596, 2061.701053347256, 863.2489733931394, 896.2650626486219, 897.761089696228, 899.5142622983516, 922.7139586728135, 16020.679586408207, 16213.189340532927, 16416.261268242717, 16431.1784410779, 16809.663806724042, 870.0951010948669, 881.4755220643707, 886.3219636977717, 894.9686760963335, 904.7602385367883, 8945.821083578292, 8959.462432253955, 9161.0, 9313.487758173365, 9368.90631093694, 355221.0, 359877.0, 363226.0, 364189.0, 369924.0, 75564.62217688876, 75986.15017961794, 76416.0, 76779.23220767833, 77009.0, 1038.5430410619151, 1044.102072217892, 1066.386827574148, 1067.4662668665667, 1070.7055559721139, 14242.501512447014, 14268.501807310498, 14298.499552516028, 14488.637784055061, 15160.696786063996, 37631.62368376281, 37651.0, 37708.811455942545, 37736.433953491265, 37820.810895945346, 46742.0, 48860.0, 50612.74693626508, 51043.0, 54327.45672543224, 7515.736949206752, 7871.48835325702, 7938.880916786368, 8072.556009419538, 8096.352291816758, 11135.33188008722, 11453.713657158638, 11704.239224450383, 11874.406279686154, 12104.152709310616, 9623.278254130828, 9735.318527702993, 9939.30424870281, 10071.496425178859, 10214.233932454947, 9089.318301127574, 9213.723588292361, 9307.488088155216, 9422.670206542738, 9481.857772133562, 9218.723438296862, 10046.598136074768, 10104.343217690826, 10252.38485690861, 10631.627893023708, 8036.799080023046, 8130.583302626319, 8230.341572674051, 8333.499990000377, 8530.317574594143, 9973.850392244267, 9993.550290236812, 10060.899391005996, 10216.591336346462, 10301.845472317771], "value": 8500.916483630534, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1248.5754843353259, 1264.1530174782895, 1280.91033627646, 1295.423536526245, 1314.717335772809, 9861.60553577857, 10333.483325833717, 10360.378377297358, 10384.792304153922, 10436.634717784878, 10425.947870260658, 10550.997655222742, 10553.6306229282, 10608.0, 10627.734306642318, 2277.191596983068, 2294.4149241943283, 2296.1619009061737, 2316.177756896303, 2318.188633978111, 2169.9132034718673, 2196.5606878624258, 2218.977810221901, 2220.4226901005773, 2221.3669104305277, 2181.6727490876337, 2197.241951526729, 2232.2968264996475, 2233.0955962834996, 2241.2491815241833, 2022.6573191638704, 2083.2396175395947, 2117.8517503774665, 2119.586680597284, 2125.436759258798, 2034.6235946349973, 2180.967285490719, 2189.2884812436023, 2191.430228140679, 2220.844540882139, 10111.191104711605, 10138.03688649577, 10185.694429167137, 10256.43589602579, 10264.076233139054, 5685.886282274331, 5900.64596124234, 5902.144189092601, 5926.703664816785, 5946.70266486674, 3220.91947701307, 3257.5234795205893, 3377.392069427502, 3427.5886893572683, 3438.8452519636676, 1087.0325410384764, 1120.3445984099312, 1132.8527291452142, 1133.076542617772, 1133.9433028348549, 15056.849431505763, 15060.397584096623, 15107.924460377737, 15137.621559461102, 15238.466653667068, 4610.907781844345, 4755.881102972453, 4942.110420124341, 4947.109520286383, 5020.723860187652, 10836.783264334827, 10846.45767711627, 10859.18556108295, 10860.076893463985, 10863.891361086446, 5639.6334238274385, 5653.378128405872, 5653.9151912721345, 5666.093425052054, 5671.461211184931, 5014.197728363444, 5123.769430375642, 5250.553702935217, 5253.975474782381, 5259.0796610593, 3670.9816450917574, 3735.8879233623034, 3793.6206379362393, 3834.0, 3865.6520913117956, 1095.46322302073, 1096.336716286635, 1100.1968562949091, 1114.2311804854623, 1119.4290911635126, 704.9823754406181, 717.6806321187127, 720.5676594043532, 732.7984804178786, 741.5773009384599, 5504.752286147133, 5589.860253493695, 5624.409437009055, 5687.118496632946, 5734.713264336767, 531.8085489223877, 554.3458718711878, 556.6743455078824, 557.7796770275719, 558.4750334685383, 3312.7681062325405, 3361.2941582026215, 3386.8645254189555, 3636.745427820027, 3723.422869455239, 12875.291858947849, 13775.173489590657, 13860.306984650728, 13864.653383665287, 13864.722705545833, 13440.731185376238, 13486.460541578423, 13514.256715880721, 13599.184048957095, 13668.794968075486, 7665.156832748393, 7898.486598371088, 7944.205579442125, 7993.880091798627, 8077.35381169505, 5413.106837371947, 5433.157860531624, 5707.372189059117, 5718.971405142947, 5992.221011268507, 11459.828102578302, 11887.762244754884, 11892.702682432662, 11956.34240116802, 12268.141230113806, 11928.821067683819, 11992.460339284578, 12035.157538972187, 12192.329421881881, 12198.268103913793, 7985.840283194188, 8313.168683131638, 8313.41806073569, 8353.95823020881, 8420.747377578682, 9197.264218862341, 9210.861837072584, 9231.676891308773, 9303.209227215762, 9373.531323433665, 7812.648430820513, 7982.521048737094, 8113.5131892086665, 8190.180981901762, 8223.917760822555, 7499.5875226863045, 7662.6934922604705, 7670.463067585216, 7733.883991740241, 7735.419843511647, 7066.328698773608, 7199.172095209118, 7205.279472052753, 7214.098237720285, 7214.639268036683, 5050.166722490748, 5284.154535274338, 5336.0, 5490.0, 5592.273004509388, 5387.218853266333, 5439.945600543944, 5454.990826697073, 5500.972495137498, 5569.415211402745], "value": 4688.798098229622, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [368.73819588092454, 379.48579674540997, 385.93632050711625, 386.43773309834177, 390.9315869722798, 5468.535174510162, 5610.382857885635, 5654.519365853907, 5673.716314184295, 5689.402612725667, 5396.082665946788, 5445.782168713246, 5497.367802702691, 5504.091824848895, 5519.668819870811, 4094.6928980326447, 4095.9385609215888, 4124.855630052949, 4128.710990230685, 4135.813888375031, 4072.696737044147, 4090.8772736817796, 4099.118689481761, 4129.752214867118, 4149.107941792514, 4070.613291737295, 4074.6740260779216, 4081.0, 4089.1208390196102, 4101.753894766309, 4082.7340825841648, 4083.938740918874, 4084.346504559286, 4103.507579090498, 4115.36211887158, 3564.8395822188063, 3570.80360580168, 3572.071261472036, 3577.3560759063357, 3578.58846232684, 5268.473152684739, 5381.704006279653, 5382.273393091961, 5386.757595908154, 5430.266913966603, 4802.903941921142, 4837.346958160639, 4838.201696720037, 4842.806287748486, 4852.320675105488, 5756.222909907151, 5761.3950535194035, 5817.243758311435, 5839.751695597183, 5862.325832529271, 3959.425883246942, 3963.1875465529783, 3976.170961357779, 3988.282109220339, 3994.720369574131, 5997.6701281429505, 6106.45041946227, 6145.385461453863, 6161.383861613803, 6205.906911396378, 4088.7955602220363, 4117.855875044359, 4119.134981653826, 4125.339945608688, 4127.7936103194725, 4149.33610622299, 4162.958370416318, 4166.395872598457, 4178.561251068655, 4179.644730197967, 4722.338872557844, 4752.976235118802, 4811.6767888830855, 4846.903061938741, 4857.417109946829, 5857.121431785266, 5858.53131749459, 5866.658672582258, 5870.26621672291, 5901.114832775118, 1425.8075159853288, 1430.1204759073303, 1430.928453577317, 1432.9355179016968, 1434.6700258940293, 922.3589605224305, 956.3592393096642, 957.7892863570004, 959.5586030426082, 963.4989805301204, 5058.519440653132, 5075.213341932006, 5079.212722028092, 5082.110630639697, 5089.160288552347, 5997.0, 6017.578769486182, 6045.21412216409, 6058.757649694051, 6071.51427885768, 4924.8276310328965, 5036.622253331015, 5057.924131138036, 5105.770240339194, 5119.692818430832, 3187.0240450920114, 3210.3097833965808, 3224.4357237483346, 3228.4188846007946, 3245.123816569513, 5477.863053423696, 5646.096624540136, 5652.152177173375, 5652.660840349592, 5657.377688454267, 6261.436470717566, 6295.98528470885, 6298.330942300294, 6304.968475157595, 6312.747490100344, 5624.268845050199, 5653.152027195872, 5661.235733176051, 5667.2349232854685, 5667.979763642502, 5913.733881975408, 6080.270367555921, 6103.633781973096, 6117.296510901303, 6139.465133716571, 5994.100884867305, 6002.369751176238, 6005.438585967592, 6020.127081573235, 6028.0355143176885, 5450.400455949922, 5612.775488980558, 5637.633553818989, 5642.802501912413, 5664.405237450009, 4569.451665800125, 4625.884352891205, 4628.861134165981, 4631.791569379453, 4648.814047438064, 5839.0949402842625, 6018.668973206516, 6138.416850399205, 6142.0, 6188.783392581238, 5853.326867410132, 5864.589478736448, 5872.941270587239, 5875.294964604275, 5875.529957603467, 5856.12158176277, 5878.941210587839, 5891.675957822361, 5892.911606325994, 5920.851978700567, 5548.639338442988, 5745.621050947826, 5824.184614153937, 5829.242198514166, 5847.210626565529, 5903.793367232126, 5940.405959404025, 5951.345352011189, 5959.0, 5964.0, 5508.504234618904, 5687.971560142173, 5735.87772524152, 5756.683382414008, 5767.394423585463], "value": 4366.087949970357, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [615.2555407956372, 621.4717490133385, 627.9905801412979, 628.3716283716284, 629.1600713048081, 12095.153339266244, 12488.063395245348, 12499.187552809073, 13928.303584820744, 14911.7017659647, 14637.194954277511, 14773.852261477383, 15007.474738384159, 15010.849891501082, 15203.391864325413, 872.3631748823378, 886.8935727712684, 886.9246114080311, 889.0176355127588, 891.7057371067532, 864.6195673903494, 881.8060026794095, 897.7082448204327, 897.7710683775628, 904.6336233825278, 934.392644780891, 934.8691183234318, 937.1237892570434, 937.2642475656611, 938.6433155400972, 927.4435338796735, 928.0858354520825, 928.2295694573488, 931.1805611062222, 933.3932943586655, 686.0943554508051, 694.1150033707014, 695.4644923408947, 696.4184905603777, 696.4393663101201, 12115.39423028845, 12434.564790232298, 12501.062420318513, 12532.060095492783, 12880.871191288155, 14702.4854130106, 14852.331645075998, 15339.233038348038, 15359.232038398035, 15384.230788460643, 11627.76744465106, 11741.236819606698, 11775.823362649568, 11776.352300623463, 11784.587539436165, 2813.6201612782215, 2905.970940290591, 2911.970880291191, 2928.3411232472736, 2931.062060140756, 61564.0, 62944.0, 63129.0, 63367.683161584355, 64041.67979160074, 12017.098717596215, 12356.691082722824, 12359.62921112368, 12477.376131193585, 12654.873451265554, 18901.62196756057, 19967.500812479513, 19992.300269490497, 20096.59806803885, 20121.49696257576, 6090.421409966046, 6098.207233059674, 6175.876482470326, 6184.628922264678, 6232.657203853741, 2948.88204471823, 3003.834789086621, 3013.0960711786374, 3013.4575776360466, 3020.6073210482937, 3296.3901678189613, 3375.8987230383127, 3401.931961360759, 3404.14896275931, 3408.0457471907907, 734.9485536012535, 736.7458226911707, 740.2412527159597, 741.2328240271294, 742.6286856571714, 592.3424998251937, 607.7325976570384, 610.71906922816, 614.2874265851591, 629.8551333193391, 9460.243180545678, 9487.715368538955, 9515.23878089751, 9631.807363852684, 9894.80210395788, 598.9041753319448, 605.8424809549549, 610.996945015281, 611.9479844213203, 622.4988883948465, 4205.137946720914, 4271.508776490681, 4291.249031419489, 4319.568043195718, 4326.6538676905775, 62885.68557157185, 62929.68535157386, 63324.36675633277, 64043.0, 64128.0, 57000.0, 57307.426925731044, 57788.0, 57974.0, 58004.4199557999, 52423.0, 52796.73601632044, 52863.73568132135, 52958.73520632449, 53007.0, 8650.870236946577, 8773.736787896374, 8809.735707928772, 8812.823743525221, 9013.774655633662, 26832.19503414901, 27248.455030898873, 27801.721982779913, 27895.860520697268, 28294.0, 32471.837640811646, 32574.34851303008, 33087.0, 33241.0, 33391.49912751359, 10319.329243599143, 10486.895131048592, 10574.41840698769, 10606.840897386392, 10612.151027917593, 12020.459079341275, 12029.278243305429, 12427.875721242672, 12441.502339906303, 12532.185407948455, 11593.188476806543, 11827.763444730885, 13023.413946372246, 13520.459181632625, 13647.590572282847, 13225.074244803156, 13449.327533623475, 13554.72890542164, 13558.186508809504, 13711.0, 13899.791503127664, 13959.651008724457, 14242.0, 14319.785203221752, 14433.566992990227, 9904.207663387057, 10013.098821106136, 10041.196704263788, 10185.185185185019, 10501.947490262806, 11219.419533507176, 11660.358680272666, 11681.182317237712, 11789.410529473664, 12097.879021210027], "value": 6547.23910351596, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1547.9, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 113.0, 111.0, 111.0, 115.0, 112.0, 110.0, 113.0, 113.0, 112.0], "value": 111.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 121.0, 123.0, 188.0, 129.0, 123.0, 127.0, 125.0, 151.0, 124.0], "value": 136.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 165.0, 165.0, 165.0, 165.0, 166.0, 166.0, 169.0, 165.0, 165.0], "value": 165.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 117.0, 75.0, 76.0, 75.0, 84.0, 101.0, 77.0], "value": 83.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 82.0, 100.0, 84.0, 83.0, 84.0, 111.0, 84.0, 88.0, 110.0], "value": 91.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 114.0, 114.0, 114.0, 115.0, 114.0, 113.0, 114.0, 115.0], "value": 114.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 150.0, 150.0, 151.0, 150.0, 151.0, 151.0, 149.0, 151.0, 151.0], "value": 150.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 96.0, 95.0, 95.0, 94.0, 95.0, 94.0, 94.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 55.0, 55.0, 54.0, 57.0, 57.0, 55.0, 55.0, 56.0, 57.0], "value": 55.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 55.0, 55.0, 55.0, 55.0, 55.0, 57.0, 55.0, 55.0], "value": 55.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 81.0, 84.0, 83.0, 84.0, 82.0, 81.0, 83.0, 82.0, 84.0], "value": 82.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 134.0, 141.0, 132.0, 131.0, 135.0, 132.0, 132.0, 181.0, 133.0], "value": 139.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [187.0, 200.0, 197.0, 192.0, 195.0, 197.0, 195.0, 198.0, 189.0, 194.0], "value": 194.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 73.0, 74.0, 72.0, 76.0, 73.0, 72.0, 72.0, 76.0, 71.0], "value": 73.5, "unit": "score"}]}]} 09:02:32 INFO - Return code: 0 09:02:32 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:02:32 INFO - # TBPL SUCCESS # 09:02:32 INFO - Running post-action listener: _resource_record_post_action 09:02:32 INFO - [mozharness: 2017-05-15 16:02:32.526687Z] Finished run-tests step (success) 09:02:32 INFO - Running post-run listener: _resource_record_post_run 09:02:32 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 0; Write bytes: 374984704; Read time: 0; Write time: 260400 09:02:32 INFO - TinderboxPrint: CPU usage
13.3% 09:02:32 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 09:02:32 INFO - TinderboxPrint: I/O write bytes / time
374,984,704 / 260,400 09:02:32 INFO - TinderboxPrint: CPU idle
8,297.7 (86.7%) 09:02:32 INFO - TinderboxPrint: CPU user
1,215.0 (12.7%) 09:02:32 INFO - TinderboxPrint: Swap in / out
0 / 0 09:02:32 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 102473728; Read time: 0; Write time: 101524 09:02:32 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 0; Write bytes: 271925248; Read time: 0; Write time: 158848 09:02:33 INFO - Running post-run listener: _upload_blobber_files 09:02:33 INFO - Blob upload gear active. 09:02:33 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:02:33 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 09:02:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:02:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:02:33 INFO - (blobuploader) - INFO - Open directory for files ... 09:02:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 09:02:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:02:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:02:34 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 09:02:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:02:34 INFO - (blobuploader) - INFO - Done attempting. 09:02:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:02:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:02:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:02:37 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:02:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:02:37 INFO - (blobuploader) - INFO - Done attempting. 09:02:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:02:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:02:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:02:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:02:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:02:38 INFO - (blobuploader) - INFO - Done attempting. 09:02:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:02:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:02:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:02:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:02:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:02:39 INFO - (blobuploader) - INFO - Done attempting. 09:02:39 INFO - (blobuploader) - INFO - Iteration through files over. 09:02:39 INFO - Return code: 0 09:02:39 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:02:39 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:02:39 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/579f9354f4bb53069ca6e1d53ba50a2a41f645bbc9620f7d49ad8533f7a321e0c465424c5a1f407fbeee27e2806b9db1e89258c133717692c0bfa6e30da88ebe", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e97b2cc1ecec1618170370c7c2a05593b9dfa4fe12a6cef7c3a9e49f3e7c93fc8d2264b14bd869a0ddcbcfa933d77ec5d8140bf7f01a28212397da117f83c5f5", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/846a621b15ccb5538f98d52d1f53963d526bbd0be756ed6e3482ed4ca4698f3608997571c2c2124c1524efc9f6272425f50cbe24131dec0fc3bc7a5ed2a3563e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1f6cb3616b8e79600130531cd185c6928d2adbda666346252db59635089599ba09025db4fbdcd0eeea66c472dbd782aa9584b3203b377cc63a3f3c9f5596fa69"} 09:02:39 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:02:39 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:02:39 INFO - Contents: 09:02:39 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/579f9354f4bb53069ca6e1d53ba50a2a41f645bbc9620f7d49ad8533f7a321e0c465424c5a1f407fbeee27e2806b9db1e89258c133717692c0bfa6e30da88ebe", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e97b2cc1ecec1618170370c7c2a05593b9dfa4fe12a6cef7c3a9e49f3e7c93fc8d2264b14bd869a0ddcbcfa933d77ec5d8140bf7f01a28212397da117f83c5f5", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/846a621b15ccb5538f98d52d1f53963d526bbd0be756ed6e3482ed4ca4698f3608997571c2c2124c1524efc9f6272425f50cbe24131dec0fc3bc7a5ed2a3563e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1f6cb3616b8e79600130531cd185c6928d2adbda666346252db59635089599ba09025db4fbdcd0eeea66c472dbd782aa9584b3203b377cc63a3f3c9f5596fa69"} 09:02:39 INFO - Running post-run listener: copy_logs_to_upload_dir 09:02:39 INFO - Copying logs to upload dir... 09:02:39 INFO - mkdir: /builds/slave/test/build/upload/logs 09:02:39 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1256.676218 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2017-05-15 09:02:37.759858) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-15 09:02:37.764943) ========= 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=9bfb7e13875ed353a705960e000001c0-1494861795.280042-2121079661 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/579f9354f4bb53069ca6e1d53ba50a2a41f645bbc9620f7d49ad8533f7a321e0c465424c5a1f407fbeee27e2806b9db1e89258c133717692c0bfa6e30da88ebe", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e97b2cc1ecec1618170370c7c2a05593b9dfa4fe12a6cef7c3a9e49f3e7c93fc8d2264b14bd869a0ddcbcfa933d77ec5d8140bf7f01a28212397da117f83c5f5", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/846a621b15ccb5538f98d52d1f53963d526bbd0be756ed6e3482ed4ca4698f3608997571c2c2124c1524efc9f6272425f50cbe24131dec0fc3bc7a5ed2a3563e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1f6cb3616b8e79600130531cd185c6928d2adbda666346252db59635089599ba09025db4fbdcd0eeea66c472dbd782aa9584b3203b377cc63a3f3c9f5596fa69"} build_url:https://queue.taskcluster.net/v1/task/BlNALE4CQSCZx5ZxLH6NPA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011239 build_url: 'https://queue.taskcluster.net/v1/task/BlNALE4CQSCZx5ZxLH6NPA/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/579f9354f4bb53069ca6e1d53ba50a2a41f645bbc9620f7d49ad8533f7a321e0c465424c5a1f407fbeee27e2806b9db1e89258c133717692c0bfa6e30da88ebe", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e97b2cc1ecec1618170370c7c2a05593b9dfa4fe12a6cef7c3a9e49f3e7c93fc8d2264b14bd869a0ddcbcfa933d77ec5d8140bf7f01a28212397da117f83c5f5", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/846a621b15ccb5538f98d52d1f53963d526bbd0be756ed6e3482ed4ca4698f3608997571c2c2124c1524efc9f6272425f50cbe24131dec0fc3bc7a5ed2a3563e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1f6cb3616b8e79600130531cd185c6928d2adbda666346252db59635089599ba09025db4fbdcd0eeea66c472dbd782aa9584b3203b377cc63a3f3c9f5596fa69"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-15 09:02:37.794146) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-15 09:02:37.794543) ========= 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=9bfb7e13875ed353a705960e000001c0-1494861795.280042-2121079661 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004513 ========= master_lag: 0.07 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-15 09:02:37.873220) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-15 09:02:37.876599) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-15 09:02:37.876921) ========= ========= Total master_lag: 0.21 =========