builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-008 starttime: 1474982551.51 results: success (0) buildid: 20160927033006 builduid: f6749104b0f24b6b9524a8c280e1e7ca revision: cb212903f7036117ddbb29b3bdbc390b161b1bb2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-27 06:22:31.511859) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-27 06:22:31.512470) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-27 06:22:31.512792) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-27 06:22:31.541094) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 06:22:31.541451) ========= 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=32c5991c409366f7fec8a718000001d2-1474981754.227521-1152516045 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-27 06:22:31-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 113M=0s 2016-09-27 06:22:31 (113 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.138816 ========= master_lag: 0.26 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 06:22:31.942884) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 06:22:31.943221) ========= 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=32c5991c409366f7fec8a718000001d2-1474981754.227521-1152516045 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019084 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 06:22:32.012750) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 06:22:32.013167) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev cb212903f7036117ddbb29b3bdbc390b161b1bb2 --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 cb212903f7036117ddbb29b3bdbc390b161b1bb2 --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=32c5991c409366f7fec8a718000001d2-1474981754.227521-1152516045 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-27 06:22:32,145 truncating revision to first 12 chars 2016-09-27 06:22:32,145 Setting DEBUG logging. 2016-09-27 06:22:32,145 attempt 1/10 2016-09-27 06:22:32,145 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/cb212903f703?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-27 06:22:32,759 unpacking tar archive at: fx-team-cb212903f703/testing/mozharness/ program finished with exit code 0 elapsedTime=0.937979 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 06:22:32.971665) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-27 06:22:32.972019) ========= script_repo_revision: cb212903f7036117ddbb29b3bdbc390b161b1bb2 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-27 06:22:32.972484) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-27 06:22:32.972795) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-27 06:22:32.983812) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-09-27 06:22:32.984232) ========= /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=32c5991c409366f7fec8a718000001d2-1474981754.227521-1152516045 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:22:33 INFO - MultiFileLogger online at 20160927 06:22:33 in /builds/slave/test 06:22:33 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:22:33 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:22:33 INFO - {'append_to_log': False, 06:22:33 INFO - 'base_work_dir': '/builds/slave/test', 06:22:33 INFO - 'blob_upload_branch': 'Fx-Team', 06:22:33 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:22:33 INFO - 'branch': 'Fx-Team', 06:22:33 INFO - 'buildbot_json_path': 'buildprops.json', 06:22:33 INFO - 'config_files': ('talos/linux_config.py',), 06:22:33 INFO - 'default_actions': ('clobber', 06:22:33 INFO - 'read-buildbot-config', 06:22:33 INFO - 'download-and-extract', 06:22:33 INFO - 'populate-webroot', 06:22:33 INFO - 'create-virtualenv', 06:22:33 INFO - 'install', 06:22:33 INFO - 'run-tests'), 06:22:33 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:22:33 INFO - 'download_minidump_stackwalk': True, 06:22:33 INFO - 'download_symbols': 'ondemand', 06:22:33 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:22:33 INFO - 'tooltool.py': '/tools/tooltool.py', 06:22:33 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:22:33 INFO - '/tools/misc-python/virtualenv.py')}, 06:22:33 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:22:33 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:22:33 INFO - 'installer_path': 'installer.exe', 06:22:33 INFO - 'log_level': 'info', 06:22:33 INFO - 'log_name': 'talos', 06:22:33 INFO - 'log_to_console': True, 06:22:33 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:22:33 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:22:33 INFO - 'opt_config_files': (), 06:22:33 INFO - 'pip_index': False, 06:22:33 INFO - 'sps_profile': False, 06:22:33 INFO - 'sps_profile_interval': 0, 06:22:33 INFO - 'suite': 'dromaeojs-e10s', 06:22:33 INFO - 'system_bits': '32', 06:22:33 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:22:33 INFO - 'title': 'talos-linux64-ix-008', 06:22:33 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:22:33 INFO - 'use_talos_json': True, 06:22:33 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:22:33 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:22:33 INFO - 'work_dir': 'build'} 06:22:33 INFO - [mozharness: 2016-09-27 13:22:33.206036Z] Running clobber step. 06:22:33 INFO - Running pre-action listener: _resource_record_pre_action 06:22:33 INFO - Running main action method: clobber 06:22:33 INFO - rmtree: /builds/slave/test/build 06:22:33 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:22:34 INFO - Running post-action listener: _resource_record_post_action 06:22:34 INFO - [mozharness: 2016-09-27 13:22:34.173816Z] Finished clobber step (success) 06:22:34 INFO - [mozharness: 2016-09-27 13:22:34.173914Z] Running read-buildbot-config step. 06:22:34 INFO - Running pre-action listener: _resource_record_pre_action 06:22:34 INFO - Running main action method: read_buildbot_config 06:22:34 INFO - Using buildbot properties: 06:22:34 INFO - { 06:22:34 INFO - "project": "", 06:22:34 INFO - "product": "firefox", 06:22:34 INFO - "script_repo_revision": "production", 06:22:34 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 06:22:34 INFO - "repository": "", 06:22:34 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 06:22:34 INFO - "buildid": "20160927033006", 06:22:34 INFO - "pgo_build": "True", 06:22:34 INFO - "basedir": "/builds/slave/test", 06:22:34 INFO - "buildnumber": 771, 06:22:34 INFO - "slavename": "talos-linux64-ix-008", 06:22:34 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 06:22:34 INFO - "platform": "ubuntu64_hw", 06:22:34 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 06:22:34 INFO - "branch": "fx-team", 06:22:34 INFO - "repo_path": "integration/fx-team", 06:22:34 INFO - "revision": "cb212903f7036117ddbb29b3bdbc390b161b1bb2", 06:22:34 INFO - "stage_platform": "linux64-pgo", 06:22:34 INFO - "builduid": "f6749104b0f24b6b9524a8c280e1e7ca", 06:22:34 INFO - "slavebuilddir": "test" 06:22:34 INFO - } 06:22:34 INFO - Found installer url https://queue.taskcluster.net/v1/task/MYsYVFtIQOSwzpAwK0uyyg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 06:22:34 INFO - Running post-action listener: _resource_record_post_action 06:22:34 INFO - [mozharness: 2016-09-27 13:22:34.176336Z] Finished read-buildbot-config step (success) 06:22:34 INFO - [mozharness: 2016-09-27 13:22:34.176425Z] Running download-and-extract step. 06:22:34 INFO - Running pre-action listener: _resource_record_pre_action 06:22:34 INFO - Running main action method: download_and_extract 06:22:34 INFO - mkdir: /builds/slave/test/build/tests 06:22:34 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:22:34 INFO - trying https://queue.taskcluster.net/v1/task/MYsYVFtIQOSwzpAwK0uyyg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 06:22:34 INFO - Downloading https://queue.taskcluster.net/v1/task/MYsYVFtIQOSwzpAwK0uyyg/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:22:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MYsYVFtIQOSwzpAwK0uyyg/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:22:34 INFO - Downloaded 1361 bytes. 06:22:34 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 06:22:34 INFO - Using the following test package requirements: 06:22:34 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 06:22:34 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:22:34 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 06:22:34 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:22:34 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 06:22:34 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:22:34 INFO - u'jsshell-linux-x86_64.zip'], 06:22:34 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:22:34 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 06:22:34 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 06:22:34 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:22:34 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 06:22:34 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:22:34 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 06:22:34 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:22:34 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 06:22:34 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:22:34 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 06:22:34 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:22:34 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MYsYVFtIQOSwzpAwK0uyyg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 06:22:34 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MYsYVFtIQOSwzpAwK0uyyg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:22:34 INFO - Fetch https://queue.taskcluster.net/v1/task/MYsYVFtIQOSwzpAwK0uyyg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 06:22:35 INFO - Expected file size: 21984910 06:22:40 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:22:40 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MYsYVFtIQOSwzpAwK0uyyg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 06:22:40 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MYsYVFtIQOSwzpAwK0uyyg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:22:40 INFO - Fetch https://queue.taskcluster.net/v1/task/MYsYVFtIQOSwzpAwK0uyyg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 06:22:40 INFO - Expected file size: 21984910 06:22:45 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MYsYVFtIQOSwzpAwK0uyyg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 06:22:45 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MYsYVFtIQOSwzpAwK0uyyg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 06:22:45 INFO - Fetch https://queue.taskcluster.net/v1/task/MYsYVFtIQOSwzpAwK0uyyg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 06:22:46 INFO - Expected file size: 14414057 06:22:47 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:22:47 INFO - trying https://queue.taskcluster.net/v1/task/MYsYVFtIQOSwzpAwK0uyyg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 06:22:47 INFO - Downloading https://queue.taskcluster.net/v1/task/MYsYVFtIQOSwzpAwK0uyyg/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:22:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MYsYVFtIQOSwzpAwK0uyyg/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:22:49 INFO - Downloaded 59718393 bytes. 06:22:49 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/MYsYVFtIQOSwzpAwK0uyyg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 06:22:49 INFO - mkdir: /builds/slave/test/properties 06:22:49 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:22:49 INFO - Writing to file /builds/slave/test/properties/build_url 06:22:49 INFO - Contents: 06:22:49 INFO - build_url:https://queue.taskcluster.net/v1/task/MYsYVFtIQOSwzpAwK0uyyg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 06:22:50 INFO - Running post-action listener: _resource_record_post_action 06:22:50 INFO - Running post-action listener: set_extra_try_arguments 06:22:50 INFO - [mozharness: 2016-09-27 13:22:50.211491Z] Finished download-and-extract step (success) 06:22:50 INFO - [mozharness: 2016-09-27 13:22:50.211716Z] Running populate-webroot step. 06:22:50 INFO - Running pre-action listener: _resource_record_pre_action 06:22:50 INFO - Running main action method: populate_webroot 06:22:50 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:22:50 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:22:50 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:22:50 INFO - '--tppagecycles', 06:22:50 INFO - '7'], 06:22:50 INFO - 'tests': ['tsvgm']}}, 06:22:50 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:22:50 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:22:50 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:22:50 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:22:50 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:22:50 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:22:50 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:22:50 INFO - 'talos_options': ['--disable-e10s'], 06:22:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:22:50 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:22:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:22:50 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:22:50 INFO - 'talos_options': ['--disable-e10s'], 06:22:50 INFO - 'tests': ['damp', 'tps']}, 06:22:50 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:22:50 INFO - 'tests': ['damp', 'tps']}, 06:22:50 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:22:50 INFO - 'tests': ['dromaeo_dom']}, 06:22:50 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:22:50 INFO - 'g4': {'talos_options': ['--disable-e10s'], 06:22:50 INFO - 'tests': ['basic_compositor_video']}, 06:22:50 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 06:22:50 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:22:50 INFO - 'tests': ['a11yr', 06:22:50 INFO - 'ts_paint', 06:22:50 INFO - 'tpaint', 06:22:50 INFO - 'sessionrestore', 06:22:50 INFO - 'sessionrestore_no_auto_restore', 06:22:50 INFO - 'tabpaint']}, 06:22:50 INFO - 'other-e10s': {'tests': ['a11yr', 06:22:50 INFO - 'ts_paint', 06:22:50 INFO - 'tpaint', 06:22:50 INFO - 'sessionrestore', 06:22:50 INFO - 'sessionrestore_no_auto_restore', 06:22:50 INFO - 'tabpaint']}, 06:22:50 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:22:50 INFO - 'ts_paint', 06:22:50 INFO - 'tpaint', 06:22:50 INFO - 'sessionrestore', 06:22:50 INFO - 'sessionrestore_no_auto_restore', 06:22:50 INFO - 'tabpaint']}, 06:22:50 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:22:50 INFO - 'ts_paint', 06:22:50 INFO - 'tpaint', 06:22:50 INFO - 'sessionrestore', 06:22:50 INFO - 'sessionrestore_no_auto_restore', 06:22:50 INFO - 'tabpaint']}, 06:22:50 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:22:50 INFO - 'tests': ['a11yr', 06:22:50 INFO - 'ts_paint', 06:22:50 INFO - 'tpaint', 06:22:50 INFO - 'sessionrestore', 06:22:50 INFO - 'sessionrestore_no_auto_restore', 06:22:50 INFO - 'tabpaint']}, 06:22:50 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:22:50 INFO - 'tests': ['a11yr', 06:22:50 INFO - 'ts_paint', 06:22:50 INFO - 'tpaint', 06:22:50 INFO - 'sessionrestore', 06:22:50 INFO - 'sessionrestore_no_auto_restore', 06:22:50 INFO - 'tabpaint']}, 06:22:50 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:22:50 INFO - 'tests': ['tsvgx', 06:22:50 INFO - 'tsvgr_opacity', 06:22:50 INFO - 'tart', 06:22:50 INFO - 'tscrollx', 06:22:50 INFO - 'cart']}, 06:22:50 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:22:50 INFO - 'tsvgr_opacity', 06:22:50 INFO - 'tart', 06:22:50 INFO - 'tscrollx', 06:22:50 INFO - 'cart']}, 06:22:50 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:22:50 INFO - 'talos_options': ['--disable-e10s'], 06:22:50 INFO - 'tests': ['tp5o']}, 06:22:50 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:22:50 INFO - 'tests': ['tp5o']}, 06:22:50 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:22:50 INFO - 'talos_options': ['--disable-e10s', 06:22:50 INFO - '--xperf_path', 06:22:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:22:50 INFO - 'tests': ['tp5n']}, 06:22:50 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:22:50 INFO - 'talos_options': ['--xperf_path', 06:22:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:22:50 INFO - 'tests': ['tp5n']}}, 06:22:50 INFO - 'talos.zip': {'path': '', 06:22:50 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:22:50 INFO - Running post-action listener: _resource_record_post_action 06:22:50 INFO - [mozharness: 2016-09-27 13:22:50.229204Z] Finished populate-webroot step (success) 06:22:50 INFO - [mozharness: 2016-09-27 13:22:50.229293Z] Running create-virtualenv step. 06:22:50 INFO - Running pre-action listener: _resource_record_pre_action 06:22:50 INFO - Running main action method: create_virtualenv 06:22:50 INFO - Creating virtualenv /builds/slave/test/build/venv 06:22:50 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:22:50 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:22:50 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:22:50 INFO - Using real prefix '/usr' 06:22:50 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:22:50 INFO - Installing distribute.............................................................................................................................................................................................done. 06:22:52 INFO - Installing pip.................done. 06:22:52 INFO - Return code: 0 06:22:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 06:22:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 06:22:53 INFO - Reading from file tmpfile_stdout 06:22:53 INFO - Output received: 06:22:53 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:22:53 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:22:53 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:22:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:22:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:22:53 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:22:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:22:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:22:53 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 0x7f0f9b609f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15bf790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15bc930>, '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 0x15bd830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15bdcc0>, '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': '32c5991c409366f7fec8a718000001d2-1474981754.227521-1152516045', '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:22:53 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:22:53 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:22:53 INFO - Using env: {'DISPLAY': ':0', 06:22:53 INFO - 'HOME': '/home/cltbld', 06:22:53 INFO - 'LANG': 'en_US.UTF-8', 06:22:53 INFO - 'LANGUAGE': 'en_US:en', 06:22:53 INFO - 'LOGNAME': 'cltbld', 06:22:53 INFO - 'MAIL': '/var/mail/cltbld', 06:22:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:22:53 INFO - 'MOZ_NO_REMOTE': '1', 06:22:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:22:53 INFO - 'NO_EM_RESTART': '1', 06:22:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:22:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:22:53 INFO - 'PWD': '/builds/slave/test', 06:22:53 INFO - 'SHELL': '/bin/bash', 06:22:53 INFO - 'SHLVL': '1', 06:22:53 INFO - 'TERM': 'linux', 06:22:53 INFO - 'TMOUT': '86400', 06:22:53 INFO - 'USER': 'cltbld', 06:22:53 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1474981754.227521-1152516045', 06:22:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:22:53 INFO - '_': '/tools/buildbot/bin/python'} 06:22:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:22:53 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:22:53 INFO - Cleaning up... 06:22:53 INFO - Return code: 0 06:22:53 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:22:53 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:22:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:22:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:22:53 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:22:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:22:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:22:53 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 0x7f0f9b609f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15bf790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15bc930>, '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 0x15bd830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15bdcc0>, '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': '32c5991c409366f7fec8a718000001d2-1474981754.227521-1152516045', '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:22:53 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:22:53 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:22:53 INFO - Using env: {'DISPLAY': ':0', 06:22:53 INFO - 'HOME': '/home/cltbld', 06:22:53 INFO - 'LANG': 'en_US.UTF-8', 06:22:53 INFO - 'LANGUAGE': 'en_US:en', 06:22:53 INFO - 'LOGNAME': 'cltbld', 06:22:53 INFO - 'MAIL': '/var/mail/cltbld', 06:22:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:22:53 INFO - 'MOZ_NO_REMOTE': '1', 06:22:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:22:53 INFO - 'NO_EM_RESTART': '1', 06:22:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:22:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:22:53 INFO - 'PWD': '/builds/slave/test', 06:22:53 INFO - 'SHELL': '/bin/bash', 06:22:53 INFO - 'SHLVL': '1', 06:22:53 INFO - 'TERM': 'linux', 06:22:53 INFO - 'TMOUT': '86400', 06:22:53 INFO - 'USER': 'cltbld', 06:22:53 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1474981754.227521-1152516045', 06:22:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:22:53 INFO - '_': '/tools/buildbot/bin/python'} 06:22:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:22:53 INFO - Downloading/unpacking psutil>=3.1.1 06:22:53 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:22:53 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:22:53 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:22:53 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:22:53 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:22:53 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:22:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:22:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:22:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:22:55 INFO - Installing collected packages: psutil 06:22:55 INFO - Running setup.py install for psutil 06:22:55 INFO - building 'psutil._psutil_linux' extension 06:22:55 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:22:55 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:22:55 INFO - building 'psutil._psutil_posix' extension 06:22:55 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:22:55 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:22:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:22:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:22:55 INFO - Successfully installed psutil 06:22:55 INFO - Cleaning up... 06:22:56 INFO - Return code: 0 06:22:56 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:22:56 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:22:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:22:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:22:56 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:22:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:22:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:22:56 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 0x7f0f9b609f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15bf790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15bc930>, '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 0x15bd830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15bdcc0>, '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': '32c5991c409366f7fec8a718000001d2-1474981754.227521-1152516045', '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:22:56 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:22:56 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:22:56 INFO - Using env: {'DISPLAY': ':0', 06:22:56 INFO - 'HOME': '/home/cltbld', 06:22:56 INFO - 'LANG': 'en_US.UTF-8', 06:22:56 INFO - 'LANGUAGE': 'en_US:en', 06:22:56 INFO - 'LOGNAME': 'cltbld', 06:22:56 INFO - 'MAIL': '/var/mail/cltbld', 06:22:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:22:56 INFO - 'MOZ_NO_REMOTE': '1', 06:22:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:22:56 INFO - 'NO_EM_RESTART': '1', 06:22:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:22:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:22:56 INFO - 'PWD': '/builds/slave/test', 06:22:56 INFO - 'SHELL': '/bin/bash', 06:22:56 INFO - 'SHLVL': '1', 06:22:56 INFO - 'TERM': 'linux', 06:22:56 INFO - 'TMOUT': '86400', 06:22:56 INFO - 'USER': 'cltbld', 06:22:56 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1474981754.227521-1152516045', 06:22:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:22:56 INFO - '_': '/tools/buildbot/bin/python'} 06:22:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:22:56 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:22:56 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:22:56 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:22:56 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:22:56 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:22:56 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:22:56 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:22:58 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:22:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:22:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:22:58 INFO - Installing collected packages: mozsystemmonitor 06:22:58 INFO - Running setup.py install for mozsystemmonitor 06:22:58 INFO - Successfully installed mozsystemmonitor 06:22:58 INFO - Cleaning up... 06:22:58 INFO - Return code: 0 06:22:58 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:22:58 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:22:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:22:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:22:58 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:22:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:22:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:22:58 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 0x7f0f9b609f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15bf790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15bc930>, '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 0x15bd830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15bdcc0>, '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': '32c5991c409366f7fec8a718000001d2-1474981754.227521-1152516045', '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:22:58 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:22:58 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:22:58 INFO - Using env: {'DISPLAY': ':0', 06:22:58 INFO - 'HOME': '/home/cltbld', 06:22:58 INFO - 'LANG': 'en_US.UTF-8', 06:22:58 INFO - 'LANGUAGE': 'en_US:en', 06:22:58 INFO - 'LOGNAME': 'cltbld', 06:22:58 INFO - 'MAIL': '/var/mail/cltbld', 06:22:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:22:58 INFO - 'MOZ_NO_REMOTE': '1', 06:22:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:22:58 INFO - 'NO_EM_RESTART': '1', 06:22:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:22:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:22:58 INFO - 'PWD': '/builds/slave/test', 06:22:58 INFO - 'SHELL': '/bin/bash', 06:22:58 INFO - 'SHLVL': '1', 06:22:58 INFO - 'TERM': 'linux', 06:22:58 INFO - 'TMOUT': '86400', 06:22:58 INFO - 'USER': 'cltbld', 06:22:58 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1474981754.227521-1152516045', 06:22:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:22:58 INFO - '_': '/tools/buildbot/bin/python'} 06:22:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:22:58 INFO - Downloading/unpacking jsonschema==2.5.1 06:22:58 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:22:58 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:22:58 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:22:58 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:22:58 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:22:58 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:23:00 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:23:00 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:23:00 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:23:00 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:23:00 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:23:00 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:23:00 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:23:00 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:23:00 INFO - Downloading functools32-3.2.3-2.tar.gz 06:23:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:23:00 INFO - warning: no files found matching '*.txt' 06:23:00 INFO - no previously-included directories found matching 'build' 06:23:00 INFO - no previously-included directories found matching 'dist' 06:23:00 INFO - no previously-included directories found matching '.git*' 06:23:00 INFO - Installing collected packages: jsonschema, functools32 06:23:00 INFO - Running setup.py install for functools32 06:23:00 INFO - warning: no files found matching '*.txt' 06:23:00 INFO - no previously-included directories found matching 'build' 06:23:00 INFO - no previously-included directories found matching 'dist' 06:23:00 INFO - no previously-included directories found matching '.git*' 06:23:00 INFO - Successfully installed jsonschema functools32 06:23:00 INFO - Cleaning up... 06:23:00 INFO - Return code: 0 06:23:00 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 06:23:00 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:23:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:23:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:23:00 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:23:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:23:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:23:00 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 0x7f0f9b609f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15bf790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15bc930>, '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 0x15bd830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15bdcc0>, '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': '32c5991c409366f7fec8a718000001d2-1474981754.227521-1152516045', '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:23:00 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:23:00 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:23:00 INFO - Using env: {'DISPLAY': ':0', 06:23:00 INFO - 'HOME': '/home/cltbld', 06:23:00 INFO - 'LANG': 'en_US.UTF-8', 06:23:00 INFO - 'LANGUAGE': 'en_US:en', 06:23:00 INFO - 'LOGNAME': 'cltbld', 06:23:00 INFO - 'MAIL': '/var/mail/cltbld', 06:23:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:23:00 INFO - 'MOZ_NO_REMOTE': '1', 06:23:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:23:00 INFO - 'NO_EM_RESTART': '1', 06:23:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:23:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:23:00 INFO - 'PWD': '/builds/slave/test', 06:23:00 INFO - 'SHELL': '/bin/bash', 06:23:00 INFO - 'SHLVL': '1', 06:23:00 INFO - 'TERM': 'linux', 06:23:00 INFO - 'TMOUT': '86400', 06:23:00 INFO - 'USER': 'cltbld', 06:23:00 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1474981754.227521-1152516045', 06:23:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:23:00 INFO - '_': '/tools/buildbot/bin/python'} 06:23:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:23:01 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 06:23:01 INFO - Cleaning up... 06:23:01 INFO - Return code: 0 06:23:01 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:23:01 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:23:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:23:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:23:01 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:23:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:23:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:23:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.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 0x7f0f9b609f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15bf790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15bc930>, '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 0x15bd830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15bdcc0>, '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': '32c5991c409366f7fec8a718000001d2-1474981754.227521-1152516045', '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:23:01 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:23:01 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:23:01 INFO - Using env: {'DISPLAY': ':0', 06:23:01 INFO - 'HOME': '/home/cltbld', 06:23:01 INFO - 'LANG': 'en_US.UTF-8', 06:23:01 INFO - 'LANGUAGE': 'en_US:en', 06:23:01 INFO - 'LOGNAME': 'cltbld', 06:23:01 INFO - 'MAIL': '/var/mail/cltbld', 06:23:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:23:01 INFO - 'MOZ_NO_REMOTE': '1', 06:23:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:23:01 INFO - 'NO_EM_RESTART': '1', 06:23:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:23:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:23:01 INFO - 'PWD': '/builds/slave/test', 06:23:01 INFO - 'SHELL': '/bin/bash', 06:23:01 INFO - 'SHLVL': '1', 06:23:01 INFO - 'TERM': 'linux', 06:23:01 INFO - 'TMOUT': '86400', 06:23:01 INFO - 'USER': 'cltbld', 06:23:01 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1474981754.227521-1152516045', 06:23:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:23:01 INFO - '_': '/tools/buildbot/bin/python'} 06:23:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:23:01 INFO - Downloading/unpacking blobuploader==1.2.4 06:23:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:23:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:23:01 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:23:01 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:23:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:23:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:23:03 INFO - Downloading blobuploader-1.2.4.tar.gz 06:23:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:23:03 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:23:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:23:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:23:03 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:23:03 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:23:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:23:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:23:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:23:03 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:23:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:23:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:23:03 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:23:03 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:23:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:23:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:23:04 INFO - Downloading docopt-0.6.1.tar.gz 06:23:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:23:04 INFO - Installing collected packages: blobuploader, requests, docopt 06:23:04 INFO - Running setup.py install for blobuploader 06:23:04 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:23:04 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:23:04 INFO - Running setup.py install for requests 06:23:04 INFO - Running setup.py install for docopt 06:23:04 INFO - Successfully installed blobuploader requests docopt 06:23:04 INFO - Cleaning up... 06:23:04 INFO - Return code: 0 06:23:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:23: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:23:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:23:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:23: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:23:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:23:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:23:04 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 0x7f0f9b609f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15bf790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15bc930>, '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 0x15bd830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15bdcc0>, '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': '32c5991c409366f7fec8a718000001d2-1474981754.227521-1152516045', '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:23:04 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:23:04 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:23:04 INFO - Using env: {'DISPLAY': ':0', 06:23:04 INFO - 'HOME': '/home/cltbld', 06:23:04 INFO - 'LANG': 'en_US.UTF-8', 06:23:04 INFO - 'LANGUAGE': 'en_US:en', 06:23:04 INFO - 'LOGNAME': 'cltbld', 06:23:04 INFO - 'MAIL': '/var/mail/cltbld', 06:23:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:23:04 INFO - 'MOZ_NO_REMOTE': '1', 06:23:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:23:04 INFO - 'NO_EM_RESTART': '1', 06:23:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:23:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:23:04 INFO - 'PWD': '/builds/slave/test', 06:23:04 INFO - 'SHELL': '/bin/bash', 06:23:04 INFO - 'SHLVL': '1', 06:23:04 INFO - 'TERM': 'linux', 06:23:04 INFO - 'TMOUT': '86400', 06:23:04 INFO - 'USER': 'cltbld', 06:23:04 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1474981754.227521-1152516045', 06:23:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:23:04 INFO - '_': '/tools/buildbot/bin/python'} 06:23:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:23:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:23:05 INFO - Running setup.py (path:/tmp/pip-owoFRM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:23:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:23:05 INFO - Running setup.py (path:/tmp/pip-CnQyWX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:23:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:23:05 INFO - Running setup.py (path:/tmp/pip-fdUpBQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:23:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:23:05 INFO - Running setup.py (path:/tmp/pip-aQ1THg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:23:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:23:05 INFO - Running setup.py (path:/tmp/pip-lRBXSh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:23:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:23:05 INFO - Running setup.py (path:/tmp/pip-eiBzM3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:23:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:23:05 INFO - Running setup.py (path:/tmp/pip-Wnng1p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:23:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:23:05 INFO - Running setup.py (path:/tmp/pip-0qI0Z_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:23:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:23:05 INFO - Running setup.py (path:/tmp/pip-R40qBJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:23:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:23:05 INFO - Running setup.py (path:/tmp/pip-q7UCpF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:23:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:23:05 INFO - Running setup.py (path:/tmp/pip-vtbsFP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:23:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:23:05 INFO - Running setup.py (path:/tmp/pip-iIPfIk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:23:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:23:05 INFO - Running setup.py (path:/tmp/pip-er6Nyi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:23:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:23:05 INFO - Running setup.py (path:/tmp/pip-zSdf_2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:23:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:23:06 INFO - Running setup.py (path:/tmp/pip-4IHU1T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:23:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:23:06 INFO - Running setup.py (path:/tmp/pip-wWs6rq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:23:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:23:06 INFO - Running setup.py (path:/tmp/pip-EyH2xH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:23:06 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:23:06 INFO - Running setup.py install for manifestparser 06:23:06 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:23:06 INFO - Running setup.py install for mozcrash 06:23:06 INFO - Running setup.py install for mozdebug 06:23:06 INFO - Running setup.py install for mozdevice 06:23:06 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:23:06 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:23:06 INFO - Running setup.py install for mozfile 06:23:06 INFO - Running setup.py install for mozhttpd 06:23:06 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:23:06 INFO - Running setup.py install for mozinfo 06:23:06 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:23:06 INFO - Running setup.py install for mozInstall 06:23:07 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:23:07 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:23:07 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:23:07 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:23:07 INFO - Running setup.py install for mozleak 06:23:07 INFO - Running setup.py install for mozlog 06:23:07 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:23:07 INFO - Running setup.py install for moznetwork 06:23:07 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:23:07 INFO - Running setup.py install for mozprocess 06:23:07 INFO - Running setup.py install for mozprofile 06:23:07 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:23:07 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:23:07 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:23:07 INFO - Running setup.py install for mozrunner 06:23:07 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:23:07 INFO - Running setup.py install for mozscreenshot 06:23:07 INFO - Running setup.py install for moztest 06:23:07 INFO - Running setup.py install for mozversion 06:23:07 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:23:08 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:23:08 INFO - Cleaning up... 06:23:08 INFO - Return code: 0 06:23:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:23:08 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:23:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:23:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:23:08 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:23:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:23:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:23:08 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 0x7f0f9b609f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15bf790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15bc930>, '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 0x15bd830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15bdcc0>, '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': '32c5991c409366f7fec8a718000001d2-1474981754.227521-1152516045', '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:23:08 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:23:08 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:23:08 INFO - Using env: {'DISPLAY': ':0', 06:23:08 INFO - 'HOME': '/home/cltbld', 06:23:08 INFO - 'LANG': 'en_US.UTF-8', 06:23:08 INFO - 'LANGUAGE': 'en_US:en', 06:23:08 INFO - 'LOGNAME': 'cltbld', 06:23:08 INFO - 'MAIL': '/var/mail/cltbld', 06:23:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:23:08 INFO - 'MOZ_NO_REMOTE': '1', 06:23:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:23:08 INFO - 'NO_EM_RESTART': '1', 06:23:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:23:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:23:08 INFO - 'PWD': '/builds/slave/test', 06:23:08 INFO - 'SHELL': '/bin/bash', 06:23:08 INFO - 'SHLVL': '1', 06:23:08 INFO - 'TERM': 'linux', 06:23:08 INFO - 'TMOUT': '86400', 06:23:08 INFO - 'USER': 'cltbld', 06:23:08 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1474981754.227521-1152516045', 06:23:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:23:08 INFO - '_': '/tools/buildbot/bin/python'} 06:23:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:23:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:23:08 INFO - Running setup.py (path:/tmp/pip-AG41bv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:23:08 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:23:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:23:08 INFO - Running setup.py (path:/tmp/pip-UimUZ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:23:08 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:23:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:23:08 INFO - Running setup.py (path:/tmp/pip-Riqu37-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:23:08 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:23:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:23:08 INFO - Running setup.py (path:/tmp/pip-EU8u3F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:23:08 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:23:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:23:08 INFO - Running setup.py (path:/tmp/pip-x4lfXh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:23:08 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:23:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:23:08 INFO - Running setup.py (path:/tmp/pip-PT3P7r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:23:08 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:23:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:23:08 INFO - Running setup.py (path:/tmp/pip-LX60cv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:23:08 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:23:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:23:08 INFO - Running setup.py (path:/tmp/pip-8LukdB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:23:08 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:23:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:23:08 INFO - Running setup.py (path:/tmp/pip-G7uPDF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:23:08 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:23:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:23:08 INFO - Running setup.py (path:/tmp/pip-SPkcbp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:23:08 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:23:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:23:08 INFO - Running setup.py (path:/tmp/pip-TFw7v6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:23:09 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:23:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:23:09 INFO - Running setup.py (path:/tmp/pip-ZVOfu4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:23:09 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:23:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:23:09 INFO - Running setup.py (path:/tmp/pip-N7UvPR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:23:09 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:23:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:23:09 INFO - Running setup.py (path:/tmp/pip-ZvRLfF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:23:09 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:23:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:23:09 INFO - Running setup.py (path:/tmp/pip-XqDnn4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:23:09 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:23:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:23:09 INFO - Running setup.py (path:/tmp/pip-65X1Zs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:23:09 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:23:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:23:09 INFO - Running setup.py (path:/tmp/pip-Q74kqn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:23:09 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:23:09 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:23:09 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:23:09 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:23:09 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:23:09 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:23:09 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:23:09 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:23:09 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:23:09 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:23:09 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:23:09 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:23:09 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:23:11 INFO - Downloading blessings-1.6.tar.gz 06:23:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:23:11 INFO - Installing collected packages: blessings 06:23:11 INFO - Running setup.py install for blessings 06:23:11 INFO - Successfully installed blessings 06:23:11 INFO - Cleaning up... 06:23:11 INFO - Return code: 0 06:23:11 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:23:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:23:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:23:11 INFO - Reading from file tmpfile_stdout 06:23:11 INFO - Current package versions: 06:23:11 INFO - argparse == 1.2.1 06:23:11 INFO - blessings == 1.6 06:23:11 INFO - blobuploader == 1.2.4 06:23:11 INFO - docopt == 0.6.1 06:23:11 INFO - functools32 == 3.2.3-2 06:23:11 INFO - jsonschema == 2.5.1 06:23:11 INFO - manifestparser == 1.1 06:23:11 INFO - mozInstall == 1.12 06:23:11 INFO - mozcrash == 0.17 06:23:11 INFO - mozdebug == 0.1 06:23:11 INFO - mozdevice == 0.48 06:23:11 INFO - mozfile == 1.2 06:23:11 INFO - mozhttpd == 0.7 06:23:11 INFO - mozinfo == 0.9 06:23:11 INFO - mozleak == 0.1 06:23:11 INFO - mozlog == 3.4 06:23:11 INFO - moznetwork == 0.27 06:23:11 INFO - mozprocess == 0.23 06:23:11 INFO - mozprofile == 0.28 06:23:11 INFO - mozrunner == 6.12 06:23:11 INFO - mozscreenshot == 0.1 06:23:11 INFO - mozsystemmonitor == 0.3 06:23:11 INFO - moztest == 0.7 06:23:11 INFO - mozversion == 1.4 06:23:11 INFO - psutil == 3.1.1 06:23:11 INFO - requests == 1.2.3 06:23:11 INFO - wsgiref == 0.1.2 06:23:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:23:11 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:23:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:23:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:23:11 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:23:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:23:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:23:11 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 0x7f0f9b609f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15bf790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15bc930>, '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 0x15bd830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15bdcc0>, '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': '32c5991c409366f7fec8a718000001d2-1474981754.227521-1152516045', '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:23:11 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:23:11 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:23:11 INFO - Using env: {'DISPLAY': ':0', 06:23:11 INFO - 'HOME': '/home/cltbld', 06:23:11 INFO - 'LANG': 'en_US.UTF-8', 06:23:11 INFO - 'LANGUAGE': 'en_US:en', 06:23:11 INFO - 'LOGNAME': 'cltbld', 06:23:11 INFO - 'MAIL': '/var/mail/cltbld', 06:23:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:23:11 INFO - 'MOZ_NO_REMOTE': '1', 06:23:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:23:11 INFO - 'NO_EM_RESTART': '1', 06:23:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:23:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:23:11 INFO - 'PWD': '/builds/slave/test', 06:23:11 INFO - 'SHELL': '/bin/bash', 06:23:11 INFO - 'SHLVL': '1', 06:23:11 INFO - 'TERM': 'linux', 06:23:11 INFO - 'TMOUT': '86400', 06:23:11 INFO - 'USER': 'cltbld', 06:23:11 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1474981754.227521-1152516045', 06:23:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:23:11 INFO - '_': '/tools/buildbot/bin/python'} 06:23:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:23:12 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:23:12 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:23:12 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:23:12 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:23:12 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:23:12 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:23:12 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:23:12 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:23:12 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:23:12 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:23:12 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:23:12 INFO - Cleaning up... 06:23:12 INFO - Return code: 0 06:23:12 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:23:12 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:23:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:23:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:23:12 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:23:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:23:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:23:12 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 0x7f0f9b609f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14f28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15bf790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15bc930>, '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 0x15bd830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15bdcc0>, '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': '32c5991c409366f7fec8a718000001d2-1474981754.227521-1152516045', '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:23:12 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:23:12 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:23:12 INFO - Using env: {'DISPLAY': ':0', 06:23:12 INFO - 'HOME': '/home/cltbld', 06:23:12 INFO - 'LANG': 'en_US.UTF-8', 06:23:12 INFO - 'LANGUAGE': 'en_US:en', 06:23:12 INFO - 'LOGNAME': 'cltbld', 06:23:12 INFO - 'MAIL': '/var/mail/cltbld', 06:23:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:23:12 INFO - 'MOZ_NO_REMOTE': '1', 06:23:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:23:12 INFO - 'NO_EM_RESTART': '1', 06:23:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:23:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:23:12 INFO - 'PWD': '/builds/slave/test', 06:23:12 INFO - 'SHELL': '/bin/bash', 06:23:12 INFO - 'SHLVL': '1', 06:23:12 INFO - 'TERM': 'linux', 06:23:12 INFO - 'TMOUT': '86400', 06:23:12 INFO - 'USER': 'cltbld', 06:23:12 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1474981754.227521-1152516045', 06:23:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:23:12 INFO - '_': '/tools/buildbot/bin/python'} 06:23:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:23:12 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:23:12 INFO - Cleaning up... 06:23:12 INFO - Return code: 0 06:23:12 INFO - Running post-action listener: _resource_record_post_action 06:23:12 INFO - Running post-action listener: _start_resource_monitoring 06:23:12 INFO - Starting resource monitoring. 06:23:12 INFO - [mozharness: 2016-09-27 13:23:12.365958Z] Finished create-virtualenv step (success) 06:23:12 INFO - [mozharness: 2016-09-27 13:23:12.366491Z] Running install step. 06:23:12 INFO - Running pre-action listener: _resource_record_pre_action 06:23:12 INFO - Running main action method: install 06:23:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:23:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:23:12 INFO - Reading from file tmpfile_stdout 06:23:12 INFO - Detecting whether we're running mozinstall >=1.0... 06:23:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:23:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:23:12 INFO - Reading from file tmpfile_stdout 06:23:12 INFO - Output received: 06:23:12 INFO - Usage: mozinstall [options] installer 06:23:12 INFO - Options: 06:23:12 INFO - -h, --help show this help message and exit 06:23:12 INFO - -d DEST, --destination=DEST 06:23:12 INFO - Directory to install application into. [default: 06:23:12 INFO - "/builds/slave/test"] 06:23:12 INFO - --app=APP Application being installed. [default: firefox] 06:23:12 INFO - mkdir: /builds/slave/test/build/application 06:23:12 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:23:12 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:23:29 INFO - Reading from file tmpfile_stdout 06:23:29 INFO - Output received: 06:23:29 INFO - /builds/slave/test/build/application/firefox/firefox 06:23:29 INFO - Running post-action listener: _resource_record_post_action 06:23:29 INFO - [mozharness: 2016-09-27 13:23:29.697327Z] Finished install step (success) 06:23:29 INFO - [mozharness: 2016-09-27 13:23:29.697570Z] Running run-tests step. 06:23:29 INFO - Running pre-action listener: _resource_record_pre_action 06:23:29 INFO - Running main action method: run_tests 06:23:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:23:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:23:29 INFO - Python 2.7.3 06:23:29 INFO - Return code: 0 06:23:29 INFO - grabbing minidump binary from tooltool 06:23: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:23:29 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15bc930>, '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 0x15bd830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15bdcc0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:23:29 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 06:23:29 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 06:23:29 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 06:23:29 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:23:29 INFO - Return code: 0 06:23:29 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:23:29 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:23:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:23:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:23:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:23:29 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/MYsYVFtIQOSwzpAwK0uyyg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--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:23:29 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/MYsYVFtIQOSwzpAwK0uyyg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-008 --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:23:29 INFO - Using env: {'DISPLAY': ':0', 06:23:29 INFO - 'HOME': '/home/cltbld', 06:23:29 INFO - 'LANG': 'en_US.UTF-8', 06:23:29 INFO - 'LANGUAGE': 'en_US:en', 06:23:29 INFO - 'LOGNAME': 'cltbld', 06:23:29 INFO - 'MAIL': '/var/mail/cltbld', 06:23:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:23:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:23:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:23:29 INFO - 'MOZ_NO_REMOTE': '1', 06:23:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:23:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:23:29 INFO - 'NO_EM_RESTART': '1', 06:23:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:23:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:23:29 INFO - 'PWD': '/builds/slave/test', 06:23:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:23:29 INFO - 'SHELL': '/bin/bash', 06:23:29 INFO - 'SHLVL': '1', 06:23:29 INFO - 'TERM': 'linux', 06:23:29 INFO - 'TMOUT': '86400', 06:23:29 INFO - 'USER': 'cltbld', 06:23:29 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1474981754.227521-1152516045', 06:23:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:23:29 INFO - '_': '/tools/buildbot/bin/python'} 06:23:29 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/MYsYVFtIQOSwzpAwK0uyyg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--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:23:29 INFO - mozversion application_buildid: 20160927033006 06:23:29 INFO - mozversion application_changeset: cb212903f7036117ddbb29b3bdbc390b161b1bb2 06:23:29 INFO - mozversion application_display_name: Nightly 06:23:29 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:23:29 INFO - mozversion application_name: Firefox 06:23:29 INFO - mozversion application_remotingname: firefox 06:23:29 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 06:23:29 INFO - mozversion application_vendor: Mozilla 06:23:29 INFO - mozversion application_version: 52.0a1 06:23:29 INFO - mozversion platform_buildid: 20160927033006 06:23:29 INFO - mozversion platform_changeset: cb212903f7036117ddbb29b3bdbc390b161b1bb2 06:23:29 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 06:23:29 INFO - mozversion platform_version: 52.0a1 06:23:29 INFO - using testdate: 1474982609 06:23:29 INFO - actual date: 1474982609 06:23:29 INFO - starting webserver on 'localhost:37358' 06:23:29 INFO - SUITE-START | Running 2 tests 06:23:29 INFO - TEST-START | dromaeo_css 06:23:29 INFO - operating with platform_type : linux_ 06:23:29 INFO - Initialising browser for dromaeo_css test... 06:23:29 INFO - TEST-INFO | started process 10952 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpC808uZ/profile http://localhost:37358/getInfo.html) 06:23:34 INFO - PROCESS | 10952 | __metrics Screen width/height:1600/1200 06:23:34 INFO - PROCESS | 10952 | colorDepth:24 06:23:34 INFO - PROCESS | 10952 | Browser inner width/height: 1024/697 06:23:34 INFO - PROCESS | 10952 | __metrics 06:23:35 ERROR - PROCESS | 10952 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3067: TypeError: this.tabs is undefined 06:23:36 INFO - TEST-INFO | 10952: exit 0 06:23:36 INFO - Browser initialized. 06:23:36 INFO - Running cycle 1/1 for dromaeo_css test... 06:23:36 INFO - TEST-INFO | started process 11072 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpC808uZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:23:48 INFO - PROCESS | 11072 | RSS: Main: 185217024 06:23:48 INFO - PROCESS | 11072 | 06:24:37 INFO - PROCESS | 11072 | 1474982677871 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:26:47 INFO - PROCESS | 11072 | Cycle 1(1): loaded http://localhost:37358/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37358/tests/dromaeo/cssquery-ext.html) 06:26:48 INFO - PROCESS | 11072 | RSS: Main: 200531968 06:26:48 INFO - PROCESS | 11072 | 06:29:50 INFO - PROCESS | 11072 | Cycle 1(1): loaded http://localhost:37358/tests/dromaeo/cssquery-ext.html (next: http://localhost:37358/tests/dromaeo/cssquery-jquery.html) 06:29:51 INFO - PROCESS | 11072 | RSS: Main: 197398528 06:29:51 INFO - PROCESS | 11072 | 06:32:53 INFO - PROCESS | 11072 | Cycle 1(1): loaded http://localhost:37358/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37358/tests/dromaeo/cssquery-mootools.html) 06:32:53 INFO - PROCESS | 11072 | RSS: Main: 198860800 06:32:53 INFO - PROCESS | 11072 | 06:35:55 INFO - PROCESS | 11072 | Cycle 1(1): loaded http://localhost:37358/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37358/tests/dromaeo/cssquery-prototype.html) 06:35:56 INFO - PROCESS | 11072 | RSS: Main: 195457024 06:35:56 INFO - PROCESS | 11072 | 06:38:58 INFO - PROCESS | 11072 | Cycle 1(1): loaded http://localhost:37358/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37358/tests/dromaeo/cssquery-yui.html) 06:38:59 INFO - PROCESS | 11072 | RSS: Main: 199327744 06:38:59 INFO - PROCESS | 11072 | 06:42:02 INFO - PROCESS | 11072 | Cycle 1(1): loaded http://localhost:37358/tests/dromaeo/cssquery-yui.html (next: http://localhost:37358/tests/dromaeo/cssquery-dojo.html) 06:42:02 INFO - PROCESS | 11072 | RSS: Main: 199376896 06:42:02 INFO - PROCESS | 11072 | 06:42:02 INFO - PROCESS | 11072 | __start_tp_report 06:42:02 INFO - PROCESS | 11072 | _x_x_mozilla_page_load 06:42:02 INFO - PROCESS | 11072 | _x_x_mozilla_page_load_details 06:42:02 INFO - PROCESS | 11072 | |i|pagename|runs| 06:42:02 INFO - PROCESS | 11072 | |0;dojo.html;3025.8335791531463;3047.3143542702883;3061.647910490293;3075;3082.0445661844824;5277.815276465324;5323.92014119788;5355.6518826276315;5386.380566234884;5465.398806131322;5310.8141215057485;5311.681299122055;5384.515393614574;5448.673079615226;5452.372977107634;4845.176320025586;4851.854444366666;4936.5063493650705;4977.900441991158;4982.352294201767;4957.628177886655;5000.799968001275;5017.297578339036;5027.069992051483;5078.7968481260705;4793.712377257376;4810.8316208932865;4964.6276529260085;5027.874303142414;5038.168702164138;4847.51524847516;4852.878678033042;4906.975465122688;4928.285398617216;4994.425641051289;4849.539293767087;4887.902241955177;4890.413150421937;4893.657443978923;4949.777260023272;5220.582353411756;5345.786168553253;5350.571954243651;5377.596680248997;5384.515393614593;5639.8590035249035;5672.205891175197;5692.0323544997445;5714.971425142848;5812.970935145339;5756.453136951983;5775.711214439261;5777.046787280094;5785.218995435646;5786.508146807527;5370.704611246419;5377.838664840061;5379;5391.919121213106;5396.055690254189;5676.659400435987;5726.541876649858;5794.50746686528;5795.246617939641;5809.912851307234;5526.06056970316;5533.474319939599;5534.363548192009;5536.474034966672;5570.749316280777;5652.802151924663;5660.377358490563;5719.256496655408;5727.455891690282;5745.770169193269;5580.776768929279;5634.943650563524;5675.545956323567;5684.37471878093;5698.2592263005545;5728.77084916607;5733.369329373765;5737.225474560881;5750.7987220447085;5764.13537969308;4377.890552736207;4412.227860124465;4434.667399945017;4450.5549445055885;4509.887252818706;3930.9213815723524;3947.5657677655436;3975.8210880510446;4005.0988527581644;4032.294348489003;5470.070088085035;5502.064649009678;5509.669419834742;5538.944610553924;5580;5605.635633683797;5810.535157187415;5840.445157710011;5842.532597392198;5852.94147058524;5329.8934021319355;5402.783888644411;5469.890602187934;5502.257195278667;5556.611037227436;4953.479884612136;4959.404871415453;4960.429550601727;4968.403791545038;5026.824061157842;5935.495482884004;5942.257217847769;5944.554158438048;5952.7023648817385;5963.970180149072;5613.663180209037;5642.407547207648;5718.7998420056765;5745;5756.079027355603;5914.585978981602;5923.200367950271;5928.703564821828;5947;5996.130561068533;5690.601657883908;5705.914411283917;5709.771609135754;5714.171445140514;5714.228579141763;5651.180578816131;5695.943040569541;5698.6580805151825;5721.885562288814;5772.913406298825;5568.55451563882;5613.522850557585;5629.408912064175;5647.463490968352;5677.545796336366;5566.415526369835;5601.215829783915;5609.186667933209;5616.354119276336;5617.297837770278;5445.754941027584;5446.809361672323;5477.3427188737605;5492.588055895903;5505.642133261325;5702.743376547983;5708.400617935057;5709.058005429224;5712.34308054579;5714.628549144292;5553.416891226363;5559.555235581225;5564.38791732901;5564.4991950724625;5566.081596536526 06:42:02 INFO - PROCESS | 11072 | |1;ext.html;544.0067784207434;579.1052823387865;591.1635036423461;597.4055814464608;607.3865395950091;41896;43427;43452.56547434525;46938.295925561055;47303.45224108188;44318.556814431846;44816;44824.3276350855;45014.54985450144;45067.09865802682;8883.733487995354;9017.864732029026;9034.277257819358;9038.457692538435;9051.14014168653;8827.73516794494;8828.161324674178;8843.380963332569;8865.911340886605;8913.55432228386;8828.073052329477;8865.822683546357;8875.68935087272;8879.866801997976;8892.555372231363;8833.690820821272;8834.072422395653;8837.867431988558;8884.156005179562;8889.688860889903;8729.781755456164;8779.824403511893;8839.16027977341;8850.159234872677;8865.936087669521;42048.36927446091;42258.1548369034;42356.78821605903;42441.36337954933;42831;3241.8865339712997;3350.8324583770714;3386.86452541898;3426.3318652862704;3495.8077305748175;29417.55873661897;30125.849370753007;31994.840025799724;32238.194045148823;32424.513632295533;4189.62293393593;4303.074838909618;4316.848910288125;4369.104333611634;4469.7318160910445;327149;331658;332703;333895;334677.3266133678;61234.38765612376;61657;62281.37718622846;62281.688591556755;62420;36937.44593831095;37579;37777.24445511075;39936.201275974316;40202.39696404556;17194.570135746708;17278.963262204306;17426.564335891704;17461.912690436468;17513.649727005388;13039.608811735663;13100.868991309964;13127.409266583027;13147.53983610569;13151.67120821968;19602.21591136367;19794.90102549507;19884.60230795376;19884.90057549703;19919.800801992085;7408.592527411044;7632.5038872473115;7676.270754278335;7773.68905243784;7885.526868387915;857.8284343131398;997.2470784557613;1000.4347543637822;1014.822406078948;1097.6103483263487;32394;32535.511967320508;32548.349033019207;32554.186145346557;33136.33727325488;1119.5857532712948;1122.1639878290725;1123.8819923908036;1166.912481563886;1171.0221964659434;15810.68378632444;16923.915380423266;17218.741718874226;17224.569385765455;17262;468035.65982169873;468278;470950;471756;472212;58537.41462585405;58556;59063.40936590579;59078.40921590815;59204.40795591989;1277.3166355999497;1325.4095085896963;1331.2877610478347;1339.5177736015028;1345.132389608697;28553.857230713715;31482.37035259328;31902.680973190898;32008.35983280368;32043.146891838936;47003.76498117488;47067.29399058948;47068.7646561765;47086.293705595126;47255;391570;392087;393278;394061;394157;29306.560401593568;29378.55932161062;29457.263568410963;29725.851370743007;29891;46845;46911.530884690714;47575.85908634189;48753.26870097022;48887;39584.40623390709;39850.402243965786;40096.39855402113;41131.58868411397;41797;41004.1799164021;41169;41817;41881.37177942273;41976.1604767909;34976.125596860285;35754;40457.59542404656;41334;41612.79193604013;33191.66808331886;36565.45151822671;37181.81409092937;37773;37994.62005379911;27881.442371152058;28130.437391252468;28209.858950705937;28439.43121137607;28527.714722852506 06:42:02 INFO - PROCESS | 11072 | |2;jquery.html;378.1284140057168;387.4111350746864;395.7981429470969;395.99231894295895;418.43093392985537;17504.824951750477;18943.431697049076;18982.525436864085;18996.810031899677;19945.301914433;18838.52903677409;19128.61742765144;19366.32217872375;19544.511387215327;19580.608387832235;5493.917591236134;5512;5631;5644.491995720385;5705.686187259699;5572.916406253909;5573.21974923509;5623.718814059301;5669.064604340299;5673.971630141864;5433.7283135843245;5482.369527504328;5561.165825126223;5574.202531016128;5591.049521581341;5550.084236101038;5571.275734154554;5586.86032849178;5589.133684278943;5591.440855914376;4853.150698627726;4868.391451068616;4912.8700398908095;4913.385826771653;4918;22691.659625105636;22764.95408289898;22844.31467055991;23087.653685194568;23287.7671223289;2280.5894938910988;2333.5216280662426;2335.2760644200184;2347.9882600587057;2511.234073607549;14056.859431405657;14535.418583256656;14588.197649129293;14609.269536523238;15158.924205379013;1894.8673592848368;1934.3906669399094;1950.4343740315433;2012.4666963254604;2071.7513898332145;82215.588922055;83465.58267208625;83914.58042709809;84773;85129;10966.725831854268;11149.554017839195;11178.149571859123;11311.83032254517;11505.769884602261;15484.535463935874;15516.922415387851;15537.844621553866;15576.532704018671;15636.843631563766;8183.590820458953;8316.916830831735;8389.706360277483;8542.060373358925;8560.315174786003;7580.848383032308;7801.80495487606;7974.401919856034;8013.15861834499;8229.556039738594;4593.356930029799;4760.857174284777;4827.275908613666;4877.244027175793;4905.656604037683;1992.9402117936486;2063.030375723408;2073.5438203595186;2081.7732514602308;2090.3937858021004;902.4495058014605;931.4411353188033;938.6620816506053;943.9386439881386;995.0845222395413;18310.450686479428;19328.806711932702;19546.413607591796;19616;19639.607207855763;982.1651596143364;990.005328499501;1013.6097602423121;1014.9340292880939;1048.7902419516126;10343.793124137626;10913.618023369145;10963.451827408599;10974.341539507655;11012.779744405067;446209;448125;448963;449732;451901;86135.569322153;88617.55691221631;91098;95597.5220123895;95768.52115739377;1000.8198524265703;1004.1765752083368;1019.6788011776415;1020.1889497849079;1022.0239671114217;17047.48857534276;17089.48731538056;17576.82423175752;17774.555636109202;17803.198856051768;30261.697383026767;41140.794296028325;42622;43510;44226;61515.692421537606;62727.6863615679;63494.36505634885;65054;65590.34409656034;8144.959275203586;8333.666653334041;8480.194381533744;8586.699465518677;8620.741377758677;11524.481398336928;12685.365731713193;12759.744805104032;12764.29796361172;13271.137376070525;10710;10955.671329860117;10971.122310215003;11580.436641053688;11855.822162667395;10585.629502967358;10598.629047983284;10713.464326783786;11412.714682133013;11527.596534121265;11299.774004519699;11379.374134422354;11445.313281203154;11588.36264005454;11669.941650291694;8248;8273;8514.233718965323;8615.396922215636;8756.168164024408;11109.611163609236;11179.776404471702;11214.943925280322;11332.37671928019;11788.115891308358 06:42:02 INFO - PROCESS | 11072 | |3;mootools.html;1474.2923396769554;1511.0178384050369;1609.5090997245843;1687.932482700692;1762.3038899634644;7774.339181169593;8107.513549187053;8229.711960081399;8899.288056955444;8907.64369425223;8180.304674102708;8477.067522572512;8524.318054555637;8735.728710535259;8754.6935857245;2293.5412917416543;2331.079223706635;2335.311083230451;2337.567550003255;2344.6014177589764;2272.9090836366527;2277.8519396239276;2291.6562515622622;2318.9188378406675;2327.359976006595;2306.4695120122296;2317.4669825940045;2318.710161229846;2320.2227253869974;2345.3901985483812;2244.7530771615193;2250.4711392822674;2268.54629074185;2271.8977646005806;2277.2826559633745;2225.833062520301;2229.1752051740796;2240.451089483087;2244.2706120510734;2245.2815099168274;8744.344174186961;8810.779730506725;8815.030346661862;8844.33667474942;8942.329325300629;5135.152699804527;5260.763265653055;5274.630775845692;5280.498352656491;5296.496832800916;3153.22745927247;3210.1653570071717;3382.8985130446126;3384.76306658534;3393.032985599117;1167.6788883057227;1177.8527684039495;1188.144535934126;1194.7192409783695;1200.5677955935855;12120.515179392814;12165.756684866341;12193.512259509609;12212.206206596631;12255;4411.867643970621;4623.42207224097;4741.359916411309;4777.928331075037;4820.758962051884;10388.584456621802;10398.168146548258;10402.375857448576;10411.427371494488;10438.269321147447;5361.973190134102;5371.597130215249;5373.220882972026;5373.274607927958;5374.865628359323;4221.831126754957;4310.073334233092;4749.3588365570895;4838.298446725275;4926.064047830901;3908.843646254118;3962.484876965976;4029.15387768566;4037.8990525237105;4066.0851308455362;1253.129075292663;1260.0738457233927;1271.2372576454054;1280.5902111324287;1292.3796577642597;787.3897729259755;906.2704522859161;924.9815003700023;932.9766755831158;934.6168071090956;5774.711264436762;5944;5954.910676339859;6013.1581578579035;6190.7523699052435;457.39166908012265;458.68350837921724;462.3942635147967;468.84996801023345;476.7258826174963;3747.7376583638884;3865.613438656112;3869.496965394537;3885.592012838611;3917.314469967744;10597.25819192649;11053.778924421467;11100.777984440267;11126.721831954266;11131.109511239081;10788.568457261621;10898.18263630215;10934.125269978382;11016.834747478793;11102.722431939104;8173;8179.918200818035;8212.34301255898;8246.752597422086;8255.091939886728;5689.7439615218245;5707.372189059117;5727.140928860705;5747.3103227612955;5908.645481271137;9978.650747223812;10038.146757525692;10041.447720375449;10206.489675516046;10236.539355729159;9505.42967421957;9917.553710083208;9921.553530091307;10118.392896426238;10202.642907498202;6951.895721564281;7183.784486465414;7447.88828167567;7709.383249339927;7871.173526779606;8380.58097095155;8558.914410856061;8604.526751028754;8607;8629.43908645936;7576.886346704914;7583.393328533593;7772.84454310922;7829.217078292125;7833.412494062854;7377.372923301579;7519.172890982097;7525.285097915689;7565.319121279112;7757.612119393895;6869.656517174021;6988.510804243654;6993.755218567326;7003.614801185984;7024.894626580503;5160.277561141368;5175.844724658266;5219.4780521947505;5231.29377534028;5438.347398312228;5222.66052706588;5243.973780131228;5256.159014557806;5269.631125821155;5549.306336707911 06:42:02 INFO - PROCESS | 11072 | |4;prototype.html;294.7509354595368;316.3593722711509;316.76242817886583;316.8922566327449;324.9350129974006;5347.946520534793;5463.9180412293845;5480.287562616859;5572.804951826687;5587.161925711145;5293.808892999083;5393.460653934604;5421.430749771266;5435.347758269003;5473.616846820714;4233.978830105845;4257.489101307832;4270.231358355495;4272.380504826799;4275.273203555403;4176.290030694774;4234.661227101825;4249.89630133083;4250.574942505756;4253.8723838284905;4222.071144348254;4222.339925846728;4232.470941132358;4245.702800803945;4254.638355739766;4230.830766769325;4242.8727138185905;4247.426597409341;4249.745015299092;4253.97873010633;3671.94492082619;3750.906227344311;3759.793211373373;3776.206996530732;3777.2067865748227;5257.185136303879;5284.2521888618085;5291.497307755757;5300.973495132538;5341.4658534146665;4850.442199147073;4857.198562237227;4875.024995000978;4888.706677599355;4894.143524883131;5442.564594832444;5601.439856014366;5712.11462223356;5725.942740572625;5730.6275092119295;4092.260789164623;4093.713440059197;4096.631303182728;4116.444280022189;4122.649574786146;5903.439173278532;5917.644941303535;5926.792562260343;5964.105384192362;5977.641341519479;4112.424260603518;4213.314674130373;4224.746515209097;4248.511421186541;4258.5954334338185;4236.766977816188;4258.6380157686945;4264.552222016706;4273.786310684453;4290.4636920384955;4838.911244969853;4843.782029808667;4849.612031037508;4862.954464790017;4867.537583929521;5590.720463976866;5738.24564209182;5777.277840269966;5782.739776709974;5787.565932555075;1460.5545308680955;1487.8958472907009;1488.732028234928;1493.872126544452;1498.8234236124808;900.4282280751639;937.3672770879629;943.8772959515356;943.9852158929178;953.2326477185932;4785.617150627942;4845.152098382769;4863.392075990501;4874.8537543873745;4884.975575122173;5142.794288228429;5163.483651634807;5171.241777795568;5180.870478238075;5182.460594308762;4619.8845028873875;4856.15466122871;4862.246351815475;4865.9756701216265;4871.611590696634;2743.1496236166854;2748.6014527893344;2755.76575991039;2762.557990721475;2764.4609301186074;5297.920531192035;5311.442298558596;5317.335333083364;5319.973400133052;5347.919781203285;5277.551408130352;5284.233786100994;5690.236026831695;6078.787242446493;6106.72519736613;6141.385861413823;6141.508679305645;6176.7838125665385;6186.876262474725;6193.841141018203;5693.580228402995;5887.7056147193325;6011.7595296187665;6015.12780646795;6051.304100028553;5865.5600829937075;5941.7623295067715;5952.166696662384;5955.285365756137;5956.731947062479;6124.846878828065;6132.202813634199;6183.412575805291;6191.35928978812;6201.255849298113;3770.342767515506;4034.495688038995;4140.44104045962;4151.315033019518;4152.356384760367;5923.970380148072;5931.228940237742;5933.673647949404;5936.436038576328;5937.435943585352;5655.830325090254;5763.394843541536;5768.855778605568;5780.884382312246;5782.681952492653;5742.569307301886;5757.9424205757405;5770.3652598215;5773.393793651774;5785.652860828363;5692.800751973661;5695.857603559944;5699;5705.258316419005;5733.426657334233;5596.468335508121;5734.799282025109;5764.827055188351;5775.220345253337;5793.304803423616;5646.491815736439;5649.576281778801;5669.489745922887;5673.404292549388;5686.516646085129 06:42:02 INFO - PROCESS | 11072 | |5;yui.html;691.8062942376135;736.9042024536813;748.6780684305746;759.4110609012072;794.7933537280312;15059.849401505982;16414.753778693314;16472.176391180452;16517.174141292948;16532.91733541332;16548.255328510215;17013.744793828104;17151.656966860653;17175.227114779835;17177.227024783882;783.7217787685389;807.5033854179696;809.8906647602587;810.0360570920585;810.3395732478041;770.7418014964993;800.9159038300982;802.7952872017627;806.762005208462;807.4872455990429;847.8558645030329;849.4987957105307;850.7915560687641;851.0808327006818;851.2168804699692;834.0366876257932;836.9204925532065;844.2654890245465;846.0862268749767;846.8899043124385;617.1360095865779;617.7868635320852;619.4827319188483;619.5415392609436;621.6674079367561;15843;15957.920210398874;15970.201489925457;16023.679526409524;16049.2777824997;14447.349869255804;14566.635834104127;14647.560573182715;14707.264636768226;14834.703305933928;11342.206045576813;11463.36951467669;11510.942445287803;11742.060635149168;11814.763704725858;3672.412414013745;3693.113652723354;3724.3854763963914;3754.4743735877;3800.9809950950344;83441;85217;85367;85868.99999999937;86833.27750753694;10436.165718120108;10636.095931845724;10660;10706.73233169177;10841.295315804447;19107.140178691992;19351.612967740566;19589.60820783605;19981;20103.19587216495;8024.959875200587;8048.315893149031;8071.23323284287;8194.918050819535;8228.958855205685;4394.209042372404;4526.592606665416;4536.500984891659;4539.455265368111;4539.84110556129;3613.0967258185456;3694.6120657330594;3711.257748450321;3714.0714821294678;3728.5525736911745;589.6756783768996;593.489598944907;610.404855266112;615.9753609855645;636.6275728698763;598.2372475094203;653.3466533466534;661.8279247395616;662.8740539297518;666.2171947961223;8822.294216462667;8881.600327985256;8980.820383592292;9012.81974360509;9353.11145441182;589.6579983609496;639.7623174052983;640.7340953504337;640.9359064093646;663.7444583835162;4187.476565429321;4244.448221731155;4367.912641747147;4521.66087543429;4582.266837306015;78547.60726196332;125966;127070.93935909502;128714;133236;114178;115770;116915;117711;121004.68948415667;78715.60642196867;79694;79999.20000800033;88851.55574222216;96079;8305.709300174465;8988.146126118008;8999.64001439935;9054.773630659287;9199.678011269574;52465.47534524606;53936.19095713489;54802.45197547974;55056;56230.15654765264;69209.65395173193;77107.61446192733;77757.50091245794;79347;81656.59171704104;12088.093392995384;12183.329916854658;12255.816162757388;12295.815562766387;12611.495540178657;13613.251271179784;13746.862531374958;13755.38100785487;13794.448222071005;14223.857761422254;12101.394930253276;12282.140250182401;12449.823198366668;12574.245545267313;13003.544875929298;11886;12076.21504602198;13068.411921463367;13090.803637945248;13128.277944713132;11392.145589080686;11487.885121148682;12309;12342.382880855741;12359.073069519642;9772.951135244279;10089.445080520349;10160;10186.388816671024;10203.234757393077;9830.4101753895;9830.950845246014;10348.706411698538;10900.836487452536;11360.943195283971 06:42:02 INFO - PROCESS | 11072 | __end_tp_report 06:42:02 INFO - PROCESS | 11072 | __start_cc_report 06:42:02 INFO - PROCESS | 11072 | _x_x_mozilla_cycle_collect,287 06:42:02 INFO - PROCESS | 11072 | __end_cc_report 06:42:02 INFO - PROCESS | 11072 | __startTimestamp1474983722835__endTimestamp 06:42:02 INFO - PROCESS | 11072 | 06:42:02 INFO - PROCESS | 11072 | ------- Summary: start ------- 06:42:02 INFO - PROCESS | 11072 | Number of tests: 6 06:42:02 INFO - PROCESS | 11072 | 06:42:02 INFO - PROCESS | 11072 | [#0] dojo.html Cycles:165 Average:5339.13 Median:5553.42 stddev:594.37 (10.7%) stddev-sans-first:567.81 06:42:02 INFO - PROCESS | 11072 | Values: 3025.8 3047.3 3061.6 3075.0 3082.0 5277.8 5323.9 5355.7 5386.4 5465.4 5310.8 5311.7 5384.5 5448.7 5452.4 4845.2 4851.9 4936.5 4977.9 4982.4 4957.6 5000.8 5017.3 5027.1 5078.8 4793.7 4810.8 4964.6 5027.9 5038.2 4847.5 4852.9 4907.0 4928.3 4994.4 4849.5 4887.9 4890.4 4893.7 4949.8 5220.6 5345.8 5350.6 5377.6 5384.5 5639.9 5672.2 5692.0 5715.0 5813.0 5756.5 5775.7 5777.0 5785.2 5786.5 5370.7 5377.8 5379.0 5391.9 5396.1 5676.7 5726.5 5794.5 5795.2 5809.9 5526.1 5533.5 5534.4 5536.5 5570.7 5652.8 5660.4 5719.3 5727.5 5745.8 5580.8 5634.9 5675.5 5684.4 5698.3 5728.8 5733.4 5737.2 5750.8 5764.1 4377.9 4412.2 4434.7 4450.6 4509.9 3930.9 3947.6 3975.8 4005.1 4032.3 5470.1 5502.1 5509.7 5538.9 5580.0 5605.6 5810.5 5840.4 5842.5 5852.9 5329.9 5402.8 5469.9 5502.3 5556.6 4953.5 4959.4 4960.4 4968.4 5026.8 5935.5 5942.3 5944.6 5952.7 5964.0 5613.7 5642.4 5718.8 5745.0 5756.1 5914.6 5923.2 5928.7 5947.0 5996.1 5690.6 5705.9 5709.8 5714.2 5714.2 5651.2 5695.9 5698.7 5721.9 5772.9 5568.6 5613.5 5629.4 5647.5 5677.5 5566.4 5601.2 5609.2 5616.4 5617.3 5445.8 5446.8 5477.3 5492.6 5505.6 5702.7 5708.4 5709.1 5712.3 5714.6 5553.4 5559.6 5564.4 5564.5 5566.1 06:42:02 INFO - PROCESS | 11072 | 06:42:02 INFO - PROCESS | 11072 | [#1] ext.html Cycles:180 Average:56184.51 Median:41150.29 stddev:106211.29 (258.1%) stddev-sans-first:106427.09 06:42:02 INFO - PROCESS | 11072 | Values: 544.0 579.1 591.2 597.4 607.4 41896.0 43427.0 43452.6 46938.3 47303.5 44318.6 44816.0 44824.3 45014.5 45067.1 8883.7 9017.9 9034.3 9038.5 9051.1 8827.7 8828.2 8843.4 8865.9 8913.6 8828.1 8865.8 8875.7 8879.9 8892.6 8833.7 8834.1 8837.9 8884.2 8889.7 8729.8 8779.8 8839.2 8850.2 8865.9 42048.4 42258.2 42356.8 42441.4 42831.0 3241.9 3350.8 3386.9 3426.3 3495.8 29417.6 30125.8 31994.8 32238.2 32424.5 4189.6 4303.1 4316.8 4369.1 4469.7 327149.0 331658.0 332703.0 333895.0 334677.3 61234.4 61657.0 62281.4 62281.7 62420.0 36937.4 37579.0 37777.2 39936.2 40202.4 17194.6 17279.0 17426.6 17461.9 17513.6 13039.6 13100.9 13127.4 13147.5 13151.7 19602.2 19794.9 19884.6 19884.9 19919.8 7408.6 7632.5 7676.3 7773.7 7885.5 857.8 997.2 1000.4 1014.8 1097.6 32394.0 32535.5 32548.3 32554.2 33136.3 1119.6 1122.2 1123.9 1166.9 1171.0 15810.7 16923.9 17218.7 17224.6 17262.0 468035.7 468278.0 470950.0 471756.0 472212.0 58537.4 58556.0 59063.4 59078.4 59204.4 1277.3 1325.4 1331.3 1339.5 1345.1 28553.9 31482.4 31902.7 32008.4 32043.1 47003.8 47067.3 47068.8 47086.3 47255.0 391570.0 392087.0 393278.0 394061.0 394157.0 29306.6 29378.6 29457.3 29725.9 29891.0 46845.0 46911.5 47575.9 48753.3 48887.0 39584.4 39850.4 40096.4 41131.6 41797.0 41004.2 41169.0 41817.0 41881.4 41976.2 34976.1 35754.0 40457.6 41334.0 41612.8 33191.7 36565.5 37181.8 37773.0 37994.6 27881.4 28130.4 28209.9 28439.4 28527.7 06:42:02 INFO - PROCESS | 11072 | 06:42:02 INFO - PROCESS | 11072 | [#2] jquery.html Cycles:180 Average:28083.21 Median:2341.63 stddev:74385.63 (3176.7%) stddev-sans-first:74565.22 06:42:02 INFO - PROCESS | 11072 | Values: 378.1 387.4 395.8 396.0 418.4 17504.8 18943.4 18982.5 18996.8 19945.3 18838.5 19128.6 19366.3 19544.5 19580.6 5493.9 5512.0 5631.0 5644.5 5705.7 5572.9 5573.2 5623.7 5669.1 5674.0 5433.7 5482.4 5561.2 5574.2 5591.0 5550.1 5571.3 5586.9 5589.1 5591.4 4853.2 4868.4 4912.9 4913.4 4918.0 22691.7 22765.0 22844.3 23087.7 23287.8 2280.6 2333.5 2335.3 2348.0 2511.2 14056.9 14535.4 14588.2 14609.3 15158.9 1894.9 1934.4 1950.4 2012.5 2071.8 82215.6 83465.6 83914.6 84773.0 85129.0 10966.7 11149.6 11178.1 11311.8 11505.8 15484.5 15516.9 15537.8 15576.5 15636.8 8183.6 8316.9 8389.7 8542.1 8560.3 7580.8 7801.8 7974.4 8013.2 8229.6 4593.4 4760.9 4827.3 4877.2 4905.7 1992.9 2063.0 2073.5 2081.8 2090.4 902.4 931.4 938.7 943.9 995.1 18310.5 19328.8 19546.4 19616.0 19639.6 982.2 990.0 1013.6 1014.9 1048.8 10343.8 10913.6 10963.5 10974.3 11012.8 446209.0 448125.0 448963.0 449732.0 451901.0 86135.6 88617.6 91098.0 95597.5 95768.5 1000.8 1004.2 1019.7 1020.2 1022.0 17047.5 17089.5 17576.8 17774.6 17803.2 30261.7 41140.8 42622.0 43510.0 44226.0 61515.7 62727.7 63494.4 65054.0 65590.3 8145.0 8333.7 8480.2 8586.7 8620.7 11524.5 12685.4 12759.7 12764.3 13271.1 10710.0 10955.7 10971.1 11580.4 11855.8 10585.6 10598.6 10713.5 11412.7 11527.6 11299.8 11379.4 11445.3 11588.4 11669.9 8248.0 8273.0 8514.2 8615.4 8756.2 11109.6 11179.8 11214.9 11332.4 11788.1 06:42:02 INFO - PROCESS | 11072 | 06:42:02 INFO - PROCESS | 11072 | [#3] mootools.html Cycles:180 Average:5750.13 Median:2613.04 stddev:3299.96 (126.3%) stddev-sans-first:3293.58 06:42:02 INFO - PROCESS | 11072 | Values: 1474.3 1511.0 1609.5 1687.9 1762.3 7774.3 8107.5 8229.7 8899.3 8907.6 8180.3 8477.1 8524.3 8735.7 8754.7 2293.5 2331.1 2335.3 2337.6 2344.6 2272.9 2277.9 2291.7 2318.9 2327.4 2306.5 2317.5 2318.7 2320.2 2345.4 2244.8 2250.5 2268.5 2271.9 2277.3 2225.8 2229.2 2240.5 2244.3 2245.3 8744.3 8810.8 8815.0 8844.3 8942.3 5135.2 5260.8 5274.6 5280.5 5296.5 3153.2 3210.2 3382.9 3384.8 3393.0 1167.7 1177.9 1188.1 1194.7 1200.6 12120.5 12165.8 12193.5 12212.2 12255.0 4411.9 4623.4 4741.4 4777.9 4820.8 10388.6 10398.2 10402.4 10411.4 10438.3 5362.0 5371.6 5373.2 5373.3 5374.9 4221.8 4310.1 4749.4 4838.3 4926.1 3908.8 3962.5 4029.2 4037.9 4066.1 1253.1 1260.1 1271.2 1280.6 1292.4 787.4 906.3 925.0 933.0 934.6 5774.7 5944.0 5954.9 6013.2 6190.8 457.4 458.7 462.4 468.8 476.7 3747.7 3865.6 3869.5 3885.6 3917.3 10597.3 11053.8 11100.8 11126.7 11131.1 10788.6 10898.2 10934.1 11016.8 11102.7 8173.0 8179.9 8212.3 8246.8 8255.1 5689.7 5707.4 5727.1 5747.3 5908.6 9978.7 10038.1 10041.4 10206.5 10236.5 9505.4 9917.6 9921.6 10118.4 10202.6 6951.9 7183.8 7447.9 7709.4 7871.2 8380.6 8558.9 8604.5 8607.0 8629.4 7576.9 7583.4 7772.8 7829.2 7833.4 7377.4 7519.2 7525.3 7565.3 7757.6 6869.7 6988.5 6993.8 7003.6 7024.9 5160.3 5175.8 5219.5 5231.3 5438.3 5222.7 5244.0 5256.2 5269.6 5549.3 06:42:02 INFO - PROCESS | 11072 | 06:42:02 INFO - PROCESS | 11072 | [#4] prototype.html Cycles:180 Average:4740.77 Median:5295.86 stddev:1412.09 (26.7%) stddev-sans-first:1376.05 06:42:02 INFO - PROCESS | 11072 | Values: 294.8 316.4 316.8 316.9 324.9 5347.9 5463.9 5480.3 5572.8 5587.2 5293.8 5393.5 5421.4 5435.3 5473.6 4234.0 4257.5 4270.2 4272.4 4275.3 4176.3 4234.7 4249.9 4250.6 4253.9 4222.1 4222.3 4232.5 4245.7 4254.6 4230.8 4242.9 4247.4 4249.7 4254.0 3671.9 3750.9 3759.8 3776.2 3777.2 5257.2 5284.3 5291.5 5301.0 5341.5 4850.4 4857.2 4875.0 4888.7 4894.1 5442.6 5601.4 5712.1 5725.9 5730.6 4092.3 4093.7 4096.6 4116.4 4122.6 5903.4 5917.6 5926.8 5964.1 5977.6 4112.4 4213.3 4224.7 4248.5 4258.6 4236.8 4258.6 4264.6 4273.8 4290.5 4838.9 4843.8 4849.6 4863.0 4867.5 5590.7 5738.2 5777.3 5782.7 5787.6 1460.6 1487.9 1488.7 1493.9 1498.8 900.4 937.4 943.9 944.0 953.2 4785.6 4845.2 4863.4 4874.9 4885.0 5142.8 5163.5 5171.2 5180.9 5182.5 4619.9 4856.2 4862.2 4866.0 4871.6 2743.1 2748.6 2755.8 2762.6 2764.5 5297.9 5311.4 5317.3 5320.0 5347.9 5277.6 5284.2 5690.2 6078.8 6106.7 6141.4 6141.5 6176.8 6186.9 6193.8 5693.6 5887.7 6011.8 6015.1 6051.3 5865.6 5941.8 5952.2 5955.3 5956.7 6124.8 6132.2 6183.4 6191.4 6201.3 3770.3 4034.5 4140.4 4151.3 4152.4 5924.0 5931.2 5933.7 5936.4 5937.4 5655.8 5763.4 5768.9 5780.9 5782.7 5742.6 5757.9 5770.4 5773.4 5785.7 5692.8 5695.9 5699.0 5705.3 5733.4 5596.5 5734.8 5764.8 5775.2 5793.3 5646.5 5649.6 5669.5 5673.4 5686.5 06:42:02 INFO - PROCESS | 11072 | 06:42:02 INFO - PROCESS | 11072 | [#5] yui.html Cycles:180 Average:21546.79 Median:4524.13 stddev:32535.01 (719.1%) stddev-sans-first:32588.60 06:42:02 INFO - PROCESS | 11072 | Values: 691.8 736.9 748.7 759.4 794.8 15059.8 16414.8 16472.2 16517.2 16532.9 16548.3 17013.7 17151.7 17175.2 17177.2 783.7 807.5 809.9 810.0 810.3 770.7 800.9 802.8 806.8 807.5 847.9 849.5 850.8 851.1 851.2 834.0 836.9 844.3 846.1 846.9 617.1 617.8 619.5 619.5 621.7 15843.0 15957.9 15970.2 16023.7 16049.3 14447.3 14566.6 14647.6 14707.3 14834.7 11342.2 11463.4 11510.9 11742.1 11814.8 3672.4 3693.1 3724.4 3754.5 3801.0 83441.0 85217.0 85367.0 85869.0 86833.3 10436.2 10636.1 10660.0 10706.7 10841.3 19107.1 19351.6 19589.6 19981.0 20103.2 8025.0 8048.3 8071.2 8194.9 8229.0 4394.2 4526.6 4536.5 4539.5 4539.8 3613.1 3694.6 3711.3 3714.1 3728.6 589.7 593.5 610.4 616.0 636.6 598.2 653.3 661.8 662.9 666.2 8822.3 8881.6 8980.8 9012.8 9353.1 589.7 639.8 640.7 640.9 663.7 4187.5 4244.4 4367.9 4521.7 4582.3 78547.6 125966.0 127070.9 128714.0 133236.0 114178.0 115770.0 116915.0 117711.0 121004.7 78715.6 79694.0 79999.2 88851.6 96079.0 8305.7 8988.1 8999.6 9054.8 9199.7 52465.5 53936.2 54802.5 55056.0 56230.2 69209.7 77107.6 77757.5 79347.0 81656.6 12088.1 12183.3 12255.8 12295.8 12611.5 13613.3 13746.9 13755.4 13794.4 14223.9 12101.4 12282.1 12449.8 12574.2 13003.5 11886.0 12076.2 13068.4 13090.8 13128.3 11392.1 11487.9 12309.0 12342.4 12359.1 9773.0 10089.4 10160.0 10186.4 10203.2 9830.4 9831.0 10348.7 10900.8 11360.9 06:42:02 INFO - PROCESS | 11072 | -------- Summary: end -------- 06:42:02 INFO - PROCESS | 11072 | 06:42:03 INFO - TEST-INFO | 11072: exit 0 06:42:03 INFO - TEST-OK | dromaeo_css | took 1113957ms 06:42:03 INFO - TEST-START | kraken 06:42:03 INFO - operating with platform_type : linux_ 06:42:03 INFO - Initialising browser for kraken test... 06:42:03 INFO - TEST-INFO | started process 11434 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5k538C/profile http://localhost:37358/getInfo.html) 06:42:08 INFO - PROCESS | 11434 | __metrics Screen width/height:1600/1200 06:42:08 INFO - PROCESS | 11434 | colorDepth:24 06:42:08 INFO - PROCESS | 11434 | Browser inner width/height: 1024/697 06:42:08 INFO - PROCESS | 11434 | __metrics 06:42:09 ERROR - PROCESS | 11434 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3067: TypeError: this.tabs is undefined 06:42:10 INFO - TEST-INFO | 11434: exit 0 06:42:10 INFO - Browser initialized. 06:42:10 INFO - Running cycle 1/1 for kraken test... 06:42:10 INFO - TEST-INFO | started process 11554 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5k538C/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:42:22 INFO - PROCESS | 11554 | RSS: Main: 185630720 06:42:22 INFO - PROCESS | 11554 | 06:42:25 INFO - PROCESS | 11554 | Cycle 1(1): loaded http://localhost:37358/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37358/tests/kraken/driver.html?testName=audio-beat-detection) 06:42:25 INFO - PROCESS | 11554 | RSS: Main: 200126464 06:42:25 INFO - PROCESS | 11554 | 06:42:28 INFO - PROCESS | 11554 | Cycle 1(1): loaded http://localhost:37358/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37358/tests/kraken/driver.html?testName=audio-dft) 06:42:29 INFO - PROCESS | 11554 | RSS: Main: 197206016 06:42:29 INFO - PROCESS | 11554 | 06:42:32 INFO - PROCESS | 11554 | Cycle 1(1): loaded http://localhost:37358/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37358/tests/kraken/driver.html?testName=audio-fft) 06:42:32 INFO - PROCESS | 11554 | RSS: Main: 193007616 06:42:32 INFO - PROCESS | 11554 | 06:42:34 INFO - PROCESS | 11554 | Cycle 1(1): loaded http://localhost:37358/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37358/tests/kraken/driver.html?testName=audio-oscillator) 06:42:35 INFO - PROCESS | 11554 | RSS: Main: 193634304 06:42:35 INFO - PROCESS | 11554 | 06:42:37 INFO - PROCESS | 11554 | Cycle 1(1): loaded http://localhost:37358/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37358/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:42:38 INFO - PROCESS | 11554 | RSS: Main: 193937408 06:42:38 INFO - PROCESS | 11554 | 06:42:41 INFO - PROCESS | 11554 | Cycle 1(1): loaded http://localhost:37358/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37358/tests/kraken/driver.html?testName=imaging-darkroom) 06:42:41 INFO - PROCESS | 11554 | RSS: Main: 194822144 06:42:41 INFO - PROCESS | 11554 | 06:42:45 INFO - PROCESS | 11554 | Cycle 1(1): loaded http://localhost:37358/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37358/tests/kraken/driver.html?testName=imaging-desaturate) 06:42:45 INFO - PROCESS | 11554 | RSS: Main: 192331776 06:42:45 INFO - PROCESS | 11554 | 06:42:48 INFO - PROCESS | 11554 | Cycle 1(1): loaded http://localhost:37358/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37358/tests/kraken/driver.html?testName=json-parse-financial) 06:42:49 INFO - PROCESS | 11554 | RSS: Main: 193593344 06:42:49 INFO - PROCESS | 11554 | 06:42:50 INFO - PROCESS | 11554 | Cycle 1(1): loaded http://localhost:37358/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37358/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:42:51 INFO - PROCESS | 11554 | RSS: Main: 194007040 06:42:51 INFO - PROCESS | 11554 | 06:42:53 INFO - PROCESS | 11554 | Cycle 1(1): loaded http://localhost:37358/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37358/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:42:54 INFO - PROCESS | 11554 | RSS: Main: 194170880 06:42:54 INFO - PROCESS | 11554 | 06:42:56 INFO - PROCESS | 11554 | Cycle 1(1): loaded http://localhost:37358/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37358/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:42:56 INFO - PROCESS | 11554 | RSS: Main: 194228224 06:42:56 INFO - PROCESS | 11554 | 06:42:59 INFO - PROCESS | 11554 | Cycle 1(1): loaded http://localhost:37358/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37358/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:43:00 INFO - PROCESS | 11554 | RSS: Main: 194244608 06:43:00 INFO - PROCESS | 11554 | 06:43:02 INFO - PROCESS | 11554 | Cycle 1(1): loaded http://localhost:37358/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37358/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:43:03 INFO - PROCESS | 11554 | RSS: Main: 194433024 06:43:03 INFO - PROCESS | 11554 | 06:43:05 INFO - PROCESS | 11554 | Cycle 1(1): loaded http://localhost:37358/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37358/tests/kraken/driver.html?testName=ai-astar) 06:43:05 INFO - PROCESS | 11554 | RSS: Main: 195911680 06:43:05 INFO - PROCESS | 11554 | 06:43:05 INFO - PROCESS | 11554 | __start_tp_report 06:43:05 INFO - PROCESS | 11554 | _x_x_mozilla_page_load 06:43:05 INFO - PROCESS | 11554 | _x_x_mozilla_page_load_details 06:43:05 INFO - PROCESS | 11554 | |i|pagename|runs| 06:43:05 INFO - PROCESS | 11554 | |0;ai-astar;105;114;112;113;113;112;113;111;113;112 06:43:05 INFO - PROCESS | 11554 | |1;audio-beat-detection;154;119;120;172;123;123;122;123;147;125 06:43:05 INFO - PROCESS | 11554 | |2;audio-dft;164;165;166;173;165;165;161;163;163;161 06:43:05 INFO - PROCESS | 11554 | |3;audio-fft;77;77;75;110;77;77;76;77;99;74 06:43:05 INFO - PROCESS | 11554 | |4;audio-oscillator;82;82;112;83;83;83;99;83;82;114 06:43:05 INFO - PROCESS | 11554 | |5;imaging-gaussian-blur;117;119;118;118;118;119;118;118;118;118 06:43:05 INFO - PROCESS | 11554 | |6;imaging-darkroom;148;147;146;146;148;148;147;148;148;146 06:43:05 INFO - PROCESS | 11554 | |7;imaging-desaturate;95;96;96;95;95;95;96;97;97;95 06:43:05 INFO - PROCESS | 11554 | |8;json-parse-financial;57;52;54;52;52;52;57;54;54;52 06:43:05 INFO - PROCESS | 11554 | |9;json-stringify-tinderbox;63;64;64;62;67;63;62;62;62;63 06:43:05 INFO - PROCESS | 11554 | |10;stanford-crypto-aes;79;79;79;80;82;80;80;84;84;80 06:43:05 INFO - PROCESS | 11554 | |11;stanford-crypto-ccm;137;132;123;138;124;143;135;129;177;134 06:43:05 INFO - PROCESS | 11554 | |12;stanford-crypto-pbkdf2;164;167;166;164;165;163;172;165;166;163 06:43:05 INFO - PROCESS | 11554 | |13;stanford-crypto-sha256-iterative;66;66;66;65;64;66;64;65;69;63 06:43:05 INFO - PROCESS | 11554 | __end_tp_report 06:43:05 INFO - PROCESS | 11554 | __start_cc_report 06:43:05 INFO - PROCESS | 11554 | _x_x_mozilla_cycle_collect,767 06:43:05 INFO - PROCESS | 11554 | __end_cc_report 06:43:05 INFO - PROCESS | 11554 | __startTimestamp1474983785456__endTimestamp 06:43:05 INFO - PROCESS | 11554 | 06:43:05 INFO - PROCESS | 11554 | ------- Summary: start ------- 06:43:05 INFO - PROCESS | 11554 | Number of tests: 14 06:43:05 INFO - PROCESS | 11554 | 06:43:05 INFO - PROCESS | 11554 | [#0] ai-astar Cycles:10 Average:111.80 Median:113.00 stddev:2.53 (2.2%) stddev-sans-first:0.88 06:43:05 INFO - PROCESS | 11554 | Values: 105.0 114.0 112.0 113.0 113.0 112.0 113.0 111.0 113.0 112.0 06:43:05 INFO - PROCESS | 11554 | 06:43:05 INFO - PROCESS | 11554 | [#1] audio-beat-detection Cycles:10 Average:132.80 Median:124.00 stddev:18.28 (14.7%) stddev-sans-first:17.71 06:43:05 INFO - PROCESS | 11554 | Values: 154.0 119.0 120.0 172.0 123.0 123.0 122.0 123.0 147.0 125.0 06:43:05 INFO - PROCESS | 11554 | 06:43:05 INFO - PROCESS | 11554 | [#2] audio-dft Cycles:10 Average:164.60 Median:165.00 stddev:3.41 (2.1%) stddev-sans-first:3.61 06:43:05 INFO - PROCESS | 11554 | Values: 164.0 165.0 166.0 173.0 165.0 165.0 161.0 163.0 163.0 161.0 06:43:05 INFO - PROCESS | 11554 | 06:43:05 INFO - PROCESS | 11554 | [#3] audio-fft Cycles:10 Average:81.90 Median:77.00 stddev:12.23 (15.9%) stddev-sans-first:12.85 06:43:05 INFO - PROCESS | 11554 | Values: 77.0 77.0 75.0 110.0 77.0 77.0 76.0 77.0 99.0 74.0 06:43:05 INFO - PROCESS | 11554 | 06:43:05 INFO - PROCESS | 11554 | [#4] audio-oscillator Cycles:10 Average:90.30 Median:83.00 stddev:13.03 (15.7%) stddev-sans-first:13.47 06:43:05 INFO - PROCESS | 11554 | Values: 82.0 82.0 112.0 83.0 83.0 83.0 99.0 83.0 82.0 114.0 06:43:05 INFO - PROCESS | 11554 | 06:43:05 INFO - PROCESS | 11554 | [#5] imaging-gaussian-blur Cycles:10 Average:118.10 Median:118.00 stddev:0.57 (0.5%) stddev-sans-first:0.44 06:43:05 INFO - PROCESS | 11554 | Values: 117.0 119.0 118.0 118.0 118.0 119.0 118.0 118.0 118.0 118.0 06:43:05 INFO - PROCESS | 11554 | 06:43:05 INFO - PROCESS | 11554 | [#6] imaging-darkroom Cycles:10 Average:147.20 Median:148.00 stddev:0.92 (0.6%) stddev-sans-first:0.93 06:43:05 INFO - PROCESS | 11554 | Values: 148.0 147.0 146.0 146.0 148.0 148.0 147.0 148.0 148.0 146.0 06:43:05 INFO - PROCESS | 11554 | 06:43:05 INFO - PROCESS | 11554 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.82 (0.9%) stddev-sans-first:0.83 06:43:05 INFO - PROCESS | 11554 | Values: 95.0 96.0 96.0 95.0 95.0 95.0 96.0 97.0 97.0 95.0 06:43:05 INFO - PROCESS | 11554 | 06:43:05 INFO - PROCESS | 11554 | [#8] json-parse-financial Cycles:10 Average:53.60 Median:54.00 stddev:2.01 (3.7%) stddev-sans-first:1.72 06:43:05 INFO - PROCESS | 11554 | Values: 57.0 52.0 54.0 52.0 52.0 52.0 57.0 54.0 54.0 52.0 06:43:05 INFO - PROCESS | 11554 | 06:43:05 INFO - PROCESS | 11554 | [#9] json-stringify-tinderbox Cycles:10 Average:63.20 Median:63.00 stddev:1.55 (2.5%) stddev-sans-first:1.64 06:43:05 INFO - PROCESS | 11554 | Values: 63.0 64.0 64.0 62.0 67.0 63.0 62.0 62.0 62.0 63.0 06:43:05 INFO - PROCESS | 11554 | 06:43:05 INFO - PROCESS | 11554 | [#10] stanford-crypto-aes Cycles:10 Average:80.70 Median:80.00 stddev:1.95 (2.4%) stddev-sans-first:1.96 06:43:05 INFO - PROCESS | 11554 | Values: 79.0 79.0 79.0 80.0 82.0 80.0 80.0 84.0 84.0 80.0 06:43:05 INFO - PROCESS | 11554 | 06:43:05 INFO - PROCESS | 11554 | [#11] stanford-crypto-ccm Cycles:10 Average:137.20 Median:136.00 stddev:15.29 (11.2%) stddev-sans-first:16.22 06:43:05 INFO - PROCESS | 11554 | Values: 137.0 132.0 123.0 138.0 124.0 143.0 135.0 129.0 177.0 134.0 06:43:05 INFO - PROCESS | 11554 | 06:43:05 INFO - PROCESS | 11554 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.50 Median:165.50 stddev:2.64 (1.6%) stddev-sans-first:2.74 06:43:05 INFO - PROCESS | 11554 | Values: 164.0 167.0 166.0 164.0 165.0 163.0 172.0 165.0 166.0 163.0 06:43:05 INFO - PROCESS | 11554 | 06:43:05 INFO - PROCESS | 11554 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.40 Median:66.00 stddev:1.65 (2.5%) stddev-sans-first:1.73 06:43:05 INFO - PROCESS | 11554 | Values: 66.0 66.0 66.0 65.0 64.0 66.0 64.0 65.0 69.0 63.0 06:43:05 INFO - PROCESS | 11554 | -------- Summary: end -------- 06:43:05 INFO - PROCESS | 11554 | 06:43:05 INFO - PROCESS | 11554 | 06:43:05 INFO - PROCESS | 11554 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 06:43:05 INFO - PROCESS | 11554 | 06:43:05 INFO - PROCESS | 11554 | 06:43:05 INFO - PROCESS | 11554 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 06:43:05 INFO - PROCESS | 11554 | 06:43:05 INFO - PROCESS | 11554 | 06:43:05 INFO - PROCESS | 11554 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 06:43:05 INFO - PROCESS | 11554 | 06:43:05 INFO - PROCESS | 11554 | 06:43:05 INFO - PROCESS | 11554 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 06:43:05 INFO - PROCESS | 11554 | 06:43:05 INFO - PROCESS | 11554 | 06:43:05 INFO - PROCESS | 11554 | ###!!! [Parent][MessageChannel] Error: (msgtype=0x2000B,name=PAPZ::Msg_Destroy) Channel error: cannot send/recv 06:43:05 INFO - PROCESS | 11554 | 06:43:06 INFO - TEST-INFO | 11554: exit 0 06:43:06 INFO - TEST-OK | kraken | took 62603ms 06:43:06 INFO - SUITE-END | took 1176s 06:43:06 INFO - Completed test suite (00:19:36) 06:43:06 INFO - javascript benchmark 06:43:06 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7194.67073723091, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3025.8335791531463, 3047.3143542702883, 3061.647910490293, 3075.0, 3082.0445661844824, 5277.815276465324, 5323.92014119788, 5355.6518826276315, 5386.380566234884, 5465.398806131322, 5310.8141215057485, 5311.681299122055, 5384.515393614574, 5448.673079615226, 5452.372977107634, 4845.176320025586, 4851.854444366666, 4936.5063493650705, 4977.900441991158, 4982.352294201767, 4957.628177886655, 5000.799968001275, 5017.297578339036, 5027.069992051483, 5078.7968481260705, 4793.712377257376, 4810.8316208932865, 4964.6276529260085, 5027.874303142414, 5038.168702164138, 4847.51524847516, 4852.878678033042, 4906.975465122688, 4928.285398617216, 4994.425641051289, 4849.539293767087, 4887.902241955177, 4890.413150421937, 4893.657443978923, 4949.777260023272, 5220.582353411756, 5345.786168553253, 5350.571954243651, 5377.596680248997, 5384.515393614593, 5639.8590035249035, 5672.205891175197, 5692.0323544997445, 5714.971425142848, 5812.970935145339, 5756.453136951983, 5775.711214439261, 5777.046787280094, 5785.218995435646, 5786.508146807527, 5370.704611246419, 5377.838664840061, 5379.0, 5391.919121213106, 5396.055690254189, 5676.659400435987, 5726.541876649858, 5794.50746686528, 5795.246617939641, 5809.912851307234, 5526.06056970316, 5533.474319939599, 5534.363548192009, 5536.474034966672, 5570.749316280777, 5652.802151924663, 5660.377358490563, 5719.256496655408, 5727.455891690282, 5745.770169193269, 5580.776768929279, 5634.943650563524, 5675.545956323567, 5684.37471878093, 5698.2592263005545, 5728.77084916607, 5733.369329373765, 5737.225474560881, 5750.7987220447085, 5764.13537969308, 4377.890552736207, 4412.227860124465, 4434.667399945017, 4450.5549445055885, 4509.887252818706, 3930.9213815723524, 3947.5657677655436, 3975.8210880510446, 4005.0988527581644, 4032.294348489003, 5470.070088085035, 5502.064649009678, 5509.669419834742, 5538.944610553924, 5580.0, 5605.635633683797, 5810.535157187415, 5840.445157710011, 5842.532597392198, 5852.94147058524, 5329.8934021319355, 5402.783888644411, 5469.890602187934, 5502.257195278667, 5556.611037227436, 4953.479884612136, 4959.404871415453, 4960.429550601727, 4968.403791545038, 5026.824061157842, 5935.495482884004, 5942.257217847769, 5944.554158438048, 5952.7023648817385, 5963.970180149072, 5613.663180209037, 5642.407547207648, 5718.7998420056765, 5745.0, 5756.079027355603, 5914.585978981602, 5923.200367950271, 5928.703564821828, 5947.0, 5996.130561068533, 5690.601657883908, 5705.914411283917, 5709.771609135754, 5714.171445140514, 5714.228579141763, 5651.180578816131, 5695.943040569541, 5698.6580805151825, 5721.885562288814, 5772.913406298825, 5568.55451563882, 5613.522850557585, 5629.408912064175, 5647.463490968352, 5677.545796336366, 5566.415526369835, 5601.215829783915, 5609.186667933209, 5616.354119276336, 5617.297837770278, 5445.754941027584, 5446.809361672323, 5477.3427188737605, 5492.588055895903, 5505.642133261325, 5702.743376547983, 5708.400617935057, 5709.058005429224, 5712.34308054579, 5714.628549144292, 5553.416891226363, 5559.555235581225, 5564.38791732901, 5564.4991950724625, 5566.081596536526], "value": 5299.162794435996, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [544.0067784207434, 579.1052823387865, 591.1635036423461, 597.4055814464608, 607.3865395950091, 41896.0, 43427.0, 43452.56547434525, 46938.295925561055, 47303.45224108188, 44318.556814431846, 44816.0, 44824.3276350855, 45014.54985450144, 45067.09865802682, 8883.733487995354, 9017.864732029026, 9034.277257819358, 9038.457692538435, 9051.14014168653, 8827.73516794494, 8828.161324674178, 8843.380963332569, 8865.911340886605, 8913.55432228386, 8828.073052329477, 8865.822683546357, 8875.68935087272, 8879.866801997976, 8892.555372231363, 8833.690820821272, 8834.072422395653, 8837.867431988558, 8884.156005179562, 8889.688860889903, 8729.781755456164, 8779.824403511893, 8839.16027977341, 8850.159234872677, 8865.936087669521, 42048.36927446091, 42258.1548369034, 42356.78821605903, 42441.36337954933, 42831.0, 3241.8865339712997, 3350.8324583770714, 3386.86452541898, 3426.3318652862704, 3495.8077305748175, 29417.55873661897, 30125.849370753007, 31994.840025799724, 32238.194045148823, 32424.513632295533, 4189.62293393593, 4303.074838909618, 4316.848910288125, 4369.104333611634, 4469.7318160910445, 327149.0, 331658.0, 332703.0, 333895.0, 334677.3266133678, 61234.38765612376, 61657.0, 62281.37718622846, 62281.688591556755, 62420.0, 36937.44593831095, 37579.0, 37777.24445511075, 39936.201275974316, 40202.39696404556, 17194.570135746708, 17278.963262204306, 17426.564335891704, 17461.912690436468, 17513.649727005388, 13039.608811735663, 13100.868991309964, 13127.409266583027, 13147.53983610569, 13151.67120821968, 19602.21591136367, 19794.90102549507, 19884.60230795376, 19884.90057549703, 19919.800801992085, 7408.592527411044, 7632.5038872473115, 7676.270754278335, 7773.68905243784, 7885.526868387915, 857.8284343131398, 997.2470784557613, 1000.4347543637822, 1014.822406078948, 1097.6103483263487, 32394.0, 32535.511967320508, 32548.349033019207, 32554.186145346557, 33136.33727325488, 1119.5857532712948, 1122.1639878290725, 1123.8819923908036, 1166.912481563886, 1171.0221964659434, 15810.68378632444, 16923.915380423266, 17218.741718874226, 17224.569385765455, 17262.0, 468035.65982169873, 468278.0, 470950.0, 471756.0, 472212.0, 58537.41462585405, 58556.0, 59063.40936590579, 59078.40921590815, 59204.40795591989, 1277.3166355999497, 1325.4095085896963, 1331.2877610478347, 1339.5177736015028, 1345.132389608697, 28553.857230713715, 31482.37035259328, 31902.680973190898, 32008.35983280368, 32043.146891838936, 47003.76498117488, 47067.29399058948, 47068.7646561765, 47086.293705595126, 47255.0, 391570.0, 392087.0, 393278.0, 394061.0, 394157.0, 29306.560401593568, 29378.55932161062, 29457.263568410963, 29725.851370743007, 29891.0, 46845.0, 46911.530884690714, 47575.85908634189, 48753.26870097022, 48887.0, 39584.40623390709, 39850.402243965786, 40096.39855402113, 41131.58868411397, 41797.0, 41004.1799164021, 41169.0, 41817.0, 41881.37177942273, 41976.1604767909, 34976.125596860285, 35754.0, 40457.59542404656, 41334.0, 41612.79193604013, 33191.66808331886, 36565.45151822671, 37181.81409092937, 37773.0, 37994.62005379911, 27881.442371152058, 28130.437391252468, 28209.858950705937, 28439.43121137607, 28527.714722852506], "value": 19745.48820529123, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [378.1284140057168, 387.4111350746864, 395.7981429470969, 395.99231894295895, 418.43093392985537, 17504.824951750477, 18943.431697049076, 18982.525436864085, 18996.810031899677, 19945.301914433, 18838.52903677409, 19128.61742765144, 19366.32217872375, 19544.511387215327, 19580.608387832235, 5493.917591236134, 5512.0, 5631.0, 5644.491995720385, 5705.686187259699, 5572.916406253909, 5573.21974923509, 5623.718814059301, 5669.064604340299, 5673.971630141864, 5433.7283135843245, 5482.369527504328, 5561.165825126223, 5574.202531016128, 5591.049521581341, 5550.084236101038, 5571.275734154554, 5586.86032849178, 5589.133684278943, 5591.440855914376, 4853.150698627726, 4868.391451068616, 4912.8700398908095, 4913.385826771653, 4918.0, 22691.659625105636, 22764.95408289898, 22844.31467055991, 23087.653685194568, 23287.7671223289, 2280.5894938910988, 2333.5216280662426, 2335.2760644200184, 2347.9882600587057, 2511.234073607549, 14056.859431405657, 14535.418583256656, 14588.197649129293, 14609.269536523238, 15158.924205379013, 1894.8673592848368, 1934.3906669399094, 1950.4343740315433, 2012.4666963254604, 2071.7513898332145, 82215.588922055, 83465.58267208625, 83914.58042709809, 84773.0, 85129.0, 10966.725831854268, 11149.554017839195, 11178.149571859123, 11311.83032254517, 11505.769884602261, 15484.535463935874, 15516.922415387851, 15537.844621553866, 15576.532704018671, 15636.843631563766, 8183.590820458953, 8316.916830831735, 8389.706360277483, 8542.060373358925, 8560.315174786003, 7580.848383032308, 7801.80495487606, 7974.401919856034, 8013.15861834499, 8229.556039738594, 4593.356930029799, 4760.857174284777, 4827.275908613666, 4877.244027175793, 4905.656604037683, 1992.9402117936486, 2063.030375723408, 2073.5438203595186, 2081.7732514602308, 2090.3937858021004, 902.4495058014605, 931.4411353188033, 938.6620816506053, 943.9386439881386, 995.0845222395413, 18310.450686479428, 19328.806711932702, 19546.413607591796, 19616.0, 19639.607207855763, 982.1651596143364, 990.005328499501, 1013.6097602423121, 1014.9340292880939, 1048.7902419516126, 10343.793124137626, 10913.618023369145, 10963.451827408599, 10974.341539507655, 11012.779744405067, 446209.0, 448125.0, 448963.0, 449732.0, 451901.0, 86135.569322153, 88617.55691221631, 91098.0, 95597.5220123895, 95768.52115739377, 1000.8198524265703, 1004.1765752083368, 1019.6788011776415, 1020.1889497849079, 1022.0239671114217, 17047.48857534276, 17089.48731538056, 17576.82423175752, 17774.555636109202, 17803.198856051768, 30261.697383026767, 41140.794296028325, 42622.0, 43510.0, 44226.0, 61515.692421537606, 62727.6863615679, 63494.36505634885, 65054.0, 65590.34409656034, 8144.959275203586, 8333.666653334041, 8480.194381533744, 8586.699465518677, 8620.741377758677, 11524.481398336928, 12685.365731713193, 12759.744805104032, 12764.29796361172, 13271.137376070525, 10710.0, 10955.671329860117, 10971.122310215003, 11580.436641053688, 11855.822162667395, 10585.629502967358, 10598.629047983284, 10713.464326783786, 11412.714682133013, 11527.596534121265, 11299.774004519699, 11379.374134422354, 11445.313281203154, 11588.36264005454, 11669.941650291694, 8248.0, 8273.0, 8514.233718965323, 8615.396922215636, 8756.168164024408, 11109.611163609236, 11179.776404471702, 11214.943925280322, 11332.37671928019, 11788.115891308358], "value": 9226.587438210361, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1474.2923396769554, 1511.0178384050369, 1609.5090997245843, 1687.932482700692, 1762.3038899634644, 7774.339181169593, 8107.513549187053, 8229.711960081399, 8899.288056955444, 8907.64369425223, 8180.304674102708, 8477.067522572512, 8524.318054555637, 8735.728710535259, 8754.6935857245, 2293.5412917416543, 2331.079223706635, 2335.311083230451, 2337.567550003255, 2344.6014177589764, 2272.9090836366527, 2277.8519396239276, 2291.6562515622622, 2318.9188378406675, 2327.359976006595, 2306.4695120122296, 2317.4669825940045, 2318.710161229846, 2320.2227253869974, 2345.3901985483812, 2244.7530771615193, 2250.4711392822674, 2268.54629074185, 2271.8977646005806, 2277.2826559633745, 2225.833062520301, 2229.1752051740796, 2240.451089483087, 2244.2706120510734, 2245.2815099168274, 8744.344174186961, 8810.779730506725, 8815.030346661862, 8844.33667474942, 8942.329325300629, 5135.152699804527, 5260.763265653055, 5274.630775845692, 5280.498352656491, 5296.496832800916, 3153.22745927247, 3210.1653570071717, 3382.8985130446126, 3384.76306658534, 3393.032985599117, 1167.6788883057227, 1177.8527684039495, 1188.144535934126, 1194.7192409783695, 1200.5677955935855, 12120.515179392814, 12165.756684866341, 12193.512259509609, 12212.206206596631, 12255.0, 4411.867643970621, 4623.42207224097, 4741.359916411309, 4777.928331075037, 4820.758962051884, 10388.584456621802, 10398.168146548258, 10402.375857448576, 10411.427371494488, 10438.269321147447, 5361.973190134102, 5371.597130215249, 5373.220882972026, 5373.274607927958, 5374.865628359323, 4221.831126754957, 4310.073334233092, 4749.3588365570895, 4838.298446725275, 4926.064047830901, 3908.843646254118, 3962.484876965976, 4029.15387768566, 4037.8990525237105, 4066.0851308455362, 1253.129075292663, 1260.0738457233927, 1271.2372576454054, 1280.5902111324287, 1292.3796577642597, 787.3897729259755, 906.2704522859161, 924.9815003700023, 932.9766755831158, 934.6168071090956, 5774.711264436762, 5944.0, 5954.910676339859, 6013.1581578579035, 6190.7523699052435, 457.39166908012265, 458.68350837921724, 462.3942635147967, 468.84996801023345, 476.7258826174963, 3747.7376583638884, 3865.613438656112, 3869.496965394537, 3885.592012838611, 3917.314469967744, 10597.25819192649, 11053.778924421467, 11100.777984440267, 11126.721831954266, 11131.109511239081, 10788.568457261621, 10898.18263630215, 10934.125269978382, 11016.834747478793, 11102.722431939104, 8173.0, 8179.918200818035, 8212.34301255898, 8246.752597422086, 8255.091939886728, 5689.7439615218245, 5707.372189059117, 5727.140928860705, 5747.3103227612955, 5908.645481271137, 9978.650747223812, 10038.146757525692, 10041.447720375449, 10206.489675516046, 10236.539355729159, 9505.42967421957, 9917.553710083208, 9921.553530091307, 10118.392896426238, 10202.642907498202, 6951.895721564281, 7183.784486465414, 7447.88828167567, 7709.383249339927, 7871.173526779606, 8380.58097095155, 8558.914410856061, 8604.526751028754, 8607.0, 8629.43908645936, 7576.886346704914, 7583.393328533593, 7772.84454310922, 7829.217078292125, 7833.412494062854, 7377.372923301579, 7519.172890982097, 7525.285097915689, 7565.319121279112, 7757.612119393895, 6869.656517174021, 6988.510804243654, 6993.755218567326, 7003.614801185984, 7024.894626580503, 5160.277561141368, 5175.844724658266, 5219.4780521947505, 5231.29377534028, 5438.347398312228, 5222.66052706588, 5243.973780131228, 5256.159014557806, 5269.631125821155, 5549.306336707911], "value": 4521.656417884053, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [294.7509354595368, 316.3593722711509, 316.76242817886583, 316.8922566327449, 324.9350129974006, 5347.946520534793, 5463.9180412293845, 5480.287562616859, 5572.804951826687, 5587.161925711145, 5293.808892999083, 5393.460653934604, 5421.430749771266, 5435.347758269003, 5473.616846820714, 4233.978830105845, 4257.489101307832, 4270.231358355495, 4272.380504826799, 4275.273203555403, 4176.290030694774, 4234.661227101825, 4249.89630133083, 4250.574942505756, 4253.8723838284905, 4222.071144348254, 4222.339925846728, 4232.470941132358, 4245.702800803945, 4254.638355739766, 4230.830766769325, 4242.8727138185905, 4247.426597409341, 4249.745015299092, 4253.97873010633, 3671.94492082619, 3750.906227344311, 3759.793211373373, 3776.206996530732, 3777.2067865748227, 5257.185136303879, 5284.2521888618085, 5291.497307755757, 5300.973495132538, 5341.4658534146665, 4850.442199147073, 4857.198562237227, 4875.024995000978, 4888.706677599355, 4894.143524883131, 5442.564594832444, 5601.439856014366, 5712.11462223356, 5725.942740572625, 5730.6275092119295, 4092.260789164623, 4093.713440059197, 4096.631303182728, 4116.444280022189, 4122.649574786146, 5903.439173278532, 5917.644941303535, 5926.792562260343, 5964.105384192362, 5977.641341519479, 4112.424260603518, 4213.314674130373, 4224.746515209097, 4248.511421186541, 4258.5954334338185, 4236.766977816188, 4258.6380157686945, 4264.552222016706, 4273.786310684453, 4290.4636920384955, 4838.911244969853, 4843.782029808667, 4849.612031037508, 4862.954464790017, 4867.537583929521, 5590.720463976866, 5738.24564209182, 5777.277840269966, 5782.739776709974, 5787.565932555075, 1460.5545308680955, 1487.8958472907009, 1488.732028234928, 1493.872126544452, 1498.8234236124808, 900.4282280751639, 937.3672770879629, 943.8772959515356, 943.9852158929178, 953.2326477185932, 4785.617150627942, 4845.152098382769, 4863.392075990501, 4874.8537543873745, 4884.975575122173, 5142.794288228429, 5163.483651634807, 5171.241777795568, 5180.870478238075, 5182.460594308762, 4619.8845028873875, 4856.15466122871, 4862.246351815475, 4865.9756701216265, 4871.611590696634, 2743.1496236166854, 2748.6014527893344, 2755.76575991039, 2762.557990721475, 2764.4609301186074, 5297.920531192035, 5311.442298558596, 5317.335333083364, 5319.973400133052, 5347.919781203285, 5277.551408130352, 5284.233786100994, 5690.236026831695, 6078.787242446493, 6106.72519736613, 6141.385861413823, 6141.508679305645, 6176.7838125665385, 6186.876262474725, 6193.841141018203, 5693.580228402995, 5887.7056147193325, 6011.7595296187665, 6015.12780646795, 6051.304100028553, 5865.5600829937075, 5941.7623295067715, 5952.166696662384, 5955.285365756137, 5956.731947062479, 6124.846878828065, 6132.202813634199, 6183.412575805291, 6191.35928978812, 6201.255849298113, 3770.342767515506, 4034.495688038995, 4140.44104045962, 4151.315033019518, 4152.356384760367, 5923.970380148072, 5931.228940237742, 5933.673647949404, 5936.436038576328, 5937.435943585352, 5655.830325090254, 5763.394843541536, 5768.855778605568, 5780.884382312246, 5782.681952492653, 5742.569307301886, 5757.9424205757405, 5770.3652598215, 5773.393793651774, 5785.652860828363, 5692.800751973661, 5695.857603559944, 5699.0, 5705.258316419005, 5733.426657334233, 5596.468335508121, 5734.799282025109, 5764.827055188351, 5775.220345253337, 5793.304803423616, 5646.491815736439, 5649.576281778801, 5669.489745922887, 5673.404292549388, 5686.516646085129], "value": 4283.791780548732, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [691.8062942376135, 736.9042024536813, 748.6780684305746, 759.4110609012072, 794.7933537280312, 15059.849401505982, 16414.753778693314, 16472.176391180452, 16517.174141292948, 16532.91733541332, 16548.255328510215, 17013.744793828104, 17151.656966860653, 17175.227114779835, 17177.227024783882, 783.7217787685389, 807.5033854179696, 809.8906647602587, 810.0360570920585, 810.3395732478041, 770.7418014964993, 800.9159038300982, 802.7952872017627, 806.762005208462, 807.4872455990429, 847.8558645030329, 849.4987957105307, 850.7915560687641, 851.0808327006818, 851.2168804699692, 834.0366876257932, 836.9204925532065, 844.2654890245465, 846.0862268749767, 846.8899043124385, 617.1360095865779, 617.7868635320852, 619.4827319188483, 619.5415392609436, 621.6674079367561, 15843.0, 15957.920210398874, 15970.201489925457, 16023.679526409524, 16049.2777824997, 14447.349869255804, 14566.635834104127, 14647.560573182715, 14707.264636768226, 14834.703305933928, 11342.206045576813, 11463.36951467669, 11510.942445287803, 11742.060635149168, 11814.763704725858, 3672.412414013745, 3693.113652723354, 3724.3854763963914, 3754.4743735877, 3800.9809950950344, 83441.0, 85217.0, 85367.0, 85868.99999999937, 86833.27750753694, 10436.165718120108, 10636.095931845724, 10660.0, 10706.73233169177, 10841.295315804447, 19107.140178691992, 19351.612967740566, 19589.60820783605, 19981.0, 20103.19587216495, 8024.959875200587, 8048.315893149031, 8071.23323284287, 8194.918050819535, 8228.958855205685, 4394.209042372404, 4526.592606665416, 4536.500984891659, 4539.455265368111, 4539.84110556129, 3613.0967258185456, 3694.6120657330594, 3711.257748450321, 3714.0714821294678, 3728.5525736911745, 589.6756783768996, 593.489598944907, 610.404855266112, 615.9753609855645, 636.6275728698763, 598.2372475094203, 653.3466533466534, 661.8279247395616, 662.8740539297518, 666.2171947961223, 8822.294216462667, 8881.600327985256, 8980.820383592292, 9012.81974360509, 9353.11145441182, 589.6579983609496, 639.7623174052983, 640.7340953504337, 640.9359064093646, 663.7444583835162, 4187.476565429321, 4244.448221731155, 4367.912641747147, 4521.66087543429, 4582.266837306015, 78547.60726196332, 125966.0, 127070.93935909502, 128714.0, 133236.0, 114178.0, 115770.0, 116915.0, 117711.0, 121004.68948415667, 78715.60642196867, 79694.0, 79999.20000800033, 88851.55574222216, 96079.0, 8305.709300174465, 8988.146126118008, 8999.64001439935, 9054.773630659287, 9199.678011269574, 52465.47534524606, 53936.19095713489, 54802.45197547974, 55056.0, 56230.15654765264, 69209.65395173193, 77107.61446192733, 77757.50091245794, 79347.0, 81656.59171704104, 12088.093392995384, 12183.329916854658, 12255.816162757388, 12295.815562766387, 12611.495540178657, 13613.251271179784, 13746.862531374958, 13755.38100785487, 13794.448222071005, 14223.857761422254, 12101.394930253276, 12282.140250182401, 12449.823198366668, 12574.245545267313, 13003.544875929298, 11886.0, 12076.21504602198, 13068.411921463367, 13090.803637945248, 13128.277944713132, 11392.145589080686, 11487.885121148682, 12309.0, 12342.382880855741, 12359.073069519642, 9772.951135244279, 10089.445080520349, 10160.0, 10186.388816671024, 10203.234757393077, 9830.4101753895, 9830.950845246014, 10348.706411698538, 10900.836487452536, 11360.943195283971], "value": 7416.151129919732, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1508.0000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 114.0, 112.0, 113.0, 113.0, 112.0, 113.0, 111.0, 113.0, 112.0], "value": 111.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 119.0, 120.0, 172.0, 123.0, 123.0, 122.0, 123.0, 147.0, 125.0], "value": 132.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 165.0, 166.0, 173.0, 165.0, 165.0, 161.0, 163.0, 163.0, 161.0], "value": 164.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 77.0, 75.0, 110.0, 77.0, 77.0, 76.0, 77.0, 99.0, 74.0], "value": 81.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 112.0, 83.0, 83.0, 83.0, 99.0, 83.0, 82.0, 114.0], "value": 90.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 119.0, 118.0, 118.0, 118.0, 119.0, 118.0, 118.0, 118.0, 118.0], "value": 118.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 146.0, 146.0, 148.0, 148.0, 147.0, 148.0, 148.0, 146.0], "value": 147.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 96.0, 95.0, 95.0, 95.0, 96.0, 97.0, 97.0, 95.0], "value": 95.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 52.0, 54.0, 52.0, 52.0, 52.0, 57.0, 54.0, 54.0, 52.0], "value": 53.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 64.0, 62.0, 67.0, 63.0, 62.0, 62.0, 62.0, 63.0], "value": 63.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 79.0, 80.0, 82.0, 80.0, 80.0, 84.0, 84.0, 80.0], "value": 80.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 132.0, 123.0, 138.0, 124.0, 143.0, 135.0, 129.0, 177.0, 134.0], "value": 137.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 167.0, 166.0, 164.0, 165.0, 163.0, 172.0, 165.0, 166.0, 163.0], "value": 165.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 66.0, 65.0, 64.0, 66.0, 64.0, 65.0, 69.0, 63.0], "value": 65.4, "unit": "score"}]}]} 06:43:06 INFO - Return code: 0 06:43:06 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:43:06 ERROR - # TBPL SUCCESS # 06:43:06 INFO - Running post-action listener: _resource_record_post_action 06:43:06 INFO - [mozharness: 2016-09-27 13:43:06.786004Z] Finished run-tests step (success) 06:43:06 INFO - Running post-run listener: _resource_record_post_run 06:43:06 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 8192; Write bytes: 392876032; Read time: 192; Write time: 284208 06:43:06 INFO - TinderboxPrint: CPU usage
13.4% 06:43:06 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 192 06:43:06 INFO - TinderboxPrint: I/O write bytes / time
392,876,032 / 284,208 06:43:06 INFO - TinderboxPrint: CPU idle
8,244.6 (86.6%) 06:43:06 INFO - TinderboxPrint: CPU user
1,214.7 (12.8%) 06:43:06 INFO - TinderboxPrint: Swap in / out
0 / 0 06:43:06 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 103776256; Read time: 0; Write time: 105388 06:43:06 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 4096; Write bytes: 289099776; Read time: 180; Write time: 178820 06:43:07 INFO - Running post-run listener: _upload_blobber_files 06:43:07 INFO - Blob upload gear active. 06:43:07 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:43:07 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:43:07 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:43:07 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:43:07 INFO - (blobuploader) - INFO - Open directory for files ... 06:43:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:43:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:43:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:43:12 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:43:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:43:12 INFO - (blobuploader) - INFO - Done attempting. 06:43:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 06:43:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:43:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:43:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 06:43:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:43:12 INFO - (blobuploader) - INFO - Done attempting. 06:43:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 06:43:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:43:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:43:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 06:43:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:43:13 INFO - (blobuploader) - INFO - Done attempting. 06:43:13 INFO - (blobuploader) - INFO - Iteration through files over. 06:43:13 INFO - Return code: 0 06:43:13 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:43:13 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:43:13 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8a2ad7eba76c97440e47665dfc2e2c16970cbc673182f6fdea3f87b447d5e1793ea154a258c0886f8c85b0fa81bd1e9ea2ce5b038e9d9715708d74898d8782f3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/41e7e929b90ad235923b7f7f55e0093b53eab429864f988c5c6b3ebe65e12f017e7745a34321f31eb637ffdef05a2232dd3352cf3c0cbd8170bad74ea40f6874", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6598b3c37fa4cf4a62683be6d2f090f65be6bbb1f95dece02f458a98408a809d5e513fa676f664ba7c8dee29cfbdbe37f360bc7d4b675efc8c589e61f23d7f32"} 06:43:13 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:43:13 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:43:13 INFO - Contents: 06:43:13 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8a2ad7eba76c97440e47665dfc2e2c16970cbc673182f6fdea3f87b447d5e1793ea154a258c0886f8c85b0fa81bd1e9ea2ce5b038e9d9715708d74898d8782f3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/41e7e929b90ad235923b7f7f55e0093b53eab429864f988c5c6b3ebe65e12f017e7745a34321f31eb637ffdef05a2232dd3352cf3c0cbd8170bad74ea40f6874", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6598b3c37fa4cf4a62683be6d2f090f65be6bbb1f95dece02f458a98408a809d5e513fa676f664ba7c8dee29cfbdbe37f360bc7d4b675efc8c589e61f23d7f32"} 06:43:13 INFO - Running post-run listener: copy_logs_to_upload_dir 06:43:13 INFO - Copying logs to upload dir... 06:43:13 INFO - mkdir: /builds/slave/test/build/upload/logs 06:43:13 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.779522 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-09-27 06:43:13.784504) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-27 06:43:13.787640) ========= 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=32c5991c409366f7fec8a718000001d2-1474981754.227521-1152516045 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/8a2ad7eba76c97440e47665dfc2e2c16970cbc673182f6fdea3f87b447d5e1793ea154a258c0886f8c85b0fa81bd1e9ea2ce5b038e9d9715708d74898d8782f3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/41e7e929b90ad235923b7f7f55e0093b53eab429864f988c5c6b3ebe65e12f017e7745a34321f31eb637ffdef05a2232dd3352cf3c0cbd8170bad74ea40f6874", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6598b3c37fa4cf4a62683be6d2f090f65be6bbb1f95dece02f458a98408a809d5e513fa676f664ba7c8dee29cfbdbe37f360bc7d4b675efc8c589e61f23d7f32"} build_url:https://queue.taskcluster.net/v1/task/MYsYVFtIQOSwzpAwK0uyyg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011275 build_url: 'https://queue.taskcluster.net/v1/task/MYsYVFtIQOSwzpAwK0uyyg/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/8a2ad7eba76c97440e47665dfc2e2c16970cbc673182f6fdea3f87b447d5e1793ea154a258c0886f8c85b0fa81bd1e9ea2ce5b038e9d9715708d74898d8782f3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/41e7e929b90ad235923b7f7f55e0093b53eab429864f988c5c6b3ebe65e12f017e7745a34321f31eb637ffdef05a2232dd3352cf3c0cbd8170bad74ea40f6874", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6598b3c37fa4cf4a62683be6d2f090f65be6bbb1f95dece02f458a98408a809d5e513fa676f664ba7c8dee29cfbdbe37f360bc7d4b675efc8c589e61f23d7f32"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-27 06:43:13.816398) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 06:43:13.816744) ========= 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=32c5991c409366f7fec8a718000001d2-1474981754.227521-1152516045 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004517 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 06:43:13.903900) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-27 06:43:13.904697) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-27 06:43:13.905404) ========= ========= Total master_lag: 0.45 =========