builder: mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s slave: talos-linux64-ix-016 starttime: 1494933538.88 results: success (0) revision: 49365d675cbb2a8368cda3e4858a2a0d0634c249 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-16 04:18:58.884776) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-16 04:18:58.888386) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-16 04:18:58.888783) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-16 04:18:59.077598) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-16 04:18:59.077888) ========= 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=00204705a9daa57ed339a427000001b9-1494933253.287804-1827586896 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-16 04:18:59-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 42.7M=0s 2017-05-16 04:18:59 (42.7 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.089846 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-16 04:18:59.219017) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-16 04:18:59.219325) ========= 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=00204705a9daa57ed339a427000001b9-1494933253.287804-1827586896 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014860 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-16 04:18:59.282121) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-16 04:18:59.282486) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 49365d675cbb2a8368cda3e4858a2a0d0634c249 --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 49365d675cbb2a8368cda3e4858a2a0d0634c249 --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=00204705a9daa57ed339a427000001b9-1494933253.287804-1827586896 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-16 04:18:59,800 truncating revision to first 12 chars 2017-05-16 04:18:59,800 Setting DEBUG logging. 2017-05-16 04:18:59,800 attempt 1/10 2017-05-16 04:18:59,800 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/49365d675cbb?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-16 04:19:00,179 unpacking tar archive at: mozilla-central-49365d675cbb/testing/mozharness/ program finished with exit code 0 elapsedTime=0.642374 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-16 04:18:59.940440) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-16 04:18:59.940820) ========= script_repo_revision: 49365d675cbb2a8368cda3e4858a2a0d0634c249 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-16 04:18:59.941220) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-16 04:18:59.941499) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-16 04:18:59.957848) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2017-05-16 04:18:59.958176) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=00204705a9daa57ed339a427000001b9-1494933253.287804-1827586896 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:19:00 INFO - MultiFileLogger online at 20170516 04:19:00 in /builds/slave/test 04:19:00 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 04:19:00 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:19:00 INFO - {'append_to_log': False, 04:19:00 INFO - 'base_work_dir': '/builds/slave/test', 04:19:00 INFO - 'blob_upload_branch': 'Firefox', 04:19:00 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:19:00 INFO - 'branch': 'Firefox', 04:19:00 INFO - 'buildbot_json_path': 'buildprops.json', 04:19:00 INFO - 'config_files': ('talos/linux_config.py',), 04:19:00 INFO - 'default_actions': ('clobber', 04:19:00 INFO - 'read-buildbot-config', 04:19:00 INFO - 'download-and-extract', 04:19:00 INFO - 'populate-webroot', 04:19:00 INFO - 'create-virtualenv', 04:19:00 INFO - 'install', 04:19:00 INFO - 'run-tests'), 04:19:00 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:19:00 INFO - 'download_minidump_stackwalk': True, 04:19:00 INFO - 'download_symbols': 'ondemand', 04:19:00 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:19:00 INFO - 'tooltool.py': '/tools/tooltool.py', 04:19:00 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:19:00 INFO - '/tools/misc-python/virtualenv.py')}, 04:19:00 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:19:00 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:19:00 INFO - 'gecko_profile': False, 04:19:00 INFO - 'gecko_profile_interval': 0, 04:19:00 INFO - 'installer_path': 'installer.exe', 04:19:00 INFO - 'log_level': 'info', 04:19:00 INFO - 'log_name': 'talos', 04:19:00 INFO - 'log_to_console': True, 04:19:00 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:19:00 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:19:00 INFO - 'opt_config_files': (), 04:19:00 INFO - 'pip_index': False, 04:19:00 INFO - 'suite': 'dromaeojs-e10s', 04:19:00 INFO - 'system_bits': '32', 04:19:00 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:19:00 INFO - 'title': 'talos-linux64-ix-016', 04:19:00 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:19:00 INFO - 'use_talos_json': True, 04:19:00 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:19:00 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:19:00 INFO - 'work_dir': 'build'} 04:19:00 INFO - [mozharness: 2017-05-16 11:19:00.575798Z] Running clobber step. 04:19:00 INFO - Running pre-action listener: _resource_record_pre_action 04:19:00 INFO - Running main action method: clobber 04:19:00 INFO - rmtree: /builds/slave/test/build 04:19:00 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:19:01 INFO - Running post-action listener: _resource_record_post_action 04:19:01 INFO - [mozharness: 2017-05-16 11:19:01.571336Z] Finished clobber step (success) 04:19:01 INFO - [mozharness: 2017-05-16 11:19:01.571438Z] Running read-buildbot-config step. 04:19:01 INFO - Running pre-action listener: _resource_record_pre_action 04:19:01 INFO - Running main action method: read_buildbot_config 04:19:01 INFO - Using buildbot properties: 04:19:01 INFO - { 04:19:01 INFO - "project": "", 04:19:01 INFO - "product": "firefox", 04:19:01 INFO - "who": "cbook@mozilla.com", 04:19:01 INFO - "installer_path": "public/build/target.tar.bz2", 04:19:01 INFO - "builddir": "mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s", 04:19:01 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 04:19:01 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo-sequential mozilla-central talos dromaeojs-e10s", 04:19:01 INFO - "stage_platform": "linux64-styloseq", 04:19:01 INFO - "basedir": "/builds/slave/test", 04:19:01 INFO - "buildnumber": 0, 04:19:01 INFO - "platform": "ubuntu64_hw_styloseq", 04:19:01 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 04:19:01 INFO - "slavebuilddir": "test", 04:19:01 INFO - "taskId": "Rkg1ORnhSfC9ItL-hQpGyg", 04:19:01 INFO - "branch": "mozilla-central", 04:19:01 INFO - "script_repo_revision": "production", 04:19:01 INFO - "revision": "49365d675cbb2a8368cda3e4858a2a0d0634c249", 04:19:01 INFO - "slavename": "talos-linux64-ix-016", 04:19:01 INFO - "repo_path": "mozilla-central" 04:19:01 INFO - } 04:19:01 INFO - Finding installer, test and symbols from parent task. 04:19:01 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Rkg1ORnhSfC9ItL-hQpGyg'}, attempt #1 04:19:02 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Rkg1ORnhSfC9ItL-hQpGyg'}, attempt #1 04:19:02 INFO - Task dependencies: Y9d5ZEd2RamAy9r3IxOe8A 04:19:02 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Y9d5ZEd2RamAy9r3IxOe8A'}, attempt #1 04:19:02 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/Y9d5ZEd2RamAy9r3IxOe8A/artifacts/public/build/target.tar.bz2 04:19:02 INFO - Set test_url: https://queue.taskcluster.net/v1/task/Y9d5ZEd2RamAy9r3IxOe8A/artifacts/public/build/test_packages.json 04:19:02 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/Y9d5ZEd2RamAy9r3IxOe8A/artifacts/public/build/target.crashreporter-symbols.zip 04:19:02 INFO - Running post-action listener: _resource_record_post_action 04:19:02 INFO - [mozharness: 2017-05-16 11:19:02.934849Z] Finished read-buildbot-config step (success) 04:19:02 INFO - [mozharness: 2017-05-16 11:19:02.935071Z] Running download-and-extract step. 04:19:02 INFO - Running pre-action listener: _resource_record_pre_action 04:19:02 INFO - Running main action method: download_and_extract 04:19:02 INFO - mkdir: /builds/slave/test/build/tests 04:19:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:19:02 INFO - trying https://queue.taskcluster.net/v1/task/Y9d5ZEd2RamAy9r3IxOe8A/artifacts/public/build/target.test_packages.json 04:19:02 INFO - Downloading https://queue.taskcluster.net/v1/task/Y9d5ZEd2RamAy9r3IxOe8A/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 04:19:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Y9d5ZEd2RamAy9r3IxOe8A/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 04:19:03 INFO - Downloaded 986 bytes. 04:19:03 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 04:19:03 INFO - Using the following test package requirements: 04:19:03 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 04:19:03 INFO - u'common': [u'target.common.tests.zip'], 04:19:03 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 04:19:03 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 04:19:03 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 04:19:03 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 04:19:03 INFO - u'mozbase': [u'target.common.tests.zip'], 04:19:03 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 04:19:03 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 04:19:03 INFO - u'web-platform': [u'target.common.tests.zip', 04:19:03 INFO - u'target.web-platform.tests.zip'], 04:19:03 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 04:19:03 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 04:19:03 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Y9d5ZEd2RamAy9r3IxOe8A/artifacts/public/build/target.common.tests.zip 04:19:03 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Y9d5ZEd2RamAy9r3IxOe8A/artifacts/public/build/target.common.tests.zip'}, attempt #1 04:19:03 INFO - Fetch https://queue.taskcluster.net/v1/task/Y9d5ZEd2RamAy9r3IxOe8A/artifacts/public/build/target.common.tests.zip into memory 04:19:04 INFO - Content-Length response header: 62450019 04:19:04 INFO - Bytes received: 62450019 04:19:15 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 04:19:15 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Y9d5ZEd2RamAy9r3IxOe8A/artifacts/public/build/target.common.tests.zip 04:19:15 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Y9d5ZEd2RamAy9r3IxOe8A/artifacts/public/build/target.common.tests.zip'}, attempt #1 04:19:15 INFO - Fetch https://queue.taskcluster.net/v1/task/Y9d5ZEd2RamAy9r3IxOe8A/artifacts/public/build/target.common.tests.zip into memory 04:19:16 INFO - Content-Length response header: 62450019 04:19:16 INFO - Bytes received: 62450019 04:19:29 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Y9d5ZEd2RamAy9r3IxOe8A/artifacts/public/build/target.talos.tests.zip 04:19:29 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Y9d5ZEd2RamAy9r3IxOe8A/artifacts/public/build/target.talos.tests.zip'}, attempt #1 04:19:29 INFO - Fetch https://queue.taskcluster.net/v1/task/Y9d5ZEd2RamAy9r3IxOe8A/artifacts/public/build/target.talos.tests.zip into memory 04:19:29 INFO - Content-Length response header: 14410018 04:19:29 INFO - Bytes received: 14410018 04:19:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:19:30 INFO - trying https://queue.taskcluster.net/v1/task/Y9d5ZEd2RamAy9r3IxOe8A/artifacts/public/build/target.tar.bz2 04:19:30 INFO - Downloading https://queue.taskcluster.net/v1/task/Y9d5ZEd2RamAy9r3IxOe8A/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 04:19:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Y9d5ZEd2RamAy9r3IxOe8A/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 04:19:31 INFO - Downloaded 65165658 bytes. 04:19:31 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Y9d5ZEd2RamAy9r3IxOe8A/artifacts/public/build/target.tar.bz2 04:19:31 INFO - mkdir: /builds/slave/test/properties 04:19:31 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:19:31 INFO - Writing to file /builds/slave/test/properties/build_url 04:19:31 INFO - Contents: 04:19:31 INFO - build_url:https://queue.taskcluster.net/v1/task/Y9d5ZEd2RamAy9r3IxOe8A/artifacts/public/build/target.tar.bz2 04:19:31 INFO - Running post-action listener: _resource_record_post_action 04:19:31 INFO - Running post-action listener: set_extra_try_arguments 04:19:31 INFO - [mozharness: 2017-05-16 11:19:31.418682Z] Finished download-and-extract step (success) 04:19:31 INFO - [mozharness: 2017-05-16 11:19:31.418779Z] Running populate-webroot step. 04:19:31 INFO - Running pre-action listener: _resource_record_pre_action 04:19:31 INFO - Running main action method: populate_webroot 04:19:31 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:19:31 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:19:31 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:19:31 INFO - '--tppagecycles', 04:19:31 INFO - '7'], 04:19:31 INFO - 'tests': ['tsvgm']}}, 04:19:31 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:19:31 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:19:31 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:19:31 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:19:31 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:19:31 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:19:31 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 04:19:31 INFO - 'talos_options': ['--disable-e10s'], 04:19:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:19:31 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 04:19:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:19:31 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 04:19:31 INFO - 'talos_options': ['--disable-e10s'], 04:19:31 INFO - 'tests': ['damp', 'tps']}, 04:19:31 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 04:19:31 INFO - 'tests': ['damp', 'tps']}, 04:19:31 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:19:31 INFO - 'tests': ['dromaeo_dom']}, 04:19:31 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:19:31 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:19:31 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 04:19:31 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 04:19:31 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:19:31 INFO - 'tests': ['a11yr', 04:19:31 INFO - 'ts_paint', 04:19:31 INFO - 'tpaint', 04:19:31 INFO - 'sessionrestore', 04:19:31 INFO - 'sessionrestore_no_auto_restore', 04:19:31 INFO - 'tabpaint']}, 04:19:31 INFO - 'other-e10s': {'tests': ['a11yr', 04:19:31 INFO - 'ts_paint', 04:19:31 INFO - 'tpaint', 04:19:31 INFO - 'sessionrestore', 04:19:31 INFO - 'sessionrestore_no_auto_restore', 04:19:31 INFO - 'tabpaint']}, 04:19:31 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:19:31 INFO - 'ts_paint', 04:19:31 INFO - 'tpaint', 04:19:31 INFO - 'sessionrestore', 04:19:31 INFO - 'sessionrestore_no_auto_restore', 04:19:31 INFO - 'tabpaint']}, 04:19:31 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:19:31 INFO - 'ts_paint', 04:19:31 INFO - 'tpaint', 04:19:31 INFO - 'sessionrestore', 04:19:31 INFO - 'sessionrestore_no_auto_restore', 04:19:31 INFO - 'tabpaint']}, 04:19:31 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:19:31 INFO - 'tests': ['a11yr', 04:19:31 INFO - 'ts_paint', 04:19:31 INFO - 'tpaint', 04:19:31 INFO - 'sessionrestore', 04:19:31 INFO - 'sessionrestore_no_auto_restore', 04:19:31 INFO - 'tabpaint']}, 04:19:31 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:19:31 INFO - 'tests': ['a11yr', 04:19:31 INFO - 'ts_paint', 04:19:31 INFO - 'tpaint', 04:19:31 INFO - 'sessionrestore', 04:19:31 INFO - 'sessionrestore_no_auto_restore', 04:19:31 INFO - 'tabpaint']}, 04:19:31 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 04:19:31 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 04:19:31 INFO - 'bloom_basic_ref']}, 04:19:31 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:19:31 INFO - 'tests': ['tsvgx', 04:19:31 INFO - 'tsvgr_opacity', 04:19:31 INFO - 'tart', 04:19:31 INFO - 'tscrollx', 04:19:31 INFO - 'cart', 04:19:31 INFO - 'tsvg_static']}, 04:19:31 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:19:31 INFO - 'tsvgr_opacity', 04:19:31 INFO - 'tart', 04:19:31 INFO - 'tscrollx', 04:19:31 INFO - 'cart', 04:19:31 INFO - 'tsvg_static']}, 04:19:31 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 04:19:31 INFO - 'talos_options': ['--disable-e10s'], 04:19:31 INFO - 'tests': ['tp5o']}, 04:19:31 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 04:19:31 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 04:19:31 INFO - 'talos_options': ['--disable-e10s', 04:19:31 INFO - '--xperf_path', 04:19:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:19:31 INFO - 'tests': ['tp5n']}, 04:19:31 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 04:19:31 INFO - 'talos_options': ['--xperf_path', 04:19:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:19:31 INFO - 'tests': ['tp5n']}}, 04:19:31 INFO - 'talos.zip': {'path': '', 04:19:31 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:19:31 INFO - Running post-action listener: _resource_record_post_action 04:19:31 INFO - [mozharness: 2017-05-16 11:19:31.432452Z] Finished populate-webroot step (success) 04:19:31 INFO - [mozharness: 2017-05-16 11:19:31.432542Z] Running create-virtualenv step. 04:19:31 INFO - Running pre-action listener: _resource_record_pre_action 04:19:31 INFO - Running main action method: create_virtualenv 04:19:31 INFO - Creating virtualenv /builds/slave/test/build/venv 04:19:31 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 04:19:31 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:19:31 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:19:31 INFO - Using real prefix '/usr' 04:19:31 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:19:32 INFO - Installing distribute.............................................................................................................................................................................................done. 04:19:33 INFO - Installing pip.................done. 04:19:34 INFO - Return code: 0 04:19:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:19:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:19:34 INFO - Reading from file tmpfile_stdout 04:19:34 INFO - Output received: 04:19:34 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) 04:19:34 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:19:34 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')]} 04:19:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:19:34 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')]} 04:19:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:19:34 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 0x1bf51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dc2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f685c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f657a0>, '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 0x1f666a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f66b30>, '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': '00204705a9daa57ed339a427000001b9-1494933253.287804-1827586896', '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 04:19:34 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 04:19:34 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 04:19:34 INFO - Using env: {'DISPLAY': ':0', 04:19:34 INFO - 'HOME': '/home/cltbld', 04:19:34 INFO - 'LANG': 'en_US.UTF-8', 04:19:34 INFO - 'LANGUAGE': 'en_US:en', 04:19:34 INFO - 'LOGNAME': 'cltbld', 04:19:34 INFO - 'MAIL': '/var/mail/cltbld', 04:19:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:19:34 INFO - 'MOZ_NO_REMOTE': '1', 04:19:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:19:34 INFO - 'NO_EM_RESTART': '1', 04:19:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:19:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:19:34 INFO - 'PWD': '/builds/slave/test', 04:19:34 INFO - 'SHELL': '/bin/bash', 04:19:34 INFO - 'SHLVL': '1', 04:19:34 INFO - 'TERM': 'linux', 04:19:34 INFO - 'TMOUT': '86400', 04:19:34 INFO - 'USER': 'cltbld', 04:19:34 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1494933253.287804-1827586896', 04:19:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:19:34 INFO - '_': '/tools/buildbot/bin/python'} 04:19:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:19:34 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 04:19:34 INFO - Cleaning up... 04:19:34 INFO - Return code: 0 04:19:34 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:19:34 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')]} 04:19:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:19:34 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')]} 04:19:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:19:34 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 0x1bf51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dc2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f685c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f657a0>, '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 0x1f666a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f66b30>, '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': '00204705a9daa57ed339a427000001b9-1494933253.287804-1827586896', '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 04:19:34 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 04:19:34 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 04:19:34 INFO - Using env: {'DISPLAY': ':0', 04:19:34 INFO - 'HOME': '/home/cltbld', 04:19:34 INFO - 'LANG': 'en_US.UTF-8', 04:19:34 INFO - 'LANGUAGE': 'en_US:en', 04:19:34 INFO - 'LOGNAME': 'cltbld', 04:19:34 INFO - 'MAIL': '/var/mail/cltbld', 04:19:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:19:34 INFO - 'MOZ_NO_REMOTE': '1', 04:19:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:19:34 INFO - 'NO_EM_RESTART': '1', 04:19:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:19:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:19:34 INFO - 'PWD': '/builds/slave/test', 04:19:34 INFO - 'SHELL': '/bin/bash', 04:19:34 INFO - 'SHLVL': '1', 04:19:34 INFO - 'TERM': 'linux', 04:19:34 INFO - 'TMOUT': '86400', 04:19:34 INFO - 'USER': 'cltbld', 04:19:34 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1494933253.287804-1827586896', 04:19:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:19:34 INFO - '_': '/tools/buildbot/bin/python'} 04:19:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:19:34 INFO - Downloading/unpacking psutil>=3.1.1 04:19:34 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 04:19:34 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 04:19:34 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 04:19:34 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 04:19:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:19:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:19:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:19:35 INFO - Installing collected packages: psutil 04:19:35 INFO - Running setup.py install for psutil 04:19:35 INFO - building 'psutil._psutil_linux' extension 04:19:35 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 04:19:36 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 04:19:36 INFO - building 'psutil._psutil_posix' extension 04:19:36 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 04:19:36 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 04:19:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:19:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:19:36 INFO - Successfully installed psutil 04:19:36 INFO - Cleaning up... 04:19:36 INFO - Return code: 0 04:19:36 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:19:36 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')]} 04:19:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:19:36 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')]} 04:19:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:19:36 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 0x1bf51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dc2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f685c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f657a0>, '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 0x1f666a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f66b30>, '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': '00204705a9daa57ed339a427000001b9-1494933253.287804-1827586896', '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 04:19:36 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 04:19:36 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 04:19:36 INFO - Using env: {'DISPLAY': ':0', 04:19:36 INFO - 'HOME': '/home/cltbld', 04:19:36 INFO - 'LANG': 'en_US.UTF-8', 04:19:36 INFO - 'LANGUAGE': 'en_US:en', 04:19:36 INFO - 'LOGNAME': 'cltbld', 04:19:36 INFO - 'MAIL': '/var/mail/cltbld', 04:19:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:19:36 INFO - 'MOZ_NO_REMOTE': '1', 04:19:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:19:36 INFO - 'NO_EM_RESTART': '1', 04:19:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:19:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:19:36 INFO - 'PWD': '/builds/slave/test', 04:19:36 INFO - 'SHELL': '/bin/bash', 04:19:36 INFO - 'SHLVL': '1', 04:19:36 INFO - 'TERM': 'linux', 04:19:36 INFO - 'TMOUT': '86400', 04:19:36 INFO - 'USER': 'cltbld', 04:19:36 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1494933253.287804-1827586896', 04:19:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:19:36 INFO - '_': '/tools/buildbot/bin/python'} 04:19:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:19:36 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:19:36 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 04:19:36 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 04:19:36 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 04:19:36 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 04:19:37 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:19:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:19:37 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:19:37 INFO - Installing collected packages: mozsystemmonitor 04:19:37 INFO - Running setup.py install for mozsystemmonitor 04:19:37 INFO - Successfully installed mozsystemmonitor 04:19:37 INFO - Cleaning up... 04:19:37 INFO - Return code: 0 04:19:37 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:19:37 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')]} 04:19:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:19:37 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')]} 04:19:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:19:37 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 0x1bf51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dc2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f685c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f657a0>, '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 0x1f666a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f66b30>, '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': '00204705a9daa57ed339a427000001b9-1494933253.287804-1827586896', '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 04:19:37 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 04:19:37 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 04:19:37 INFO - Using env: {'DISPLAY': ':0', 04:19:37 INFO - 'HOME': '/home/cltbld', 04:19:37 INFO - 'LANG': 'en_US.UTF-8', 04:19:37 INFO - 'LANGUAGE': 'en_US:en', 04:19:37 INFO - 'LOGNAME': 'cltbld', 04:19:37 INFO - 'MAIL': '/var/mail/cltbld', 04:19:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:19:37 INFO - 'MOZ_NO_REMOTE': '1', 04:19:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:19:37 INFO - 'NO_EM_RESTART': '1', 04:19:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:19:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:19:37 INFO - 'PWD': '/builds/slave/test', 04:19:37 INFO - 'SHELL': '/bin/bash', 04:19:37 INFO - 'SHLVL': '1', 04:19:37 INFO - 'TERM': 'linux', 04:19:37 INFO - 'TMOUT': '86400', 04:19:37 INFO - 'USER': 'cltbld', 04:19:37 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1494933253.287804-1827586896', 04:19:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:19:37 INFO - '_': '/tools/buildbot/bin/python'} 04:19:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:19:38 INFO - Downloading/unpacking jsonschema==2.5.1 04:19:38 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 04:19:38 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 04:19:38 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 04:19:38 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 04:19:39 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:19:39 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:19:39 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 04:19:39 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 04:19:39 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 04:19:39 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 04:19:39 INFO - Downloading functools32-3.2.3-2.tar.gz 04:19:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:19:39 INFO - warning: no files found matching '*.txt' 04:19:39 INFO - no previously-included directories found matching 'build' 04:19:39 INFO - no previously-included directories found matching 'dist' 04:19:39 INFO - no previously-included directories found matching '.git*' 04:19:39 INFO - Installing collected packages: jsonschema, functools32 04:19:39 INFO - Running setup.py install for functools32 04:19:39 INFO - warning: no files found matching '*.txt' 04:19:39 INFO - no previously-included directories found matching 'build' 04:19:39 INFO - no previously-included directories found matching 'dist' 04:19:39 INFO - no previously-included directories found matching '.git*' 04:19:39 INFO - Successfully installed jsonschema functools32 04:19:39 INFO - Cleaning up... 04:19:39 INFO - Return code: 0 04:19:39 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:19:39 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')]} 04:19:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:19:39 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')]} 04:19:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:19:39 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 0x1bf51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dc2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f685c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f657a0>, '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 0x1f666a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f66b30>, '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': '00204705a9daa57ed339a427000001b9-1494933253.287804-1827586896', '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 04:19:39 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 04:19:39 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 04:19:39 INFO - Using env: {'DISPLAY': ':0', 04:19:39 INFO - 'HOME': '/home/cltbld', 04:19:39 INFO - 'LANG': 'en_US.UTF-8', 04:19:39 INFO - 'LANGUAGE': 'en_US:en', 04:19:39 INFO - 'LOGNAME': 'cltbld', 04:19:39 INFO - 'MAIL': '/var/mail/cltbld', 04:19:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:19:39 INFO - 'MOZ_NO_REMOTE': '1', 04:19:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:19:39 INFO - 'NO_EM_RESTART': '1', 04:19:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:19:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:19:39 INFO - 'PWD': '/builds/slave/test', 04:19:39 INFO - 'SHELL': '/bin/bash', 04:19:39 INFO - 'SHLVL': '1', 04:19:39 INFO - 'TERM': 'linux', 04:19:39 INFO - 'TMOUT': '86400', 04:19:39 INFO - 'USER': 'cltbld', 04:19:39 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1494933253.287804-1827586896', 04:19:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:19:39 INFO - '_': '/tools/buildbot/bin/python'} 04:19:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:19:39 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:19:39 INFO - Cleaning up... 04:19:39 INFO - Return code: 0 04:19:39 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:19:39 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')]} 04:19:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:19:39 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')]} 04:19:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:19:39 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 0x1bf51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dc2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f685c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f657a0>, '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 0x1f666a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f66b30>, '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': '00204705a9daa57ed339a427000001b9-1494933253.287804-1827586896', '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 04:19:39 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 04:19:39 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 04:19:39 INFO - Using env: {'DISPLAY': ':0', 04:19:39 INFO - 'HOME': '/home/cltbld', 04:19:39 INFO - 'LANG': 'en_US.UTF-8', 04:19:39 INFO - 'LANGUAGE': 'en_US:en', 04:19:39 INFO - 'LOGNAME': 'cltbld', 04:19:39 INFO - 'MAIL': '/var/mail/cltbld', 04:19:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:19:39 INFO - 'MOZ_NO_REMOTE': '1', 04:19:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:19:39 INFO - 'NO_EM_RESTART': '1', 04:19:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:19:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:19:39 INFO - 'PWD': '/builds/slave/test', 04:19:39 INFO - 'SHELL': '/bin/bash', 04:19:39 INFO - 'SHLVL': '1', 04:19:39 INFO - 'TERM': 'linux', 04:19:39 INFO - 'TMOUT': '86400', 04:19:39 INFO - 'USER': 'cltbld', 04:19:39 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1494933253.287804-1827586896', 04:19:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:19:39 INFO - '_': '/tools/buildbot/bin/python'} 04:19:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:19:39 INFO - Downloading/unpacking blobuploader==1.2.4 04:19:39 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 04:19:39 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 04:19:39 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 04:19:39 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 04:19:40 INFO - Downloading blobuploader-1.2.4.tar.gz 04:19:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:19:41 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:19:41 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 04:19:41 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 04:19:41 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 04:19:41 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 04:19:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:19:41 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:19:41 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 04:19:41 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 04:19:41 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 04:19:41 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 04:19:41 INFO - Downloading docopt-0.6.1.tar.gz 04:19:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:19:41 INFO - Installing collected packages: blobuploader, requests, docopt 04:19:41 INFO - Running setup.py install for blobuploader 04:19:41 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:19:41 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:19:41 INFO - Running setup.py install for requests 04:19:42 INFO - Running setup.py install for docopt 04:19:42 INFO - Successfully installed blobuploader requests docopt 04:19:42 INFO - Cleaning up... 04:19:42 INFO - Return code: 0 04:19:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:19:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:19:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:19:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:19:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:19:42 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 0x1bf51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dc2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f685c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f657a0>, '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 0x1f666a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f66b30>, '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': '00204705a9daa57ed339a427000001b9-1494933253.287804-1827586896', '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 04:19:42 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 04:19:42 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 04:19:42 INFO - Using env: {'DISPLAY': ':0', 04:19:42 INFO - 'HOME': '/home/cltbld', 04:19:42 INFO - 'LANG': 'en_US.UTF-8', 04:19:42 INFO - 'LANGUAGE': 'en_US:en', 04:19:42 INFO - 'LOGNAME': 'cltbld', 04:19:42 INFO - 'MAIL': '/var/mail/cltbld', 04:19:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:19:42 INFO - 'MOZ_NO_REMOTE': '1', 04:19:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:19:42 INFO - 'NO_EM_RESTART': '1', 04:19:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:19:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:19:42 INFO - 'PWD': '/builds/slave/test', 04:19:42 INFO - 'SHELL': '/bin/bash', 04:19:42 INFO - 'SHLVL': '1', 04:19:42 INFO - 'TERM': 'linux', 04:19:42 INFO - 'TMOUT': '86400', 04:19:42 INFO - 'USER': 'cltbld', 04:19:42 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1494933253.287804-1827586896', 04:19:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:19:42 INFO - '_': '/tools/buildbot/bin/python'} 04:19:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:19:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:19:42 INFO - Running setup.py (path:/tmp/pip-l6Mwzy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:19:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:19:42 INFO - Running setup.py (path:/tmp/pip-2t9ABR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:19:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:19:42 INFO - Running setup.py (path:/tmp/pip-An_Blh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:19:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:19:42 INFO - Running setup.py (path:/tmp/pip-2NVrj6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:19:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:19:42 INFO - Running setup.py (path:/tmp/pip-TxDy99-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:19:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:19:42 INFO - Running setup.py (path:/tmp/pip-NCzBeS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:19:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:19:42 INFO - Running setup.py (path:/tmp/pip-xQOuam-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:19:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:19:42 INFO - Running setup.py (path:/tmp/pip-cXkkPB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:19:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:19:42 INFO - Running setup.py (path:/tmp/pip-41_07a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:19:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:19:43 INFO - Running setup.py (path:/tmp/pip-h7FBRY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:19:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:19:43 INFO - Running setup.py (path:/tmp/pip-NPXJm9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:19:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:19:43 INFO - Running setup.py (path:/tmp/pip-4CPiap-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:19:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:19:43 INFO - Running setup.py (path:/tmp/pip-8b7jiX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:19:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:19:43 INFO - Running setup.py (path:/tmp/pip-WSX6fK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:19:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:19:43 INFO - Running setup.py (path:/tmp/pip-QIhJlH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:19:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:19:43 INFO - Running setup.py (path:/tmp/pip-fWQao4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:19:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:19:43 INFO - Running setup.py (path:/tmp/pip-8xqPts-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:19:43 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:19:43 INFO - Running setup.py install for manifestparser 04:19:43 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:19:43 INFO - Running setup.py install for mozcrash 04:19:43 INFO - Running setup.py install for mozdebug 04:19:43 INFO - Running setup.py install for mozdevice 04:19:44 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:19:44 INFO - Running setup.py install for mozfile 04:19:44 INFO - Running setup.py install for mozhttpd 04:19:44 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:19:44 INFO - Running setup.py install for mozinfo 04:19:44 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:19:44 INFO - Running setup.py install for mozInstall 04:19:44 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:19:44 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:19:44 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:19:44 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:19:44 INFO - Running setup.py install for mozleak 04:19:44 INFO - Running setup.py install for mozlog 04:19:44 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:19:44 INFO - Running setup.py install for moznetwork 04:19:44 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:19:44 INFO - Running setup.py install for mozprocess 04:19:44 INFO - Running setup.py install for mozprofile 04:19:44 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:19:44 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:19:44 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:19:44 INFO - Running setup.py install for mozrunner 04:19:45 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:19:45 INFO - Running setup.py install for mozscreenshot 04:19:45 INFO - Running setup.py install for moztest 04:19:45 INFO - Running setup.py install for mozversion 04:19:45 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:19:45 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:19:45 INFO - Cleaning up... 04:19:45 INFO - Return code: 0 04:19:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:19: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')]} 04:19:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:19: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')]} 04:19:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:19:45 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 0x1bf51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dc2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f685c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f657a0>, '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 0x1f666a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f66b30>, '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': '00204705a9daa57ed339a427000001b9-1494933253.287804-1827586896', '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 04:19:45 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 04:19:45 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 04:19:45 INFO - Using env: {'DISPLAY': ':0', 04:19:45 INFO - 'HOME': '/home/cltbld', 04:19:45 INFO - 'LANG': 'en_US.UTF-8', 04:19:45 INFO - 'LANGUAGE': 'en_US:en', 04:19:45 INFO - 'LOGNAME': 'cltbld', 04:19:45 INFO - 'MAIL': '/var/mail/cltbld', 04:19:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:19:45 INFO - 'MOZ_NO_REMOTE': '1', 04:19:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:19:45 INFO - 'NO_EM_RESTART': '1', 04:19:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:19:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:19:45 INFO - 'PWD': '/builds/slave/test', 04:19:45 INFO - 'SHELL': '/bin/bash', 04:19:45 INFO - 'SHLVL': '1', 04:19:45 INFO - 'TERM': 'linux', 04:19:45 INFO - 'TMOUT': '86400', 04:19:45 INFO - 'USER': 'cltbld', 04:19:45 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1494933253.287804-1827586896', 04:19:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:19:45 INFO - '_': '/tools/buildbot/bin/python'} 04:19:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:19:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:19:45 INFO - Running setup.py (path:/tmp/pip-5qSM4E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:19:45 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)) 04:19:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:19:45 INFO - Running setup.py (path:/tmp/pip-0Cqyd2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:19:45 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)) 04:19:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:19:45 INFO - Running setup.py (path:/tmp/pip-17TD17-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:19:45 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)) 04:19:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:19:45 INFO - Running setup.py (path:/tmp/pip-9L0W2n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:19:45 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)) 04:19:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:19:45 INFO - Running setup.py (path:/tmp/pip-X5JJJO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:19:45 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)) 04:19:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:19:45 INFO - Running setup.py (path:/tmp/pip-Bi9mal-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:19:46 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)) 04:19:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:19:46 INFO - Running setup.py (path:/tmp/pip-of2jNr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:19:46 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)) 04:19:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:19:46 INFO - Running setup.py (path:/tmp/pip-0bU0SO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:19:46 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)) 04:19:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:19:46 INFO - Running setup.py (path:/tmp/pip-0CrBLP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:19:46 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)) 04:19:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:19:46 INFO - Running setup.py (path:/tmp/pip-68c_Zr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:19:46 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)) 04:19:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:19:46 INFO - Running setup.py (path:/tmp/pip-8MQpev-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:19:46 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)) 04:19:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:19:46 INFO - Running setup.py (path:/tmp/pip-aLpuaA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:19:46 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)) 04:19:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:19:46 INFO - Running setup.py (path:/tmp/pip-Rbv4vE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:19:46 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)) 04:19:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:19:46 INFO - Running setup.py (path:/tmp/pip-8c0lCa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:19:46 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)) 04:19:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:19:46 INFO - Running setup.py (path:/tmp/pip-Ns8Cn8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:19:46 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)) 04:19:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:19:46 INFO - Running setup.py (path:/tmp/pip-4Z6wiO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:19:46 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)) 04:19:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:19:46 INFO - Running setup.py (path:/tmp/pip-nIwdUm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:19:46 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)) 04:19:46 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)) 04:19:46 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)) 04:19:46 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)) 04:19:46 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)) 04:19:46 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)) 04:19:46 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:19:46 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 04:19:46 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 04:19:46 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 04:19:46 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 04:19:47 INFO - Downloading blessings-1.6.tar.gz 04:19:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:19:48 INFO - Installing collected packages: blessings 04:19:48 INFO - Running setup.py install for blessings 04:19:48 INFO - Successfully installed blessings 04:19:48 INFO - Cleaning up... 04:19:48 INFO - Return code: 0 04:19:48 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:19:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:19:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:19:48 INFO - Reading from file tmpfile_stdout 04:19:48 INFO - Current package versions: 04:19:48 INFO - argparse == 1.2.1 04:19:48 INFO - blessings == 1.6 04:19:48 INFO - blobuploader == 1.2.4 04:19:48 INFO - docopt == 0.6.1 04:19:48 INFO - functools32 == 3.2.3-2 04:19:48 INFO - jsonschema == 2.5.1 04:19:48 INFO - manifestparser == 1.1 04:19:48 INFO - mozInstall == 1.12 04:19:48 INFO - mozcrash == 1.0 04:19:48 INFO - mozdebug == 0.1 04:19:48 INFO - mozdevice == 0.50 04:19:48 INFO - mozfile == 1.2 04:19:48 INFO - mozhttpd == 0.7 04:19:48 INFO - mozinfo == 0.9 04:19:48 INFO - mozleak == 0.1 04:19:48 INFO - mozlog == 3.4 04:19:48 INFO - moznetwork == 0.27 04:19:48 INFO - mozprocess == 0.25 04:19:48 INFO - mozprofile == 0.28 04:19:48 INFO - mozrunner == 6.13 04:19:48 INFO - mozscreenshot == 0.1 04:19:48 INFO - mozsystemmonitor == 0.3 04:19:48 INFO - moztest == 0.8 04:19:48 INFO - mozversion == 1.4 04:19:48 INFO - psutil == 3.1.1 04:19:48 INFO - requests == 1.2.3 04:19:48 INFO - wsgiref == 0.1.2 04:19:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:19:48 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')]} 04:19:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:19:48 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')]} 04:19:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:19:48 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 0x1bf51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dc2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f685c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f657a0>, '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 0x1f666a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f66b30>, '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': '00204705a9daa57ed339a427000001b9-1494933253.287804-1827586896', '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 04:19:48 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 04:19:48 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 04:19:48 INFO - Using env: {'DISPLAY': ':0', 04:19:48 INFO - 'HOME': '/home/cltbld', 04:19:48 INFO - 'LANG': 'en_US.UTF-8', 04:19:48 INFO - 'LANGUAGE': 'en_US:en', 04:19:48 INFO - 'LOGNAME': 'cltbld', 04:19:48 INFO - 'MAIL': '/var/mail/cltbld', 04:19:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:19:48 INFO - 'MOZ_NO_REMOTE': '1', 04:19:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:19:48 INFO - 'NO_EM_RESTART': '1', 04:19:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:19:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:19:48 INFO - 'PWD': '/builds/slave/test', 04:19:48 INFO - 'SHELL': '/bin/bash', 04:19:48 INFO - 'SHLVL': '1', 04:19:48 INFO - 'TERM': 'linux', 04:19:48 INFO - 'TMOUT': '86400', 04:19:48 INFO - 'USER': 'cltbld', 04:19:48 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1494933253.287804-1827586896', 04:19:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:19:48 INFO - '_': '/tools/buildbot/bin/python'} 04:19:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:19:48 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)) 04:19:48 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)) 04:19:48 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)) 04:19:48 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)) 04:19:48 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)) 04:19:48 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)) 04:19:48 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)) 04:19:48 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)) 04:19:48 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)) 04:19:48 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)) 04:19:48 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)) 04:19:48 INFO - Cleaning up... 04:19:48 INFO - Return code: 0 04:19:48 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:19:48 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')]} 04:19:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:19:48 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')]} 04:19:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:19:48 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 0x1bf51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dc2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f685c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f657a0>, '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 0x1f666a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f66b30>, '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': '00204705a9daa57ed339a427000001b9-1494933253.287804-1827586896', '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 04:19:48 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 04:19:48 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 04:19:48 INFO - Using env: {'DISPLAY': ':0', 04:19:48 INFO - 'HOME': '/home/cltbld', 04:19:48 INFO - 'LANG': 'en_US.UTF-8', 04:19:48 INFO - 'LANGUAGE': 'en_US:en', 04:19:48 INFO - 'LOGNAME': 'cltbld', 04:19:48 INFO - 'MAIL': '/var/mail/cltbld', 04:19:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:19:48 INFO - 'MOZ_NO_REMOTE': '1', 04:19:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:19:48 INFO - 'NO_EM_RESTART': '1', 04:19:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:19:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:19:48 INFO - 'PWD': '/builds/slave/test', 04:19:48 INFO - 'SHELL': '/bin/bash', 04:19:48 INFO - 'SHLVL': '1', 04:19:48 INFO - 'TERM': 'linux', 04:19:48 INFO - 'TMOUT': '86400', 04:19:48 INFO - 'USER': 'cltbld', 04:19:48 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1494933253.287804-1827586896', 04:19:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:19:48 INFO - '_': '/tools/buildbot/bin/python'} 04:19:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:19:48 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:19:48 INFO - Cleaning up... 04:19:48 INFO - Return code: 0 04:19:48 INFO - Running post-action listener: _resource_record_post_action 04:19:48 INFO - Running post-action listener: _start_resource_monitoring 04:19:48 INFO - Starting resource monitoring. 04:19:48 INFO - [mozharness: 2017-05-16 11:19:48.896850Z] Finished create-virtualenv step (success) 04:19:48 INFO - [mozharness: 2017-05-16 11:19:48.897487Z] Running install step. 04:19:48 INFO - Running pre-action listener: _resource_record_pre_action 04:19:48 INFO - Running main action method: install 04:19:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:19:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:19:49 INFO - Reading from file tmpfile_stdout 04:19:49 INFO - Detecting whether we're running mozinstall >=1.0... 04:19:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:19:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:19:49 INFO - Reading from file tmpfile_stdout 04:19:49 INFO - Output received: 04:19:49 INFO - Usage: mozinstall [options] installer 04:19:49 INFO - Options: 04:19:49 INFO - -h, --help show this help message and exit 04:19:49 INFO - -d DEST, --destination=DEST 04:19:49 INFO - Directory to install application into. [default: 04:19:49 INFO - "/builds/slave/test"] 04:19:49 INFO - --app=APP Application being installed. [default: firefox] 04:19:49 INFO - mkdir: /builds/slave/test/build/application 04:19:49 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'] 04:19:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 04:20:05 INFO - Reading from file tmpfile_stdout 04:20:05 INFO - Output received: 04:20:05 INFO - /builds/slave/test/build/application/firefox/firefox 04:20:05 INFO - Running post-action listener: _resource_record_post_action 04:20:05 INFO - [mozharness: 2017-05-16 11:20:05.583836Z] Finished install step (success) 04:20:05 INFO - [mozharness: 2017-05-16 11:20:05.584110Z] Running run-tests step. 04:20:05 INFO - Running pre-action listener: _resource_record_pre_action 04:20:05 INFO - Running main action method: run_tests 04:20:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:20:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:20:05 INFO - Python 2.7.3 04:20:05 INFO - Return code: 0 04:20:05 INFO - grabbing minidump binary from tooltool 04:20:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:20:05 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 0x1f657a0>, '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 0x1f666a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f66b30>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:20:05 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 04:20:05 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 04:20:05 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 04:20:05 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:20:05 INFO - Return code: 0 04:20:05 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:20:05 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:20:05 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:20:05 INFO - ENV: RUST_BACKTRACE is now 1 04:20:05 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:20:05 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:20:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Y9d5ZEd2RamAy9r3IxOe8A/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-016', '--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 04:20:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Y9d5ZEd2RamAy9r3IxOe8A/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-016 --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 04:20:05 INFO - Using env: {'DISPLAY': ':0', 04:20:05 INFO - 'HOME': '/home/cltbld', 04:20:05 INFO - 'LANG': 'en_US.UTF-8', 04:20:05 INFO - 'LANGUAGE': 'en_US:en', 04:20:05 INFO - 'LOGNAME': 'cltbld', 04:20:05 INFO - 'MAIL': '/var/mail/cltbld', 04:20:05 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:20:05 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:20:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:20:05 INFO - 'MOZ_NO_REMOTE': '1', 04:20:05 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:20:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:20:05 INFO - 'NO_EM_RESTART': '1', 04:20:05 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:20:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:20:05 INFO - 'PWD': '/builds/slave/test', 04:20:05 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:20:05 INFO - 'RUST_BACKTRACE': '1', 04:20:05 INFO - 'SHELL': '/bin/bash', 04:20:05 INFO - 'SHLVL': '1', 04:20:05 INFO - 'TERM': 'linux', 04:20:05 INFO - 'TMOUT': '86400', 04:20:05 INFO - 'USER': 'cltbld', 04:20:05 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1494933253.287804-1827586896', 04:20:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:20:05 INFO - '_': '/tools/buildbot/bin/python'} 04:20:05 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Y9d5ZEd2RamAy9r3IxOe8A/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-016', '--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 04:20:05 INFO - mozversion application_buildid: 20170516103419 04:20:05 INFO - mozversion application_changeset: 49365d675cbb2a8368cda3e4858a2a0d0634c249 04:20:05 INFO - mozversion application_display_name: Nightly 04:20:05 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:20:05 INFO - mozversion application_name: Firefox 04:20:05 INFO - mozversion application_remotingname: firefox 04:20:05 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:20:05 INFO - mozversion application_vendor: Mozilla 04:20:05 INFO - mozversion application_version: 55.0a1 04:20:05 INFO - mozversion platform_buildid: 20170516103419 04:20:05 INFO - mozversion platform_changeset: 49365d675cbb2a8368cda3e4858a2a0d0634c249 04:20:05 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:20:05 INFO - mozversion platform_version: 55.0a1 04:20:05 INFO - using testdate: 1494933605 04:20:05 INFO - actual date: 1494933605 04:20:05 INFO - starting webserver on 'localhost:37202' 04:20:05 INFO - SUITE-START | Running 2 tests 04:20:05 INFO - TEST-START | dromaeo_css 04:20:05 INFO - operating with platform_type : linux_ 04:20:05 INFO - Initialising browser for dromaeo_css test... 04:20:05 INFO - TEST-INFO | started process 4199 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGxpLR_/profile http://localhost:37202/getInfo.html) 04:20:06 INFO - PID 4199 | JavaScript warning: resource://gre/modules/addons/XPIProvider.jsm, line 2932: String.localeCompare is deprecated; use String.prototype.localeCompare instead 04:20:10 INFO - PID 4199 | __metrics Screen width/height:1600/1200 04:20:10 INFO - PID 4199 | colorDepth:24 04:20:10 INFO - PID 4199 | Browser inner width/height: 1024/695 04:20:10 INFO - PID 4199 | __metrics 04:20:11 INFO - TEST-INFO | 4199: exit 0 04:20:11 INFO - Browser initialized. 04:20:11 INFO - Running cycle 1/1 for dromaeo_css test... 04:20:11 INFO - TEST-INFO | started process 4388 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGxpLR_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:20:23 INFO - PID 4388 | RSS: Main: 165670912 04:20:23 INFO - PID 4388 | 04:23:29 INFO - PID 4388 | Cycle 1(1): loaded http://localhost:37202/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37202/tests/dromaeo/cssquery-ext.html) 04:23:31 INFO - PID 4388 | RSS: Main: 173256704 04:23:31 INFO - PID 4388 | 04:26:33 INFO - PID 4388 | Cycle 1(1): loaded http://localhost:37202/tests/dromaeo/cssquery-ext.html (next: http://localhost:37202/tests/dromaeo/cssquery-jquery.html) 04:26:34 INFO - PID 4388 | RSS: Main: 171114496 04:26:34 INFO - PID 4388 | 04:29:36 INFO - PID 4388 | Cycle 1(1): loaded http://localhost:37202/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37202/tests/dromaeo/cssquery-mootools.html) 04:29:36 INFO - PID 4388 | RSS: Main: 172802048 04:29:36 INFO - PID 4388 | 04:32:38 INFO - PID 4388 | Cycle 1(1): loaded http://localhost:37202/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37202/tests/dromaeo/cssquery-prototype.html) 04:32:39 INFO - PID 4388 | RSS: Main: 170647552 04:32:39 INFO - PID 4388 | 04:35:42 INFO - PID 4388 | Cycle 1(1): loaded http://localhost:37202/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37202/tests/dromaeo/cssquery-yui.html) 04:35:42 INFO - PID 4388 | RSS: Main: 171425792 04:35:42 INFO - PID 4388 | 04:38:44 INFO - PID 4388 | Cycle 1(1): loaded http://localhost:37202/tests/dromaeo/cssquery-yui.html (next: http://localhost:37202/tests/dromaeo/cssquery-dojo.html) 04:38:45 INFO - PID 4388 | RSS: Main: 177295360 04:38:45 INFO - PID 4388 | 04:38:45 INFO - PID 4388 | __start_tp_report 04:38:45 INFO - PID 4388 | _x_x_mozilla_page_load 04:38:45 INFO - PID 4388 | _x_x_mozilla_page_load_details 04:38:45 INFO - PID 4388 | |i|pagename|runs| 04:38:45 INFO - PID 4388 | |0;dojo.html;2749.0515772058634;2754.7658449031833;2763.419681866808;2774.2232174990995;2779.847108409038;5220.947790522094;5337.1994200869885;5341.492558206969;5343.251944727736;5349.625526213166;5278.736063196834;5283.101872681644;5383.542398896098;5385.623006389555;5401.891962160755;4634.513376095512;4653.092646933849;4700.294955756647;4723.881902952419;4756.310335001423;4698.08387364464;4782.473927867932;4807.975960120195;4814.807407703687;4850.2724591311235;4692.319613656035;4738.241881298975;4744.745043267335;4797.448293446263;4820.108279968217;4712.481627021025;4721.197396442613;4724.503927087675;4759.405074365704;4773.76131193439;4640.303954406832;4684.929726054112;4686.648501362377;4706.976465117653;4729.645276604234;5233.633645644806;5283;5288.23320618512;5298.125809241509;5305.257263983045;5721.541007043219;5747.396523365028;5773;5784.652920824722;5794.217780599607;5833.912491312633;5834.533237341003;5842.707864606795;5844.240248767675;5853.5902486825935;5253.054450199001;5378.7041712705395;5391.406945236021;5394.136938089887;5399.595030372738;5896.734646940898;5915.438033386821;5978.760849566055;5999;6000.009998350223;5647.407022262685;5668.376478587352;5669.688167150846;5674.687892165971;5690.971545142248;5678;5721.828345149652;5749.425057494217;5771.567132465082;5781.71091445426;5726.541876649858;5766.048601980626;5778.219940308089;5800.8259752207505;5818.650880947157;5749.712514374264;5750.971245143747;5752.769889204469;5756.5682573807135;5766.971165144231;4761.95238047622;4795.112904112751;4819.831305904277;4855.490173531799;4911.410630724265;4168.270552653335;4200.6219440249915;4201.579842015774;4205.306124489486;4207.579242075829;4856.4415092264135;4862.80548778052;4866.294387313819;4866.7079975201605;4868.14807408702;5770.740316685759;5780.075187969905;5780.53755699543;5782.566307526952;5783.306003279633;4809.735464549483;4850.660453768202;4854.101991131582;4860.343853579721;4863.4650188479945;5128.1794912813775;5143.331366922276;5146.459621739738;5146.562542183881;5151.278820965068;5327.7336133193185;5398.973005135028;5402.405735369028;5404.32445944257;5406.540444062299;5803.071508558611;5817.680027598522;5818.534517238695;5826.271716035496;5831.591788574759;5341.278927344759;5342.9465705342445;5345.625806193529;5352.464753524617;5403.027455058127;5552.333719953632;5561.916571251515;5641.464060914206;5667.1782591524825;5732.484076433141;5788.247527821356;5799.82600521985;5804.303483581997;5805.883882322414;5833.154192642128;5579.972100139474;5591.384947655836;5595.832125036255;5607.074832652566;5613.607047506799;5449.482299181572;5468.835934921959;5490.1764735288425;5518.751656175562;5582.274304340573;5456.0451920914475;5528.364238112668;5533.695646739468;5564.443555644403;5565.833025009256;5646.520045796154;5661.660300381825;5675.9499492594005;5677.801276955287;5688.459596338341;5240.318758561515;5493.368262649847;5503;5527.474889885454;5551.666899986014 04:38:45 INFO - PID 4388 | |1;ext.html;747.3908764357049;769.6036541181289;1076.074575864756;1101.0640955188096;1183.0240051957128;33374.66625333746;34346.65653343469;34488.655113448855;34536.48195277073;34576.30847383051;31661;32009.199770005762;32050;32066.198345041386;32077.1980700482;6518.7392504300005;6575.309592492791;6669.233038200597;6687.164104486939;7164.85670286594;7121.181064177634;7220.24187460317;7223.313785190425;7227.530210536324;7242.855142897139;7191.352778249957;7195.424366050704;7242.71029158833;7251.456140789462;7253.74611888584;7106.822329441754;7199.172095209039;7216.639168041629;7244.45666575009;7249.71001159953;6963.199232088274;7021.192562855286;7043.542169758949;7057.470689698242;7079.327463890922;31371.686283137104;31553;31557.368852623047;31590;31716.207094822585;3045.558394032875;3083.5374693795884;3083.922901927447;3084.36770462057;3085.1515833146063;24825.62761558578;24837.62743558848;25003;25172;25221.747782522125;3113.1283240692414;3146.6381366142728;3157.9684203157904;3166.3508980658908;3192.2498212919945;135552.32223838917;135698.3215083928;136276;136313;136770;38675.226495469935;40575.59424405777;40743.59256407457;40841.97895052648;41119.7944010278;42114.789426053285;42468.78765606152;42626.78686606547;42645.14709705789;42751.572484275384;11885;12062.095342849147;12081.939590302169;12097.879021209852;12102.33437160947;9353.625854965725;9423.90576094244;9426.528673566294;9458.52707364629;9461.195798357217;12815.551455699006;12872.16330938486;12951.78330288353;12964.416601252966;12969.481220751253;5104.3619547556555;5282.577393808486;5316.441773613792;5371.039570556797;5382.78468861249;880.3617377401333;908.7228395339484;910.7085732565515;918.9218916392182;931.701855406277;20532.79467205309;21624.459388515414;21672.34982950514;21694.34916952494;21970.231041913456;962.8974823826819;975.7804493988796;977.3012296208245;1001.3140998416109;1004.3622299839654;11181.496832642551;11410.714732131597;11472.77054458906;11525.654230373102;11571.132165087653;182356;182735;182763;182996;183122.0843895772;39295.41056884149;39525.40711889324;39549.60450395517;39589;39791.80104099461;1213.2356615332285;1249.2754202562492;1251.4994002399112;1253.7743206222967;1255.7802384582662;19613.41159765209;19754.518411118937;20339.288124915558;20807.1677132913;21227;29150.27124321909;29309.7069029307;29332.56001160027;29357.119286421443;29369.265768355108;150454.24772876065;151053;151361.24319378333;151388;151563;28858.51688179239;29112.27219319534;29312.430638179532;30363.696363036088;30410.54384184283;35893.461598076574;36128.27743445169;36241.63758362383;36357.27285454223;36396;26417.33956651099;27553.72446275592;27737.306567335978;27837.860810695816;27886.58170127409;27172;27585.448291034467;27967.30081747891;28842.42315153727;29020.419591607628;30524.236894077825;30647.693523065376;30717.692823071484;30827;30946.53580196254;26039.609405858548;26486.470270594866;27148.32129196786;27370.726292736817;27883.44233115367;20172.697409539163;22029.889850550644;22213.77786222117;22444.5511089774;22529.211477598205 04:38:45 INFO - PID 4388 | |2;jquery.html;424.56270041856897;425.2013980860958;433.6729607401351;448.5223237252324;448.9371487991682;16535.751963720555;17084.060376679292;17411.390601328956;17523.561910952234;17559.824401755977;16140.112293823835;16329.83670163298;16805.91597042013;17030.23363948622;17273.91363043186;5573.777048918038;5645.745941432645;5646.802361917344;5733.254676891998;5775.27809023872;5289.629725919187;5555.527780138693;5617.0731829248125;5692.089265717486;5719.685417302067;5544.695041772701;5569.805056823012;5591.189277554752;5591.2731344925305;5602.7758889644365;5390.110631745777;5523.6409633373905;5525.557955363562;5531.585131115163;5596.496315331599;5061.949380506185;5064.721440320781;5072.289879416885;5106.617003724736;5119.641625086246;21518.354449366387;22623.095076196932;22652.773472265395;22872.542549148922;23061.884690576608;1638.230031885012;1685.4269548353618;1688.282479946018;1690.9323627054903;1691.2558474271282;14644.267786610626;14858.628534286621;15116.622084447867;15270.770938435933;15348.616284592863;2082.916683332665;2130.4673831542113;2137.209232583954;2142.8928553572414;2154.6229409853368;75708.62145689291;84247.57876210641;88088.55955720245;96631;98980;11326.263792853439;11342.792309802293;11473.426328683532;11484.827727584094;11523.423828808525;15665.216739162996;15731.774986127817;15800.36798528069;15848.44530441429;15904.522864314089;7520.736774212876;7633.770986870402;7750.418718596128;7920.128785833554;7964.920350796418;6771.119754431892;6864.690407634523;6944.479164062715;7082.787516374517;7084.716611335489;7088.326608972139;7105.680244388912;7113.3953613943395;7201.783946481614;7244.166920804069;2079.46973521751;2120.639491286485;2126.3195777351407;2152.9031193596325;2229.955400891973;843.3211264931789;876.2858270509514;884.4560595234013;897.3673560140086;915.3089417489753;17094.316227351017;17151.11337752846;17686.115694215496;17697.292108315523;17955.727930188295;873.9606717697719;875.671623141322;885.3890815337396;896.3367108339781;896.789254525186;9374.062593740571;9608.183304419063;9847.409155450696;9999.700008999742;11153.776924461465;369167;370696;374807;375168;376646;76494.61752691201;81257.59371203225;82835;82907;83766.58116709499;1068.513826209073;1069.6202847989007;1126.6676330482364;1127.3067063755896;1129.830525421177;17719.557011074827;17974.868599673075;18533;18541;18829.811701883355;38177.427338590496;38213.23573528458;38751.418728719655;38757.80621096877;40324.79837600911;50127.74936125442;50222.49777502324;52240.47759522508;52658;52658.21012684889;8228.25945664893;8625.956870215608;8644.697435589724;8684.522351270489;8775.517346545746;12917;13271.469141234242;13365.53220637273;13594.184348939096;13630.522931697344;10814.405207713651;10878.238523303293;10984.505697243803;11051.281666691639;11331;10556.947215263874;10688.946555267174;10860.131189504978;10872.456377181268;10917.23579349438;11663.650090497298;11717.414129293671;11744.119191060534;11763.529458821551;12034.398280085785;8561.914380856111;8602.956985215284;8659.783505412415;8758.649654013769;8795.648174072965;10779.191560632828;10916.617918372818;11285.605003824827;11489.54041838317;11765.11761617865 04:38:45 INFO - PID 4388 | |3;mootools.html;1263.5198624522682;1293.4308904082204;1329.3419757220177;1330.5742162507997;1334.9599512014643;10223.693289201317;10780.245382823196;10805;10932.836007459875;11113.333200008004;10872.6738197854;11037.282576632513;11051.557937682503;11051.668449946494;11054.392008439532;2258.5934531784274;2302.297799171252;2304.9051700442324;2306.5041016181603;2310.4339436837913;2149.9570008599817;2220.123051394698;2232.497688020199;2234.229190929127;2236.586231547169;2189.540196558725;2214.77852214778;2245.0907382510027;2253.2451628704403;2255;2151.7633060363346;2183.2031308572414;2211.347652442533;2228.6768418579295;2234.4078819112865;2141.539568992674;2172.9565408691897;2187.737471503414;2243.8990245438995;2268.126771193086;10222.795544089151;10481.475926203735;10483.947580262125;10519.421431821247;10538.631147909786;5563.415841336642;5676.375598684142;5724.5992780505385;5773.989551828413;5776.740046697909;3282.573265475497;3368.2084710093354;3465;3480.6345333739846;3527.382708026111;1131.9434028298551;1180.2269513468607;1190.5594230980523;1210.382704820539;1229.3238718704677;15522.611934701723;15827.446039388682;15845.207739612973;15925.840741592552;15964.12197329158;4793.472718001017;4967.677100988424;5137.743112844343;5157.6647517911215;5185.585153187736;13027.934860325639;13091.738165236642;13109.344532773513;13125.60623181306;13159.53941612039;5623.5220006299105;5639.830805075854;5646.378898321182;5667.518260947865;5675.5459563234845;4970.005998800254;5029.421616514074;5081.923771143436;5212.661177023481;5360.678359298455;4333.349997500337;4342.934855977162;4350.760708161019;4398.868033958986;4401.955980440219;1344.1330341929597;1386.895982801294;1386.986130138706;1404;1412.4491448335157;685.1025157044288;702.596007295807;711.6441779110445;728.5446595877577;730.3280981497036;5401.189821526802;5485.807996720096;5494.532964698045;5503.036968530491;5594.328680558359;554.7032337699311;569.4903061759702;570.6718636783866;573.5010540829505;579.3164066401603;3304.8512816923294;3404.1149301181376;3446.724262059029;3672.192117734094;3673.5224420825657;13278.340207474066;13558.728825423435;13862.722745545032;13879.306034698224;13901;13405.195688258736;13430.529931452547;13483.865161348262;13779.104358216684;13797.655058623413;7500.062492188476;7502.099748030162;7610.771676849814;7621.352185064221;7624.5425274483705;5460.31746031746;5467.7266136692215;5478.45215478449;5523.25436066142;5656.6888821115235;11785.705357366134;11953.983911367632;12123.45444454984;12123.75752484963;12140.939295303468;11965.700857478632;12147.574834880737;12162.452689629165;12188.878111218773;12289.692757680772;8139.104698483044;8218.096009439076;8272.793180170544;8287.834243315221;8300;9843.507824608598;9847.409155450696;9932.205423565953;9935.950320248352;9937.751556211153;8146.837063258583;8273.503589784632;8292.792680183044;8402.579871006548;8589.82820343577;8288.21261980111;8425.620847061775;8446.070932197576;8595.484270943763;8655.52394618302;7519.624018798929;7696.345810605937;7730.613469326398;7740.3420709240345;7746.070471543451;4866.418414015388;4898.167311556973;4900.044491324157;5021.799128034984;5091.898162036812;5214.765335559985;5233.502817232356;5275.894482110413;5293.391260004994;5358.115910874662 04:38:45 INFO - PID 4388 | |4;prototype.html;349.59796234330514;366.22360595537464;375.9680427163689;387.59109139857446;389.13805919887443;5541.251930989315;5549.528290095342;5563.471470210334;5568.805091821782;5580.386157522669;5423.755930983105;5445.779520871317;5458.972705136479;5468.945310546894;5475.835724928259;4156.418101465797;4186.874393768192;4240.1307731914885;4241.1941731071;4247.171801498709;4190.790460476979;4213.2837417639075;4221.978890105545;4228.492580890297;4243.83024679014;4209.116085622023;4218.1563687262515;4222.366645003243;4223.704340696153;4239.40648309237;4163.479565054368;4222.831086756526;4223.598758117974;4228.260054490452;4228.843289922131;3730.6642402183934;3769.6230376962085;3777.0934975605933;3779.527559055118;3784.280986612535;5345.705986170759;5359.115745901921;5362.91955620666;5373.194020896858;5375.377175628956;4539.591436770674;4992.600591952635;5017;5026.924596131061;5061.974690126563;5677.659340439545;5721.342045664718;5738.254026976508;5742.569307301927;5754.165645981351;3926.3717805151323;3932.488776459042;3934.429507721364;3951.9012024699614;3953.486046813896;5884.322633201926;6035.637861728266;6085.6348619083;6118.757058758865;6177.876442471171;4094.303968325392;4107.322291821875;4108.055147316074;4108.4453598763785;4117.5882411758585;4159.896002599899;4163.708540402204;4165.229432554987;4174.415581818548;4188.246115699203;4705.058988202305;4780.808767649255;4792.257200133985;4807.975960120177;4818.301346304766;5755.1367294906095;5756.856078597984;5771.538276937835;5786.971065144648;5790.449907258803;1411.3225651687249;1416.553785557546;1417.206364435919;1418.949977017;1424.6936908564708;920.1902325953253;948.4830767231875;948.7390967483997;953.0183910572122;956.8851737791509;4987.979868153404;4999.42506611737;5015.297858299841;5031.622628302892;5037.168867136881;6016.315431679137;6017.518598512196;6019.849503762441;6025.6083354581815;6026.276846778327;4822.734749588806;4973.5523802857915;4985.202367621163;5010.342450011512;5015.724135172528;3160.178353628073;3162.826044567525;3165.3352795912656;3177.253345463814;3181.840907954593;5411.377691565521;5552.639078459887;5556.194351818964;5560.249366335493;5575.275214222206;6104.633721976696;6122.724477398528;6129.1419201311855;6130.754769809158;6155.21498765353;5530.695811730233;5541.836214394942;5560.860978475571;5561.221428999943;5563.248961390242;5956.404359564009;6010.838890137644;6022.5784195105925;6037.799966018018;6050.1227322037175;5834.299884013945;5873.530117590668;5888.205092312483;5905.498032667271;5906.143609176731;5327.413984461628;5486.396496385315;5521.365043019943;5530.695811730394;5542.445755424425;4027.7986100695434;4053.3919912013434;4057.5739547348285;4065.9796701016307;4066.34938409853;5913.846799873983;6038.154658347747;6050.152978582913;6060.757569697339;6069.150318955261;5813.476787089182;5815.94184058154;5829.737661805314;5834.416558344132;5834.474897259267;5787.276590426197;5822.126680997884;5829.300483941955;5836.270466191726;5837.824865254049;5646.71766411686;5711.971440142773;5723.399043100415;5732.57005724564;5761.395053519488;5884.264466941632;5885.61743486672;5902.557308201816;5913.793017244376;5925.733341999707;5480.6437581557075;5642.420122365744;5739.368669446441;5745.2818397700285;5747.85042991395 04:38:45 INFO - PID 4388 | |5;yui.html;743.5835931878152;746.5520687587448;760.7755712064937;765.5368502056256;772.1506343022676;12133.635990920264;12576.937115314433;14072.929635351822;14656.706865862676;14674.413023479061;14947.252637368143;15374.615634609141;15452.15013174275;15530.45643402481;15643.843561564381;840.4285086141422;860.8149247911698;861.0313397427893;861.0958493581745;865.2385900407633;913.1005959130251;923.5290002098944;924.075924075924;924.3437159616681;926.9582868770922;938.7090002099371;940.1773448232797;942.8727121838567;943.575391074016;944.2351695126935;932.6922115701802;934.5700977550335;936.5925822267302;938.8920274168489;940.6660635474376;685.4790359326897;693.6497068980183;693.7398475571661;695.6243628440636;697.6128248821901;14360;14789.778153327708;14812.407503699838;14870.553883383516;14967.326470308863;15824.92087539555;15826.60433489172;16157.192140392934;16208.675826483523;16276.593085172846;12615;12732.618021459371;12831.615051548468;12851;12972.610821675271;2870.2106920596793;2881.9567706484418;2896.724811142938;2899.7680185585104;2908.1566345759707;68682.65658671725;68857.3114268861;69511.65244173797;69803.65098174528;70609.29390706078;11079.335239885633;11124.944375278072;11237.38194399316;11321.490532926038;11347.489362978686;17791.288348466176;17983.190756415992;17984.9100754498;18015.27938882456;18041.54896127581;5781.248437703071;6116.510679145657;6285.434310911948;6315.8105256841445;6343.555951083472;2884.6971068037556;2943.028800495831;2952.143878275276;2962.837043962603;2978.538326559343;3570.892873213808;3614.855405783792;3643.508126402902;3644.6719795218028;3651.8904432867057;719.3453956899197;720.038748271064;723.3742812467178;724.699249811333;727.6361819090455;579.8202557207279;582.9387914269025;583.1806312131462;586.6450797267591;602.6233603997501;9564.61741530345;9923.206143508502;10084.344517606332;10184.796304073878;10407.375557466576;564.8051422259314;573.1030936584232;574.7729646789495;580.6748220996171;592.2478452365472;4510.729356238636;4665.6734028617675;4696.577308042292;4753.382060332135;4852.417709874838;62237.68881155565;63010.36989630045;64273.35726642767;64538.35461645418;66178;54445;55520.89270180277;57351.71324143353;57875.421245787846;59965.700171498866;50533;50605.49394506008;50669.49330506721;51847.70380740587;52816.73591632017;9309.906900930904;9331.346805723535;9425.528723563657;9461.148496635336;9768.218542516439;27075.1877443677;27117.457650846478;27426.5886011706;27782.583261250693;28069.719302806712;32711.836440817642;33120;33165.668343316254;34217.486737698455;34335.31329373349;10997.61508347204;11144.164187685794;11154.944225279147;11349.886501134883;11352.205345625727;15019.849801501845;15333.463328783439;15770.763438548202;15780.132092734551;16025.679486409974;14199.574012779633;14397.9280103603;14826.481073162387;14976.700465990838;15219.543413697607;14297.499587514387;14353.856461435253;14421.7836732447;14558;14825.92587037058;13924.791128133289;14029.088109272865;14105.153690778176;14184.858151418353;14400.639984000483;10285.228607854291;10397.792044158923;10637;10948.452577370941;11154.219204655596;10729.302595331279;11422.771544568895;11505.194636375709;11925.463354148911;12062.51749930028 04:38:45 INFO - PID 4388 | __end_tp_report 04:38:45 INFO - PID 4388 | __start_cc_report 04:38:45 INFO - PID 4388 | _x_x_mozilla_cycle_collect,285 04:38:45 INFO - PID 4388 | __end_cc_report 04:38:45 INFO - PID 4388 | __startTimestamp1494934725008__endTimestamp 04:38:45 INFO - PID 4388 | 04:38:45 INFO - PID 4388 | ------- Summary: start ------- 04:38:45 INFO - PID 4388 | Number of tests: 6 04:38:45 INFO - PID 4388 | 04:38:45 INFO - PID 4388 | [#0] dojo.html Cycles:165 Average:5262.95 Median:5402.41 stddev:625.64 (11.6%) stddev-sans-first:595.67 04:38:45 INFO - PID 4388 | Values: 2749.1 2754.8 2763.4 2774.2 2779.8 5220.9 5337.2 5341.5 5343.3 5349.6 5278.7 5283.1 5383.5 5385.6 5401.9 4634.5 4653.1 4700.3 4723.9 4756.3 4698.1 4782.5 4808.0 4814.8 4850.3 4692.3 4738.2 4744.7 4797.4 4820.1 4712.5 4721.2 4724.5 4759.4 4773.8 4640.3 4684.9 4686.6 4707.0 4729.6 5233.6 5283.0 5288.2 5298.1 5305.3 5721.5 5747.4 5773.0 5784.7 5794.2 5833.9 5834.5 5842.7 5844.2 5853.6 5253.1 5378.7 5391.4 5394.1 5399.6 5896.7 5915.4 5978.8 5999.0 6000.0 5647.4 5668.4 5669.7 5674.7 5691.0 5678.0 5721.8 5749.4 5771.6 5781.7 5726.5 5766.0 5778.2 5800.8 5818.7 5749.7 5751.0 5752.8 5756.6 5767.0 4762.0 4795.1 4819.8 4855.5 4911.4 4168.3 4200.6 4201.6 4205.3 4207.6 4856.4 4862.8 4866.3 4866.7 4868.1 5770.7 5780.1 5780.5 5782.6 5783.3 4809.7 4850.7 4854.1 4860.3 4863.5 5128.2 5143.3 5146.5 5146.6 5151.3 5327.7 5399.0 5402.4 5404.3 5406.5 5803.1 5817.7 5818.5 5826.3 5831.6 5341.3 5342.9 5345.6 5352.5 5403.0 5552.3 5561.9 5641.5 5667.2 5732.5 5788.2 5799.8 5804.3 5805.9 5833.2 5580.0 5591.4 5595.8 5607.1 5613.6 5449.5 5468.8 5490.2 5518.8 5582.3 5456.0 5528.4 5533.7 5564.4 5565.8 5646.5 5661.7 5675.9 5677.8 5688.5 5240.3 5493.4 5503.0 5527.5 5551.7 04:38:45 INFO - PID 4388 | 04:38:45 INFO - PID 4388 | [#1] ext.html Cycles:180 Average:30121.25 Median:3083.73 stddev:40737.34 (1321.0%) stddev-sans-first:40791.90 04:38:45 INFO - PID 4388 | Values: 747.4 769.6 1076.1 1101.1 1183.0 33374.7 34346.7 34488.7 34536.5 34576.3 31661.0 32009.2 32050.0 32066.2 32077.2 6518.7 6575.3 6669.2 6687.2 7164.9 7121.2 7220.2 7223.3 7227.5 7242.9 7191.4 7195.4 7242.7 7251.5 7253.7 7106.8 7199.2 7216.6 7244.5 7249.7 6963.2 7021.2 7043.5 7057.5 7079.3 31371.7 31553.0 31557.4 31590.0 31716.2 3045.6 3083.5 3083.9 3084.4 3085.2 24825.6 24837.6 25003.0 25172.0 25221.7 3113.1 3146.6 3158.0 3166.4 3192.2 135552.3 135698.3 136276.0 136313.0 136770.0 38675.2 40575.6 40743.6 40842.0 41119.8 42114.8 42468.8 42626.8 42645.1 42751.6 11885.0 12062.1 12081.9 12097.9 12102.3 9353.6 9423.9 9426.5 9458.5 9461.2 12815.6 12872.2 12951.8 12964.4 12969.5 5104.4 5282.6 5316.4 5371.0 5382.8 880.4 908.7 910.7 918.9 931.7 20532.8 21624.5 21672.3 21694.3 21970.2 962.9 975.8 977.3 1001.3 1004.4 11181.5 11410.7 11472.8 11525.7 11571.1 182356.0 182735.0 182763.0 182996.0 183122.1 39295.4 39525.4 39549.6 39589.0 39791.8 1213.2 1249.3 1251.5 1253.8 1255.8 19613.4 19754.5 20339.3 20807.2 21227.0 29150.3 29309.7 29332.6 29357.1 29369.3 150454.2 151053.0 151361.2 151388.0 151563.0 28858.5 29112.3 29312.4 30363.7 30410.5 35893.5 36128.3 36241.6 36357.3 36396.0 26417.3 27553.7 27737.3 27837.9 27886.6 27172.0 27585.4 27967.3 28842.4 29020.4 30524.2 30647.7 30717.7 30827.0 30946.5 26039.6 26486.5 27148.3 27370.7 27883.4 20172.7 22029.9 22213.8 22444.6 22529.2 04:38:45 INFO - PID 4388 | 04:38:45 INFO - PID 4388 | [#2] jquery.html Cycles:180 Average:25346.80 Median:207411.71 stddev:62216.51 (30.0%) stddev-sans-first:62362.90 04:38:45 INFO - PID 4388 | Values: 424.6 425.2 433.7 448.5 448.9 16535.8 17084.1 17411.4 17523.6 17559.8 16140.1 16329.8 16805.9 17030.2 17273.9 5573.8 5645.7 5646.8 5733.3 5775.3 5289.6 5555.5 5617.1 5692.1 5719.7 5544.7 5569.8 5591.2 5591.3 5602.8 5390.1 5523.6 5525.6 5531.6 5596.5 5061.9 5064.7 5072.3 5106.6 5119.6 21518.4 22623.1 22652.8 22872.5 23061.9 1638.2 1685.4 1688.3 1690.9 1691.3 14644.3 14858.6 15116.6 15270.8 15348.6 2082.9 2130.5 2137.2 2142.9 2154.6 75708.6 84247.6 88088.6 96631.0 98980.0 11326.3 11342.8 11473.4 11484.8 11523.4 15665.2 15731.8 15800.4 15848.4 15904.5 7520.7 7633.8 7750.4 7920.1 7964.9 6771.1 6864.7 6944.5 7082.8 7084.7 7088.3 7105.7 7113.4 7201.8 7244.2 2079.5 2120.6 2126.3 2152.9 2230.0 843.3 876.3 884.5 897.4 915.3 17094.3 17151.1 17686.1 17697.3 17955.7 874.0 875.7 885.4 896.3 896.8 9374.1 9608.2 9847.4 9999.7 11153.8 369167.0 370696.0 374807.0 375168.0 376646.0 76494.6 81257.6 82835.0 82907.0 83766.6 1068.5 1069.6 1126.7 1127.3 1129.8 17719.6 17974.9 18533.0 18541.0 18829.8 38177.4 38213.2 38751.4 38757.8 40324.8 50127.7 50222.5 52240.5 52658.0 52658.2 8228.3 8626.0 8644.7 8684.5 8775.5 12917.0 13271.5 13365.5 13594.2 13630.5 10814.4 10878.2 10984.5 11051.3 11331.0 10556.9 10688.9 10860.1 10872.5 10917.2 11663.7 11717.4 11744.1 11763.5 12034.4 8561.9 8603.0 8659.8 8758.6 8795.6 10779.2 10916.6 11285.6 11489.5 11765.1 04:38:45 INFO - PID 4388 | 04:38:45 INFO - PID 4388 | [#3] mootools.html Cycles:180 Average:6478.11 Median:3472.82 stddev:4258.44 (122.6%) stddev-sans-first:4252.37 04:38:45 INFO - PID 4388 | Values: 1263.5 1293.4 1329.3 1330.6 1335.0 10223.7 10780.2 10805.0 10932.8 11113.3 10872.7 11037.3 11051.6 11051.7 11054.4 2258.6 2302.3 2304.9 2306.5 2310.4 2150.0 2220.1 2232.5 2234.2 2236.6 2189.5 2214.8 2245.1 2253.2 2255.0 2151.8 2183.2 2211.3 2228.7 2234.4 2141.5 2173.0 2187.7 2243.9 2268.1 10222.8 10481.5 10483.9 10519.4 10538.6 5563.4 5676.4 5724.6 5774.0 5776.7 3282.6 3368.2 3465.0 3480.6 3527.4 1131.9 1180.2 1190.6 1210.4 1229.3 15522.6 15827.4 15845.2 15925.8 15964.1 4793.5 4967.7 5137.7 5157.7 5185.6 13027.9 13091.7 13109.3 13125.6 13159.5 5623.5 5639.8 5646.4 5667.5 5675.5 4970.0 5029.4 5081.9 5212.7 5360.7 4333.3 4342.9 4350.8 4398.9 4402.0 1344.1 1386.9 1387.0 1404.0 1412.4 685.1 702.6 711.6 728.5 730.3 5401.2 5485.8 5494.5 5503.0 5594.3 554.7 569.5 570.7 573.5 579.3 3304.9 3404.1 3446.7 3672.2 3673.5 13278.3 13558.7 13862.7 13879.3 13901.0 13405.2 13430.5 13483.9 13779.1 13797.7 7500.1 7502.1 7610.8 7621.4 7624.5 5460.3 5467.7 5478.5 5523.3 5656.7 11785.7 11954.0 12123.5 12123.8 12140.9 11965.7 12147.6 12162.5 12188.9 12289.7 8139.1 8218.1 8272.8 8287.8 8300.0 9843.5 9847.4 9932.2 9936.0 9937.8 8146.8 8273.5 8292.8 8402.6 8589.8 8288.2 8425.6 8446.1 8595.5 8655.5 7519.6 7696.3 7730.6 7740.3 7746.1 4866.4 4898.2 4900.0 5021.8 5091.9 5214.8 5233.5 5275.9 5293.4 5358.1 04:38:45 INFO - PID 4388 | 04:38:45 INFO - PID 4388 | [#4] prototype.html Cycles:180 Average:4778.13 Median:5472.39 stddev:1417.18 (25.9%) stddev-sans-first:1381.62 04:38:45 INFO - PID 4388 | Values: 349.6 366.2 376.0 387.6 389.1 5541.3 5549.5 5563.5 5568.8 5580.4 5423.8 5445.8 5459.0 5468.9 5475.8 4156.4 4186.9 4240.1 4241.2 4247.2 4190.8 4213.3 4222.0 4228.5 4243.8 4209.1 4218.2 4222.4 4223.7 4239.4 4163.5 4222.8 4223.6 4228.3 4228.8 3730.7 3769.6 3777.1 3779.5 3784.3 5345.7 5359.1 5362.9 5373.2 5375.4 4539.6 4992.6 5017.0 5026.9 5062.0 5677.7 5721.3 5738.3 5742.6 5754.2 3926.4 3932.5 3934.4 3951.9 3953.5 5884.3 6035.6 6085.6 6118.8 6177.9 4094.3 4107.3 4108.1 4108.4 4117.6 4159.9 4163.7 4165.2 4174.4 4188.2 4705.1 4780.8 4792.3 4808.0 4818.3 5755.1 5756.9 5771.5 5787.0 5790.4 1411.3 1416.6 1417.2 1418.9 1424.7 920.2 948.5 948.7 953.0 956.9 4988.0 4999.4 5015.3 5031.6 5037.2 6016.3 6017.5 6019.8 6025.6 6026.3 4822.7 4973.6 4985.2 5010.3 5015.7 3160.2 3162.8 3165.3 3177.3 3181.8 5411.4 5552.6 5556.2 5560.2 5575.3 6104.6 6122.7 6129.1 6130.8 6155.2 5530.7 5541.8 5560.9 5561.2 5563.2 5956.4 6010.8 6022.6 6037.8 6050.1 5834.3 5873.5 5888.2 5905.5 5906.1 5327.4 5486.4 5521.4 5530.7 5542.4 4027.8 4053.4 4057.6 4066.0 4066.3 5913.8 6038.2 6050.2 6060.8 6069.2 5813.5 5815.9 5829.7 5834.4 5834.5 5787.3 5822.1 5829.3 5836.3 5837.8 5646.7 5712.0 5723.4 5732.6 5761.4 5884.3 5885.6 5902.6 5913.8 5925.7 5480.6 5642.4 5739.4 5745.3 5747.9 04:38:45 INFO - PID 4388 | 04:38:45 INFO - PID 4388 | [#5] yui.html Cycles:180 Average:15106.84 Median:33691.58 stddev:17943.27 (53.3%) stddev-sans-first:17961.19 04:38:45 INFO - PID 4388 | Values: 743.6 746.6 760.8 765.5 772.2 12133.6 12576.9 14072.9 14656.7 14674.4 14947.3 15374.6 15452.2 15530.5 15643.8 840.4 860.8 861.0 861.1 865.2 913.1 923.5 924.1 924.3 927.0 938.7 940.2 942.9 943.6 944.2 932.7 934.6 936.6 938.9 940.7 685.5 693.6 693.7 695.6 697.6 14360.0 14789.8 14812.4 14870.6 14967.3 15824.9 15826.6 16157.2 16208.7 16276.6 12615.0 12732.6 12831.6 12851.0 12972.6 2870.2 2882.0 2896.7 2899.8 2908.2 68682.7 68857.3 69511.7 69803.7 70609.3 11079.3 11124.9 11237.4 11321.5 11347.5 17791.3 17983.2 17984.9 18015.3 18041.5 5781.2 6116.5 6285.4 6315.8 6343.6 2884.7 2943.0 2952.1 2962.8 2978.5 3570.9 3614.9 3643.5 3644.7 3651.9 719.3 720.0 723.4 724.7 727.6 579.8 582.9 583.2 586.6 602.6 9564.6 9923.2 10084.3 10184.8 10407.4 564.8 573.1 574.8 580.7 592.2 4510.7 4665.7 4696.6 4753.4 4852.4 62237.7 63010.4 64273.4 64538.4 66178.0 54445.0 55520.9 57351.7 57875.4 59965.7 50533.0 50605.5 50669.5 51847.7 52816.7 9309.9 9331.3 9425.5 9461.1 9768.2 27075.2 27117.5 27426.6 27782.6 28069.7 32711.8 33120.0 33165.7 34217.5 34335.3 10997.6 11144.2 11154.9 11349.9 11352.2 15019.8 15333.5 15770.8 15780.1 16025.7 14199.6 14397.9 14826.5 14976.7 15219.5 14297.5 14353.9 14421.8 14558.0 14825.9 13924.8 14029.1 14105.2 14184.9 14400.6 10285.2 10397.8 10637.0 10948.5 11154.2 10729.3 11422.8 11505.2 11925.5 12062.5 04:38:45 INFO - PID 4388 | -------- Summary: end -------- 04:38:45 INFO - PID 4388 | 04:38:45 INFO - TEST-INFO | 4388: exit 0 04:38:45 INFO - TEST-OK | dromaeo_css | took 1119948ms 04:38:45 INFO - TEST-START | kraken 04:38:45 INFO - operating with platform_type : linux_ 04:38:45 INFO - Initialising browser for kraken test... 04:38:45 INFO - TEST-INFO | started process 4816 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4eJX7c/profile http://localhost:37202/getInfo.html) 04:38:46 INFO - PID 4816 | JavaScript warning: resource://gre/modules/addons/XPIProvider.jsm, line 2932: String.localeCompare is deprecated; use String.prototype.localeCompare instead 04:38:49 INFO - PID 4816 | __metrics Screen width/height:1600/1200 04:38:49 INFO - PID 4816 | colorDepth:24 04:38:49 INFO - PID 4816 | Browser inner width/height: 1024/695 04:38:49 INFO - PID 4816 | __metrics 04:38:51 INFO - TEST-INFO | 4816: exit 0 04:38:51 INFO - Browser initialized. 04:38:51 INFO - Running cycle 1/1 for kraken test... 04:38:51 INFO - TEST-INFO | started process 5005 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4eJX7c/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:39:03 INFO - PID 5005 | RSS: Main: 165761024 04:39:03 INFO - PID 5005 | 04:39:05 INFO - PID 5005 | Cycle 1(1): loaded http://localhost:37202/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37202/tests/kraken/driver.html?testName=audio-beat-detection) 04:39:06 INFO - PID 5005 | RSS: Main: 170348544 04:39:06 INFO - PID 5005 | 04:39:09 INFO - PID 5005 | Cycle 1(1): loaded http://localhost:37202/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37202/tests/kraken/driver.html?testName=audio-dft) 04:39:10 INFO - PID 5005 | RSS: Main: 170266624 04:39:10 INFO - PID 5005 | 04:39:13 INFO - PID 5005 | Cycle 1(1): loaded http://localhost:37202/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37202/tests/kraken/driver.html?testName=audio-fft) 04:39:13 INFO - PID 5005 | RSS: Main: 165916672 04:39:13 INFO - PID 5005 | 04:39:15 INFO - PID 5005 | Cycle 1(1): loaded http://localhost:37202/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37202/tests/kraken/driver.html?testName=audio-oscillator) 04:39:16 INFO - PID 5005 | RSS: Main: 166105088 04:39:16 INFO - PID 5005 | 04:39:18 INFO - PID 5005 | Cycle 1(1): loaded http://localhost:37202/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37202/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:39:19 INFO - PID 5005 | RSS: Main: 166617088 04:39:19 INFO - PID 5005 | 04:39:22 INFO - PID 5005 | Cycle 1(1): loaded http://localhost:37202/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37202/tests/kraken/driver.html?testName=imaging-darkroom) 04:39:23 INFO - PID 5005 | RSS: Main: 170934272 04:39:23 INFO - PID 5005 | 04:39:26 INFO - PID 5005 | Cycle 1(1): loaded http://localhost:37202/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37202/tests/kraken/driver.html?testName=imaging-desaturate) 04:39:27 INFO - PID 5005 | RSS: Main: 168783872 04:39:27 INFO - PID 5005 | 04:39:30 INFO - PID 5005 | Cycle 1(1): loaded http://localhost:37202/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37202/tests/kraken/driver.html?testName=json-parse-financial) 04:39:30 INFO - PID 5005 | RSS: Main: 169160704 04:39:30 INFO - PID 5005 | 04:39:32 INFO - PID 5005 | Cycle 1(1): loaded http://localhost:37202/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37202/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:39:33 INFO - PID 5005 | RSS: Main: 169680896 04:39:33 INFO - PID 5005 | 04:39:34 INFO - PID 5005 | Cycle 1(1): loaded http://localhost:37202/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37202/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:39:35 INFO - PID 5005 | RSS: Main: 169656320 04:39:35 INFO - PID 5005 | 04:39:37 INFO - PID 5005 | Cycle 1(1): loaded http://localhost:37202/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37202/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:39:38 INFO - PID 5005 | RSS: Main: 169308160 04:39:38 INFO - PID 5005 | 04:39:40 INFO - PID 5005 | Cycle 1(1): loaded http://localhost:37202/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37202/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:39:41 INFO - PID 5005 | RSS: Main: 169328640 04:39:41 INFO - PID 5005 | 04:39:44 INFO - PID 5005 | Cycle 1(1): loaded http://localhost:37202/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37202/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:39:45 INFO - PID 5005 | RSS: Main: 169644032 04:39:45 INFO - PID 5005 | 04:39:47 INFO - PID 5005 | Cycle 1(1): loaded http://localhost:37202/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37202/tests/kraken/driver.html?testName=ai-astar) 04:39:47 INFO - PID 5005 | RSS: Main: 170909696 04:39:47 INFO - PID 5005 | 04:39:47 INFO - PID 5005 | __start_tp_report 04:39:47 INFO - PID 5005 | _x_x_mozilla_page_load 04:39:47 INFO - PID 5005 | _x_x_mozilla_page_load_details 04:39:47 INFO - PID 5005 | |i|pagename|runs| 04:39:47 INFO - PID 5005 | |0;ai-astar;106;111;111;110;110;110;111;111;110;112 04:39:47 INFO - PID 5005 | |1;audio-beat-detection;147;126;128;172;126;127;126;125;156;125 04:39:47 INFO - PID 5005 | |2;audio-dft;164;164;163;164;164;167;166;172;164;165 04:39:47 INFO - PID 5005 | |3;audio-fft;78;79;75;104;75;77;77;79;102;76 04:39:47 INFO - PID 5005 | |4;audio-oscillator;83;82;108;83;83;82;97;83;83;114 04:39:47 INFO - PID 5005 | |5;imaging-gaussian-blur;117;115;114;114;115;114;114;114;115;115 04:39:47 INFO - PID 5005 | |6;imaging-darkroom;154;153;155;151;152;150;151;149;150;154 04:39:47 INFO - PID 5005 | |7;imaging-desaturate;95;96;94;95;94;95;95;94;94;95 04:39:47 INFO - PID 5005 | |8;json-parse-financial;55;56;54;54;55;57;54;56;55;57 04:39:47 INFO - PID 5005 | |9;json-stringify-tinderbox;54;56;54;55;56;56;56;55;55;59 04:39:47 INFO - PID 5005 | |10;stanford-crypto-aes;82;86;82;84;82;83;90;83;82;82 04:39:47 INFO - PID 5005 | |11;stanford-crypto-ccm;138;139;138;140;146;133;136;139;178;141 04:39:47 INFO - PID 5005 | |12;stanford-crypto-pbkdf2;189;197;194;193;204;190;197;194;186;190 04:39:47 INFO - PID 5005 | |13;stanford-crypto-sha256-iterative;74;76;74;77;75;75;75;76;74;72 04:39:47 INFO - PID 5005 | __end_tp_report 04:39:47 INFO - PID 5005 | __start_cc_report 04:39:47 INFO - PID 5005 | _x_x_mozilla_cycle_collect,777 04:39:47 INFO - PID 5005 | __end_cc_report 04:39:47 INFO - PID 5005 | __startTimestamp1494934787659__endTimestamp 04:39:47 INFO - PID 5005 | 04:39:47 INFO - PID 5005 | ------- Summary: start ------- 04:39:47 INFO - PID 5005 | Number of tests: 14 04:39:47 INFO - PID 5005 | 04:39:47 INFO - PID 5005 | [#0] ai-astar Cycles:10 Average:110.20 Median:111.00 stddev:1.62 (1.5%) stddev-sans-first:0.71 04:39:47 INFO - PID 5005 | Values: 106.0 111.0 111.0 110.0 110.0 110.0 111.0 111.0 110.0 112.0 04:39:47 INFO - PID 5005 | 04:39:47 INFO - PID 5005 | [#1] audio-beat-detection Cycles:10 Average:135.80 Median:127.50 stddev:16.68 (13.1%) stddev-sans-first:17.19 04:39:47 INFO - PID 5005 | Values: 147.0 126.0 128.0 172.0 126.0 127.0 126.0 125.0 156.0 125.0 04:39:47 INFO - PID 5005 | 04:39:47 INFO - PID 5005 | [#2] audio-dft Cycles:10 Average:165.30 Median:164.50 stddev:2.63 (1.6%) stddev-sans-first:2.74 04:39:47 INFO - PID 5005 | Values: 164.0 164.0 163.0 164.0 164.0 167.0 166.0 172.0 164.0 165.0 04:39:47 INFO - PID 5005 | 04:39:47 INFO - PID 5005 | [#3] audio-fft Cycles:10 Average:82.20 Median:77.00 stddev:11.06 (14.4%) stddev-sans-first:11.63 04:39:47 INFO - PID 5005 | Values: 78.0 79.0 75.0 104.0 75.0 77.0 77.0 79.0 102.0 76.0 04:39:47 INFO - PID 5005 | 04:39:47 INFO - PID 5005 | [#4] audio-oscillator Cycles:10 Average:89.80 Median:83.00 stddev:12.12 (14.6%) stddev-sans-first:12.60 04:39:47 INFO - PID 5005 | Values: 83.0 82.0 108.0 83.0 83.0 82.0 97.0 83.0 83.0 114.0 04:39:47 INFO - PID 5005 | 04:39:47 INFO - PID 5005 | [#5] imaging-gaussian-blur Cycles:10 Average:114.70 Median:115.00 stddev:0.95 (0.8%) stddev-sans-first:0.53 04:39:47 INFO - PID 5005 | Values: 117.0 115.0 114.0 114.0 115.0 114.0 114.0 114.0 115.0 115.0 04:39:47 INFO - PID 5005 | 04:39:47 INFO - PID 5005 | [#6] imaging-darkroom Cycles:10 Average:151.90 Median:152.50 stddev:2.02 (1.3%) stddev-sans-first:2.00 04:39:47 INFO - PID 5005 | Values: 154.0 153.0 155.0 151.0 152.0 150.0 151.0 149.0 150.0 154.0 04:39:47 INFO - PID 5005 | 04:39:47 INFO - PID 5005 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 04:39:47 INFO - PID 5005 | Values: 95.0 96.0 94.0 95.0 94.0 95.0 95.0 94.0 94.0 95.0 04:39:47 INFO - PID 5005 | 04:39:47 INFO - PID 5005 | [#8] json-parse-financial Cycles:10 Average:55.30 Median:55.50 stddev:1.16 (2.1%) stddev-sans-first:1.22 04:39:47 INFO - PID 5005 | Values: 55.0 56.0 54.0 54.0 55.0 57.0 54.0 56.0 55.0 57.0 04:39:47 INFO - PID 5005 | 04:39:47 INFO - PID 5005 | [#9] json-stringify-tinderbox Cycles:10 Average:55.60 Median:56.00 stddev:1.43 (2.6%) stddev-sans-first:1.39 04:39:47 INFO - PID 5005 | Values: 54.0 56.0 54.0 55.0 56.0 56.0 56.0 55.0 55.0 59.0 04:39:47 INFO - PID 5005 | 04:39:47 INFO - PID 5005 | [#10] stanford-crypto-aes Cycles:10 Average:83.60 Median:83.00 stddev:2.59 (3.1%) stddev-sans-first:2.68 04:39:47 INFO - PID 5005 | Values: 82.0 86.0 82.0 84.0 82.0 83.0 90.0 83.0 82.0 82.0 04:39:47 INFO - PID 5005 | 04:39:47 INFO - PID 5005 | [#11] stanford-crypto-ccm Cycles:10 Average:142.80 Median:139.50 stddev:12.81 (9.2%) stddev-sans-first:13.47 04:39:47 INFO - PID 5005 | Values: 138.0 139.0 138.0 140.0 146.0 133.0 136.0 139.0 178.0 141.0 04:39:47 INFO - PID 5005 | 04:39:47 INFO - PID 5005 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:193.40 Median:194.00 stddev:5.13 (2.6%) stddev-sans-first:5.18 04:39:47 INFO - PID 5005 | Values: 189.0 197.0 194.0 193.0 204.0 190.0 197.0 194.0 186.0 190.0 04:39:47 INFO - PID 5005 | 04:39:47 INFO - PID 5005 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.80 Median:75.00 stddev:1.40 (1.9%) stddev-sans-first:1.45 04:39:47 INFO - PID 5005 | Values: 74.0 76.0 74.0 77.0 75.0 75.0 75.0 76.0 74.0 72.0 04:39:47 INFO - PID 5005 | -------- Summary: end -------- 04:39:47 INFO - PID 5005 | 04:39:48 INFO - TEST-INFO | 5005: exit 0 04:39:48 INFO - TEST-OK | kraken | took 62957ms 04:39:48 INFO - SUITE-END | took 1182s 04:39:48 INFO - Completed test suite (00:19:42) 04:39:48 INFO - javascript benchmark 04:39:48 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6777.645615468729, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2749.0515772058634, 2754.7658449031833, 2763.419681866808, 2774.2232174990995, 2779.847108409038, 5220.947790522094, 5337.1994200869885, 5341.492558206969, 5343.251944727736, 5349.625526213166, 5278.736063196834, 5283.101872681644, 5383.542398896098, 5385.623006389555, 5401.891962160755, 4634.513376095512, 4653.092646933849, 4700.294955756647, 4723.881902952419, 4756.310335001423, 4698.08387364464, 4782.473927867932, 4807.975960120195, 4814.807407703687, 4850.2724591311235, 4692.319613656035, 4738.241881298975, 4744.745043267335, 4797.448293446263, 4820.108279968217, 4712.481627021025, 4721.197396442613, 4724.503927087675, 4759.405074365704, 4773.76131193439, 4640.303954406832, 4684.929726054112, 4686.648501362377, 4706.976465117653, 4729.645276604234, 5233.633645644806, 5283.0, 5288.23320618512, 5298.125809241509, 5305.257263983045, 5721.541007043219, 5747.396523365028, 5773.0, 5784.652920824722, 5794.217780599607, 5833.912491312633, 5834.533237341003, 5842.707864606795, 5844.240248767675, 5853.5902486825935, 5253.054450199001, 5378.7041712705395, 5391.406945236021, 5394.136938089887, 5399.595030372738, 5896.734646940898, 5915.438033386821, 5978.760849566055, 5999.0, 6000.009998350223, 5647.407022262685, 5668.376478587352, 5669.688167150846, 5674.687892165971, 5690.971545142248, 5678.0, 5721.828345149652, 5749.425057494217, 5771.567132465082, 5781.71091445426, 5726.541876649858, 5766.048601980626, 5778.219940308089, 5800.8259752207505, 5818.650880947157, 5749.712514374264, 5750.971245143747, 5752.769889204469, 5756.5682573807135, 5766.971165144231, 4761.95238047622, 4795.112904112751, 4819.831305904277, 4855.490173531799, 4911.410630724265, 4168.270552653335, 4200.6219440249915, 4201.579842015774, 4205.306124489486, 4207.579242075829, 4856.4415092264135, 4862.80548778052, 4866.294387313819, 4866.7079975201605, 4868.14807408702, 5770.740316685759, 5780.075187969905, 5780.53755699543, 5782.566307526952, 5783.306003279633, 4809.735464549483, 4850.660453768202, 4854.101991131582, 4860.343853579721, 4863.4650188479945, 5128.1794912813775, 5143.331366922276, 5146.459621739738, 5146.562542183881, 5151.278820965068, 5327.7336133193185, 5398.973005135028, 5402.405735369028, 5404.32445944257, 5406.540444062299, 5803.071508558611, 5817.680027598522, 5818.534517238695, 5826.271716035496, 5831.591788574759, 5341.278927344759, 5342.9465705342445, 5345.625806193529, 5352.464753524617, 5403.027455058127, 5552.333719953632, 5561.916571251515, 5641.464060914206, 5667.1782591524825, 5732.484076433141, 5788.247527821356, 5799.82600521985, 5804.303483581997, 5805.883882322414, 5833.154192642128, 5579.972100139474, 5591.384947655836, 5595.832125036255, 5607.074832652566, 5613.607047506799, 5449.482299181572, 5468.835934921959, 5490.1764735288425, 5518.751656175562, 5582.274304340573, 5456.0451920914475, 5528.364238112668, 5533.695646739468, 5564.443555644403, 5565.833025009256, 5646.520045796154, 5661.660300381825, 5675.9499492594005, 5677.801276955287, 5688.459596338341, 5240.318758561515, 5493.368262649847, 5503.0, 5527.474889885454, 5551.666899986014], "value": 5217.035485775867, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [747.3908764357049, 769.6036541181289, 1076.074575864756, 1101.0640955188096, 1183.0240051957128, 33374.66625333746, 34346.65653343469, 34488.655113448855, 34536.48195277073, 34576.30847383051, 31661.0, 32009.199770005762, 32050.0, 32066.198345041386, 32077.1980700482, 6518.7392504300005, 6575.309592492791, 6669.233038200597, 6687.164104486939, 7164.85670286594, 7121.181064177634, 7220.24187460317, 7223.313785190425, 7227.530210536324, 7242.855142897139, 7191.352778249957, 7195.424366050704, 7242.71029158833, 7251.456140789462, 7253.74611888584, 7106.822329441754, 7199.172095209039, 7216.639168041629, 7244.45666575009, 7249.71001159953, 6963.199232088274, 7021.192562855286, 7043.542169758949, 7057.470689698242, 7079.327463890922, 31371.686283137104, 31553.0, 31557.368852623047, 31590.0, 31716.207094822585, 3045.558394032875, 3083.5374693795884, 3083.922901927447, 3084.36770462057, 3085.1515833146063, 24825.62761558578, 24837.62743558848, 25003.0, 25172.0, 25221.747782522125, 3113.1283240692414, 3146.6381366142728, 3157.9684203157904, 3166.3508980658908, 3192.2498212919945, 135552.32223838917, 135698.3215083928, 136276.0, 136313.0, 136770.0, 38675.226495469935, 40575.59424405777, 40743.59256407457, 40841.97895052648, 41119.7944010278, 42114.789426053285, 42468.78765606152, 42626.78686606547, 42645.14709705789, 42751.572484275384, 11885.0, 12062.095342849147, 12081.939590302169, 12097.879021209852, 12102.33437160947, 9353.625854965725, 9423.90576094244, 9426.528673566294, 9458.52707364629, 9461.195798357217, 12815.551455699006, 12872.16330938486, 12951.78330288353, 12964.416601252966, 12969.481220751253, 5104.3619547556555, 5282.577393808486, 5316.441773613792, 5371.039570556797, 5382.78468861249, 880.3617377401333, 908.7228395339484, 910.7085732565515, 918.9218916392182, 931.701855406277, 20532.79467205309, 21624.459388515414, 21672.34982950514, 21694.34916952494, 21970.231041913456, 962.8974823826819, 975.7804493988796, 977.3012296208245, 1001.3140998416109, 1004.3622299839654, 11181.496832642551, 11410.714732131597, 11472.77054458906, 11525.654230373102, 11571.132165087653, 182356.0, 182735.0, 182763.0, 182996.0, 183122.0843895772, 39295.41056884149, 39525.40711889324, 39549.60450395517, 39589.0, 39791.80104099461, 1213.2356615332285, 1249.2754202562492, 1251.4994002399112, 1253.7743206222967, 1255.7802384582662, 19613.41159765209, 19754.518411118937, 20339.288124915558, 20807.1677132913, 21227.0, 29150.27124321909, 29309.7069029307, 29332.56001160027, 29357.119286421443, 29369.265768355108, 150454.24772876065, 151053.0, 151361.24319378333, 151388.0, 151563.0, 28858.51688179239, 29112.27219319534, 29312.430638179532, 30363.696363036088, 30410.54384184283, 35893.461598076574, 36128.27743445169, 36241.63758362383, 36357.27285454223, 36396.0, 26417.33956651099, 27553.72446275592, 27737.306567335978, 27837.860810695816, 27886.58170127409, 27172.0, 27585.448291034467, 27967.30081747891, 28842.42315153727, 29020.419591607628, 30524.236894077825, 30647.693523065376, 30717.692823071484, 30827.0, 30946.53580196254, 26039.609405858548, 26486.470270594866, 27148.32129196786, 27370.726292736817, 27883.44233115367, 20172.697409539163, 22029.889850550644, 22213.77786222117, 22444.5511089774, 22529.211477598205], "value": 14539.079125820122, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [424.56270041856897, 425.2013980860958, 433.6729607401351, 448.5223237252324, 448.9371487991682, 16535.751963720555, 17084.060376679292, 17411.390601328956, 17523.561910952234, 17559.824401755977, 16140.112293823835, 16329.83670163298, 16805.91597042013, 17030.23363948622, 17273.91363043186, 5573.777048918038, 5645.745941432645, 5646.802361917344, 5733.254676891998, 5775.27809023872, 5289.629725919187, 5555.527780138693, 5617.0731829248125, 5692.089265717486, 5719.685417302067, 5544.695041772701, 5569.805056823012, 5591.189277554752, 5591.2731344925305, 5602.7758889644365, 5390.110631745777, 5523.6409633373905, 5525.557955363562, 5531.585131115163, 5596.496315331599, 5061.949380506185, 5064.721440320781, 5072.289879416885, 5106.617003724736, 5119.641625086246, 21518.354449366387, 22623.095076196932, 22652.773472265395, 22872.542549148922, 23061.884690576608, 1638.230031885012, 1685.4269548353618, 1688.282479946018, 1690.9323627054903, 1691.2558474271282, 14644.267786610626, 14858.628534286621, 15116.622084447867, 15270.770938435933, 15348.616284592863, 2082.916683332665, 2130.4673831542113, 2137.209232583954, 2142.8928553572414, 2154.6229409853368, 75708.62145689291, 84247.57876210641, 88088.55955720245, 96631.0, 98980.0, 11326.263792853439, 11342.792309802293, 11473.426328683532, 11484.827727584094, 11523.423828808525, 15665.216739162996, 15731.774986127817, 15800.36798528069, 15848.44530441429, 15904.522864314089, 7520.736774212876, 7633.770986870402, 7750.418718596128, 7920.128785833554, 7964.920350796418, 6771.119754431892, 6864.690407634523, 6944.479164062715, 7082.787516374517, 7084.716611335489, 7088.326608972139, 7105.680244388912, 7113.3953613943395, 7201.783946481614, 7244.166920804069, 2079.46973521751, 2120.639491286485, 2126.3195777351407, 2152.9031193596325, 2229.955400891973, 843.3211264931789, 876.2858270509514, 884.4560595234013, 897.3673560140086, 915.3089417489753, 17094.316227351017, 17151.11337752846, 17686.115694215496, 17697.292108315523, 17955.727930188295, 873.9606717697719, 875.671623141322, 885.3890815337396, 896.3367108339781, 896.789254525186, 9374.062593740571, 9608.183304419063, 9847.409155450696, 9999.700008999742, 11153.776924461465, 369167.0, 370696.0, 374807.0, 375168.0, 376646.0, 76494.61752691201, 81257.59371203225, 82835.0, 82907.0, 83766.58116709499, 1068.513826209073, 1069.6202847989007, 1126.6676330482364, 1127.3067063755896, 1129.830525421177, 17719.557011074827, 17974.868599673075, 18533.0, 18541.0, 18829.811701883355, 38177.427338590496, 38213.23573528458, 38751.418728719655, 38757.80621096877, 40324.79837600911, 50127.74936125442, 50222.49777502324, 52240.47759522508, 52658.0, 52658.21012684889, 8228.25945664893, 8625.956870215608, 8644.697435589724, 8684.522351270489, 8775.517346545746, 12917.0, 13271.469141234242, 13365.53220637273, 13594.184348939096, 13630.522931697344, 10814.405207713651, 10878.238523303293, 10984.505697243803, 11051.281666691639, 11331.0, 10556.947215263874, 10688.946555267174, 10860.131189504978, 10872.456377181268, 10917.23579349438, 11663.650090497298, 11717.414129293671, 11744.119191060534, 11763.529458821551, 12034.398280085785, 8561.914380856111, 8602.956985215284, 8659.783505412415, 8758.649654013769, 8795.648174072965, 10779.191560632828, 10916.617918372818, 11285.605003824827, 11489.54041838317, 11765.11761617865], "value": 9040.825117983539, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1263.5198624522682, 1293.4308904082204, 1329.3419757220177, 1330.5742162507997, 1334.9599512014643, 10223.693289201317, 10780.245382823196, 10805.0, 10932.836007459875, 11113.333200008004, 10872.6738197854, 11037.282576632513, 11051.557937682503, 11051.668449946494, 11054.392008439532, 2258.5934531784274, 2302.297799171252, 2304.9051700442324, 2306.5041016181603, 2310.4339436837913, 2149.9570008599817, 2220.123051394698, 2232.497688020199, 2234.229190929127, 2236.586231547169, 2189.540196558725, 2214.77852214778, 2245.0907382510027, 2253.2451628704403, 2255.0, 2151.7633060363346, 2183.2031308572414, 2211.347652442533, 2228.6768418579295, 2234.4078819112865, 2141.539568992674, 2172.9565408691897, 2187.737471503414, 2243.8990245438995, 2268.126771193086, 10222.795544089151, 10481.475926203735, 10483.947580262125, 10519.421431821247, 10538.631147909786, 5563.415841336642, 5676.375598684142, 5724.5992780505385, 5773.989551828413, 5776.740046697909, 3282.573265475497, 3368.2084710093354, 3465.0, 3480.6345333739846, 3527.382708026111, 1131.9434028298551, 1180.2269513468607, 1190.5594230980523, 1210.382704820539, 1229.3238718704677, 15522.611934701723, 15827.446039388682, 15845.207739612973, 15925.840741592552, 15964.12197329158, 4793.472718001017, 4967.677100988424, 5137.743112844343, 5157.6647517911215, 5185.585153187736, 13027.934860325639, 13091.738165236642, 13109.344532773513, 13125.60623181306, 13159.53941612039, 5623.5220006299105, 5639.830805075854, 5646.378898321182, 5667.518260947865, 5675.5459563234845, 4970.005998800254, 5029.421616514074, 5081.923771143436, 5212.661177023481, 5360.678359298455, 4333.349997500337, 4342.934855977162, 4350.760708161019, 4398.868033958986, 4401.955980440219, 1344.1330341929597, 1386.895982801294, 1386.986130138706, 1404.0, 1412.4491448335157, 685.1025157044288, 702.596007295807, 711.6441779110445, 728.5446595877577, 730.3280981497036, 5401.189821526802, 5485.807996720096, 5494.532964698045, 5503.036968530491, 5594.328680558359, 554.7032337699311, 569.4903061759702, 570.6718636783866, 573.5010540829505, 579.3164066401603, 3304.8512816923294, 3404.1149301181376, 3446.724262059029, 3672.192117734094, 3673.5224420825657, 13278.340207474066, 13558.728825423435, 13862.722745545032, 13879.306034698224, 13901.0, 13405.195688258736, 13430.529931452547, 13483.865161348262, 13779.104358216684, 13797.655058623413, 7500.062492188476, 7502.099748030162, 7610.771676849814, 7621.352185064221, 7624.5425274483705, 5460.31746031746, 5467.7266136692215, 5478.45215478449, 5523.25436066142, 5656.6888821115235, 11785.705357366134, 11953.983911367632, 12123.45444454984, 12123.75752484963, 12140.939295303468, 11965.700857478632, 12147.574834880737, 12162.452689629165, 12188.878111218773, 12289.692757680772, 8139.104698483044, 8218.096009439076, 8272.793180170544, 8287.834243315221, 8300.0, 9843.507824608598, 9847.409155450696, 9932.205423565953, 9935.950320248352, 9937.751556211153, 8146.837063258583, 8273.503589784632, 8292.792680183044, 8402.579871006548, 8589.82820343577, 8288.21261980111, 8425.620847061775, 8446.070932197576, 8595.484270943763, 8655.52394618302, 7519.624018798929, 7696.345810605937, 7730.613469326398, 7740.3420709240345, 7746.070471543451, 4866.418414015388, 4898.167311556973, 4900.044491324157, 5021.799128034984, 5091.898162036812, 5214.765335559985, 5233.502817232356, 5275.894482110413, 5293.391260004994, 5358.115910874662], "value": 4821.472494164748, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [349.59796234330514, 366.22360595537464, 375.9680427163689, 387.59109139857446, 389.13805919887443, 5541.251930989315, 5549.528290095342, 5563.471470210334, 5568.805091821782, 5580.386157522669, 5423.755930983105, 5445.779520871317, 5458.972705136479, 5468.945310546894, 5475.835724928259, 4156.418101465797, 4186.874393768192, 4240.1307731914885, 4241.1941731071, 4247.171801498709, 4190.790460476979, 4213.2837417639075, 4221.978890105545, 4228.492580890297, 4243.83024679014, 4209.116085622023, 4218.1563687262515, 4222.366645003243, 4223.704340696153, 4239.40648309237, 4163.479565054368, 4222.831086756526, 4223.598758117974, 4228.260054490452, 4228.843289922131, 3730.6642402183934, 3769.6230376962085, 3777.0934975605933, 3779.527559055118, 3784.280986612535, 5345.705986170759, 5359.115745901921, 5362.91955620666, 5373.194020896858, 5375.377175628956, 4539.591436770674, 4992.600591952635, 5017.0, 5026.924596131061, 5061.974690126563, 5677.659340439545, 5721.342045664718, 5738.254026976508, 5742.569307301927, 5754.165645981351, 3926.3717805151323, 3932.488776459042, 3934.429507721364, 3951.9012024699614, 3953.486046813896, 5884.322633201926, 6035.637861728266, 6085.6348619083, 6118.757058758865, 6177.876442471171, 4094.303968325392, 4107.322291821875, 4108.055147316074, 4108.4453598763785, 4117.5882411758585, 4159.896002599899, 4163.708540402204, 4165.229432554987, 4174.415581818548, 4188.246115699203, 4705.058988202305, 4780.808767649255, 4792.257200133985, 4807.975960120177, 4818.301346304766, 5755.1367294906095, 5756.856078597984, 5771.538276937835, 5786.971065144648, 5790.449907258803, 1411.3225651687249, 1416.553785557546, 1417.206364435919, 1418.949977017, 1424.6936908564708, 920.1902325953253, 948.4830767231875, 948.7390967483997, 953.0183910572122, 956.8851737791509, 4987.979868153404, 4999.42506611737, 5015.297858299841, 5031.622628302892, 5037.168867136881, 6016.315431679137, 6017.518598512196, 6019.849503762441, 6025.6083354581815, 6026.276846778327, 4822.734749588806, 4973.5523802857915, 4985.202367621163, 5010.342450011512, 5015.724135172528, 3160.178353628073, 3162.826044567525, 3165.3352795912656, 3177.253345463814, 3181.840907954593, 5411.377691565521, 5552.639078459887, 5556.194351818964, 5560.249366335493, 5575.275214222206, 6104.633721976696, 6122.724477398528, 6129.1419201311855, 6130.754769809158, 6155.21498765353, 5530.695811730233, 5541.836214394942, 5560.860978475571, 5561.221428999943, 5563.248961390242, 5956.404359564009, 6010.838890137644, 6022.5784195105925, 6037.799966018018, 6050.1227322037175, 5834.299884013945, 5873.530117590668, 5888.205092312483, 5905.498032667271, 5906.143609176731, 5327.413984461628, 5486.396496385315, 5521.365043019943, 5530.695811730394, 5542.445755424425, 4027.7986100695434, 4053.3919912013434, 4057.5739547348285, 4065.9796701016307, 4066.34938409853, 5913.846799873983, 6038.154658347747, 6050.152978582913, 6060.757569697339, 6069.150318955261, 5813.476787089182, 5815.94184058154, 5829.737661805314, 5834.416558344132, 5834.474897259267, 5787.276590426197, 5822.126680997884, 5829.300483941955, 5836.270466191726, 5837.824865254049, 5646.71766411686, 5711.971440142773, 5723.399043100415, 5732.57005724564, 5761.395053519488, 5884.264466941632, 5885.61743486672, 5902.557308201816, 5913.793017244376, 5925.733341999707, 5480.6437581557075, 5642.420122365744, 5739.368669446441, 5745.2818397700285, 5747.85042991395], "value": 4334.728628895891, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [743.5835931878152, 746.5520687587448, 760.7755712064937, 765.5368502056256, 772.1506343022676, 12133.635990920264, 12576.937115314433, 14072.929635351822, 14656.706865862676, 14674.413023479061, 14947.252637368143, 15374.615634609141, 15452.15013174275, 15530.45643402481, 15643.843561564381, 840.4285086141422, 860.8149247911698, 861.0313397427893, 861.0958493581745, 865.2385900407633, 913.1005959130251, 923.5290002098944, 924.075924075924, 924.3437159616681, 926.9582868770922, 938.7090002099371, 940.1773448232797, 942.8727121838567, 943.575391074016, 944.2351695126935, 932.6922115701802, 934.5700977550335, 936.5925822267302, 938.8920274168489, 940.6660635474376, 685.4790359326897, 693.6497068980183, 693.7398475571661, 695.6243628440636, 697.6128248821901, 14360.0, 14789.778153327708, 14812.407503699838, 14870.553883383516, 14967.326470308863, 15824.92087539555, 15826.60433489172, 16157.192140392934, 16208.675826483523, 16276.593085172846, 12615.0, 12732.618021459371, 12831.615051548468, 12851.0, 12972.610821675271, 2870.2106920596793, 2881.9567706484418, 2896.724811142938, 2899.7680185585104, 2908.1566345759707, 68682.65658671725, 68857.3114268861, 69511.65244173797, 69803.65098174528, 70609.29390706078, 11079.335239885633, 11124.944375278072, 11237.38194399316, 11321.490532926038, 11347.489362978686, 17791.288348466176, 17983.190756415992, 17984.9100754498, 18015.27938882456, 18041.54896127581, 5781.248437703071, 6116.510679145657, 6285.434310911948, 6315.8105256841445, 6343.555951083472, 2884.6971068037556, 2943.028800495831, 2952.143878275276, 2962.837043962603, 2978.538326559343, 3570.892873213808, 3614.855405783792, 3643.508126402902, 3644.6719795218028, 3651.8904432867057, 719.3453956899197, 720.038748271064, 723.3742812467178, 724.699249811333, 727.6361819090455, 579.8202557207279, 582.9387914269025, 583.1806312131462, 586.6450797267591, 602.6233603997501, 9564.61741530345, 9923.206143508502, 10084.344517606332, 10184.796304073878, 10407.375557466576, 564.8051422259314, 573.1030936584232, 574.7729646789495, 580.6748220996171, 592.2478452365472, 4510.729356238636, 4665.6734028617675, 4696.577308042292, 4753.382060332135, 4852.417709874838, 62237.68881155565, 63010.36989630045, 64273.35726642767, 64538.35461645418, 66178.0, 54445.0, 55520.89270180277, 57351.71324143353, 57875.421245787846, 59965.700171498866, 50533.0, 50605.49394506008, 50669.49330506721, 51847.70380740587, 52816.73591632017, 9309.906900930904, 9331.346805723535, 9425.528723563657, 9461.148496635336, 9768.218542516439, 27075.1877443677, 27117.457650846478, 27426.5886011706, 27782.583261250693, 28069.719302806712, 32711.836440817642, 33120.0, 33165.668343316254, 34217.486737698455, 34335.31329373349, 10997.61508347204, 11144.164187685794, 11154.944225279147, 11349.886501134883, 11352.205345625727, 15019.849801501845, 15333.463328783439, 15770.763438548202, 15780.132092734551, 16025.679486409974, 14199.574012779633, 14397.9280103603, 14826.481073162387, 14976.700465990838, 15219.543413697607, 14297.499587514387, 14353.856461435253, 14421.7836732447, 14558.0, 14825.92587037058, 13924.791128133289, 14029.088109272865, 14105.153690778176, 14184.858151418353, 14400.639984000483, 10285.228607854291, 10397.792044158923, 10637.0, 10948.452577370941, 11154.219204655596, 10729.302595331279, 11422.771544568895, 11505.194636375709, 11925.463354148911, 12062.51749930028], "value": 6762.878944829987, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1550.1, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 111.0, 111.0, 110.0, 110.0, 110.0, 111.0, 111.0, 110.0, 112.0], "value": 110.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 126.0, 128.0, 172.0, 126.0, 127.0, 126.0, 125.0, 156.0, 125.0], "value": 135.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 164.0, 163.0, 164.0, 164.0, 167.0, 166.0, 172.0, 164.0, 165.0], "value": 165.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 79.0, 75.0, 104.0, 75.0, 77.0, 77.0, 79.0, 102.0, 76.0], "value": 82.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 108.0, 83.0, 83.0, 82.0, 97.0, 83.0, 83.0, 114.0], "value": 89.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 115.0, 114.0, 114.0, 115.0, 114.0, 114.0, 114.0, 115.0, 115.0], "value": 114.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 153.0, 155.0, 151.0, 152.0, 150.0, 151.0, 149.0, 150.0, 154.0], "value": 151.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 94.0, 95.0, 94.0, 95.0, 95.0, 94.0, 94.0, 95.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 56.0, 54.0, 54.0, 55.0, 57.0, 54.0, 56.0, 55.0, 57.0], "value": 55.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 56.0, 54.0, 55.0, 56.0, 56.0, 56.0, 55.0, 55.0, 59.0], "value": 55.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 86.0, 82.0, 84.0, 82.0, 83.0, 90.0, 83.0, 82.0, 82.0], "value": 83.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 139.0, 138.0, 140.0, 146.0, 133.0, 136.0, 139.0, 178.0, 141.0], "value": 142.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [189.0, 197.0, 194.0, 193.0, 204.0, 190.0, 197.0, 194.0, 186.0, 190.0], "value": 193.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 74.0, 77.0, 75.0, 75.0, 75.0, 76.0, 74.0, 72.0], "value": 74.8, "unit": "score"}]}]} 04:39:48 INFO - Return code: 0 04:39:48 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:39:48 INFO - # TBPL SUCCESS # 04:39:48 INFO - Running post-action listener: _resource_record_post_action 04:39:48 INFO - [mozharness: 2017-05-16 11:39:48.949100Z] Finished run-tests step (success) 04:39:48 INFO - Running post-run listener: _resource_record_post_run 04:39:49 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 421888; Write bytes: 399503360; Read time: 44; Write time: 224424 04:39:49 INFO - TinderboxPrint: CPU usage
13.3% 04:39:49 INFO - TinderboxPrint: I/O read bytes / time
421,888 / 44 04:39:49 INFO - TinderboxPrint: I/O write bytes / time
399,503,360 / 224,424 04:39:49 INFO - TinderboxPrint: CPU idle
8,300.4 (86.7%) 04:39:49 INFO - TinderboxPrint: CPU user
1,220.8 (12.7%) 04:39:49 INFO - TinderboxPrint: Swap in / out
0 / 0 04:39:49 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 41103360; Read time: 0; Write time: 10052 04:39:49 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 421888; Write bytes: 353157120; Read time: 44; Write time: 214116 04:39:49 INFO - Running post-run listener: _upload_blobber_files 04:39:49 INFO - Blob upload gear active. 04:39:49 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:39:49 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 04:39:49 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', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:39:49 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 -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:39:50 INFO - (blobuploader) - INFO - Open directory for files ... 04:39:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 04:39:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:39:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:39:50 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 04:39:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:39:50 INFO - (blobuploader) - INFO - Done attempting. 04:39:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:39:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:39:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:39:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:39:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:39:51 INFO - (blobuploader) - INFO - Done attempting. 04:39:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:39:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:39:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:39:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:39:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:39:52 INFO - (blobuploader) - INFO - Done attempting. 04:39:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:39:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:39:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:39:55 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:39:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:39:55 INFO - (blobuploader) - INFO - Done attempting. 04:39:55 INFO - (blobuploader) - INFO - Iteration through files over. 04:39:55 INFO - Return code: 0 04:39:55 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:39:55 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:39:55 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/41d0beb6ded608308bd2ab97582824886066f37884f9e34583804a3f9f900f60735c7c593e39fe3c7a3bd4b5bfa5efece414d240e49903b07b5f43c97261ce3a", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/29c23202717554856f1133322d7d57cad1ad723c1583da869d64f16cb3499ab4a6955cc8ca2c4f20d1e2c4006f0ef404921871dc8d76da1dcac266fdcbb9666c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/68041c46affa6048efc09b929a00c720baf04d8edbea6566015088fa11f3f55163921b5e440303daa544dbaa451bf2f3d0da0630f3c64c707d5de939d9d305b1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2d20e2091ce8db1676ccfa571cccdf0e4bf38ac7a01bf6686c75ac1750968c135b93e8d30cccfe6f0cf31ec389d2ea34fedd6ef04a2229d654a979f970fa6013"} 04:39:55 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:39:55 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:39:55 INFO - Contents: 04:39:55 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/41d0beb6ded608308bd2ab97582824886066f37884f9e34583804a3f9f900f60735c7c593e39fe3c7a3bd4b5bfa5efece414d240e49903b07b5f43c97261ce3a", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/29c23202717554856f1133322d7d57cad1ad723c1583da869d64f16cb3499ab4a6955cc8ca2c4f20d1e2c4006f0ef404921871dc8d76da1dcac266fdcbb9666c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/68041c46affa6048efc09b929a00c720baf04d8edbea6566015088fa11f3f55163921b5e440303daa544dbaa451bf2f3d0da0630f3c64c707d5de939d9d305b1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2d20e2091ce8db1676ccfa571cccdf0e4bf38ac7a01bf6686c75ac1750968c135b93e8d30cccfe6f0cf31ec389d2ea34fedd6ef04a2229d654a979f970fa6013"} 04:39:55 INFO - Running post-run listener: copy_logs_to_upload_dir 04:39:55 INFO - Copying logs to upload dir... 04:39:55 INFO - mkdir: /builds/slave/test/build/upload/logs 04:39:55 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1255.062597 ========= master_lag: 0.73 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2017-05-16 04:39:55.746711) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-16 04:39:55.753377) ========= 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=00204705a9daa57ed339a427000001b9-1494933253.287804-1827586896 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/sha512/41d0beb6ded608308bd2ab97582824886066f37884f9e34583804a3f9f900f60735c7c593e39fe3c7a3bd4b5bfa5efece414d240e49903b07b5f43c97261ce3a", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/29c23202717554856f1133322d7d57cad1ad723c1583da869d64f16cb3499ab4a6955cc8ca2c4f20d1e2c4006f0ef404921871dc8d76da1dcac266fdcbb9666c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/68041c46affa6048efc09b929a00c720baf04d8edbea6566015088fa11f3f55163921b5e440303daa544dbaa451bf2f3d0da0630f3c64c707d5de939d9d305b1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2d20e2091ce8db1676ccfa571cccdf0e4bf38ac7a01bf6686c75ac1750968c135b93e8d30cccfe6f0cf31ec389d2ea34fedd6ef04a2229d654a979f970fa6013"} build_url:https://queue.taskcluster.net/v1/task/Y9d5ZEd2RamAy9r3IxOe8A/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011350 build_url: 'https://queue.taskcluster.net/v1/task/Y9d5ZEd2RamAy9r3IxOe8A/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/41d0beb6ded608308bd2ab97582824886066f37884f9e34583804a3f9f900f60735c7c593e39fe3c7a3bd4b5bfa5efece414d240e49903b07b5f43c97261ce3a", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/29c23202717554856f1133322d7d57cad1ad723c1583da869d64f16cb3499ab4a6955cc8ca2c4f20d1e2c4006f0ef404921871dc8d76da1dcac266fdcbb9666c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/68041c46affa6048efc09b929a00c720baf04d8edbea6566015088fa11f3f55163921b5e440303daa544dbaa451bf2f3d0da0630f3c64c707d5de939d9d305b1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2d20e2091ce8db1676ccfa571cccdf0e4bf38ac7a01bf6686c75ac1750968c135b93e8d30cccfe6f0cf31ec389d2ea34fedd6ef04a2229d654a979f970fa6013"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-16 04:39:55.779180) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-16 04:39:55.779506) ========= 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=00204705a9daa57ed339a427000001b9-1494933253.287804-1827586896 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004392 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-16 04:39:55.865024) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-16 04:39:55.865376) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-16 04:39:55.865704) ========= ========= Total master_lag: 0.94 =========