builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-023 starttime: 1475069941.81 results: success (0) buildid: 20160928033005 builduid: 1fdbba20a65a403986c4d3d3be9be1e8 revision: 45513d6773f099db66f0cd7bf1e312f6f9d11475 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-28 06:39:01.806806) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-28 06:39:01.807872) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-28 06:39:01.808397) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-28 06:39:01.824885) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-28 06:39:01.825353) ========= 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=6d15e502d8e29d5d2676d664000001c3-1475069941.289089-1163264539 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-28 06:39:02-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 49.5M=0s 2016-09-28 06:39:02 (49.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.151295 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-28 06:39:01.991630) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-28 06:39:01.992005) ========= 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=6d15e502d8e29d5d2676d664000001c3-1475069941.289089-1163264539 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022528 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-28 06:39:02.044624) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-28 06:39:02.046293) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 45513d6773f099db66f0cd7bf1e312f6f9d11475 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 45513d6773f099db66f0cd7bf1e312f6f9d11475 --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=6d15e502d8e29d5d2676d664000001c3-1475069941.289089-1163264539 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-28 06:39:02,522 truncating revision to first 12 chars 2016-09-28 06:39:02,522 Setting DEBUG logging. 2016-09-28 06:39:02,522 attempt 1/10 2016-09-28 06:39:02,522 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/45513d6773f0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-28 06:39:03,846 unpacking tar archive at: fx-team-45513d6773f0/testing/mozharness/ program finished with exit code 0 elapsedTime=1.718525 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-28 06:39:03.782981) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-28 06:39:03.783538) ========= script_repo_revision: 45513d6773f099db66f0cd7bf1e312f6f9d11475 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-28 06:39:03.784364) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-28 06:39:03.784907) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-28 06:39:03.797297) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-09-28 06:39:03.798098) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=6d15e502d8e29d5d2676d664000001c3-1475069941.289089-1163264539 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:39:04 INFO - MultiFileLogger online at 20160928 06:39:04 in /builds/slave/test 06:39:04 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 06:39:04 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:39:04 INFO - {'append_to_log': False, 06:39:04 INFO - 'base_work_dir': '/builds/slave/test', 06:39:04 INFO - 'blob_upload_branch': 'Fx-Team', 06:39:04 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:39:04 INFO - 'branch': 'Fx-Team', 06:39:04 INFO - 'buildbot_json_path': 'buildprops.json', 06:39:04 INFO - 'config_files': ('talos/linux_config.py',), 06:39:04 INFO - 'default_actions': ('clobber', 06:39:04 INFO - 'read-buildbot-config', 06:39:04 INFO - 'download-and-extract', 06:39:04 INFO - 'populate-webroot', 06:39:04 INFO - 'create-virtualenv', 06:39:04 INFO - 'install', 06:39:04 INFO - 'run-tests'), 06:39:04 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:39:04 INFO - 'download_minidump_stackwalk': True, 06:39:04 INFO - 'download_symbols': 'ondemand', 06:39:04 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:39:04 INFO - 'tooltool.py': '/tools/tooltool.py', 06:39:04 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:39:04 INFO - '/tools/misc-python/virtualenv.py')}, 06:39:04 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:39:04 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:39:04 INFO - 'installer_path': 'installer.exe', 06:39:04 INFO - 'log_level': 'info', 06:39:04 INFO - 'log_name': 'talos', 06:39:04 INFO - 'log_to_console': True, 06:39:04 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:39:04 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:39:04 INFO - 'opt_config_files': (), 06:39:04 INFO - 'pip_index': False, 06:39:04 INFO - 'sps_profile': False, 06:39:04 INFO - 'sps_profile_interval': 0, 06:39:04 INFO - 'suite': 'dromaeojs-e10s', 06:39:04 INFO - 'system_bits': '32', 06:39:04 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:39:04 INFO - 'title': 'talos-linux64-ix-023', 06:39:04 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:39:04 INFO - 'use_talos_json': True, 06:39:04 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:39:04 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:39:04 INFO - 'work_dir': 'build'} 06:39:04 INFO - [mozharness: 2016-09-28 13:39:04.370007Z] Running clobber step. 06:39:04 INFO - Running pre-action listener: _resource_record_pre_action 06:39:04 INFO - Running main action method: clobber 06:39:04 INFO - rmtree: /builds/slave/test/build 06:39:04 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:39:04 INFO - Running post-action listener: _resource_record_post_action 06:39:04 INFO - [mozharness: 2016-09-28 13:39:04.821578Z] Finished clobber step (success) 06:39:04 INFO - [mozharness: 2016-09-28 13:39:04.821678Z] Running read-buildbot-config step. 06:39:04 INFO - Running pre-action listener: _resource_record_pre_action 06:39:04 INFO - Running main action method: read_buildbot_config 06:39:04 INFO - Using buildbot properties: 06:39:04 INFO - { 06:39:04 INFO - "project": "", 06:39:04 INFO - "product": "firefox", 06:39:04 INFO - "script_repo_revision": "production", 06:39:04 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 06:39:04 INFO - "repository": "", 06:39:04 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 06:39:04 INFO - "buildid": "20160928033005", 06:39:04 INFO - "pgo_build": "True", 06:39:04 INFO - "basedir": "/builds/slave/test", 06:39:04 INFO - "buildnumber": 805, 06:39:04 INFO - "slavename": "talos-linux64-ix-023", 06:39:04 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 06:39:04 INFO - "platform": "ubuntu64_hw", 06:39:04 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 06:39:04 INFO - "branch": "fx-team", 06:39:04 INFO - "repo_path": "integration/fx-team", 06:39:04 INFO - "revision": "45513d6773f099db66f0cd7bf1e312f6f9d11475", 06:39:04 INFO - "stage_platform": "linux64-pgo", 06:39:04 INFO - "builduid": "1fdbba20a65a403986c4d3d3be9be1e8", 06:39:04 INFO - "slavebuilddir": "test" 06:39:04 INFO - } 06:39:04 INFO - Found installer url https://queue.taskcluster.net/v1/task/HTMCLMiNTnyJjm51FduZ0A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 06:39:04 INFO - Running post-action listener: _resource_record_post_action 06:39:04 INFO - [mozharness: 2016-09-28 13:39:04.824066Z] Finished read-buildbot-config step (success) 06:39:04 INFO - [mozharness: 2016-09-28 13:39:04.824153Z] Running download-and-extract step. 06:39:04 INFO - Running pre-action listener: _resource_record_pre_action 06:39:04 INFO - Running main action method: download_and_extract 06:39:04 INFO - mkdir: /builds/slave/test/build/tests 06:39:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 06:39:04 INFO - trying https://queue.taskcluster.net/v1/task/HTMCLMiNTnyJjm51FduZ0A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 06:39:04 INFO - Downloading https://queue.taskcluster.net/v1/task/HTMCLMiNTnyJjm51FduZ0A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 06:39:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HTMCLMiNTnyJjm51FduZ0A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 06:39:05 INFO - Downloaded 1361 bytes. 06:39:05 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 06:39:05 INFO - Using the following test package requirements: 06:39:05 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 06:39:05 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:39:05 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 06:39:05 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:39:05 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 06:39:05 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:39:05 INFO - u'jsshell-linux-x86_64.zip'], 06:39:05 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:39:05 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 06:39:05 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 06:39:05 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:39:05 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 06:39:05 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:39:05 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 06:39:05 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:39:05 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 06:39:05 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:39:05 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 06:39:05 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:39:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HTMCLMiNTnyJjm51FduZ0A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 06:39:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HTMCLMiNTnyJjm51FduZ0A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:39:05 INFO - Fetch https://queue.taskcluster.net/v1/task/HTMCLMiNTnyJjm51FduZ0A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 06:39:05 INFO - Expected file size: 21984074 06:39:10 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 06:39:10 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HTMCLMiNTnyJjm51FduZ0A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 06:39:10 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HTMCLMiNTnyJjm51FduZ0A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:39:10 INFO - Fetch https://queue.taskcluster.net/v1/task/HTMCLMiNTnyJjm51FduZ0A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 06:39:10 INFO - Expected file size: 21984074 06:39:15 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HTMCLMiNTnyJjm51FduZ0A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 06:39:15 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HTMCLMiNTnyJjm51FduZ0A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 06:39:15 INFO - Fetch https://queue.taskcluster.net/v1/task/HTMCLMiNTnyJjm51FduZ0A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 06:39:16 INFO - Expected file size: 14414062 06:39:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 06:39:16 INFO - trying https://queue.taskcluster.net/v1/task/HTMCLMiNTnyJjm51FduZ0A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 06:39:16 INFO - Downloading https://queue.taskcluster.net/v1/task/HTMCLMiNTnyJjm51FduZ0A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 06:39:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HTMCLMiNTnyJjm51FduZ0A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 06:39:17 INFO - Downloaded 59765697 bytes. 06:39:17 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HTMCLMiNTnyJjm51FduZ0A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 06:39:17 INFO - mkdir: /builds/slave/test/properties 06:39:17 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:39:17 INFO - Writing to file /builds/slave/test/properties/build_url 06:39:17 INFO - Contents: 06:39:17 INFO - build_url:https://queue.taskcluster.net/v1/task/HTMCLMiNTnyJjm51FduZ0A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 06:39:18 INFO - Running post-action listener: _resource_record_post_action 06:39:18 INFO - Running post-action listener: set_extra_try_arguments 06:39:18 INFO - [mozharness: 2016-09-28 13:39:18.336198Z] Finished download-and-extract step (success) 06:39:18 INFO - [mozharness: 2016-09-28 13:39:18.336462Z] Running populate-webroot step. 06:39:18 INFO - Running pre-action listener: _resource_record_pre_action 06:39:18 INFO - Running main action method: populate_webroot 06:39:18 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:39:18 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:39:18 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:39:18 INFO - '--tppagecycles', 06:39:18 INFO - '7'], 06:39:18 INFO - 'tests': ['tsvgm']}}, 06:39:18 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:39:18 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:39:18 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:39:18 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:39:18 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:39:18 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:39:18 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:39:18 INFO - 'talos_options': ['--disable-e10s'], 06:39:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:39:18 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:39:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:39:18 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:39:18 INFO - 'talos_options': ['--disable-e10s'], 06:39:18 INFO - 'tests': ['damp', 'tps']}, 06:39:18 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:39:18 INFO - 'tests': ['damp', 'tps']}, 06:39:18 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:39:18 INFO - 'tests': ['dromaeo_dom']}, 06:39:18 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:39:18 INFO - 'g4': {'talos_options': ['--disable-e10s'], 06:39:18 INFO - 'tests': ['basic_compositor_video']}, 06:39:18 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 06:39:18 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:39:18 INFO - 'tests': ['a11yr', 06:39:18 INFO - 'ts_paint', 06:39:18 INFO - 'tpaint', 06:39:18 INFO - 'sessionrestore', 06:39:18 INFO - 'sessionrestore_no_auto_restore', 06:39:18 INFO - 'tabpaint']}, 06:39:18 INFO - 'other-e10s': {'tests': ['a11yr', 06:39:18 INFO - 'ts_paint', 06:39:18 INFO - 'tpaint', 06:39:18 INFO - 'sessionrestore', 06:39:18 INFO - 'sessionrestore_no_auto_restore', 06:39:18 INFO - 'tabpaint']}, 06:39:18 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:39:18 INFO - 'ts_paint', 06:39:18 INFO - 'tpaint', 06:39:18 INFO - 'sessionrestore', 06:39:18 INFO - 'sessionrestore_no_auto_restore', 06:39:18 INFO - 'tabpaint']}, 06:39:18 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:39:18 INFO - 'ts_paint', 06:39:18 INFO - 'tpaint', 06:39:18 INFO - 'sessionrestore', 06:39:18 INFO - 'sessionrestore_no_auto_restore', 06:39:18 INFO - 'tabpaint']}, 06:39:18 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:39:18 INFO - 'tests': ['a11yr', 06:39:18 INFO - 'ts_paint', 06:39:18 INFO - 'tpaint', 06:39:18 INFO - 'sessionrestore', 06:39:18 INFO - 'sessionrestore_no_auto_restore', 06:39:18 INFO - 'tabpaint']}, 06:39:18 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:39:18 INFO - 'tests': ['a11yr', 06:39:18 INFO - 'ts_paint', 06:39:18 INFO - 'tpaint', 06:39:18 INFO - 'sessionrestore', 06:39:18 INFO - 'sessionrestore_no_auto_restore', 06:39:18 INFO - 'tabpaint']}, 06:39:18 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:39:18 INFO - 'tests': ['tsvgx', 06:39:18 INFO - 'tsvgr_opacity', 06:39:18 INFO - 'tart', 06:39:18 INFO - 'tscrollx', 06:39:18 INFO - 'cart']}, 06:39:18 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:39:18 INFO - 'tsvgr_opacity', 06:39:18 INFO - 'tart', 06:39:18 INFO - 'tscrollx', 06:39:18 INFO - 'cart']}, 06:39:18 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:39:18 INFO - 'talos_options': ['--disable-e10s'], 06:39:18 INFO - 'tests': ['tp5o']}, 06:39:18 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:39:18 INFO - 'tests': ['tp5o']}, 06:39:18 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:39:18 INFO - 'talos_options': ['--disable-e10s', 06:39:18 INFO - '--xperf_path', 06:39:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:39:18 INFO - 'tests': ['tp5n']}, 06:39:18 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:39:18 INFO - 'talos_options': ['--xperf_path', 06:39:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:39:18 INFO - 'tests': ['tp5n']}}, 06:39:18 INFO - 'talos.zip': {'path': '', 06:39:18 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:39:18 INFO - Running post-action listener: _resource_record_post_action 06:39:18 INFO - [mozharness: 2016-09-28 13:39:18.354789Z] Finished populate-webroot step (success) 06:39:18 INFO - [mozharness: 2016-09-28 13:39:18.354877Z] Running create-virtualenv step. 06:39:18 INFO - Running pre-action listener: _resource_record_pre_action 06:39:18 INFO - Running main action method: create_virtualenv 06:39:18 INFO - Creating virtualenv /builds/slave/test/build/venv 06:39:18 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 06:39:18 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:39:18 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:39:18 INFO - Using real prefix '/usr' 06:39:18 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:39:18 INFO - Installing distribute.............................................................................................................................................................................................done. 06:39:20 INFO - Installing pip.................done. 06:39:20 INFO - Return code: 0 06:39:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 06:39:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 06:39:21 INFO - Reading from file tmpfile_stdout 06:39:21 INFO - Output received: 06:39:21 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) 06:39:21 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:39:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 06:39:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:39:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:39:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 06:39:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:39:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:39:21 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x7f9e265eff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21f57b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2284790>, '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 0x2285690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2285b20>, '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': '6d15e502d8e29d5d2676d664000001c3-1475069941.289089-1163264539', '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 06:39:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 06:39:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 06:39:21 INFO - Using env: {'DISPLAY': ':0', 06:39:21 INFO - 'HOME': '/home/cltbld', 06:39:21 INFO - 'LANG': 'en_US.UTF-8', 06:39:21 INFO - 'LANGUAGE': 'en_US:en', 06:39:21 INFO - 'LOGNAME': 'cltbld', 06:39:21 INFO - 'MAIL': '/var/mail/cltbld', 06:39:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:39:21 INFO - 'MOZ_NO_REMOTE': '1', 06:39:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:39:21 INFO - 'NO_EM_RESTART': '1', 06:39:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:39:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:39:21 INFO - 'PWD': '/builds/slave/test', 06:39:21 INFO - 'SHELL': '/bin/bash', 06:39:21 INFO - 'SHLVL': '1', 06:39:21 INFO - 'TERM': 'linux', 06:39:21 INFO - 'TMOUT': '86400', 06:39:21 INFO - 'USER': 'cltbld', 06:39:21 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1475069941.289089-1163264539', 06:39:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:39:21 INFO - '_': '/tools/buildbot/bin/python'} 06:39:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:39:21 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 06:39:21 INFO - Cleaning up... 06:39:21 INFO - Return code: 0 06:39:21 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:39:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 06:39:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:39:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:39:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 06:39:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:39:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:39:21 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x7f9e265eff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21f57b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2284790>, '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 0x2285690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2285b20>, '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': '6d15e502d8e29d5d2676d664000001c3-1475069941.289089-1163264539', '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 06:39:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 06:39:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 06:39:21 INFO - Using env: {'DISPLAY': ':0', 06:39:21 INFO - 'HOME': '/home/cltbld', 06:39:21 INFO - 'LANG': 'en_US.UTF-8', 06:39:21 INFO - 'LANGUAGE': 'en_US:en', 06:39:21 INFO - 'LOGNAME': 'cltbld', 06:39:21 INFO - 'MAIL': '/var/mail/cltbld', 06:39:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:39:21 INFO - 'MOZ_NO_REMOTE': '1', 06:39:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:39:21 INFO - 'NO_EM_RESTART': '1', 06:39:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:39:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:39:21 INFO - 'PWD': '/builds/slave/test', 06:39:21 INFO - 'SHELL': '/bin/bash', 06:39:21 INFO - 'SHLVL': '1', 06:39:21 INFO - 'TERM': 'linux', 06:39:21 INFO - 'TMOUT': '86400', 06:39:21 INFO - 'USER': 'cltbld', 06:39:21 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1475069941.289089-1163264539', 06:39:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:39:21 INFO - '_': '/tools/buildbot/bin/python'} 06:39:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:39:21 INFO - Downloading/unpacking psutil>=3.1.1 06:39:21 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 06:39:21 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 06:39:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:39:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:39:21 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 06:39:21 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 06:39:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:39:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:39:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:39:23 INFO - Installing collected packages: psutil 06:39:23 INFO - Running setup.py install for psutil 06:39:23 INFO - building 'psutil._psutil_linux' extension 06:39:23 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 06:39:23 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 06:39:23 INFO - building 'psutil._psutil_posix' extension 06:39:23 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 06:39:23 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 06:39:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:39:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:39:24 INFO - Successfully installed psutil 06:39:24 INFO - Cleaning up... 06:39:24 INFO - Return code: 0 06:39:24 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:39:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 06:39:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:39:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:39:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 06:39:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:39:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:39:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x7f9e265eff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21f57b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2284790>, '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 0x2285690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2285b20>, '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': '6d15e502d8e29d5d2676d664000001c3-1475069941.289089-1163264539', '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 06:39:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 06:39:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 06:39:24 INFO - Using env: {'DISPLAY': ':0', 06:39:24 INFO - 'HOME': '/home/cltbld', 06:39:24 INFO - 'LANG': 'en_US.UTF-8', 06:39:24 INFO - 'LANGUAGE': 'en_US:en', 06:39:24 INFO - 'LOGNAME': 'cltbld', 06:39:24 INFO - 'MAIL': '/var/mail/cltbld', 06:39:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:39:24 INFO - 'MOZ_NO_REMOTE': '1', 06:39:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:39:24 INFO - 'NO_EM_RESTART': '1', 06:39:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:39:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:39:24 INFO - 'PWD': '/builds/slave/test', 06:39:24 INFO - 'SHELL': '/bin/bash', 06:39:24 INFO - 'SHLVL': '1', 06:39:24 INFO - 'TERM': 'linux', 06:39:24 INFO - 'TMOUT': '86400', 06:39:24 INFO - 'USER': 'cltbld', 06:39:24 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1475069941.289089-1163264539', 06:39:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:39:24 INFO - '_': '/tools/buildbot/bin/python'} 06:39:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:39:24 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:39:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:39:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:39:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:39:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:39:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:39:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:39:26 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:39:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:39:26 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:39:26 INFO - Installing collected packages: mozsystemmonitor 06:39:26 INFO - Running setup.py install for mozsystemmonitor 06:39:26 INFO - Successfully installed mozsystemmonitor 06:39:26 INFO - Cleaning up... 06:39:26 INFO - Return code: 0 06:39:26 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:39:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 06:39:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:39:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:39:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 06:39:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:39:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:39:26 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x7f9e265eff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21f57b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2284790>, '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 0x2285690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2285b20>, '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': '6d15e502d8e29d5d2676d664000001c3-1475069941.289089-1163264539', '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 06:39:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 06:39:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 06:39:26 INFO - Using env: {'DISPLAY': ':0', 06:39:26 INFO - 'HOME': '/home/cltbld', 06:39:26 INFO - 'LANG': 'en_US.UTF-8', 06:39:26 INFO - 'LANGUAGE': 'en_US:en', 06:39:26 INFO - 'LOGNAME': 'cltbld', 06:39:26 INFO - 'MAIL': '/var/mail/cltbld', 06:39:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:39:26 INFO - 'MOZ_NO_REMOTE': '1', 06:39:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:39:26 INFO - 'NO_EM_RESTART': '1', 06:39:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:39:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:39:26 INFO - 'PWD': '/builds/slave/test', 06:39:26 INFO - 'SHELL': '/bin/bash', 06:39:26 INFO - 'SHLVL': '1', 06:39:26 INFO - 'TERM': 'linux', 06:39:26 INFO - 'TMOUT': '86400', 06:39:26 INFO - 'USER': 'cltbld', 06:39:26 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1475069941.289089-1163264539', 06:39:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:39:26 INFO - '_': '/tools/buildbot/bin/python'} 06:39:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:39:26 INFO - Downloading/unpacking jsonschema==2.5.1 06:39:26 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 06:39:26 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 06:39:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:39:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:39:26 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 06:39:26 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 06:39:28 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:39:28 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:39:28 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 06:39:28 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 06:39:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:39:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:39:28 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 06:39:28 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 06:39:28 INFO - Downloading functools32-3.2.3-2.tar.gz 06:39:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:39:28 INFO - warning: no files found matching '*.txt' 06:39:28 INFO - no previously-included directories found matching 'build' 06:39:28 INFO - no previously-included directories found matching 'dist' 06:39:28 INFO - no previously-included directories found matching '.git*' 06:39:28 INFO - Installing collected packages: jsonschema, functools32 06:39:28 INFO - Running setup.py install for functools32 06:39:28 INFO - warning: no files found matching '*.txt' 06:39:28 INFO - no previously-included directories found matching 'build' 06:39:28 INFO - no previously-included directories found matching 'dist' 06:39:28 INFO - no previously-included directories found matching '.git*' 06:39:28 INFO - Successfully installed jsonschema functools32 06:39:28 INFO - Cleaning up... 06:39:29 INFO - Return code: 0 06:39:29 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 06:39:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 06:39:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:39:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:39:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 06:39:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:39:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:39:29 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x7f9e265eff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21f57b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2284790>, '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 0x2285690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2285b20>, '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': '6d15e502d8e29d5d2676d664000001c3-1475069941.289089-1163264539', '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 06:39:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 06:39:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 06:39:29 INFO - Using env: {'DISPLAY': ':0', 06:39:29 INFO - 'HOME': '/home/cltbld', 06:39:29 INFO - 'LANG': 'en_US.UTF-8', 06:39:29 INFO - 'LANGUAGE': 'en_US:en', 06:39:29 INFO - 'LOGNAME': 'cltbld', 06:39:29 INFO - 'MAIL': '/var/mail/cltbld', 06:39:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:39:29 INFO - 'MOZ_NO_REMOTE': '1', 06:39:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:39:29 INFO - 'NO_EM_RESTART': '1', 06:39:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:39:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:39:29 INFO - 'PWD': '/builds/slave/test', 06:39:29 INFO - 'SHELL': '/bin/bash', 06:39:29 INFO - 'SHLVL': '1', 06:39:29 INFO - 'TERM': 'linux', 06:39:29 INFO - 'TMOUT': '86400', 06:39:29 INFO - 'USER': 'cltbld', 06:39:29 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1475069941.289089-1163264539', 06:39:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:39:29 INFO - '_': '/tools/buildbot/bin/python'} 06:39:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:39:29 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 06:39:29 INFO - Cleaning up... 06:39:29 INFO - Return code: 0 06:39:29 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:39:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 06:39:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:39:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:39:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 06:39:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:39:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:39:29 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x7f9e265eff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21f57b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2284790>, '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 0x2285690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2285b20>, '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': '6d15e502d8e29d5d2676d664000001c3-1475069941.289089-1163264539', '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 06:39:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 06:39:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 06:39:29 INFO - Using env: {'DISPLAY': ':0', 06:39:29 INFO - 'HOME': '/home/cltbld', 06:39:29 INFO - 'LANG': 'en_US.UTF-8', 06:39:29 INFO - 'LANGUAGE': 'en_US:en', 06:39:29 INFO - 'LOGNAME': 'cltbld', 06:39:29 INFO - 'MAIL': '/var/mail/cltbld', 06:39:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:39:29 INFO - 'MOZ_NO_REMOTE': '1', 06:39:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:39:29 INFO - 'NO_EM_RESTART': '1', 06:39:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:39:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:39:29 INFO - 'PWD': '/builds/slave/test', 06:39:29 INFO - 'SHELL': '/bin/bash', 06:39:29 INFO - 'SHLVL': '1', 06:39:29 INFO - 'TERM': 'linux', 06:39:29 INFO - 'TMOUT': '86400', 06:39:29 INFO - 'USER': 'cltbld', 06:39:29 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1475069941.289089-1163264539', 06:39:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:39:29 INFO - '_': '/tools/buildbot/bin/python'} 06:39:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:39:29 INFO - Downloading/unpacking blobuploader==1.2.4 06:39:29 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 06:39:29 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 06:39:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:39:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:39:29 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 06:39:29 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 06:39:31 INFO - Downloading blobuploader-1.2.4.tar.gz 06:39:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:39:31 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:39:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:39:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:39:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:39:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:39:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:39:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:39:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:39:31 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:39:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:39:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:39:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:39:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:39:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:39:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:39:32 INFO - Downloading docopt-0.6.1.tar.gz 06:39:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:39:32 INFO - Installing collected packages: blobuploader, requests, docopt 06:39:32 INFO - Running setup.py install for blobuploader 06:39:32 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:39:32 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:39:32 INFO - Running setup.py install for requests 06:39:32 INFO - Running setup.py install for docopt 06:39:32 INFO - Successfully installed blobuploader requests docopt 06:39:32 INFO - Cleaning up... 06:39:32 INFO - Return code: 0 06:39:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:39:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 06:39:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:39:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:39:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 06:39:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:39:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:39:32 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x7f9e265eff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21f57b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2284790>, '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 0x2285690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2285b20>, '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': '6d15e502d8e29d5d2676d664000001c3-1475069941.289089-1163264539', '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 06:39:32 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 06:39:32 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.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:39:32 INFO - Using env: {'DISPLAY': ':0', 06:39:32 INFO - 'HOME': '/home/cltbld', 06:39:32 INFO - 'LANG': 'en_US.UTF-8', 06:39:32 INFO - 'LANGUAGE': 'en_US:en', 06:39:32 INFO - 'LOGNAME': 'cltbld', 06:39:32 INFO - 'MAIL': '/var/mail/cltbld', 06:39:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:39:32 INFO - 'MOZ_NO_REMOTE': '1', 06:39:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:39:32 INFO - 'NO_EM_RESTART': '1', 06:39:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:39:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:39:32 INFO - 'PWD': '/builds/slave/test', 06:39:32 INFO - 'SHELL': '/bin/bash', 06:39:32 INFO - 'SHLVL': '1', 06:39:32 INFO - 'TERM': 'linux', 06:39:32 INFO - 'TMOUT': '86400', 06:39:32 INFO - 'USER': 'cltbld', 06:39:32 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1475069941.289089-1163264539', 06:39:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:39:32 INFO - '_': '/tools/buildbot/bin/python'} 06:39:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:39:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:39:32 INFO - Running setup.py (path:/tmp/pip-f6X0G8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:39:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:39:32 INFO - Running setup.py (path:/tmp/pip-BXeryo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:39:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:39:33 INFO - Running setup.py (path:/tmp/pip-_40Xes-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:39:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:39:33 INFO - Running setup.py (path:/tmp/pip-QKiU12-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:39:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:39:33 INFO - Running setup.py (path:/tmp/pip-ToKIhM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:39:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:39:33 INFO - Running setup.py (path:/tmp/pip-zFXSHL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:39:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:39:33 INFO - Running setup.py (path:/tmp/pip-23JAhK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:39:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:39:33 INFO - Running setup.py (path:/tmp/pip-FIZMdK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:39:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:39:33 INFO - Running setup.py (path:/tmp/pip-25of5Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:39:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:39:33 INFO - Running setup.py (path:/tmp/pip-hAEIt9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:39:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:39:33 INFO - Running setup.py (path:/tmp/pip-Io3qc5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:39:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:39:33 INFO - Running setup.py (path:/tmp/pip-HPI21t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:39:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:39:33 INFO - Running setup.py (path:/tmp/pip-oK3Bh8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:39:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:39:33 INFO - Running setup.py (path:/tmp/pip-lCV6XU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:39:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:39:33 INFO - Running setup.py (path:/tmp/pip-8rIV9N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:39:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:39:34 INFO - Running setup.py (path:/tmp/pip-1V6NqJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:39:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:39:34 INFO - Running setup.py (path:/tmp/pip-ePpely-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:39:34 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:39:34 INFO - Running setup.py install for manifestparser 06:39:34 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:39:34 INFO - Running setup.py install for mozcrash 06:39:34 INFO - Running setup.py install for mozdebug 06:39:34 INFO - Running setup.py install for mozdevice 06:39:34 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:39:34 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:39:34 INFO - Running setup.py install for mozfile 06:39:34 INFO - Running setup.py install for mozhttpd 06:39:34 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:39:34 INFO - Running setup.py install for mozinfo 06:39:34 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:39:34 INFO - Running setup.py install for mozInstall 06:39:34 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:39:34 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:39:34 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:39:34 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:39:34 INFO - Running setup.py install for mozleak 06:39:35 INFO - Running setup.py install for mozlog 06:39:35 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:39:35 INFO - Running setup.py install for moznetwork 06:39:35 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:39:35 INFO - Running setup.py install for mozprocess 06:39:35 INFO - Running setup.py install for mozprofile 06:39:35 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:39:35 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:39:35 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:39:35 INFO - Running setup.py install for mozrunner 06:39:35 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:39:35 INFO - Running setup.py install for mozscreenshot 06:39:35 INFO - Running setup.py install for moztest 06:39:35 INFO - Running setup.py install for mozversion 06:39:35 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:39:35 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:39:35 INFO - Cleaning up... 06:39:35 INFO - Return code: 0 06:39:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:39:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 06:39:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:39:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:39:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 06:39:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:39:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:39:35 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x7f9e265eff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21f57b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2284790>, '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 0x2285690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2285b20>, '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': '6d15e502d8e29d5d2676d664000001c3-1475069941.289089-1163264539', '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 06:39:35 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 06:39:35 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.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:39:35 INFO - Using env: {'DISPLAY': ':0', 06:39:35 INFO - 'HOME': '/home/cltbld', 06:39:35 INFO - 'LANG': 'en_US.UTF-8', 06:39:35 INFO - 'LANGUAGE': 'en_US:en', 06:39:35 INFO - 'LOGNAME': 'cltbld', 06:39:35 INFO - 'MAIL': '/var/mail/cltbld', 06:39:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:39:35 INFO - 'MOZ_NO_REMOTE': '1', 06:39:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:39:35 INFO - 'NO_EM_RESTART': '1', 06:39:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:39:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:39:35 INFO - 'PWD': '/builds/slave/test', 06:39:35 INFO - 'SHELL': '/bin/bash', 06:39:35 INFO - 'SHLVL': '1', 06:39:35 INFO - 'TERM': 'linux', 06:39:35 INFO - 'TMOUT': '86400', 06:39:35 INFO - 'USER': 'cltbld', 06:39:35 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1475069941.289089-1163264539', 06:39:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:39:35 INFO - '_': '/tools/buildbot/bin/python'} 06:39:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:39:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:39:36 INFO - Running setup.py (path:/tmp/pip-AcApGh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:39:36 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)) 06:39:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:39:36 INFO - Running setup.py (path:/tmp/pip-LIC0oe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:39:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 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)) 06:39:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:39:36 INFO - Running setup.py (path:/tmp/pip-X6QSBq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:39:36 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)) 06:39:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:39:36 INFO - Running setup.py (path:/tmp/pip-YUYgkH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:39:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 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)) 06:39:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:39:36 INFO - Running setup.py (path:/tmp/pip-f4tGmm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:39:36 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)) 06:39:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:39:36 INFO - Running setup.py (path:/tmp/pip-rXYbXX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:39:36 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)) 06:39:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:39:36 INFO - Running setup.py (path:/tmp/pip-sCKEN9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:39:36 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)) 06:39:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:39:36 INFO - Running setup.py (path:/tmp/pip-YyoLk5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:39:36 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)) 06:39:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:39:36 INFO - Running setup.py (path:/tmp/pip-NQRoeo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:39:36 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)) 06:39:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:39:36 INFO - Running setup.py (path:/tmp/pip-Yx_N73-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:39:36 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)) 06:39:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:39:36 INFO - Running setup.py (path:/tmp/pip-RDVFUM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:39:36 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)) 06:39:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:39:36 INFO - Running setup.py (path:/tmp/pip-4WEkis-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:39:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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)) 06:39:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:39:37 INFO - Running setup.py (path:/tmp/pip-tkkHfC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:39:37 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)) 06:39:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:39:37 INFO - Running setup.py (path:/tmp/pip-jCm3ZI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:39:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 06:39:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:39:37 INFO - Running setup.py (path:/tmp/pip-iYv5XO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:39:37 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)) 06:39:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:39:37 INFO - Running setup.py (path:/tmp/pip-9tu_uk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:39:37 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 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)) 06:39:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:39:37 INFO - Running setup.py (path:/tmp/pip-4tRQ7X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:39:37 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)) 06:39:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:39:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:39:37 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)) 06:39:37 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:39:37 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:39:37 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:39:37 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 06:39:37 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 06:39:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:39:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:39:37 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 06:39:37 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 06:39:39 INFO - Downloading blessings-1.6.tar.gz 06:39:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:39:39 INFO - Installing collected packages: blessings 06:39:39 INFO - Running setup.py install for blessings 06:39:39 INFO - Successfully installed blessings 06:39:39 INFO - Cleaning up... 06:39:39 INFO - Return code: 0 06:39:39 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:39:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:39:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:39:39 INFO - Reading from file tmpfile_stdout 06:39:39 INFO - Current package versions: 06:39:39 INFO - argparse == 1.2.1 06:39:39 INFO - blessings == 1.6 06:39:39 INFO - blobuploader == 1.2.4 06:39:39 INFO - docopt == 0.6.1 06:39:39 INFO - functools32 == 3.2.3-2 06:39:39 INFO - jsonschema == 2.5.1 06:39:39 INFO - manifestparser == 1.1 06:39:39 INFO - mozInstall == 1.12 06:39:39 INFO - mozcrash == 0.17 06:39:39 INFO - mozdebug == 0.1 06:39:39 INFO - mozdevice == 0.48 06:39:39 INFO - mozfile == 1.2 06:39:39 INFO - mozhttpd == 0.7 06:39:39 INFO - mozinfo == 0.9 06:39:39 INFO - mozleak == 0.1 06:39:39 INFO - mozlog == 3.4 06:39:39 INFO - moznetwork == 0.27 06:39:39 INFO - mozprocess == 0.23 06:39:39 INFO - mozprofile == 0.28 06:39:39 INFO - mozrunner == 6.12 06:39:39 INFO - mozscreenshot == 0.1 06:39:39 INFO - mozsystemmonitor == 0.3 06:39:39 INFO - moztest == 0.7 06:39:39 INFO - mozversion == 1.4 06:39:39 INFO - psutil == 3.1.1 06:39:39 INFO - requests == 1.2.3 06:39:39 INFO - wsgiref == 0.1.2 06:39:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:39:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 06:39:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:39:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:39:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 06:39:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:39:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:39:39 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x7f9e265eff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21f57b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2284790>, '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 0x2285690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2285b20>, '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': '6d15e502d8e29d5d2676d664000001c3-1475069941.289089-1163264539', '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 06:39:39 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 06:39:39 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.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:39:39 INFO - Using env: {'DISPLAY': ':0', 06:39:39 INFO - 'HOME': '/home/cltbld', 06:39:39 INFO - 'LANG': 'en_US.UTF-8', 06:39:39 INFO - 'LANGUAGE': 'en_US:en', 06:39:39 INFO - 'LOGNAME': 'cltbld', 06:39:39 INFO - 'MAIL': '/var/mail/cltbld', 06:39:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:39:39 INFO - 'MOZ_NO_REMOTE': '1', 06:39:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:39:39 INFO - 'NO_EM_RESTART': '1', 06:39:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:39:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:39:39 INFO - 'PWD': '/builds/slave/test', 06:39:39 INFO - 'SHELL': '/bin/bash', 06:39:39 INFO - 'SHLVL': '1', 06:39:39 INFO - 'TERM': 'linux', 06:39:39 INFO - 'TMOUT': '86400', 06:39:39 INFO - 'USER': 'cltbld', 06:39:39 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1475069941.289089-1163264539', 06:39:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:39:39 INFO - '_': '/tools/buildbot/bin/python'} 06:39:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:39:39 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)) 06:39:39 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)) 06:39:39 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)) 06:39:39 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)) 06:39:39 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)) 06:39:39 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)) 06:39:39 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)) 06:39:39 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)) 06:39:39 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)) 06:39:39 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)) 06:39:39 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)) 06:39:39 INFO - Cleaning up... 06:39:39 INFO - Return code: 0 06:39:39 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:39:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 06:39:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:39:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:39:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 06:39:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:39:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:39: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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x7f9e265eff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21f57b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2284790>, '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 0x2285690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2285b20>, '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': '6d15e502d8e29d5d2676d664000001c3-1475069941.289089-1163264539', '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 06:39:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 06:39:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 06:39:39 INFO - Using env: {'DISPLAY': ':0', 06:39:39 INFO - 'HOME': '/home/cltbld', 06:39:39 INFO - 'LANG': 'en_US.UTF-8', 06:39:39 INFO - 'LANGUAGE': 'en_US:en', 06:39:39 INFO - 'LOGNAME': 'cltbld', 06:39:39 INFO - 'MAIL': '/var/mail/cltbld', 06:39:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:39:39 INFO - 'MOZ_NO_REMOTE': '1', 06:39:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:39:39 INFO - 'NO_EM_RESTART': '1', 06:39:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:39:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:39:39 INFO - 'PWD': '/builds/slave/test', 06:39:39 INFO - 'SHELL': '/bin/bash', 06:39:39 INFO - 'SHLVL': '1', 06:39:39 INFO - 'TERM': 'linux', 06:39:39 INFO - 'TMOUT': '86400', 06:39:39 INFO - 'USER': 'cltbld', 06:39:39 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1475069941.289089-1163264539', 06:39:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:39:39 INFO - '_': '/tools/buildbot/bin/python'} 06:39:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:39:40 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:39:40 INFO - Cleaning up... 06:39:40 INFO - Return code: 0 06:39:40 INFO - Running post-action listener: _resource_record_post_action 06:39:40 INFO - Running post-action listener: _start_resource_monitoring 06:39:40 INFO - Starting resource monitoring. 06:39:40 INFO - [mozharness: 2016-09-28 13:39:40.226246Z] Finished create-virtualenv step (success) 06:39:40 INFO - [mozharness: 2016-09-28 13:39:40.226708Z] Running install step. 06:39:40 INFO - Running pre-action listener: _resource_record_pre_action 06:39:40 INFO - Running main action method: install 06:39:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:39:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:39:40 INFO - Reading from file tmpfile_stdout 06:39:40 INFO - Detecting whether we're running mozinstall >=1.0... 06:39:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:39:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:39:40 INFO - Reading from file tmpfile_stdout 06:39:40 INFO - Output received: 06:39:40 INFO - Usage: mozinstall [options] installer 06:39:40 INFO - Options: 06:39:40 INFO - -h, --help show this help message and exit 06:39:40 INFO - -d DEST, --destination=DEST 06:39:40 INFO - Directory to install application into. [default: 06:39:40 INFO - "/builds/slave/test"] 06:39:40 INFO - --app=APP Application being installed. [default: firefox] 06:39:40 INFO - mkdir: /builds/slave/test/build/application 06:39:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 06:39:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 06:39:57 INFO - Reading from file tmpfile_stdout 06:39:57 INFO - Output received: 06:39:57 INFO - /builds/slave/test/build/application/firefox/firefox 06:39:57 INFO - Running post-action listener: _resource_record_post_action 06:39:57 INFO - [mozharness: 2016-09-28 13:39:57.534116Z] Finished install step (success) 06:39:57 INFO - [mozharness: 2016-09-28 13:39:57.534361Z] Running run-tests step. 06:39:57 INFO - Running pre-action listener: _resource_record_pre_action 06:39:57 INFO - Running main action method: run_tests 06:39:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:39:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:39:57 INFO - Python 2.7.3 06:39:57 INFO - Return code: 0 06:39:57 INFO - grabbing minidump binary from tooltool 06:39:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 06:39:57 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 0x2284790>, '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 0x2285690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2285b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:39:57 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 06:39:57 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 06:39:57 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 06:39:57 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:39:57 INFO - Return code: 0 06:39:57 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:39:57 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:39:57 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:39:57 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:39:57 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:39:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HTMCLMiNTnyJjm51FduZ0A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--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 06:39:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/HTMCLMiNTnyJjm51FduZ0A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-023 --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 06:39:57 INFO - Using env: {'DISPLAY': ':0', 06:39:57 INFO - 'HOME': '/home/cltbld', 06:39:57 INFO - 'LANG': 'en_US.UTF-8', 06:39:57 INFO - 'LANGUAGE': 'en_US:en', 06:39:57 INFO - 'LOGNAME': 'cltbld', 06:39:57 INFO - 'MAIL': '/var/mail/cltbld', 06:39:57 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:39:57 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:39:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:39:57 INFO - 'MOZ_NO_REMOTE': '1', 06:39:57 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:39:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:39:57 INFO - 'NO_EM_RESTART': '1', 06:39:57 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:39:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:39:57 INFO - 'PWD': '/builds/slave/test', 06:39:57 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:39:57 INFO - 'SHELL': '/bin/bash', 06:39:57 INFO - 'SHLVL': '1', 06:39:57 INFO - 'TERM': 'linux', 06:39:57 INFO - 'TMOUT': '86400', 06:39:57 INFO - 'USER': 'cltbld', 06:39:57 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1475069941.289089-1163264539', 06:39:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:39:57 INFO - '_': '/tools/buildbot/bin/python'} 06:39:57 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HTMCLMiNTnyJjm51FduZ0A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--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 06:39:57 INFO - mozversion application_buildid: 20160928033005 06:39:57 INFO - mozversion application_changeset: 45513d6773f099db66f0cd7bf1e312f6f9d11475 06:39:57 INFO - mozversion application_display_name: Nightly 06:39:57 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:39:57 INFO - mozversion application_name: Firefox 06:39:57 INFO - mozversion application_remotingname: firefox 06:39:57 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 06:39:57 INFO - mozversion application_vendor: Mozilla 06:39:57 INFO - mozversion application_version: 52.0a1 06:39:57 INFO - mozversion platform_buildid: 20160928033005 06:39:57 INFO - mozversion platform_changeset: 45513d6773f099db66f0cd7bf1e312f6f9d11475 06:39:57 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 06:39:57 INFO - mozversion platform_version: 52.0a1 06:39:57 INFO - using testdate: 1475069997 06:39:57 INFO - actual date: 1475069997 06:39:57 INFO - starting webserver on 'localhost:46420' 06:39:57 INFO - SUITE-START | Running 2 tests 06:39:57 INFO - TEST-START | dromaeo_css 06:39:57 INFO - operating with platform_type : linux_ 06:39:57 INFO - Initialising browser for dromaeo_css test... 06:39:57 INFO - TEST-INFO | started process 13048 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9pj6oB/profile http://localhost:46420/getInfo.html) 06:40:02 INFO - PROCESS | 13048 | __metrics Screen width/height:1600/1200 06:40:02 INFO - PROCESS | 13048 | colorDepth:24 06:40:02 INFO - PROCESS | 13048 | Browser inner width/height: 1024/697 06:40:02 INFO - PROCESS | 13048 | __metrics 06:40:02 ERROR - PROCESS | 13048 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3067: TypeError: this.tabs is undefined 06:40:03 INFO - TEST-INFO | 13048: exit 0 06:40:03 INFO - Browser initialized. 06:40:03 INFO - Running cycle 1/1 for dromaeo_css test... 06:40:03 INFO - TEST-INFO | started process 13173 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9pj6oB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:40:15 INFO - PROCESS | 13173 | RSS: Main: 184971264 06:40:15 INFO - PROCESS | 13173 | 06:41:05 INFO - PROCESS | 13173 | 1475070065313 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 06:43:15 INFO - PROCESS | 13173 | Cycle 1(1): loaded http://localhost:46420/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46420/tests/dromaeo/cssquery-ext.html) 06:43:16 INFO - PROCESS | 13173 | RSS: Main: 199905280 06:43:16 INFO - PROCESS | 13173 | 06:46:18 INFO - PROCESS | 13173 | Cycle 1(1): loaded http://localhost:46420/tests/dromaeo/cssquery-ext.html (next: http://localhost:46420/tests/dromaeo/cssquery-jquery.html) 06:46:19 INFO - PROCESS | 13173 | RSS: Main: 196046848 06:46:19 INFO - PROCESS | 13173 | 06:49:21 INFO - PROCESS | 13173 | Cycle 1(1): loaded http://localhost:46420/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46420/tests/dromaeo/cssquery-mootools.html) 06:49:21 INFO - PROCESS | 13173 | RSS: Main: 198287360 06:49:21 INFO - PROCESS | 13173 | 06:52:23 INFO - PROCESS | 13173 | Cycle 1(1): loaded http://localhost:46420/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46420/tests/dromaeo/cssquery-prototype.html) 06:52:24 INFO - PROCESS | 13173 | RSS: Main: 194813952 06:52:24 INFO - PROCESS | 13173 | 06:55:26 INFO - PROCESS | 13173 | Cycle 1(1): loaded http://localhost:46420/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46420/tests/dromaeo/cssquery-yui.html) 06:55:27 INFO - PROCESS | 13173 | RSS: Main: 198107136 06:55:27 INFO - PROCESS | 13173 | 06:58:30 INFO - PROCESS | 13173 | Cycle 1(1): loaded http://localhost:46420/tests/dromaeo/cssquery-yui.html (next: http://localhost:46420/tests/dromaeo/cssquery-dojo.html) 06:58:30 INFO - PROCESS | 13173 | RSS: Main: 198987776 06:58:30 INFO - PROCESS | 13173 | 06:58:30 INFO - PROCESS | 13173 | __start_tp_report 06:58:30 INFO - PROCESS | 13173 | _x_x_mozilla_page_load 06:58:30 INFO - PROCESS | 13173 | _x_x_mozilla_page_load_details 06:58:30 INFO - PROCESS | 13173 | |i|pagename|runs| 06:58:30 INFO - PROCESS | 13173 | |0;dojo.html;3144.38684456531;3144.7326977206935;3146.4808306629407;3179.2528755742387;3194.2014496375905;5429.619926605139;5529.728162522617;5570.749316280767;5602.523785478229;5609.074502707053;5389.865253368658;5467.562594992401;5546.972265138668;5593.797333573281;5603.775848966046;4899.681520701143;4931.975340123303;4980.452150263468;5040.823571175009;5124.0776660201145;5036.949630503703;5121.2318152277085;5122;5131.1277082895995;5145.382554093495;4912.238603016538;4941.530554597308;5008.9499105008845;5018.673786203904;5146.6140039497;4912.435069966964;4941.332920055783;4967.875803104916;4993.575546078588;5059.114654935372;4935.161022626126;4942.629302802305;4961.875953101201;4964.205727083686;4994.775235114428;5374.677519348852;5390.757415916254;5420.864478388033;5456.372517160537;5459.344878614552;5896.7936122235515;5912.4974377178;5927.110933359987;5963.522918166536;6076.665783381913;5996.400359964013;5996.8500787480225;5998.1602575639445;6006.639601623917;6050.54620903434;5593.636413633141;5600.523955463831;5613.607047506717;5622.32532096151;5624.915626265651;5907.645541267538;5968.85077873048;5977.641341519523;5991.5206783457215;6007.48936340416;5808.128780682931;5811.593188476851;5827.621204621686;5831.679257640785;5874.676892770854;5738.282714660668;5831.0378787499585;5923.200367950358;5985.730642121028;6019.729112189962;5783.826485205451;5810.535157187415;5848.912266316009;5852.795152169653;5856.824295271149;5808.30300363959;5821.27234095738;5853.239078919798;5878.265216847894;5884.440978107073;4463.308187230984;4514.932276015862;4534.841280555164;4546.727196368229;4590.242609969385;4040.4949381327333;4042.2521833460905;4083.3262511685834;4094.406311084876;4160.126373461547;5653.660780353192;5681.630694004876;5689.203511508392;5700.9429905701245;5780.768769249183;5779.393163717833;6033.245844269466;6040.486558642477;6049.727762250709;6056.364081771439;5508.91736623951;5511.476409741148;5515.972420137874;5569.387367389584;5652.604317697722;4804.399450068741;4823.710577365299;4829.082474329866;4829.251466022702;4884.12085824555;6008.819735407945;6026.21659184312;6069;6087.54343424245;6095.420935011167;5788.247527821356;5881.206037185097;5887.470127688529;5911.379305172895;5967.880642387215;6131.509479241739;6167.136600875791;6171.444569988543;6174.197354343906;6174.8147555573405;5868.765249389977;5873.794417195549;5877.647341159544;5885.646861188342;5928.407159284037;5796;5938.584299099021;5958.582899197015;5976.521878249642;5981.401859813984;5705.971470142788;5731.8567035824435;5774.740136693775;5813.6221145625395;5878.882422351615;5781.5663825214115;5784.537237020944;5787.623804452697;5790.10253410722;5797.4782269595935;5589.972050139723;5638.407967163389;5639.436056394327;5656.830295091154;5690.658560486384;5811.4479124483105;5817.94182058174;5826.359100498857;5827.708614569339;5845.444682755132;5639.915401268902;5649.4350564944825;5650.660960342392;5652;5657.717114144359 06:58:30 INFO - PROCESS | 13173 | |1;ext.html;548.6391550574685;586.510263929619;587.7149582452511;590.7135039505841;602.184040624953;40880.79559602201;42577.36133957993;42714.78642606786;46689;46940.76529617356;44190;44795;44889.7755511222;44899.32651010237;45117.323240151425;8971.596278167499;9132.497712625804;9149.862752058725;9151.542422878863;9158.313126515504;8955.462672239653;8988.370814043019;9012.143846334588;9017.639294428214;9018.36871419001;9010.279177665803;9015;9015.188633023026;9024.729258122266;9071.546422678839;8967.730968070968;9001.189892909604;9009.504477253748;9040.321975851837;9047.864282035742;8937.50843703596;8939.106089391074;9002.324825638038;9006.729798106067;9028.142326478974;42964;43088.56911430877;43398.349024764655;43478.34782478266;43482;3312.1700458592904;3460.0311912664492;3518.1556426457723;3592.515010473579;3626.528551288342;31586.526202106757;31811.363772724646;32224.35551288961;32242.516362254584;32245.838770805996;4297.162053399588;4335.414719012924;4366.08312254427;4560.863174104782;4575.702579332333;347231.26384368166;348162;348234;348769;350247;50872;55056.17415738767;55190.17214741782;55270;55312.44687553153;58302.7084864573;58487.415125849046;58514;58611.413885861446;58678.706606467545;14655.193964332064;14807.407703691948;14852.925735371255;14861.331240094221;14922.70154596902;11361.829572556418;11388.3167009978;11474.655760327036;11484.483198256099;11496.655100347003;14266.785998210034;15057.247137643075;15322.310496027705;15585.376584936475;15610.68778624421;5741.282339707536;5947.762089516371;5954.910676339859;6004.789832355847;6063.090536419572;880.9911900880909;1032.963846265377;1100.1638754546602;1100.8238681810872;1110.0287248657426;30161.698383016326;31321;31587.21031974219;31847.681523184936;32035.839820800746;996.7856910764076;1038.1383451735041;1066.7973085113958;1087.7770057138268;1097.5280629329466;16021.359145634277;16876.15619219034;16902.32390704358;16997.660046798996;17085.402010929807;495318;497777;498322;498362;499841;58049.70975145182;58341;58375.416245837;58447.41552584505;58462.415375845696;1246.2211118051218;1285.5886116442648;1290.7483040806953;1307.5685023942076;1330.1752913193882;29478.852605736833;31201.8439907799;32064.198395039377;32159.196020099684;32193.678063220006;50436.49563504318;50596.24105638345;50816.491835082656;50834;50902.490975091256;431415;431613;432085;432929.85955912765;435827;39361.80319098501;39418.802905985285;39470.7509802748;39966.80016599898;40125.398119028825;46275.305870412645;46420.30369544392;47901;48341.758291208316;50489;39171.41242881302;40182.79908600439;41222;41317.58682413137;42073.579264208194;39946.40080398738;40590.79704601458;40678.38982415325;41866.790666047695;42292.36561451519;35095.649043509235;35137;38793.61206388013;39217.411738824514;39502;30288.84855575708;36295.455568167024;36655.26689466142;37067;37422.8128859354;28096.85951570229;28408.57387139236;28662.426751464438;28813.423731525672;28867 06:58:30 INFO - PROCESS | 13173 | |2;jquery.html;389.20796179774163;399.9880003599893;403.10309561226273;410.27176761248785;421.0400287344853;17408.390706325266;19074.713879291823;19328.806711932877;19368.903155484222;19971.400857974248;18211.45365639033;18790.342338018174;18906.43280701578;19347;19576.412707618794;5214.713190774506;5336.67979921204;5602.411746766592;5850.3564607893095;5899.203607512995;5809.854753631151;5867.11993201019;5871.500922421599;5873.530117590582;5893.616914900539;5848.035074212749;6429.421352078312;6445.548811583191;6464.612123272595;6470;5808.651480911117;5992.580519363646;6509.544331896769;6544.509161812859;6574.309697481767;5611.971940140314;5643.435656434365;5646.887062258732;5652.09566469367;5665.631733937322;12849.421776020008;13296.933515332457;13362.665933351647;13717.794233086512;13792.862071379259;2228.275810361623;2293.4839661076126;2326.348622385735;2522;2543.186180422266;5522.420145884705;5620.9437905620825;9438.725772020758;9523.285753568442;10527.420991845445;1833.6607727570308;1906.6663333916508;1960.4804726747423;2007.518195633052;2012.9597408051757;70617;77893.99999999943;79844.60077699632;82212;82569.9999999994;10617.416042117758;10953.17851161166;11016.834747478793;11099.389533575732;11389.487473063731;15708;15733.606659833596;15743.921280393753;15751.842481575266;15825.52523424299;7483.13943896448;7620;7802.843943121105;7816.8827467588035;7872.173421790744;6969.895451568231;7138.250483699137;7195.640217989079;7392.260773922565;7416.629168541552;4690.671652984258;4708.340832283483;4715.95284047162;4811.831585894477;4888.462269150391;1896.1088288504382;1902.4863286912732;1933.3716542123584;1940.9227878527554;1961.2155137944935;909.9363044586815;975.7170420578095;1005.6982905128432;1022.0188618925914;1028.747956750601;17892.910535447238;18015.549611259823;18730.438086857142;19182;19258.71111933322;917.2249449215402;936.1757221749095;966.8694726212012;977.2035790830593;1001.9248556358302;10215.23385746072;10628.309159904582;10695.144388448905;10785.568577256821;10809.243352965374;332599;334654;337402;437832;440764;56396.71801641048;58387.416125839045;69493.65253173701;74710.62644686742;95289;1005.8340373838234;1011.858339832424;1047.607147319755;1062.081299675775;1065.984010239847;16827;17175.398861039805;17502;18115.547111321794;18387.72418413698;41650.58349416467;41672.79163604163;41954;43165.7841710802;43465.3480197791;57391.7130414362;58894;59827;60128.39871601403;60507;7842.568658723597;8118.431709780495;8119.75640730779;8293.95853020731;8390.202930721573;12488.96077478009;13188.790427781165;13339.799903001269;13477.730445391233;13589.388477518733;11533;11693.12301577368;11810.291382517076;11871;11979.281243125091;11105.389203593557;11219.158563107963;11336.206465547333;11461.770764584828;11745;11663.358515281741;11782.882171178178;11838.28500974425;11862.644120676394;12247.326397048248;8002.756471716212;8205.958970205349;8237.670493180205;8436.32509399259;8756.124387561193;8441.451305665112;10591.841122383017;10713.839292410776;11488.597899073493;11492.597759078391 06:58:30 INFO - PROCESS | 13173 | |3;mootools.html;1183.1717797541721;1225.8345123408337;1345.6501309659488;1721.2598582609473;1743.4072415378769;8050.557219352948;8265.049519305281;8646.437981531197;9356.812863742722;9365.953170234148;8740.606672699729;8941.552922353889;8984.595693193805;9215.539223038855;9250.953745231282;2372.608519594265;2403.2549909528016;2408.1812183857487;2409.325388891113;2410.301012706313;2370.95258094838;2374.2995816234165;2396.7962723168466;2410.8915098820594;2411.8191135664806;2381.2380038387723;2387.4986252886915;2407.927762167129;2412.9155479558217;2413.9034438622434;2301;2304.6082166031815;2312.629979203328;2312.826538009656;2374.0741110966565;2320.4314942839114;2323.047550504285;2334.661474086265;2339.976600233993;2356.081128359941;9192.586333615003;9263.583138758704;9282.535873206312;9287.860682089775;9337.813243735087;5232.424433312332;5307.2569840222395;5357.035733567956;5374.7043912584795;5383.730813459311;3466.7053300469493;3537.2748586539697;3562.750607457479;3571.928561428783;3666.358387282215;1178.8880056394628;1181.9008322260295;1193.7015746063485;1198.4127777389017;1198.8081906894854;12674.683132921658;12701.047421443429;12706.682332941658;12743.426545805462;12824.615261542262;4721.740304283228;4743.892520113276;4793;4850.442199147144;4886.364772579613;10677.359358438518;10697.358158510358;10704.625338113285;10717.785644287227;10721.946390267998;5522.3649280333275;5545.223668686387;5555.111182210908;5558.44415558441;5561.638493497991;4348.717333373321;4481.170983368087;4893.657443978887;4973.104841128632;5049.116404629175;3975.185087057146;4055.4930633670792;4151.647109995623;4157.210130075276;4165.66674666032;1337.3112846883862;1344.9798253026213;1361.7957306404119;1365.4469939674448;1375.2848518770384;916.3310783128354;948.5494390164616;952.9428234305964;960.5869476125193;982.975425614351;5931.40685931412;6016.884420103546;6132.908006379907;6150.50795936324;6167.352427995085;463.52720225369933;470.4401761903324;471.8769328996965;477.9784909679073;480.17170381093035;4011.338129208648;4032.274190645653;4044.595540445932;4064.4309796628495;4065.166640838621;10826;11098.667039988813;11120;11186.216964812385;11229.831552526719;10990.340579565252;11022.889771102185;11047.171462140372;11057.612983545698;11110.222284440173;8232.50604963692;8289.709860154986;8312.792180195544;8332.50004999702;8359.331253499706;5787.36339002701;5823.417658234142;5875.177475153568;5955.880882382241;6009.519238461;9864.112229899056;10078.848817267894;10152.543135559064;10174.440405777754;10272.869984301571;10338.9661033896;10345.534450949575;10347.327423717434;10349.120324772177;10358.430286334324;7207.639618019183;7369.963150184215;7849.529028258323;7920.722774702857;7989.2809647132035;8630.180132887366;9068.818623627358;9069.274458043472;9080.091990800867;9095.363324567217;8002.399820013406;8120.390970677105;8122.39082068859;8196.54918979462;8382.245597896219;7956.283934445928;8044.758657240292;8087;8169.877451838346;8281.875771863306;7237.3486386225495;7269.672864720995;7314.451416143704;7343.2656734328275;7391.0044288043;5288.101022826206;5302.844807339627;5426.972865135649;5465.043617367024;5474.315710536183;4972.676776009548;5236.188390799432;5254;5262.000219958196;5279.313689220377 06:58:30 INFO - PROCESS | 13173 | |4;prototype.html;332.2194966488324;336.3139196040078;340.1224839913024;345.2628637858172;348.733219087398;5483.506484416402;5592.412796656354;5613.354464236614;5684.488396044355;5722.6280291781;5416.241726158341;5500.80747173849;5511.255980442639;5547.611667183299;5589.161625756128;4293.570642935705;4355.063661312817;4378.211921854065;4393.670474714393;4393.692441529094;4285.057287396783;4332.176886391591;4369.344598310263;4406.184855801671;4411.1618792429335;4279.935800962988;4304.569543045702;4315.611594956454;4325.545817689129;4328.870133895988;4298.419713338706;4308.147496576471;4310.568943105695;4329.610335069828;4366.362614019743;3698.556173259199;3783.7162212833873;3818.694504439638;3822.5604055533413;3822.7515211511163;5401.541583772399;5409.810656627039;5427.267318911936;5429.37118864343;5436.592255580807;4952.430470495903;4972.726500042496;4976.626752993504;4980.626453016038;4988.201887697951;5584.246126772874;5798.942010579883;5837.270341207349;5845.457226106657;5862.560307976919;4121.608447197542;4142.357934520124;4142.79286035697;4168.7081904266715;4170.541240463546;6136.527233463981;6156.846078848064;6156.907646385308;6168.537359698041;6182.659953702545;4140.585941405835;4302.311630139163;4326.826926922888;4330.0906809569715;4336.457942757155;4374.321980093027;4410.426644536254;4415.725901160905;4423.336499525032;4428.31361139024;5033.572146367526;5036.546710796046;5048.671836330626;5049.2173713074535;5055.241713742895;5615.775368985195;5875.089361149029;5901.734421951022;5909.852253693692;5934.7922822701;1480.9481668141564;1532.4292600085003;1532.7087853307835;1534;1542.7917231173649;955;970.6360114956891;1005.5720876355592;1015.8882522922472;1016.769708652524;4874.8537543873745;4929.929429639488;4943.3573635427165;4992.575631071327;4996.826380524483;5289.814856480005;5307;5311.7078560678765;5323.30796996388;5327.440618735054;4650.86047418578;4988.800447982113;5010.473900240495;5020.59835213182;5064.936363363661;2742.9142215008114;2744.5745909384077;2750.80340052074;2751.463464624379;2751.793615478847;5332.92000619991;5356.651817631841;5400.972995134999;5405.945940540623;5418.539424148913;5407.702151483616;5445.863853403696;5676.801311954145;6118.510519158456;6166.198394208814;6215.9378406215355;6222.751089956351;6224.595401298901;6228.34602366754;6229.719662615194;5873.442023007808;5892.552856578778;6046.727897244723;6052.425019623129;6071.635701857903;5886.381929897299;5892.970535147297;5904.3210030845285;5910;5910.468057874812;6155.569110162425;6176.054542818998;6197.264765865565;6227.532935029982;6273.498120150468;3994.581923417145;4193.909583508249;4234.534201237923;4281.550437204173;4288.7855607220135;5908.793192238423;6009.248843894513;6038.426349496791;6084.3572235495285;6128.203333566607;5810;5822.16601770441;5830.997036526277;5869.8239052828485;5882.000119959234;5803.738831752666;5838.970805146117;5843.386444423444;5849.883002339844;5909.940900590939;5550.333959924835;5722.799702010409;5724.8282551523525;5728.455796699307;5751.7411716472025;5838.1826544282985;5854.648721076749;5855.59010869235;5901.409859014064;5951.7619295227705;5383.81156659515;5632;5659.057290209151;5661.716914154358;5707 06:58:30 INFO - PROCESS | 13173 | |5;yui.html;727;745.8172747676819;751.56784848712;765.7740966414907;843.0431460292568;15045.699086018287;15680.137592432411;15694.058356498617;15852.365905363786;15925.362985480568;13993.790093148611;14159.929200353983;14187.858121418783;14203.076800008019;14203.644908877282;784.8273379856422;797.2625321577547;801.8997625296838;812.8130529978108;815.604431850552;810.9026916769996;824.3281725393784;824.9051359093721;826.2398593294183;827.9793005174859;855.3499340501232;860.5310105992218;863.8358711844761;870.0081906626451;871.4945331707626;859.5487369131193;864.2653744317312;865.2947847504264;865.6364326982682;866.3242670716851;623.9126522286883;629.8299459146004;631.5231999840091;631.9178506794087;633.3666333666333;16277.430289939795;16455.012699237963;16467.176641167895;16471.67056658872;16490.83509164905;14569.854301457062;14691.338889749986;14790;14845.777313340308;14963.700725985529;11573.189876708633;11686.70783230426;11737.94131029348;11842;12415.379231038502;3702.907427314312;3719.6838268747188;3846.134619710571;3859.286032084073;3977.204559088165;82080;82507.9999999994;83774;84345.15654843434;84521;10308.381497110197;10754.78490430187;11187.105031597453;11211.215214934877;11261.887381126247;17704;17836.3757268495;17880.374186903395;17896.194671239824;18040.368587099652;7992.560409177435;8040.316573091236;8053.395995300376;8121.878171827428;8228.161284356887;4499.212637788374;4618.330342100377;4628.421447319085;4636.420447444069;4720.716756994591;3580.785152890835;3652.2695460907926;3667.2482141161;3693.242885208526;3767.6797472215167;627.8681476889813;638.6742761191825;653.650297091054;654.852658151912;663.6383171171626;630.6373835044867;639.4495776658648;663.1445435388295;663.151166506872;676.8510927595921;9735.853962190573;9815.950920245354;9925.828430620682;9926.156276716416;9936.155426788804;480.89660722944035;490.70312460960605;511.04525191144023;568.071203582138;582.5921854701726;4299.720518166309;4311.892202694958;4340.262155433584;4504.2905074378905;4525.977370113128;94383.52808235915;94522;98298.01701983031;113754;131841;95600.52199739096;97078;97363;98203.50898245606;98874.5056274714;83049;84102;84342.5782871094;87414;90034.54982725045;9677.612895484383;9723.270754693567;9787.657431989846;9828.705138845846;9915.20678345745;49548.75225623849;49554.25668615046;49916.500834992636;50760.74619626878;51638.22542661788;68770;70525.29474705392;72982.63508682423;74832.25167748253;76167.61916190383;12489.93755031219;12892.613221603367;13048.217106973612;13244.867551324363;14054.789178162131;14279.214643194724;14482.637934051732;15008.272978569552;15788.763168552252;16048.919755401148;13914.860851391357;14295.64260893486;14317.212553309668;14483.855161448671;14974.401023958919;13833.723325533634;14168.866490680515;14193;14366.928165359106;14789.926050369679;13696.452141914211;14017.266633006466;14042.508512202025;14219.217943013233;14472.782908256595;11469.254498457574;11807.940960295144;11840.70398240051;11903.82144267854;12073;10295.897041029493;10507;10767.946160269148;11842.644720658394;12011.279323240633 06:58:30 INFO - PROCESS | 13173 | __end_tp_report 06:58:30 INFO - PROCESS | 13173 | __start_cc_report 06:58:30 INFO - PROCESS | 13173 | _x_x_mozilla_cycle_collect,297 06:58:30 INFO - PROCESS | 13173 | __end_cc_report 06:58:30 INFO - PROCESS | 13173 | __startTimestamp1475071110549__endTimestamp 06:58:30 INFO - PROCESS | 13173 | 06:58:30 INFO - PROCESS | 13173 | ------- Summary: start ------- 06:58:30 INFO - PROCESS | 13173 | Number of tests: 6 06:58:30 INFO - PROCESS | 13173 | 06:58:30 INFO - PROCESS | 13173 | [#0] dojo.html Cycles:165 Average:5483.67 Median:5690.66 stddev:634.19 (11.1%) stddev-sans-first:609.00 06:58:30 INFO - PROCESS | 13173 | Values: 3144.4 3144.7 3146.5 3179.3 3194.2 5429.6 5529.7 5570.7 5602.5 5609.1 5389.9 5467.6 5547.0 5593.8 5603.8 4899.7 4932.0 4980.5 5040.8 5124.1 5036.9 5121.2 5122.0 5131.1 5145.4 4912.2 4941.5 5008.9 5018.7 5146.6 4912.4 4941.3 4967.9 4993.6 5059.1 4935.2 4942.6 4961.9 4964.2 4994.8 5374.7 5390.8 5420.9 5456.4 5459.3 5896.8 5912.5 5927.1 5963.5 6076.7 5996.4 5996.9 5998.2 6006.6 6050.5 5593.6 5600.5 5613.6 5622.3 5624.9 5907.6 5968.9 5977.6 5991.5 6007.5 5808.1 5811.6 5827.6 5831.7 5874.7 5738.3 5831.0 5923.2 5985.7 6019.7 5783.8 5810.5 5848.9 5852.8 5856.8 5808.3 5821.3 5853.2 5878.3 5884.4 4463.3 4514.9 4534.8 4546.7 4590.2 4040.5 4042.3 4083.3 4094.4 4160.1 5653.7 5681.6 5689.2 5700.9 5780.8 5779.4 6033.2 6040.5 6049.7 6056.4 5508.9 5511.5 5516.0 5569.4 5652.6 4804.4 4823.7 4829.1 4829.3 4884.1 6008.8 6026.2 6069.0 6087.5 6095.4 5788.2 5881.2 5887.5 5911.4 5967.9 6131.5 6167.1 6171.4 6174.2 6174.8 5868.8 5873.8 5877.6 5885.6 5928.4 5796.0 5938.6 5958.6 5976.5 5981.4 5706.0 5731.9 5774.7 5813.6 5878.9 5781.6 5784.5 5787.6 5790.1 5797.5 5590.0 5638.4 5639.4 5656.8 5690.7 5811.4 5817.9 5826.4 5827.7 5845.4 5639.9 5649.4 5650.7 5652.0 5657.7 06:58:30 INFO - PROCESS | 13173 | 06:58:30 INFO - PROCESS | 13173 | [#1] ext.html Cycles:180 Average:58896.34 Median:42839.39 stddev:113975.88 (266.1%) stddev-sans-first:114211.42 06:58:30 INFO - PROCESS | 13173 | Values: 548.6 586.5 587.7 590.7 602.2 40880.8 42577.4 42714.8 46689.0 46940.8 44190.0 44795.0 44889.8 44899.3 45117.3 8971.6 9132.5 9149.9 9151.5 9158.3 8955.5 8988.4 9012.1 9017.6 9018.4 9010.3 9015.0 9015.2 9024.7 9071.5 8967.7 9001.2 9009.5 9040.3 9047.9 8937.5 8939.1 9002.3 9006.7 9028.1 42964.0 43088.6 43398.3 43478.3 43482.0 3312.2 3460.0 3518.2 3592.5 3626.5 31586.5 31811.4 32224.4 32242.5 32245.8 4297.2 4335.4 4366.1 4560.9 4575.7 347231.3 348162.0 348234.0 348769.0 350247.0 50872.0 55056.2 55190.2 55270.0 55312.4 58302.7 58487.4 58514.0 58611.4 58678.7 14655.2 14807.4 14852.9 14861.3 14922.7 11361.8 11388.3 11474.7 11484.5 11496.7 14266.8 15057.2 15322.3 15585.4 15610.7 5741.3 5947.8 5954.9 6004.8 6063.1 881.0 1033.0 1100.2 1100.8 1110.0 30161.7 31321.0 31587.2 31847.7 32035.8 996.8 1038.1 1066.8 1087.8 1097.5 16021.4 16876.2 16902.3 16997.7 17085.4 495318.0 497777.0 498322.0 498362.0 499841.0 58049.7 58341.0 58375.4 58447.4 58462.4 1246.2 1285.6 1290.7 1307.6 1330.2 29478.9 31201.8 32064.2 32159.2 32193.7 50436.5 50596.2 50816.5 50834.0 50902.5 431415.0 431613.0 432085.0 432929.9 435827.0 39361.8 39418.8 39470.8 39966.8 40125.4 46275.3 46420.3 47901.0 48341.8 50489.0 39171.4 40182.8 41222.0 41317.6 42073.6 39946.4 40590.8 40678.4 41866.8 42292.4 35095.6 35137.0 38793.6 39217.4 39502.0 30288.8 36295.5 36655.3 37067.0 37422.8 28096.9 28408.6 28662.4 28813.4 28867.0 06:58:30 INFO - PROCESS | 13173 | 06:58:30 INFO - PROCESS | 13173 | [#2] jquery.html Cycles:180 Average:24870.34 Median:336028.00 stddev:63030.73 (18.8%) stddev-sans-first:63180.75 06:58:30 INFO - PROCESS | 13173 | Values: 389.2 400.0 403.1 410.3 421.0 17408.4 19074.7 19328.8 19368.9 19971.4 18211.5 18790.3 18906.4 19347.0 19576.4 5214.7 5336.7 5602.4 5850.4 5899.2 5809.9 5867.1 5871.5 5873.5 5893.6 5848.0 6429.4 6445.5 6464.6 6470.0 5808.7 5992.6 6509.5 6544.5 6574.3 5612.0 5643.4 5646.9 5652.1 5665.6 12849.4 13296.9 13362.7 13717.8 13792.9 2228.3 2293.5 2326.3 2522.0 2543.2 5522.4 5620.9 9438.7 9523.3 10527.4 1833.7 1906.7 1960.5 2007.5 2013.0 70617.0 77894.0 79844.6 82212.0 82570.0 10617.4 10953.2 11016.8 11099.4 11389.5 15708.0 15733.6 15743.9 15751.8 15825.5 7483.1 7620.0 7802.8 7816.9 7872.2 6969.9 7138.3 7195.6 7392.3 7416.6 4690.7 4708.3 4716.0 4811.8 4888.5 1896.1 1902.5 1933.4 1940.9 1961.2 909.9 975.7 1005.7 1022.0 1028.7 17892.9 18015.5 18730.4 19182.0 19258.7 917.2 936.2 966.9 977.2 1001.9 10215.2 10628.3 10695.1 10785.6 10809.2 332599.0 334654.0 337402.0 437832.0 440764.0 56396.7 58387.4 69493.7 74710.6 95289.0 1005.8 1011.9 1047.6 1062.1 1066.0 16827.0 17175.4 17502.0 18115.5 18387.7 41650.6 41672.8 41954.0 43165.8 43465.3 57391.7 58894.0 59827.0 60128.4 60507.0 7842.6 8118.4 8119.8 8294.0 8390.2 12489.0 13188.8 13339.8 13477.7 13589.4 11533.0 11693.1 11810.3 11871.0 11979.3 11105.4 11219.2 11336.2 11461.8 11745.0 11663.4 11782.9 11838.3 11862.6 12247.3 8002.8 8206.0 8237.7 8436.3 8756.1 8441.5 10591.8 10713.8 11488.6 11492.6 06:58:30 INFO - PROCESS | 13173 | 06:58:30 INFO - PROCESS | 13173 | [#3] mootools.html Cycles:180 Average:5932.57 Median:2610.94 stddev:3408.16 (130.5%) stddev-sans-first:3399.03 06:58:30 INFO - PROCESS | 13173 | Values: 1183.2 1225.8 1345.7 1721.3 1743.4 8050.6 8265.0 8646.4 9356.8 9366.0 8740.6 8941.6 8984.6 9215.5 9251.0 2372.6 2403.3 2408.2 2409.3 2410.3 2371.0 2374.3 2396.8 2410.9 2411.8 2381.2 2387.5 2407.9 2412.9 2413.9 2301.0 2304.6 2312.6 2312.8 2374.1 2320.4 2323.0 2334.7 2340.0 2356.1 9192.6 9263.6 9282.5 9287.9 9337.8 5232.4 5307.3 5357.0 5374.7 5383.7 3466.7 3537.3 3562.8 3571.9 3666.4 1178.9 1181.9 1193.7 1198.4 1198.8 12674.7 12701.0 12706.7 12743.4 12824.6 4721.7 4743.9 4793.0 4850.4 4886.4 10677.4 10697.4 10704.6 10717.8 10721.9 5522.4 5545.2 5555.1 5558.4 5561.6 4348.7 4481.2 4893.7 4973.1 5049.1 3975.2 4055.5 4151.6 4157.2 4165.7 1337.3 1345.0 1361.8 1365.4 1375.3 916.3 948.5 952.9 960.6 983.0 5931.4 6016.9 6132.9 6150.5 6167.4 463.5 470.4 471.9 478.0 480.2 4011.3 4032.3 4044.6 4064.4 4065.2 10826.0 11098.7 11120.0 11186.2 11229.8 10990.3 11022.9 11047.2 11057.6 11110.2 8232.5 8289.7 8312.8 8332.5 8359.3 5787.4 5823.4 5875.2 5955.9 6009.5 9864.1 10078.8 10152.5 10174.4 10272.9 10339.0 10345.5 10347.3 10349.1 10358.4 7207.6 7370.0 7849.5 7920.7 7989.3 8630.2 9068.8 9069.3 9080.1 9095.4 8002.4 8120.4 8122.4 8196.5 8382.2 7956.3 8044.8 8087.0 8169.9 8281.9 7237.3 7269.7 7314.5 7343.3 7391.0 5288.1 5302.8 5427.0 5465.0 5474.3 4972.7 5236.2 5254.0 5262.0 5279.3 06:58:30 INFO - PROCESS | 13173 | 06:58:30 INFO - PROCESS | 13173 | [#4] prototype.html Cycles:180 Average:4826.26 Median:5392.39 stddev:1425.08 (26.4%) stddev-sans-first:1388.58 06:58:30 INFO - PROCESS | 13173 | Values: 332.2 336.3 340.1 345.3 348.7 5483.5 5592.4 5613.4 5684.5 5722.6 5416.2 5500.8 5511.3 5547.6 5589.2 4293.6 4355.1 4378.2 4393.7 4393.7 4285.1 4332.2 4369.3 4406.2 4411.2 4279.9 4304.6 4315.6 4325.5 4328.9 4298.4 4308.1 4310.6 4329.6 4366.4 3698.6 3783.7 3818.7 3822.6 3822.8 5401.5 5409.8 5427.3 5429.4 5436.6 4952.4 4972.7 4976.6 4980.6 4988.2 5584.2 5798.9 5837.3 5845.5 5862.6 4121.6 4142.4 4142.8 4168.7 4170.5 6136.5 6156.8 6156.9 6168.5 6182.7 4140.6 4302.3 4326.8 4330.1 4336.5 4374.3 4410.4 4415.7 4423.3 4428.3 5033.6 5036.5 5048.7 5049.2 5055.2 5615.8 5875.1 5901.7 5909.9 5934.8 1480.9 1532.4 1532.7 1534.0 1542.8 955.0 970.6 1005.6 1015.9 1016.8 4874.9 4929.9 4943.4 4992.6 4996.8 5289.8 5307.0 5311.7 5323.3 5327.4 4650.9 4988.8 5010.5 5020.6 5064.9 2742.9 2744.6 2750.8 2751.5 2751.8 5332.9 5356.7 5401.0 5405.9 5418.5 5407.7 5445.9 5676.8 6118.5 6166.2 6215.9 6222.8 6224.6 6228.3 6229.7 5873.4 5892.6 6046.7 6052.4 6071.6 5886.4 5893.0 5904.3 5910.0 5910.5 6155.6 6176.1 6197.3 6227.5 6273.5 3994.6 4193.9 4234.5 4281.6 4288.8 5908.8 6009.2 6038.4 6084.4 6128.2 5810.0 5822.2 5831.0 5869.8 5882.0 5803.7 5839.0 5843.4 5849.9 5909.9 5550.3 5722.8 5724.8 5728.5 5751.7 5838.2 5854.6 5855.6 5901.4 5951.8 5383.8 5632.0 5659.1 5661.7 5707.0 06:58:30 INFO - PROCESS | 13173 | 06:58:30 INFO - PROCESS | 13173 | [#5] yui.html Cycles:180 Average:20627.18 Median:4678.57 stddev:29429.82 (629.0%) stddev-sans-first:29474.44 06:58:30 INFO - PROCESS | 13173 | Values: 727.0 745.8 751.6 765.8 843.0 15045.7 15680.1 15694.1 15852.4 15925.4 13993.8 14159.9 14187.9 14203.1 14203.6 784.8 797.3 801.9 812.8 815.6 810.9 824.3 824.9 826.2 828.0 855.3 860.5 863.8 870.0 871.5 859.5 864.3 865.3 865.6 866.3 623.9 629.8 631.5 631.9 633.4 16277.4 16455.0 16467.2 16471.7 16490.8 14569.9 14691.3 14790.0 14845.8 14963.7 11573.2 11686.7 11737.9 11842.0 12415.4 3702.9 3719.7 3846.1 3859.3 3977.2 82080.0 82508.0 83774.0 84345.2 84521.0 10308.4 10754.8 11187.1 11211.2 11261.9 17704.0 17836.4 17880.4 17896.2 18040.4 7992.6 8040.3 8053.4 8121.9 8228.2 4499.2 4618.3 4628.4 4636.4 4720.7 3580.8 3652.3 3667.2 3693.2 3767.7 627.9 638.7 653.7 654.9 663.6 630.6 639.4 663.1 663.2 676.9 9735.9 9816.0 9925.8 9926.2 9936.2 480.9 490.7 511.0 568.1 582.6 4299.7 4311.9 4340.3 4504.3 4526.0 94383.5 94522.0 98298.0 113754.0 131841.0 95600.5 97078.0 97363.0 98203.5 98874.5 83049.0 84102.0 84342.6 87414.0 90034.5 9677.6 9723.3 9787.7 9828.7 9915.2 49548.8 49554.3 49916.5 50760.7 51638.2 68770.0 70525.3 72982.6 74832.3 76167.6 12489.9 12892.6 13048.2 13244.9 14054.8 14279.2 14482.6 15008.3 15788.8 16048.9 13914.9 14295.6 14317.2 14483.9 14974.4 13833.7 14168.9 14193.0 14366.9 14789.9 13696.5 14017.3 14042.5 14219.2 14472.8 11469.3 11807.9 11840.7 11903.8 12073.0 10295.9 10507.0 10767.9 11842.6 12011.3 06:58:30 INFO - PROCESS | 13173 | -------- Summary: end -------- 06:58:30 INFO - PROCESS | 13173 | 06:58:31 INFO - TEST-INFO | 13173: exit 0 06:58:31 INFO - TEST-OK | dromaeo_css | took 1113850ms 06:58:31 INFO - TEST-START | kraken 06:58:31 INFO - operating with platform_type : linux_ 06:58:31 INFO - Initialising browser for kraken test... 06:58:31 INFO - TEST-INFO | started process 13530 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprJT3L2/profile http://localhost:46420/getInfo.html) 06:58:36 INFO - PROCESS | 13530 | __metrics Screen width/height:1600/1200 06:58:36 INFO - PROCESS | 13530 | colorDepth:24 06:58:36 INFO - PROCESS | 13530 | Browser inner width/height: 1024/697 06:58:36 INFO - PROCESS | 13530 | __metrics 06:58:36 ERROR - PROCESS | 13530 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3067: TypeError: this.tabs is undefined 06:58:37 INFO - TEST-INFO | 13530: exit 0 06:58:37 INFO - Browser initialized. 06:58:37 INFO - Running cycle 1/1 for kraken test... 06:58:37 INFO - TEST-INFO | started process 13652 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprJT3L2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:58:49 INFO - PROCESS | 13652 | RSS: Main: 185282560 06:58:49 INFO - PROCESS | 13652 | 06:58:52 INFO - PROCESS | 13652 | Cycle 1(1): loaded http://localhost:46420/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46420/tests/kraken/driver.html?testName=audio-beat-detection) 06:58:53 INFO - PROCESS | 13652 | RSS: Main: 199254016 06:58:53 INFO - PROCESS | 13652 | 06:58:55 INFO - PROCESS | 13652 | Cycle 1(1): loaded http://localhost:46420/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46420/tests/kraken/driver.html?testName=audio-dft) 06:58:56 INFO - PROCESS | 13652 | RSS: Main: 197394432 06:58:56 INFO - PROCESS | 13652 | 06:58:59 INFO - PROCESS | 13652 | Cycle 1(1): loaded http://localhost:46420/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46420/tests/kraken/driver.html?testName=audio-fft) 06:58:59 INFO - PROCESS | 13652 | RSS: Main: 192606208 06:58:59 INFO - PROCESS | 13652 | 06:59:02 INFO - PROCESS | 13652 | Cycle 1(1): loaded http://localhost:46420/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46420/tests/kraken/driver.html?testName=audio-oscillator) 06:59:02 INFO - PROCESS | 13652 | RSS: Main: 193298432 06:59:02 INFO - PROCESS | 13652 | 06:59:04 INFO - PROCESS | 13652 | Cycle 1(1): loaded http://localhost:46420/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46420/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:59:05 INFO - PROCESS | 13652 | RSS: Main: 193282048 06:59:05 INFO - PROCESS | 13652 | 06:59:08 INFO - PROCESS | 13652 | Cycle 1(1): loaded http://localhost:46420/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46420/tests/kraken/driver.html?testName=imaging-darkroom) 06:59:09 INFO - PROCESS | 13652 | RSS: Main: 193982464 06:59:09 INFO - PROCESS | 13652 | 06:59:12 INFO - PROCESS | 13652 | Cycle 1(1): loaded http://localhost:46420/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46420/tests/kraken/driver.html?testName=imaging-desaturate) 06:59:13 INFO - PROCESS | 13652 | RSS: Main: 194867200 06:59:13 INFO - PROCESS | 13652 | 06:59:16 INFO - PROCESS | 13652 | Cycle 1(1): loaded http://localhost:46420/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46420/tests/kraken/driver.html?testName=json-parse-financial) 06:59:16 INFO - PROCESS | 13652 | RSS: Main: 193843200 06:59:16 INFO - PROCESS | 13652 | 06:59:18 INFO - PROCESS | 13652 | Cycle 1(1): loaded http://localhost:46420/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46420/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:59:18 INFO - PROCESS | 13652 | RSS: Main: 194043904 06:59:18 INFO - PROCESS | 13652 | 06:59:20 INFO - PROCESS | 13652 | Cycle 1(1): loaded http://localhost:46420/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46420/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:59:21 INFO - PROCESS | 13652 | RSS: Main: 194117632 06:59:21 INFO - PROCESS | 13652 | 06:59:23 INFO - PROCESS | 13652 | Cycle 1(1): loaded http://localhost:46420/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46420/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:59:24 INFO - PROCESS | 13652 | RSS: Main: 194338816 06:59:24 INFO - PROCESS | 13652 | 06:59:26 INFO - PROCESS | 13652 | Cycle 1(1): loaded http://localhost:46420/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46420/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:59:27 INFO - PROCESS | 13652 | RSS: Main: 194342912 06:59:27 INFO - PROCESS | 13652 | 06:59:30 INFO - PROCESS | 13652 | Cycle 1(1): loaded http://localhost:46420/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46420/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:59:30 INFO - PROCESS | 13652 | RSS: Main: 194568192 06:59:30 INFO - PROCESS | 13652 | 06:59:32 INFO - PROCESS | 13652 | Cycle 1(1): loaded http://localhost:46420/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46420/tests/kraken/driver.html?testName=ai-astar) 06:59:32 INFO - PROCESS | 13652 | RSS: Main: 196116480 06:59:32 INFO - PROCESS | 13652 | 06:59:32 INFO - PROCESS | 13652 | __start_tp_report 06:59:32 INFO - PROCESS | 13652 | _x_x_mozilla_page_load 06:59:32 INFO - PROCESS | 13652 | _x_x_mozilla_page_load_details 06:59:32 INFO - PROCESS | 13652 | |i|pagename|runs| 06:59:32 INFO - PROCESS | 13652 | |0;ai-astar;103;112;113;113;113;112;112;112;113;112 06:59:32 INFO - PROCESS | 13652 | |1;audio-beat-detection;153;120;122;158;124;125;121;125;160;124 06:59:32 INFO - PROCESS | 13652 | |2;audio-dft;163;163;161;161;165;168;163;163;162;164 06:59:32 INFO - PROCESS | 13652 | |3;audio-fft;75;75;75;119;77;76;75;76;119;75 06:59:32 INFO - PROCESS | 13652 | |4;audio-oscillator;82;82;119;81;81;82;105;82;80;125 06:59:32 INFO - PROCESS | 13652 | |5;imaging-gaussian-blur;117;117;119;118;117;117;119;117;118;117 06:59:32 INFO - PROCESS | 13652 | |6;imaging-darkroom;148;148;147;147;147;145;146;149;146;146 06:59:32 INFO - PROCESS | 13652 | |7;imaging-desaturate;95;100;97;97;96;95;96;97;95;96 06:59:32 INFO - PROCESS | 13652 | |8;json-parse-financial;57;55;52;53;54;54;53;56;54;53 06:59:32 INFO - PROCESS | 13652 | |9;json-stringify-tinderbox;60;61;61;60;61;60;62;60;62;60 06:59:32 INFO - PROCESS | 13652 | |10;stanford-crypto-aes;80;80;80;79;81;94;79;83;78;82 06:59:32 INFO - PROCESS | 13652 | |11;stanford-crypto-ccm;128;124;127;127;121;138;137;124;162;125 06:59:32 INFO - PROCESS | 13652 | |12;stanford-crypto-pbkdf2;172;172;162;167;168;170;167;171;163;165 06:59:32 INFO - PROCESS | 13652 | |13;stanford-crypto-sha256-iterative;66;66;66;66;67;66;66;65;64;64 06:59:32 INFO - PROCESS | 13652 | __end_tp_report 06:59:32 INFO - PROCESS | 13652 | __start_cc_report 06:59:32 INFO - PROCESS | 13652 | _x_x_mozilla_cycle_collect,773 06:59:32 INFO - PROCESS | 13652 | __end_cc_report 06:59:32 INFO - PROCESS | 13652 | __startTimestamp1475071172718__endTimestamp 06:59:32 INFO - PROCESS | 13652 | 06:59:32 INFO - PROCESS | 13652 | ------- Summary: start ------- 06:59:32 INFO - PROCESS | 13652 | Number of tests: 14 06:59:32 INFO - PROCESS | 13652 | 06:59:32 INFO - PROCESS | 13652 | [#0] ai-astar Cycles:10 Average:111.50 Median:112.50 stddev:3.03 (2.7%) stddev-sans-first:0.53 06:59:32 INFO - PROCESS | 13652 | Values: 103.0 112.0 113.0 113.0 113.0 112.0 112.0 112.0 113.0 112.0 06:59:32 INFO - PROCESS | 13652 | 06:59:32 INFO - PROCESS | 13652 | [#1] audio-beat-detection Cycles:10 Average:133.20 Median:125.00 stddev:16.59 (13.3%) stddev-sans-first:15.98 06:59:32 INFO - PROCESS | 13652 | Values: 153.0 120.0 122.0 158.0 124.0 125.0 121.0 125.0 160.0 124.0 06:59:32 INFO - PROCESS | 13652 | 06:59:32 INFO - PROCESS | 13652 | [#2] audio-dft Cycles:10 Average:163.30 Median:163.00 stddev:2.06 (1.3%) stddev-sans-first:2.18 06:59:32 INFO - PROCESS | 13652 | Values: 163.0 163.0 161.0 161.0 165.0 168.0 163.0 163.0 162.0 164.0 06:59:32 INFO - PROCESS | 13652 | 06:59:32 INFO - PROCESS | 13652 | [#3] audio-fft Cycles:10 Average:84.20 Median:75.00 stddev:18.35 (24.5%) stddev-sans-first:19.16 06:59:32 INFO - PROCESS | 13652 | Values: 75.0 75.0 75.0 119.0 77.0 76.0 75.0 76.0 119.0 75.0 06:59:32 INFO - PROCESS | 13652 | 06:59:32 INFO - PROCESS | 13652 | [#4] audio-oscillator Cycles:10 Average:91.90 Median:81.50 stddev:17.55 (21.5%) stddev-sans-first:18.25 06:59:32 INFO - PROCESS | 13652 | Values: 82.0 82.0 119.0 81.0 81.0 82.0 105.0 82.0 80.0 125.0 06:59:32 INFO - PROCESS | 13652 | 06:59:32 INFO - PROCESS | 13652 | [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:117.50 stddev:0.84 (0.7%) stddev-sans-first:0.87 06:59:32 INFO - PROCESS | 13652 | Values: 117.0 117.0 119.0 118.0 117.0 117.0 119.0 117.0 118.0 117.0 06:59:32 INFO - PROCESS | 13652 | 06:59:32 INFO - PROCESS | 13652 | [#6] imaging-darkroom Cycles:10 Average:146.90 Median:147.00 stddev:1.20 (0.8%) stddev-sans-first:1.20 06:59:32 INFO - PROCESS | 13652 | Values: 148.0 148.0 147.0 147.0 147.0 145.0 146.0 149.0 146.0 146.0 06:59:32 INFO - PROCESS | 13652 | 06:59:32 INFO - PROCESS | 13652 | [#7] imaging-desaturate Cycles:10 Average:96.40 Median:96.00 stddev:1.51 (1.6%) stddev-sans-first:1.51 06:59:32 INFO - PROCESS | 13652 | Values: 95.0 100.0 97.0 97.0 96.0 95.0 96.0 97.0 95.0 96.0 06:59:32 INFO - PROCESS | 13652 | 06:59:32 INFO - PROCESS | 13652 | [#8] json-parse-financial Cycles:10 Average:54.10 Median:54.00 stddev:1.52 (2.8%) stddev-sans-first:1.20 06:59:32 INFO - PROCESS | 13652 | Values: 57.0 55.0 52.0 53.0 54.0 54.0 53.0 56.0 54.0 53.0 06:59:32 INFO - PROCESS | 13652 | 06:59:32 INFO - PROCESS | 13652 | [#9] json-stringify-tinderbox Cycles:10 Average:60.70 Median:61.00 stddev:0.82 (1.3%) stddev-sans-first:0.83 06:59:32 INFO - PROCESS | 13652 | Values: 60.0 61.0 61.0 60.0 61.0 60.0 62.0 60.0 62.0 60.0 06:59:32 INFO - PROCESS | 13652 | 06:59:32 INFO - PROCESS | 13652 | [#10] stanford-crypto-aes Cycles:10 Average:81.60 Median:80.50 stddev:4.60 (5.7%) stddev-sans-first:4.84 06:59:32 INFO - PROCESS | 13652 | Values: 80.0 80.0 80.0 79.0 81.0 94.0 79.0 83.0 78.0 82.0 06:59:32 INFO - PROCESS | 13652 | 06:59:32 INFO - PROCESS | 13652 | [#11] stanford-crypto-ccm Cycles:10 Average:131.30 Median:127.50 stddev:12.11 (9.5%) stddev-sans-first:12.79 06:59:32 INFO - PROCESS | 13652 | Values: 128.0 124.0 127.0 127.0 121.0 138.0 137.0 124.0 162.0 125.0 06:59:32 INFO - PROCESS | 13652 | 06:59:32 INFO - PROCESS | 13652 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.70 Median:169.00 stddev:3.59 (2.1%) stddev-sans-first:3.46 06:59:32 INFO - PROCESS | 13652 | Values: 172.0 172.0 162.0 167.0 168.0 170.0 167.0 171.0 163.0 165.0 06:59:32 INFO - PROCESS | 13652 | 06:59:32 INFO - PROCESS | 13652 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.60 Median:66.00 stddev:0.97 (1.5%) stddev-sans-first:1.01 06:59:32 INFO - PROCESS | 13652 | Values: 66.0 66.0 66.0 66.0 67.0 66.0 66.0 65.0 64.0 64.0 06:59:32 INFO - PROCESS | 13652 | -------- Summary: end -------- 06:59:32 INFO - PROCESS | 13652 | 06:59:32 INFO - PROCESS | 13652 | 06:59:32 INFO - PROCESS | 13652 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 06:59:32 INFO - PROCESS | 13652 | 06:59:32 INFO - PROCESS | 13652 | 06:59:32 INFO - PROCESS | 13652 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 06:59:32 INFO - PROCESS | 13652 | 06:59:32 INFO - PROCESS | 13652 | 06:59:32 INFO - PROCESS | 13652 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 06:59:32 INFO - PROCESS | 13652 | 06:59:32 INFO - PROCESS | 13652 | 06:59:32 INFO - PROCESS | 13652 | ###!!! [Parent][MessageChannel] Error: (msgtype=0x2000B,name=PAPZ::Msg_Destroy) Channel error: cannot send/recv 06:59:32 INFO - PROCESS | 13652 | 06:59:32 INFO - PROCESS | 13652 | 06:59:32 INFO - PROCESS | 13652 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 06:59:32 INFO - PROCESS | 13652 | 06:59:33 INFO - TEST-INFO | 13652: exit 0 06:59:33 INFO - TEST-OK | kraken | took 62224ms 06:59:33 INFO - SUITE-END | took 1176s 06:59:34 INFO - Completed test suite (00:19:36) 06:59:34 INFO - javascript benchmark 06:59:34 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7252.733793620005, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3144.38684456531, 3144.7326977206935, 3146.4808306629407, 3179.2528755742387, 3194.2014496375905, 5429.619926605139, 5529.728162522617, 5570.749316280767, 5602.523785478229, 5609.074502707053, 5389.865253368658, 5467.562594992401, 5546.972265138668, 5593.797333573281, 5603.775848966046, 4899.681520701143, 4931.975340123303, 4980.452150263468, 5040.823571175009, 5124.0776660201145, 5036.949630503703, 5121.2318152277085, 5122.0, 5131.1277082895995, 5145.382554093495, 4912.238603016538, 4941.530554597308, 5008.9499105008845, 5018.673786203904, 5146.6140039497, 4912.435069966964, 4941.332920055783, 4967.875803104916, 4993.575546078588, 5059.114654935372, 4935.161022626126, 4942.629302802305, 4961.875953101201, 4964.205727083686, 4994.775235114428, 5374.677519348852, 5390.757415916254, 5420.864478388033, 5456.372517160537, 5459.344878614552, 5896.7936122235515, 5912.4974377178, 5927.110933359987, 5963.522918166536, 6076.665783381913, 5996.400359964013, 5996.8500787480225, 5998.1602575639445, 6006.639601623917, 6050.54620903434, 5593.636413633141, 5600.523955463831, 5613.607047506717, 5622.32532096151, 5624.915626265651, 5907.645541267538, 5968.85077873048, 5977.641341519523, 5991.5206783457215, 6007.48936340416, 5808.128780682931, 5811.593188476851, 5827.621204621686, 5831.679257640785, 5874.676892770854, 5738.282714660668, 5831.0378787499585, 5923.200367950358, 5985.730642121028, 6019.729112189962, 5783.826485205451, 5810.535157187415, 5848.912266316009, 5852.795152169653, 5856.824295271149, 5808.30300363959, 5821.27234095738, 5853.239078919798, 5878.265216847894, 5884.440978107073, 4463.308187230984, 4514.932276015862, 4534.841280555164, 4546.727196368229, 4590.242609969385, 4040.4949381327333, 4042.2521833460905, 4083.3262511685834, 4094.406311084876, 4160.126373461547, 5653.660780353192, 5681.630694004876, 5689.203511508392, 5700.9429905701245, 5780.768769249183, 5779.393163717833, 6033.245844269466, 6040.486558642477, 6049.727762250709, 6056.364081771439, 5508.91736623951, 5511.476409741148, 5515.972420137874, 5569.387367389584, 5652.604317697722, 4804.399450068741, 4823.710577365299, 4829.082474329866, 4829.251466022702, 4884.12085824555, 6008.819735407945, 6026.21659184312, 6069.0, 6087.54343424245, 6095.420935011167, 5788.247527821356, 5881.206037185097, 5887.470127688529, 5911.379305172895, 5967.880642387215, 6131.509479241739, 6167.136600875791, 6171.444569988543, 6174.197354343906, 6174.8147555573405, 5868.765249389977, 5873.794417195549, 5877.647341159544, 5885.646861188342, 5928.407159284037, 5796.0, 5938.584299099021, 5958.582899197015, 5976.521878249642, 5981.401859813984, 5705.971470142788, 5731.8567035824435, 5774.740136693775, 5813.6221145625395, 5878.882422351615, 5781.5663825214115, 5784.537237020944, 5787.623804452697, 5790.10253410722, 5797.4782269595935, 5589.972050139723, 5638.407967163389, 5639.436056394327, 5656.830295091154, 5690.658560486384, 5811.4479124483105, 5817.94182058174, 5826.359100498857, 5827.708614569339, 5845.444682755132, 5639.915401268902, 5649.4350564944825, 5650.660960342392, 5652.0, 5657.717114144359], "value": 5440.100803124793, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [548.6391550574685, 586.510263929619, 587.7149582452511, 590.7135039505841, 602.184040624953, 40880.79559602201, 42577.36133957993, 42714.78642606786, 46689.0, 46940.76529617356, 44190.0, 44795.0, 44889.7755511222, 44899.32651010237, 45117.323240151425, 8971.596278167499, 9132.497712625804, 9149.862752058725, 9151.542422878863, 9158.313126515504, 8955.462672239653, 8988.370814043019, 9012.143846334588, 9017.639294428214, 9018.36871419001, 9010.279177665803, 9015.0, 9015.188633023026, 9024.729258122266, 9071.546422678839, 8967.730968070968, 9001.189892909604, 9009.504477253748, 9040.321975851837, 9047.864282035742, 8937.50843703596, 8939.106089391074, 9002.324825638038, 9006.729798106067, 9028.142326478974, 42964.0, 43088.56911430877, 43398.349024764655, 43478.34782478266, 43482.0, 3312.1700458592904, 3460.0311912664492, 3518.1556426457723, 3592.515010473579, 3626.528551288342, 31586.526202106757, 31811.363772724646, 32224.35551288961, 32242.516362254584, 32245.838770805996, 4297.162053399588, 4335.414719012924, 4366.08312254427, 4560.863174104782, 4575.702579332333, 347231.26384368166, 348162.0, 348234.0, 348769.0, 350247.0, 50872.0, 55056.17415738767, 55190.17214741782, 55270.0, 55312.44687553153, 58302.7084864573, 58487.415125849046, 58514.0, 58611.413885861446, 58678.706606467545, 14655.193964332064, 14807.407703691948, 14852.925735371255, 14861.331240094221, 14922.70154596902, 11361.829572556418, 11388.3167009978, 11474.655760327036, 11484.483198256099, 11496.655100347003, 14266.785998210034, 15057.247137643075, 15322.310496027705, 15585.376584936475, 15610.68778624421, 5741.282339707536, 5947.762089516371, 5954.910676339859, 6004.789832355847, 6063.090536419572, 880.9911900880909, 1032.963846265377, 1100.1638754546602, 1100.8238681810872, 1110.0287248657426, 30161.698383016326, 31321.0, 31587.21031974219, 31847.681523184936, 32035.839820800746, 996.7856910764076, 1038.1383451735041, 1066.7973085113958, 1087.7770057138268, 1097.5280629329466, 16021.359145634277, 16876.15619219034, 16902.32390704358, 16997.660046798996, 17085.402010929807, 495318.0, 497777.0, 498322.0, 498362.0, 499841.0, 58049.70975145182, 58341.0, 58375.416245837, 58447.41552584505, 58462.415375845696, 1246.2211118051218, 1285.5886116442648, 1290.7483040806953, 1307.5685023942076, 1330.1752913193882, 29478.852605736833, 31201.8439907799, 32064.198395039377, 32159.196020099684, 32193.678063220006, 50436.49563504318, 50596.24105638345, 50816.491835082656, 50834.0, 50902.490975091256, 431415.0, 431613.0, 432085.0, 432929.85955912765, 435827.0, 39361.80319098501, 39418.802905985285, 39470.7509802748, 39966.80016599898, 40125.398119028825, 46275.305870412645, 46420.30369544392, 47901.0, 48341.758291208316, 50489.0, 39171.41242881302, 40182.79908600439, 41222.0, 41317.58682413137, 42073.579264208194, 39946.40080398738, 40590.79704601458, 40678.38982415325, 41866.790666047695, 42292.36561451519, 35095.649043509235, 35137.0, 38793.61206388013, 39217.411738824514, 39502.0, 30288.84855575708, 36295.455568167024, 36655.26689466142, 37067.0, 37422.8128859354, 28096.85951570229, 28408.57387139236, 28662.426751464438, 28813.423731525672, 28867.0], "value": 19777.98800300897, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [389.20796179774163, 399.9880003599893, 403.10309561226273, 410.27176761248785, 421.0400287344853, 17408.390706325266, 19074.713879291823, 19328.806711932877, 19368.903155484222, 19971.400857974248, 18211.45365639033, 18790.342338018174, 18906.43280701578, 19347.0, 19576.412707618794, 5214.713190774506, 5336.67979921204, 5602.411746766592, 5850.3564607893095, 5899.203607512995, 5809.854753631151, 5867.11993201019, 5871.500922421599, 5873.530117590582, 5893.616914900539, 5848.035074212749, 6429.421352078312, 6445.548811583191, 6464.612123272595, 6470.0, 5808.651480911117, 5992.580519363646, 6509.544331896769, 6544.509161812859, 6574.309697481767, 5611.971940140314, 5643.435656434365, 5646.887062258732, 5652.09566469367, 5665.631733937322, 12849.421776020008, 13296.933515332457, 13362.665933351647, 13717.794233086512, 13792.862071379259, 2228.275810361623, 2293.4839661076126, 2326.348622385735, 2522.0, 2543.186180422266, 5522.420145884705, 5620.9437905620825, 9438.725772020758, 9523.285753568442, 10527.420991845445, 1833.6607727570308, 1906.6663333916508, 1960.4804726747423, 2007.518195633052, 2012.9597408051757, 70617.0, 77893.99999999943, 79844.60077699632, 82212.0, 82569.9999999994, 10617.416042117758, 10953.17851161166, 11016.834747478793, 11099.389533575732, 11389.487473063731, 15708.0, 15733.606659833596, 15743.921280393753, 15751.842481575266, 15825.52523424299, 7483.13943896448, 7620.0, 7802.843943121105, 7816.8827467588035, 7872.173421790744, 6969.895451568231, 7138.250483699137, 7195.640217989079, 7392.260773922565, 7416.629168541552, 4690.671652984258, 4708.340832283483, 4715.95284047162, 4811.831585894477, 4888.462269150391, 1896.1088288504382, 1902.4863286912732, 1933.3716542123584, 1940.9227878527554, 1961.2155137944935, 909.9363044586815, 975.7170420578095, 1005.6982905128432, 1022.0188618925914, 1028.747956750601, 17892.910535447238, 18015.549611259823, 18730.438086857142, 19182.0, 19258.71111933322, 917.2249449215402, 936.1757221749095, 966.8694726212012, 977.2035790830593, 1001.9248556358302, 10215.23385746072, 10628.309159904582, 10695.144388448905, 10785.568577256821, 10809.243352965374, 332599.0, 334654.0, 337402.0, 437832.0, 440764.0, 56396.71801641048, 58387.416125839045, 69493.65253173701, 74710.62644686742, 95289.0, 1005.8340373838234, 1011.858339832424, 1047.607147319755, 1062.081299675775, 1065.984010239847, 16827.0, 17175.398861039805, 17502.0, 18115.547111321794, 18387.72418413698, 41650.58349416467, 41672.79163604163, 41954.0, 43165.7841710802, 43465.3480197791, 57391.7130414362, 58894.0, 59827.0, 60128.39871601403, 60507.0, 7842.568658723597, 8118.431709780495, 8119.75640730779, 8293.95853020731, 8390.202930721573, 12488.96077478009, 13188.790427781165, 13339.799903001269, 13477.730445391233, 13589.388477518733, 11533.0, 11693.12301577368, 11810.291382517076, 11871.0, 11979.281243125091, 11105.389203593557, 11219.158563107963, 11336.206465547333, 11461.770764584828, 11745.0, 11663.358515281741, 11782.882171178178, 11838.28500974425, 11862.644120676394, 12247.326397048248, 8002.756471716212, 8205.958970205349, 8237.670493180205, 8436.32509399259, 8756.124387561193, 8441.451305665112, 10591.841122383017, 10713.839292410776, 11488.597899073493, 11492.597759078391], "value": 8867.193259398427, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1183.1717797541721, 1225.8345123408337, 1345.6501309659488, 1721.2598582609473, 1743.4072415378769, 8050.557219352948, 8265.049519305281, 8646.437981531197, 9356.812863742722, 9365.953170234148, 8740.606672699729, 8941.552922353889, 8984.595693193805, 9215.539223038855, 9250.953745231282, 2372.608519594265, 2403.2549909528016, 2408.1812183857487, 2409.325388891113, 2410.301012706313, 2370.95258094838, 2374.2995816234165, 2396.7962723168466, 2410.8915098820594, 2411.8191135664806, 2381.2380038387723, 2387.4986252886915, 2407.927762167129, 2412.9155479558217, 2413.9034438622434, 2301.0, 2304.6082166031815, 2312.629979203328, 2312.826538009656, 2374.0741110966565, 2320.4314942839114, 2323.047550504285, 2334.661474086265, 2339.976600233993, 2356.081128359941, 9192.586333615003, 9263.583138758704, 9282.535873206312, 9287.860682089775, 9337.813243735087, 5232.424433312332, 5307.2569840222395, 5357.035733567956, 5374.7043912584795, 5383.730813459311, 3466.7053300469493, 3537.2748586539697, 3562.750607457479, 3571.928561428783, 3666.358387282215, 1178.8880056394628, 1181.9008322260295, 1193.7015746063485, 1198.4127777389017, 1198.8081906894854, 12674.683132921658, 12701.047421443429, 12706.682332941658, 12743.426545805462, 12824.615261542262, 4721.740304283228, 4743.892520113276, 4793.0, 4850.442199147144, 4886.364772579613, 10677.359358438518, 10697.358158510358, 10704.625338113285, 10717.785644287227, 10721.946390267998, 5522.3649280333275, 5545.223668686387, 5555.111182210908, 5558.44415558441, 5561.638493497991, 4348.717333373321, 4481.170983368087, 4893.657443978887, 4973.104841128632, 5049.116404629175, 3975.185087057146, 4055.4930633670792, 4151.647109995623, 4157.210130075276, 4165.66674666032, 1337.3112846883862, 1344.9798253026213, 1361.7957306404119, 1365.4469939674448, 1375.2848518770384, 916.3310783128354, 948.5494390164616, 952.9428234305964, 960.5869476125193, 982.975425614351, 5931.40685931412, 6016.884420103546, 6132.908006379907, 6150.50795936324, 6167.352427995085, 463.52720225369933, 470.4401761903324, 471.8769328996965, 477.9784909679073, 480.17170381093035, 4011.338129208648, 4032.274190645653, 4044.595540445932, 4064.4309796628495, 4065.166640838621, 10826.0, 11098.667039988813, 11120.0, 11186.216964812385, 11229.831552526719, 10990.340579565252, 11022.889771102185, 11047.171462140372, 11057.612983545698, 11110.222284440173, 8232.50604963692, 8289.709860154986, 8312.792180195544, 8332.50004999702, 8359.331253499706, 5787.36339002701, 5823.417658234142, 5875.177475153568, 5955.880882382241, 6009.519238461, 9864.112229899056, 10078.848817267894, 10152.543135559064, 10174.440405777754, 10272.869984301571, 10338.9661033896, 10345.534450949575, 10347.327423717434, 10349.120324772177, 10358.430286334324, 7207.639618019183, 7369.963150184215, 7849.529028258323, 7920.722774702857, 7989.2809647132035, 8630.180132887366, 9068.818623627358, 9069.274458043472, 9080.091990800867, 9095.363324567217, 8002.399820013406, 8120.390970677105, 8122.39082068859, 8196.54918979462, 8382.245597896219, 7956.283934445928, 8044.758657240292, 8087.0, 8169.877451838346, 8281.875771863306, 7237.3486386225495, 7269.672864720995, 7314.451416143704, 7343.2656734328275, 7391.0044288043, 5288.101022826206, 5302.844807339627, 5426.972865135649, 5465.043617367024, 5474.315710536183, 4972.676776009548, 5236.188390799432, 5254.0, 5262.000219958196, 5279.313689220377], "value": 4655.544832458558, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [332.2194966488324, 336.3139196040078, 340.1224839913024, 345.2628637858172, 348.733219087398, 5483.506484416402, 5592.412796656354, 5613.354464236614, 5684.488396044355, 5722.6280291781, 5416.241726158341, 5500.80747173849, 5511.255980442639, 5547.611667183299, 5589.161625756128, 4293.570642935705, 4355.063661312817, 4378.211921854065, 4393.670474714393, 4393.692441529094, 4285.057287396783, 4332.176886391591, 4369.344598310263, 4406.184855801671, 4411.1618792429335, 4279.935800962988, 4304.569543045702, 4315.611594956454, 4325.545817689129, 4328.870133895988, 4298.419713338706, 4308.147496576471, 4310.568943105695, 4329.610335069828, 4366.362614019743, 3698.556173259199, 3783.7162212833873, 3818.694504439638, 3822.5604055533413, 3822.7515211511163, 5401.541583772399, 5409.810656627039, 5427.267318911936, 5429.37118864343, 5436.592255580807, 4952.430470495903, 4972.726500042496, 4976.626752993504, 4980.626453016038, 4988.201887697951, 5584.246126772874, 5798.942010579883, 5837.270341207349, 5845.457226106657, 5862.560307976919, 4121.608447197542, 4142.357934520124, 4142.79286035697, 4168.7081904266715, 4170.541240463546, 6136.527233463981, 6156.846078848064, 6156.907646385308, 6168.537359698041, 6182.659953702545, 4140.585941405835, 4302.311630139163, 4326.826926922888, 4330.0906809569715, 4336.457942757155, 4374.321980093027, 4410.426644536254, 4415.725901160905, 4423.336499525032, 4428.31361139024, 5033.572146367526, 5036.546710796046, 5048.671836330626, 5049.2173713074535, 5055.241713742895, 5615.775368985195, 5875.089361149029, 5901.734421951022, 5909.852253693692, 5934.7922822701, 1480.9481668141564, 1532.4292600085003, 1532.7087853307835, 1534.0, 1542.7917231173649, 955.0, 970.6360114956891, 1005.5720876355592, 1015.8882522922472, 1016.769708652524, 4874.8537543873745, 4929.929429639488, 4943.3573635427165, 4992.575631071327, 4996.826380524483, 5289.814856480005, 5307.0, 5311.7078560678765, 5323.30796996388, 5327.440618735054, 4650.86047418578, 4988.800447982113, 5010.473900240495, 5020.59835213182, 5064.936363363661, 2742.9142215008114, 2744.5745909384077, 2750.80340052074, 2751.463464624379, 2751.793615478847, 5332.92000619991, 5356.651817631841, 5400.972995134999, 5405.945940540623, 5418.539424148913, 5407.702151483616, 5445.863853403696, 5676.801311954145, 6118.510519158456, 6166.198394208814, 6215.9378406215355, 6222.751089956351, 6224.595401298901, 6228.34602366754, 6229.719662615194, 5873.442023007808, 5892.552856578778, 6046.727897244723, 6052.425019623129, 6071.635701857903, 5886.381929897299, 5892.970535147297, 5904.3210030845285, 5910.0, 5910.468057874812, 6155.569110162425, 6176.054542818998, 6197.264765865565, 6227.532935029982, 6273.498120150468, 3994.581923417145, 4193.909583508249, 4234.534201237923, 4281.550437204173, 4288.7855607220135, 5908.793192238423, 6009.248843894513, 6038.426349496791, 6084.3572235495285, 6128.203333566607, 5810.0, 5822.16601770441, 5830.997036526277, 5869.8239052828485, 5882.000119959234, 5803.738831752666, 5838.970805146117, 5843.386444423444, 5849.883002339844, 5909.940900590939, 5550.333959924835, 5722.799702010409, 5724.8282551523525, 5728.455796699307, 5751.7411716472025, 5838.1826544282985, 5854.648721076749, 5855.59010869235, 5901.409859014064, 5951.7619295227705, 5383.81156659515, 5632.0, 5659.057290209151, 5661.716914154358, 5707.0], "value": 4373.791197092322, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [727.0, 745.8172747676819, 751.56784848712, 765.7740966414907, 843.0431460292568, 15045.699086018287, 15680.137592432411, 15694.058356498617, 15852.365905363786, 15925.362985480568, 13993.790093148611, 14159.929200353983, 14187.858121418783, 14203.076800008019, 14203.644908877282, 784.8273379856422, 797.2625321577547, 801.8997625296838, 812.8130529978108, 815.604431850552, 810.9026916769996, 824.3281725393784, 824.9051359093721, 826.2398593294183, 827.9793005174859, 855.3499340501232, 860.5310105992218, 863.8358711844761, 870.0081906626451, 871.4945331707626, 859.5487369131193, 864.2653744317312, 865.2947847504264, 865.6364326982682, 866.3242670716851, 623.9126522286883, 629.8299459146004, 631.5231999840091, 631.9178506794087, 633.3666333666333, 16277.430289939795, 16455.012699237963, 16467.176641167895, 16471.67056658872, 16490.83509164905, 14569.854301457062, 14691.338889749986, 14790.0, 14845.777313340308, 14963.700725985529, 11573.189876708633, 11686.70783230426, 11737.94131029348, 11842.0, 12415.379231038502, 3702.907427314312, 3719.6838268747188, 3846.134619710571, 3859.286032084073, 3977.204559088165, 82080.0, 82507.9999999994, 83774.0, 84345.15654843434, 84521.0, 10308.381497110197, 10754.78490430187, 11187.105031597453, 11211.215214934877, 11261.887381126247, 17704.0, 17836.3757268495, 17880.374186903395, 17896.194671239824, 18040.368587099652, 7992.560409177435, 8040.316573091236, 8053.395995300376, 8121.878171827428, 8228.161284356887, 4499.212637788374, 4618.330342100377, 4628.421447319085, 4636.420447444069, 4720.716756994591, 3580.785152890835, 3652.2695460907926, 3667.2482141161, 3693.242885208526, 3767.6797472215167, 627.8681476889813, 638.6742761191825, 653.650297091054, 654.852658151912, 663.6383171171626, 630.6373835044867, 639.4495776658648, 663.1445435388295, 663.151166506872, 676.8510927595921, 9735.853962190573, 9815.950920245354, 9925.828430620682, 9926.156276716416, 9936.155426788804, 480.89660722944035, 490.70312460960605, 511.04525191144023, 568.071203582138, 582.5921854701726, 4299.720518166309, 4311.892202694958, 4340.262155433584, 4504.2905074378905, 4525.977370113128, 94383.52808235915, 94522.0, 98298.01701983031, 113754.0, 131841.0, 95600.52199739096, 97078.0, 97363.0, 98203.50898245606, 98874.5056274714, 83049.0, 84102.0, 84342.5782871094, 87414.0, 90034.54982725045, 9677.612895484383, 9723.270754693567, 9787.657431989846, 9828.705138845846, 9915.20678345745, 49548.75225623849, 49554.25668615046, 49916.500834992636, 50760.74619626878, 51638.22542661788, 68770.0, 70525.29474705392, 72982.63508682423, 74832.25167748253, 76167.61916190383, 12489.93755031219, 12892.613221603367, 13048.217106973612, 13244.867551324363, 14054.789178162131, 14279.214643194724, 14482.637934051732, 15008.272978569552, 15788.763168552252, 16048.919755401148, 13914.860851391357, 14295.64260893486, 14317.212553309668, 14483.855161448671, 14974.401023958919, 13833.723325533634, 14168.866490680515, 14193.0, 14366.928165359106, 14789.926050369679, 13696.452141914211, 14017.266633006466, 14042.508512202025, 14219.217943013233, 14472.782908256595, 11469.254498457574, 11807.940960295144, 11840.70398240051, 11903.82144267854, 12073.0, 10295.897041029493, 10507.0, 10767.946160269148, 11842.644720658394, 12011.279323240633], "value": 7491.427922062411, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1505.9999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 112.0, 113.0, 113.0, 113.0, 112.0, 112.0, 112.0, 113.0, 112.0], "value": 111.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 120.0, 122.0, 158.0, 124.0, 125.0, 121.0, 125.0, 160.0, 124.0], "value": 133.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 161.0, 161.0, 165.0, 168.0, 163.0, 163.0, 162.0, 164.0], "value": 163.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 119.0, 77.0, 76.0, 75.0, 76.0, 119.0, 75.0], "value": 84.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 119.0, 81.0, 81.0, 82.0, 105.0, 82.0, 80.0, 125.0], "value": 91.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 119.0, 118.0, 117.0, 117.0, 119.0, 117.0, 118.0, 117.0], "value": 117.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 147.0, 147.0, 147.0, 145.0, 146.0, 149.0, 146.0, 146.0], "value": 146.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 100.0, 97.0, 97.0, 96.0, 95.0, 96.0, 97.0, 95.0, 96.0], "value": 96.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 55.0, 52.0, 53.0, 54.0, 54.0, 53.0, 56.0, 54.0, 53.0], "value": 54.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 61.0, 60.0, 61.0, 60.0, 62.0, 60.0, 62.0, 60.0], "value": 60.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 80.0, 80.0, 79.0, 81.0, 94.0, 79.0, 83.0, 78.0, 82.0], "value": 81.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 124.0, 127.0, 127.0, 121.0, 138.0, 137.0, 124.0, 162.0, 125.0], "value": 131.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 172.0, 162.0, 167.0, 168.0, 170.0, 167.0, 171.0, 163.0, 165.0], "value": 167.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 66.0, 66.0, 67.0, 66.0, 66.0, 65.0, 64.0, 64.0], "value": 65.6, "unit": "score"}]}]} 06:59:34 INFO - Return code: 0 06:59:34 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:59:34 ERROR - # TBPL SUCCESS # 06:59:34 INFO - Running post-action listener: _resource_record_post_action 06:59:34 INFO - [mozharness: 2016-09-28 13:59:34.541191Z] Finished run-tests step (success) 06:59:34 INFO - Running post-run listener: _resource_record_post_run 06:59:34 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 4096; Write bytes: 400461824; Read time: 8; Write time: 329188 06:59:34 INFO - TinderboxPrint: CPU usage
13.4% 06:59:34 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 06:59:34 INFO - TinderboxPrint: I/O write bytes / time
400,461,824 / 329,188 06:59:34 INFO - TinderboxPrint: CPU idle
8,243.9 (86.6%) 06:59:34 INFO - TinderboxPrint: CPU user
1,216.9 (12.8%) 06:59:34 INFO - TinderboxPrint: Swap in / out
0 / 0 06:59:34 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 111034368; Read time: 0; Write time: 90620 06:59:34 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 0; Write bytes: 289427456; Read time: 0; Write time: 238568 06:59:35 INFO - Running post-run listener: _upload_blobber_files 06:59:35 INFO - Blob upload gear active. 06:59:35 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:59:35 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 06:59:35 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', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:59:35 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 Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:59:35 INFO - (blobuploader) - INFO - Open directory for files ... 06:59:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 06:59:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:59:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:59:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 06:59:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:59:36 INFO - (blobuploader) - INFO - Done attempting. 06:59:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 06:59:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:59:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:59:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 06:59:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:59:37 INFO - (blobuploader) - INFO - Done attempting. 06:59:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:59:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:59:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:59:41 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:59:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:59:41 INFO - (blobuploader) - INFO - Done attempting. 06:59:41 INFO - (blobuploader) - INFO - Iteration through files over. 06:59:41 INFO - Return code: 0 06:59:41 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:59:41 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:59:41 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bbb59363d9231740173c595f31d5e7bb3ed3ecd9fe22a6e561f9dcb5573f1d8ecc9e813cb8bc2e501e44551fe2f499e8873b11213a6fcfb25ff36a4e90c2de67", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a1c7572dc3b315f930ec55246545b9a9823651cb95bc9950c357c7250491fef04a51c9af071e4cd00dcaebb5ff741374475c92725cbd0f6d7da22046b61d2a29", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fd624d1216ec56cc6b1ac874a2c9421f27efe42bec71c1ea042637a7a58ae0df5b8ca15bd655b1a0f624fe5ac42763aba80ebe5cd4d2e3f714d55be2c3c8edf5"} 06:59:41 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:59:41 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:59:41 INFO - Contents: 06:59:41 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bbb59363d9231740173c595f31d5e7bb3ed3ecd9fe22a6e561f9dcb5573f1d8ecc9e813cb8bc2e501e44551fe2f499e8873b11213a6fcfb25ff36a4e90c2de67", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a1c7572dc3b315f930ec55246545b9a9823651cb95bc9950c357c7250491fef04a51c9af071e4cd00dcaebb5ff741374475c92725cbd0f6d7da22046b61d2a29", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fd624d1216ec56cc6b1ac874a2c9421f27efe42bec71c1ea042637a7a58ae0df5b8ca15bd655b1a0f624fe5ac42763aba80ebe5cd4d2e3f714d55be2c3c8edf5"} 06:59:41 INFO - Running post-run listener: copy_logs_to_upload_dir 06:59:41 INFO - Copying logs to upload dir... 06:59:41 INFO - mkdir: /builds/slave/test/build/upload/logs 06:59:41 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.953822 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-09-28 06:59:40.764932) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-28 06:59:40.768107) ========= 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=6d15e502d8e29d5d2676d664000001c3-1475069941.289089-1163264539 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bbb59363d9231740173c595f31d5e7bb3ed3ecd9fe22a6e561f9dcb5573f1d8ecc9e813cb8bc2e501e44551fe2f499e8873b11213a6fcfb25ff36a4e90c2de67", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a1c7572dc3b315f930ec55246545b9a9823651cb95bc9950c357c7250491fef04a51c9af071e4cd00dcaebb5ff741374475c92725cbd0f6d7da22046b61d2a29", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fd624d1216ec56cc6b1ac874a2c9421f27efe42bec71c1ea042637a7a58ae0df5b8ca15bd655b1a0f624fe5ac42763aba80ebe5cd4d2e3f714d55be2c3c8edf5"} build_url:https://queue.taskcluster.net/v1/task/HTMCLMiNTnyJjm51FduZ0A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011321 build_url: 'https://queue.taskcluster.net/v1/task/HTMCLMiNTnyJjm51FduZ0A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bbb59363d9231740173c595f31d5e7bb3ed3ecd9fe22a6e561f9dcb5573f1d8ecc9e813cb8bc2e501e44551fe2f499e8873b11213a6fcfb25ff36a4e90c2de67", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a1c7572dc3b315f930ec55246545b9a9823651cb95bc9950c357c7250491fef04a51c9af071e4cd00dcaebb5ff741374475c92725cbd0f6d7da22046b61d2a29", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fd624d1216ec56cc6b1ac874a2c9421f27efe42bec71c1ea042637a7a58ae0df5b8ca15bd655b1a0f624fe5ac42763aba80ebe5cd4d2e3f714d55be2c3c8edf5"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-28 06:59:40.793516) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-28 06:59:40.793862) ========= 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=6d15e502d8e29d5d2676d664000001c3-1475069941.289089-1163264539 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004460 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-28 06:59:40.878293) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-28 06:59:40.878647) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-28 06:59:40.878995) ========= ========= Total master_lag: 0.17 =========