builder: autoland_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-057 starttime: 1474421155.05 results: success (0) buildid: 20160920182047 builduid: 4d6e7da6f83847c480eca867edb4a528 revision: d619a8596986fe0c8d3eee7bf1d904eb4b32a664 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-20 18:25:55.048904) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-20 18:25:55.049415) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-20 18:25:55.049768) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-20 18:25:55.067576) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-20 18:25:55.067885) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1474421154.699289-1923519824 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-20 18:25:55-- 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% 223M=0s 2016-09-20 18:25:55 (223 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.326093 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-20 18:25:55.412332) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-20 18:25:55.413094) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1474421154.699289-1923519824 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016021 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-20 18:25:55.463816) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-20 18:25:55.464233) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev d619a8596986fe0c8d3eee7bf1d904eb4b32a664 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev d619a8596986fe0c8d3eee7bf1d904eb4b32a664 --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=934fc3100db09dcb9af4d4b6000001ab-1474421154.699289-1923519824 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-20 18:25:55,848 truncating revision to first 12 chars 2016-09-20 18:25:55,848 Setting DEBUG logging. 2016-09-20 18:25:55,848 attempt 1/10 2016-09-20 18:25:55,848 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/d619a8596986?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-20 18:25:56,151 unpacking tar archive at: autoland-d619a8596986/testing/mozharness/ program finished with exit code 0 elapsedTime=0.625654 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-20 18:25:56.101512) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-20 18:25:56.101944) ========= script_repo_revision: d619a8596986fe0c8d3eee7bf1d904eb4b32a664 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-20 18:25:56.102382) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-20 18:25:56.102699) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-20 18:25:56.110453) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-09-20 18:25:56.110768) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 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', 'Autoland', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland'] 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=934fc3100db09dcb9af4d4b6000001ab-1474421154.699289-1923519824 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:25:56 INFO - MultiFileLogger online at 20160920 18:25:56 in /builds/slave/test 18:25:56 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 18:25:56 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:25:56 INFO - {'append_to_log': False, 18:25:56 INFO - 'base_work_dir': '/builds/slave/test', 18:25:56 INFO - 'blob_upload_branch': 'Autoland', 18:25:56 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:25:56 INFO - 'branch': 'Autoland', 18:25:56 INFO - 'buildbot_json_path': 'buildprops.json', 18:25:56 INFO - 'config_files': ('talos/linux_config.py',), 18:25:56 INFO - 'default_actions': ('clobber', 18:25:56 INFO - 'read-buildbot-config', 18:25:56 INFO - 'download-and-extract', 18:25:56 INFO - 'populate-webroot', 18:25:56 INFO - 'create-virtualenv', 18:25:56 INFO - 'install', 18:25:56 INFO - 'run-tests'), 18:25:56 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:25:56 INFO - 'download_minidump_stackwalk': True, 18:25:56 INFO - 'download_symbols': 'ondemand', 18:25:56 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:25:56 INFO - 'tooltool.py': '/tools/tooltool.py', 18:25:56 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:25:56 INFO - '/tools/misc-python/virtualenv.py')}, 18:25:56 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:25:56 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:25:56 INFO - 'installer_path': 'installer.exe', 18:25:56 INFO - 'log_level': 'info', 18:25:56 INFO - 'log_name': 'talos', 18:25:56 INFO - 'log_to_console': True, 18:25:56 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:25:56 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:25:56 INFO - 'opt_config_files': (), 18:25:56 INFO - 'pip_index': False, 18:25:56 INFO - 'sps_profile': False, 18:25:56 INFO - 'sps_profile_interval': 0, 18:25:56 INFO - 'suite': 'dromaeojs-e10s', 18:25:56 INFO - 'system_bits': '32', 18:25:56 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:25:56 INFO - 'title': 'talos-linux64-ix-057', 18:25:56 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:25:56 INFO - 'use_talos_json': True, 18:25:56 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:25:56 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:25:56 INFO - 'work_dir': 'build'} 18:25:56 INFO - [mozharness: 2016-09-21 01:25:56.586490Z] Running clobber step. 18:25:56 INFO - Running pre-action listener: _resource_record_pre_action 18:25:56 INFO - Running main action method: clobber 18:25:56 INFO - rmtree: /builds/slave/test/build 18:25:56 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:25:57 INFO - Running post-action listener: _resource_record_post_action 18:25:57 INFO - [mozharness: 2016-09-21 01:25:57.568791Z] Finished clobber step (success) 18:25:57 INFO - [mozharness: 2016-09-21 01:25:57.568890Z] Running read-buildbot-config step. 18:25:57 INFO - Running pre-action listener: _resource_record_pre_action 18:25:57 INFO - Running main action method: read_buildbot_config 18:25:57 INFO - Using buildbot properties: 18:25:57 INFO - { 18:25:57 INFO - "project": "", 18:25:57 INFO - "product": "firefox", 18:25:57 INFO - "script_repo_revision": "production", 18:25:57 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs-e10s", 18:25:57 INFO - "repository": "", 18:25:57 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland pgo talos dromaeojs-e10s", 18:25:57 INFO - "buildid": "20160920182047", 18:25:57 INFO - "stage_platform": "linux64-pgo", 18:25:57 INFO - "basedir": "/builds/slave/test", 18:25:57 INFO - "buildnumber": 255, 18:25:57 INFO - "platform": "ubuntu64_hw", 18:25:57 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 18:25:57 INFO - "slavebuilddir": "test", 18:25:57 INFO - "branch": "autoland", 18:25:57 INFO - "revision": "d619a8596986fe0c8d3eee7bf1d904eb4b32a664", 18:25:57 INFO - "slavename": "talos-linux64-ix-057", 18:25:57 INFO - "builduid": "4d6e7da6f83847c480eca867edb4a528", 18:25:57 INFO - "repo_path": "integration/autoland" 18:25:57 INFO - } 18:25:57 INFO - Found installer url https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1474410604/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 18:25:57 INFO - Found a test packages url https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1474410604/firefox-52.0a1.en-US.linux-x86_64.test_packages.json. 18:25:57 INFO - Running post-action listener: _resource_record_post_action 18:25:57 INFO - [mozharness: 2016-09-21 01:25:57.571272Z] Finished read-buildbot-config step (success) 18:25:57 INFO - [mozharness: 2016-09-21 01:25:57.571362Z] Running download-and-extract step. 18:25:57 INFO - Running pre-action listener: _resource_record_pre_action 18:25:57 INFO - Running main action method: download_and_extract 18:25:57 INFO - mkdir: /builds/slave/test/build/tests 18:25:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:25:57 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1474410604/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 18:25:57 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1474410604/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 18:25:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1474410604/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 18:25:57 INFO - Downloaded 1361 bytes. 18:25:57 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 18:25:57 INFO - Using the following test package requirements: 18:25:57 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 18:25:57 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:25:57 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 18:25:57 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:25:57 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 18:25:57 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:25:57 INFO - u'jsshell-linux-x86_64.zip'], 18:25:57 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:25:57 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 18:25:57 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 18:25:57 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:25:57 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 18:25:57 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:25:57 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 18:25:57 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:25:57 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 18:25:57 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:25:57 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 18:25:57 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 18:25:57 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1474410604/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 18:25:57 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1474410604/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 18:25:57 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1474410604/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 18:25:57 INFO - Expected file size: 21941154 18:26:02 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 18:26:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1474410604/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 18:26:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1474410604/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 18:26:02 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1474410604/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 18:26:02 INFO - Expected file size: 21941154 18:26:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1474410604/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 18:26:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1474410604/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 18:26:06 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1474410604/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 18:26:06 INFO - Expected file size: 14414059 18:26:07 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')]} 18:26:07 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1474410604/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 18:26:07 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1474410604/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 18:26:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1474410604/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 18:26:07 INFO - Downloaded 59548700 bytes. 18:26:07 INFO - Setting buildbot property build_url to https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1474410604/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 18:26:07 INFO - mkdir: /builds/slave/test/properties 18:26:07 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:26:07 INFO - Writing to file /builds/slave/test/properties/build_url 18:26:07 INFO - Contents: 18:26:07 INFO - build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1474410604/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 18:26:08 INFO - Running post-action listener: _resource_record_post_action 18:26:08 INFO - Running post-action listener: set_extra_try_arguments 18:26:08 INFO - [mozharness: 2016-09-21 01:26:08.373487Z] Finished download-and-extract step (success) 18:26:08 INFO - [mozharness: 2016-09-21 01:26:08.373716Z] Running populate-webroot step. 18:26:08 INFO - Running pre-action listener: _resource_record_pre_action 18:26:08 INFO - Running main action method: populate_webroot 18:26:08 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:26:08 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:26:08 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:26:08 INFO - '--tppagecycles', 18:26:08 INFO - '7'], 18:26:08 INFO - 'tests': ['tsvgm']}}, 18:26:08 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 18:26:08 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:26:08 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:26:08 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:26:08 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:26:08 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:26:08 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:26:08 INFO - 'talos_options': ['--disable-e10s'], 18:26:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:26:08 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:26:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:26:08 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:26:08 INFO - 'talos_options': ['--disable-e10s'], 18:26:08 INFO - 'tests': ['damp', 'tps']}, 18:26:08 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:26:08 INFO - 'tests': ['damp', 'tps']}, 18:26:08 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:26:08 INFO - 'tests': ['dromaeo_dom']}, 18:26:08 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:26:08 INFO - 'g4': {'talos_options': ['--disable-e10s'], 18:26:08 INFO - 'tests': ['basic_compositor_video']}, 18:26:08 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 18:26:08 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:26:08 INFO - 'tests': ['a11yr', 18:26:08 INFO - 'ts_paint', 18:26:08 INFO - 'tpaint', 18:26:08 INFO - 'sessionrestore', 18:26:08 INFO - 'sessionrestore_no_auto_restore', 18:26:08 INFO - 'tabpaint']}, 18:26:08 INFO - 'other-e10s': {'tests': ['a11yr', 18:26:08 INFO - 'ts_paint', 18:26:08 INFO - 'tpaint', 18:26:08 INFO - 'sessionrestore', 18:26:08 INFO - 'sessionrestore_no_auto_restore', 18:26:08 INFO - 'tabpaint']}, 18:26:08 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:26:08 INFO - 'ts_paint', 18:26:08 INFO - 'tpaint', 18:26:08 INFO - 'sessionrestore', 18:26:08 INFO - 'sessionrestore_no_auto_restore', 18:26:08 INFO - 'tabpaint']}, 18:26:08 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:26:08 INFO - 'ts_paint', 18:26:08 INFO - 'tpaint', 18:26:08 INFO - 'sessionrestore', 18:26:08 INFO - 'sessionrestore_no_auto_restore', 18:26:08 INFO - 'tabpaint']}, 18:26:08 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:26:08 INFO - 'tests': ['a11yr', 18:26:08 INFO - 'ts_paint', 18:26:08 INFO - 'tpaint', 18:26:08 INFO - 'sessionrestore', 18:26:08 INFO - 'sessionrestore_no_auto_restore', 18:26:08 INFO - 'tabpaint']}, 18:26:08 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:26:08 INFO - 'tests': ['a11yr', 18:26:08 INFO - 'ts_paint', 18:26:08 INFO - 'tpaint', 18:26:08 INFO - 'sessionrestore', 18:26:08 INFO - 'sessionrestore_no_auto_restore', 18:26:08 INFO - 'tabpaint']}, 18:26:08 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:26:08 INFO - 'tests': ['tsvgx', 18:26:08 INFO - 'tsvgr_opacity', 18:26:08 INFO - 'tart', 18:26:08 INFO - 'tscrollx', 18:26:08 INFO - 'cart']}, 18:26:08 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:26:08 INFO - 'tsvgr_opacity', 18:26:08 INFO - 'tart', 18:26:08 INFO - 'tscrollx', 18:26:08 INFO - 'cart']}, 18:26:08 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:26:08 INFO - 'talos_options': ['--disable-e10s'], 18:26:08 INFO - 'tests': ['tp5o']}, 18:26:08 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:26:08 INFO - 'tests': ['tp5o']}, 18:26:08 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:26:08 INFO - 'talos_options': ['--disable-e10s', 18:26:08 INFO - '--xperf_path', 18:26:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:26:08 INFO - 'tests': ['tp5n']}, 18:26:08 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:26:08 INFO - 'talos_options': ['--xperf_path', 18:26:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:26:08 INFO - 'tests': ['tp5n']}}, 18:26:08 INFO - 'talos.zip': {'path': '', 18:26:08 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:26:08 INFO - Running post-action listener: _resource_record_post_action 18:26:08 INFO - [mozharness: 2016-09-21 01:26:08.390300Z] Finished populate-webroot step (success) 18:26:08 INFO - [mozharness: 2016-09-21 01:26:08.390390Z] Running create-virtualenv step. 18:26:08 INFO - Running pre-action listener: _resource_record_pre_action 18:26:08 INFO - Running main action method: create_virtualenv 18:26:08 INFO - Creating virtualenv /builds/slave/test/build/venv 18:26:08 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 18:26:08 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:26:08 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:26:08 INFO - Using real prefix '/usr' 18:26:08 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:26:08 INFO - Installing distribute.............................................................................................................................................................................................done. 18:26:10 INFO - Installing pip.................done. 18:26:10 INFO - Return code: 0 18:26:10 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:26:10 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')]} 18:26:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:26:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:26:10 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')]} 18:26:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:26:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:26:10 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 0x7f541d3cef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e178a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ee4790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee1930>, '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 0x1ee2830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ee2cc0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1474421154.699289-1923519824', '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 18:26:10 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 18:26:10 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 18:26:10 INFO - Using env: {'DISPLAY': ':0', 18:26:10 INFO - 'HOME': '/home/cltbld', 18:26:10 INFO - 'LANG': 'en_US.UTF-8', 18:26:10 INFO - 'LANGUAGE': 'en_US:en', 18:26:10 INFO - 'LOGNAME': 'cltbld', 18:26:10 INFO - 'MAIL': '/var/mail/cltbld', 18:26:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:26:10 INFO - 'MOZ_NO_REMOTE': '1', 18:26:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:26:10 INFO - 'NO_EM_RESTART': '1', 18:26:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:26:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:26:10 INFO - 'PWD': '/builds/slave/test', 18:26:10 INFO - 'SHELL': '/bin/bash', 18:26:10 INFO - 'SHLVL': '1', 18:26:10 INFO - 'TERM': 'linux', 18:26:10 INFO - 'TMOUT': '86400', 18:26:10 INFO - 'USER': 'cltbld', 18:26:10 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1474421154.699289-1923519824', 18:26:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:26:10 INFO - '_': '/tools/buildbot/bin/python'} 18:26:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:26:11 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 18:26:11 INFO - Cleaning up... 18:26:11 INFO - Return code: 0 18:26:11 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:26: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')]} 18:26:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:26:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:26: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')]} 18:26:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:26:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:26:11 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 0x7f541d3cef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e178a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ee4790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee1930>, '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 0x1ee2830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ee2cc0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1474421154.699289-1923519824', '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 18:26:11 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 18:26:11 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 18:26:11 INFO - Using env: {'DISPLAY': ':0', 18:26:11 INFO - 'HOME': '/home/cltbld', 18:26:11 INFO - 'LANG': 'en_US.UTF-8', 18:26:11 INFO - 'LANGUAGE': 'en_US:en', 18:26:11 INFO - 'LOGNAME': 'cltbld', 18:26:11 INFO - 'MAIL': '/var/mail/cltbld', 18:26:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:26:11 INFO - 'MOZ_NO_REMOTE': '1', 18:26:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:26:11 INFO - 'NO_EM_RESTART': '1', 18:26:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:26:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:26:11 INFO - 'PWD': '/builds/slave/test', 18:26:11 INFO - 'SHELL': '/bin/bash', 18:26:11 INFO - 'SHLVL': '1', 18:26:11 INFO - 'TERM': 'linux', 18:26:11 INFO - 'TMOUT': '86400', 18:26:11 INFO - 'USER': 'cltbld', 18:26:11 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1474421154.699289-1923519824', 18:26:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:26:11 INFO - '_': '/tools/buildbot/bin/python'} 18:26:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:26:11 INFO - Downloading/unpacking psutil>=3.1.1 18:26:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:26:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:26:11 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 18:26:11 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 18:26:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:26:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:26:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:26:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:26:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:26:13 INFO - Installing collected packages: psutil 18:26:13 INFO - Running setup.py install for psutil 18:26:13 INFO - building 'psutil._psutil_linux' extension 18:26:13 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 18:26:13 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 18:26:13 INFO - building 'psutil._psutil_posix' extension 18:26:13 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 18:26:13 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 18:26:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:26:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:26:13 INFO - Successfully installed psutil 18:26:13 INFO - Cleaning up... 18:26:13 INFO - Return code: 0 18:26:13 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:26:13 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')]} 18:26:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:26:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:26:13 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')]} 18:26:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:26:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:26:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.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 0x7f541d3cef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e178a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ee4790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee1930>, '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 0x1ee2830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ee2cc0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1474421154.699289-1923519824', '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 18:26:13 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 18:26:13 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 18:26:13 INFO - Using env: {'DISPLAY': ':0', 18:26:13 INFO - 'HOME': '/home/cltbld', 18:26:13 INFO - 'LANG': 'en_US.UTF-8', 18:26:13 INFO - 'LANGUAGE': 'en_US:en', 18:26:13 INFO - 'LOGNAME': 'cltbld', 18:26:13 INFO - 'MAIL': '/var/mail/cltbld', 18:26:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:26:13 INFO - 'MOZ_NO_REMOTE': '1', 18:26:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:26:13 INFO - 'NO_EM_RESTART': '1', 18:26:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:26:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:26:13 INFO - 'PWD': '/builds/slave/test', 18:26:13 INFO - 'SHELL': '/bin/bash', 18:26:13 INFO - 'SHLVL': '1', 18:26:13 INFO - 'TERM': 'linux', 18:26:13 INFO - 'TMOUT': '86400', 18:26:13 INFO - 'USER': 'cltbld', 18:26:13 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1474421154.699289-1923519824', 18:26:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:26:13 INFO - '_': '/tools/buildbot/bin/python'} 18:26:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:26:14 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:26:14 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 18:26:14 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 18:26:14 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 18:26:14 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 18:26:14 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 18:26:14 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 18:26:16 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:26:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:26:16 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:26:16 INFO - Installing collected packages: mozsystemmonitor 18:26:16 INFO - Running setup.py install for mozsystemmonitor 18:26:16 INFO - Successfully installed mozsystemmonitor 18:26:16 INFO - Cleaning up... 18:26:16 INFO - Return code: 0 18:26:16 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:26:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:26:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:26:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:26:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:26:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:26:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:26:16 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 0x7f541d3cef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e178a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ee4790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee1930>, '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 0x1ee2830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ee2cc0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1474421154.699289-1923519824', '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 18:26:16 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 18:26:16 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 18:26:16 INFO - Using env: {'DISPLAY': ':0', 18:26:16 INFO - 'HOME': '/home/cltbld', 18:26:16 INFO - 'LANG': 'en_US.UTF-8', 18:26:16 INFO - 'LANGUAGE': 'en_US:en', 18:26:16 INFO - 'LOGNAME': 'cltbld', 18:26:16 INFO - 'MAIL': '/var/mail/cltbld', 18:26:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:26:16 INFO - 'MOZ_NO_REMOTE': '1', 18:26:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:26:16 INFO - 'NO_EM_RESTART': '1', 18:26:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:26:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:26:16 INFO - 'PWD': '/builds/slave/test', 18:26:16 INFO - 'SHELL': '/bin/bash', 18:26:16 INFO - 'SHLVL': '1', 18:26:16 INFO - 'TERM': 'linux', 18:26:16 INFO - 'TMOUT': '86400', 18:26:16 INFO - 'USER': 'cltbld', 18:26:16 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1474421154.699289-1923519824', 18:26:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:26:16 INFO - '_': '/tools/buildbot/bin/python'} 18:26:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:26:16 INFO - Downloading/unpacking jsonschema==2.5.1 18:26:16 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 18:26:16 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 18:26:16 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 18:26:16 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 18:26:16 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 18:26:16 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 18:26:18 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:26:18 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:26:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:26:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:26:18 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 18:26:18 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 18:26:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:26:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:26:18 INFO - Downloading functools32-3.2.3-2.tar.gz 18:26:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:26:18 INFO - warning: no files found matching '*.txt' 18:26:18 INFO - no previously-included directories found matching 'build' 18:26:18 INFO - no previously-included directories found matching 'dist' 18:26:18 INFO - no previously-included directories found matching '.git*' 18:26:18 INFO - Installing collected packages: jsonschema, functools32 18:26:18 INFO - Running setup.py install for functools32 18:26:18 INFO - warning: no files found matching '*.txt' 18:26:18 INFO - no previously-included directories found matching 'build' 18:26:18 INFO - no previously-included directories found matching 'dist' 18:26:18 INFO - no previously-included directories found matching '.git*' 18:26:18 INFO - Successfully installed jsonschema functools32 18:26:18 INFO - Cleaning up... 18:26:18 INFO - Return code: 0 18:26:18 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 18:26:18 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')]} 18:26:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:26:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:26:18 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')]} 18:26:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:26:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:26:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.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 0x7f541d3cef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e178a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ee4790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee1930>, '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 0x1ee2830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ee2cc0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1474421154.699289-1923519824', '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 18:26:18 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 18:26:18 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 18:26:18 INFO - Using env: {'DISPLAY': ':0', 18:26:18 INFO - 'HOME': '/home/cltbld', 18:26:18 INFO - 'LANG': 'en_US.UTF-8', 18:26:18 INFO - 'LANGUAGE': 'en_US:en', 18:26:18 INFO - 'LOGNAME': 'cltbld', 18:26:18 INFO - 'MAIL': '/var/mail/cltbld', 18:26:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:26:18 INFO - 'MOZ_NO_REMOTE': '1', 18:26:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:26:18 INFO - 'NO_EM_RESTART': '1', 18:26:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:26:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:26:18 INFO - 'PWD': '/builds/slave/test', 18:26:18 INFO - 'SHELL': '/bin/bash', 18:26:18 INFO - 'SHLVL': '1', 18:26:18 INFO - 'TERM': 'linux', 18:26:18 INFO - 'TMOUT': '86400', 18:26:18 INFO - 'USER': 'cltbld', 18:26:18 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1474421154.699289-1923519824', 18:26:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:26:18 INFO - '_': '/tools/buildbot/bin/python'} 18:26:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:26:19 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 18:26:19 INFO - Cleaning up... 18:26:19 INFO - Return code: 0 18:26:19 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:26:19 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')]} 18:26:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:26:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:26:19 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')]} 18:26:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:26:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:26:19 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 0x7f541d3cef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e178a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ee4790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee1930>, '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 0x1ee2830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ee2cc0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1474421154.699289-1923519824', '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 18:26:19 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 18:26:19 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 18:26:19 INFO - Using env: {'DISPLAY': ':0', 18:26:19 INFO - 'HOME': '/home/cltbld', 18:26:19 INFO - 'LANG': 'en_US.UTF-8', 18:26:19 INFO - 'LANGUAGE': 'en_US:en', 18:26:19 INFO - 'LOGNAME': 'cltbld', 18:26:19 INFO - 'MAIL': '/var/mail/cltbld', 18:26:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:26:19 INFO - 'MOZ_NO_REMOTE': '1', 18:26:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:26:19 INFO - 'NO_EM_RESTART': '1', 18:26:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:26:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:26:19 INFO - 'PWD': '/builds/slave/test', 18:26:19 INFO - 'SHELL': '/bin/bash', 18:26:19 INFO - 'SHLVL': '1', 18:26:19 INFO - 'TERM': 'linux', 18:26:19 INFO - 'TMOUT': '86400', 18:26:19 INFO - 'USER': 'cltbld', 18:26:19 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1474421154.699289-1923519824', 18:26:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:26:19 INFO - '_': '/tools/buildbot/bin/python'} 18:26:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:26:19 INFO - Downloading/unpacking blobuploader==1.2.4 18:26:19 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 18:26:19 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 18:26:19 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 18:26:19 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 18:26:19 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 18:26:19 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 18:26:21 INFO - Downloading blobuploader-1.2.4.tar.gz 18:26:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:26:21 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:26:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:26:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:26:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:26:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:26:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:26:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:26:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:26:21 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:26:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:26:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:26:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:26:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:26:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:26:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:26:21 INFO - Downloading docopt-0.6.1.tar.gz 18:26:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:26:21 INFO - Installing collected packages: blobuploader, requests, docopt 18:26:21 INFO - Running setup.py install for blobuploader 18:26:22 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:26:22 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:26:22 INFO - Running setup.py install for requests 18:26:22 INFO - Running setup.py install for docopt 18:26:22 INFO - Successfully installed blobuploader requests docopt 18:26:22 INFO - Cleaning up... 18:26:22 INFO - Return code: 0 18:26:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:26:22 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')]} 18:26:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:26:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:26:22 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')]} 18:26:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:26:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:26:22 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 0x7f541d3cef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e178a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ee4790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee1930>, '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 0x1ee2830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ee2cc0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1474421154.699289-1923519824', '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 18:26:22 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 18:26:22 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 18:26:22 INFO - Using env: {'DISPLAY': ':0', 18:26:22 INFO - 'HOME': '/home/cltbld', 18:26:22 INFO - 'LANG': 'en_US.UTF-8', 18:26:22 INFO - 'LANGUAGE': 'en_US:en', 18:26:22 INFO - 'LOGNAME': 'cltbld', 18:26:22 INFO - 'MAIL': '/var/mail/cltbld', 18:26:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:26:22 INFO - 'MOZ_NO_REMOTE': '1', 18:26:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:26:22 INFO - 'NO_EM_RESTART': '1', 18:26:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:26:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:26:22 INFO - 'PWD': '/builds/slave/test', 18:26:22 INFO - 'SHELL': '/bin/bash', 18:26:22 INFO - 'SHLVL': '1', 18:26:22 INFO - 'TERM': 'linux', 18:26:22 INFO - 'TMOUT': '86400', 18:26:22 INFO - 'USER': 'cltbld', 18:26:22 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1474421154.699289-1923519824', 18:26:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:26:22 INFO - '_': '/tools/buildbot/bin/python'} 18:26:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:26:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:26:22 INFO - Running setup.py (path:/tmp/pip-xAbHnJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:26:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:26:22 INFO - Running setup.py (path:/tmp/pip-MC9Wvy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:26:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:26:22 INFO - Running setup.py (path:/tmp/pip-RMwArh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:26:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:26:22 INFO - Running setup.py (path:/tmp/pip-60ZPdT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:26:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:26:23 INFO - Running setup.py (path:/tmp/pip-dSuagc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:26:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:26:23 INFO - Running setup.py (path:/tmp/pip-sVLRKR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:26:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:26:23 INFO - Running setup.py (path:/tmp/pip-o0JlqD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:26:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:26:23 INFO - Running setup.py (path:/tmp/pip-R02Drh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:26:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:26:23 INFO - Running setup.py (path:/tmp/pip-EPGMfm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:26:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:26:23 INFO - Running setup.py (path:/tmp/pip-9D6c92-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:26:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:26:23 INFO - Running setup.py (path:/tmp/pip-AffLbL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:26:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:26:23 INFO - Running setup.py (path:/tmp/pip-MV91g_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:26:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:26:23 INFO - Running setup.py (path:/tmp/pip-oL20dp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:26:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:26:23 INFO - Running setup.py (path:/tmp/pip-7PrODF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:26:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:26:23 INFO - Running setup.py (path:/tmp/pip-p3wdRy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:26:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:26:23 INFO - Running setup.py (path:/tmp/pip-TeudZb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:26:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:26:23 INFO - Running setup.py (path:/tmp/pip-PMumPS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:26:23 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:26:23 INFO - Running setup.py install for manifestparser 18:26:24 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:26:24 INFO - Running setup.py install for mozcrash 18:26:24 INFO - Running setup.py install for mozdebug 18:26:24 INFO - Running setup.py install for mozdevice 18:26:24 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:26:24 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:26:24 INFO - Running setup.py install for mozfile 18:26:24 INFO - Running setup.py install for mozhttpd 18:26:24 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:26:24 INFO - Running setup.py install for mozinfo 18:26:24 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:26:24 INFO - Running setup.py install for mozInstall 18:26:24 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:26:24 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:26:24 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:26:24 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:26:24 INFO - Running setup.py install for mozleak 18:26:24 INFO - Running setup.py install for mozlog 18:26:25 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:26:25 INFO - Running setup.py install for moznetwork 18:26:25 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:26:25 INFO - Running setup.py install for mozprocess 18:26:25 INFO - Running setup.py install for mozprofile 18:26:25 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:26:25 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:26:25 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:26:25 INFO - Running setup.py install for mozrunner 18:26:25 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:26:25 INFO - Running setup.py install for mozscreenshot 18:26:25 INFO - Running setup.py install for moztest 18:26:25 INFO - Running setup.py install for mozversion 18:26:25 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:26:25 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:26:25 INFO - Cleaning up... 18:26:25 INFO - Return code: 0 18:26:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:26:25 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')]} 18:26:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:26:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:26:25 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')]} 18:26:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:26:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:26:25 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 0x7f541d3cef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e178a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ee4790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee1930>, '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 0x1ee2830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ee2cc0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1474421154.699289-1923519824', '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 18:26:25 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 18:26:25 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 18:26:25 INFO - Using env: {'DISPLAY': ':0', 18:26:25 INFO - 'HOME': '/home/cltbld', 18:26:25 INFO - 'LANG': 'en_US.UTF-8', 18:26:25 INFO - 'LANGUAGE': 'en_US:en', 18:26:25 INFO - 'LOGNAME': 'cltbld', 18:26:25 INFO - 'MAIL': '/var/mail/cltbld', 18:26:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:26:25 INFO - 'MOZ_NO_REMOTE': '1', 18:26:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:26:25 INFO - 'NO_EM_RESTART': '1', 18:26:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:26:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:26:25 INFO - 'PWD': '/builds/slave/test', 18:26:25 INFO - 'SHELL': '/bin/bash', 18:26:25 INFO - 'SHLVL': '1', 18:26:25 INFO - 'TERM': 'linux', 18:26:25 INFO - 'TMOUT': '86400', 18:26:25 INFO - 'USER': 'cltbld', 18:26:25 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1474421154.699289-1923519824', 18:26:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:26:25 INFO - '_': '/tools/buildbot/bin/python'} 18:26:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:26:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:26:26 INFO - Running setup.py (path:/tmp/pip-qnornm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:26:26 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)) 18:26:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:26:26 INFO - Running setup.py (path:/tmp/pip-oJ6SoP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:26:26 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)) 18:26:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:26:26 INFO - Running setup.py (path:/tmp/pip-VxxpJD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:26:26 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)) 18:26:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:26:26 INFO - Running setup.py (path:/tmp/pip-R4uJwL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:26:26 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)) 18:26:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:26:26 INFO - Running setup.py (path:/tmp/pip-lJ6q7Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:26:26 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)) 18:26:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:26:26 INFO - Running setup.py (path:/tmp/pip-1aev5u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:26:26 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)) 18:26:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:26:26 INFO - Running setup.py (path:/tmp/pip-zNe9ha-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:26:26 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)) 18:26:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:26:26 INFO - Running setup.py (path:/tmp/pip-MfLZnR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:26:26 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)) 18:26:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:26:26 INFO - Running setup.py (path:/tmp/pip-hY7NCn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:26:26 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)) 18:26:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:26:26 INFO - Running setup.py (path:/tmp/pip-thK1n1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:26:26 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)) 18:26:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:26:26 INFO - Running setup.py (path:/tmp/pip-8Uafw4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:26:26 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)) 18:26:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:26:26 INFO - Running setup.py (path:/tmp/pip-wu1u_3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:26:26 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)) 18:26:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:26:26 INFO - Running setup.py (path:/tmp/pip-UNNp80-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:26:26 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)) 18:26:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:26:26 INFO - Running setup.py (path:/tmp/pip-PWf9wa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:26:27 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)) 18:26:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:26:27 INFO - Running setup.py (path:/tmp/pip-oaRgYr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:26:27 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)) 18:26:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:26:27 INFO - Running setup.py (path:/tmp/pip-L8xuPi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:26:27 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)) 18:26:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:26:27 INFO - Running setup.py (path:/tmp/pip-kGBkMC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:26:27 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)) 18:26:27 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)) 18:26:27 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)) 18:26:27 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)) 18:26:27 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)) 18:26:27 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)) 18:26:27 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:26:27 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 18:26:27 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 18:26:27 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 18:26:27 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 18:26:27 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 18:26:27 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 18:26:29 INFO - Downloading blessings-1.6.tar.gz 18:26:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:26:29 INFO - Installing collected packages: blessings 18:26:29 INFO - Running setup.py install for blessings 18:26:29 INFO - Successfully installed blessings 18:26:29 INFO - Cleaning up... 18:26:29 INFO - Return code: 0 18:26:29 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:26:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:26:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:26:29 INFO - Reading from file tmpfile_stdout 18:26:29 INFO - Current package versions: 18:26:29 INFO - argparse == 1.2.1 18:26:29 INFO - blessings == 1.6 18:26:29 INFO - blobuploader == 1.2.4 18:26:29 INFO - docopt == 0.6.1 18:26:29 INFO - functools32 == 3.2.3-2 18:26:29 INFO - jsonschema == 2.5.1 18:26:29 INFO - manifestparser == 1.1 18:26:29 INFO - mozInstall == 1.12 18:26:29 INFO - mozcrash == 0.17 18:26:29 INFO - mozdebug == 0.1 18:26:29 INFO - mozdevice == 0.48 18:26:29 INFO - mozfile == 1.2 18:26:29 INFO - mozhttpd == 0.7 18:26:29 INFO - mozinfo == 0.9 18:26:29 INFO - mozleak == 0.1 18:26:29 INFO - mozlog == 3.4 18:26:29 INFO - moznetwork == 0.27 18:26:29 INFO - mozprocess == 0.23 18:26:29 INFO - mozprofile == 0.28 18:26:29 INFO - mozrunner == 6.12 18:26:29 INFO - mozscreenshot == 0.1 18:26:29 INFO - mozsystemmonitor == 0.3 18:26:29 INFO - moztest == 0.7 18:26:29 INFO - mozversion == 1.4 18:26:29 INFO - psutil == 3.1.1 18:26:29 INFO - requests == 1.2.3 18:26:29 INFO - wsgiref == 0.1.2 18:26:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:26: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')]} 18:26:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:26:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:26: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')]} 18:26:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:26:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:26:29 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 0x7f541d3cef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e178a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ee4790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee1930>, '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 0x1ee2830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ee2cc0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1474421154.699289-1923519824', '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 18:26:29 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 18:26:29 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 18:26:29 INFO - Using env: {'DISPLAY': ':0', 18:26:29 INFO - 'HOME': '/home/cltbld', 18:26:29 INFO - 'LANG': 'en_US.UTF-8', 18:26:29 INFO - 'LANGUAGE': 'en_US:en', 18:26:29 INFO - 'LOGNAME': 'cltbld', 18:26:29 INFO - 'MAIL': '/var/mail/cltbld', 18:26:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:26:29 INFO - 'MOZ_NO_REMOTE': '1', 18:26:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:26:29 INFO - 'NO_EM_RESTART': '1', 18:26:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:26:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:26:29 INFO - 'PWD': '/builds/slave/test', 18:26:29 INFO - 'SHELL': '/bin/bash', 18:26:29 INFO - 'SHLVL': '1', 18:26:29 INFO - 'TERM': 'linux', 18:26:29 INFO - 'TMOUT': '86400', 18:26:29 INFO - 'USER': 'cltbld', 18:26:29 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1474421154.699289-1923519824', 18:26:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:26:29 INFO - '_': '/tools/buildbot/bin/python'} 18:26:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:26:29 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)) 18:26:29 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)) 18:26:29 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)) 18:26:29 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)) 18:26:29 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)) 18:26:29 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)) 18:26:29 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)) 18:26:29 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)) 18:26:29 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)) 18:26:29 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)) 18:26:29 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)) 18:26:29 INFO - Cleaning up... 18:26:29 INFO - Return code: 0 18:26:29 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:26: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')]} 18:26:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:26:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:26: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')]} 18:26:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:26:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:26:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f541d3cef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e178a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ee4790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ee1930>, '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 0x1ee2830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ee2cc0>, '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': '934fc3100db09dcb9af4d4b6000001ab-1474421154.699289-1923519824', '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 18:26:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 18:26:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 18:26:29 INFO - Using env: {'DISPLAY': ':0', 18:26:29 INFO - 'HOME': '/home/cltbld', 18:26:29 INFO - 'LANG': 'en_US.UTF-8', 18:26:29 INFO - 'LANGUAGE': 'en_US:en', 18:26:29 INFO - 'LOGNAME': 'cltbld', 18:26:29 INFO - 'MAIL': '/var/mail/cltbld', 18:26:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:26:29 INFO - 'MOZ_NO_REMOTE': '1', 18:26:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:26:29 INFO - 'NO_EM_RESTART': '1', 18:26:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:26:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:26:29 INFO - 'PWD': '/builds/slave/test', 18:26:29 INFO - 'SHELL': '/bin/bash', 18:26:29 INFO - 'SHLVL': '1', 18:26:29 INFO - 'TERM': 'linux', 18:26:29 INFO - 'TMOUT': '86400', 18:26:29 INFO - 'USER': 'cltbld', 18:26:29 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1474421154.699289-1923519824', 18:26:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:26:29 INFO - '_': '/tools/buildbot/bin/python'} 18:26:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:26:30 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:26:30 INFO - Cleaning up... 18:26:30 INFO - Return code: 0 18:26:30 INFO - Running post-action listener: _resource_record_post_action 18:26:30 INFO - Running post-action listener: _start_resource_monitoring 18:26:30 INFO - Starting resource monitoring. 18:26:30 INFO - [mozharness: 2016-09-21 01:26:30.092068Z] Finished create-virtualenv step (success) 18:26:30 INFO - [mozharness: 2016-09-21 01:26:30.092579Z] Running install step. 18:26:30 INFO - Running pre-action listener: _resource_record_pre_action 18:26:30 INFO - Running main action method: install 18:26:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:26:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:26:30 INFO - Reading from file tmpfile_stdout 18:26:30 INFO - Detecting whether we're running mozinstall >=1.0... 18:26:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:26:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:26:30 INFO - Reading from file tmpfile_stdout 18:26:30 INFO - Output received: 18:26:30 INFO - Usage: mozinstall [options] installer 18:26:30 INFO - Options: 18:26:30 INFO - -h, --help show this help message and exit 18:26:30 INFO - -d DEST, --destination=DEST 18:26:30 INFO - Directory to install application into. [default: 18:26:30 INFO - "/builds/slave/test"] 18:26:30 INFO - --app=APP Application being installed. [default: firefox] 18:26:30 INFO - mkdir: /builds/slave/test/build/application 18:26:30 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'] 18:26:30 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 18:26:47 INFO - Reading from file tmpfile_stdout 18:26:47 INFO - Output received: 18:26:47 INFO - /builds/slave/test/build/application/firefox/firefox 18:26:47 INFO - Running post-action listener: _resource_record_post_action 18:26:47 INFO - [mozharness: 2016-09-21 01:26:47.497169Z] Finished install step (success) 18:26:47 INFO - [mozharness: 2016-09-21 01:26:47.497416Z] Running run-tests step. 18:26:47 INFO - Running pre-action listener: _resource_record_pre_action 18:26:47 INFO - Running main action method: run_tests 18:26:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:26:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:26:47 INFO - Python 2.7.3 18:26:47 INFO - Return code: 0 18:26:47 INFO - grabbing minidump binary from tooltool 18:26: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')]} 18:26:47 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 0x1ee1930>, '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 0x1ee2830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ee2cc0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:26:47 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 18:26:47 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 18:26:47 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 18:26:47 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:26:47 INFO - Return code: 0 18:26:47 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:26:47 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:26:47 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:26:47 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:26:47 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:26:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1474410604/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-057', '--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 18:26:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1474410604/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-057 --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 18:26:47 INFO - Using env: {'DISPLAY': ':0', 18:26:47 INFO - 'HOME': '/home/cltbld', 18:26:47 INFO - 'LANG': 'en_US.UTF-8', 18:26:47 INFO - 'LANGUAGE': 'en_US:en', 18:26:47 INFO - 'LOGNAME': 'cltbld', 18:26:47 INFO - 'MAIL': '/var/mail/cltbld', 18:26:47 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:26:47 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:26:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:26:47 INFO - 'MOZ_NO_REMOTE': '1', 18:26:47 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:26:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:26:47 INFO - 'NO_EM_RESTART': '1', 18:26:47 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:26:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:26:47 INFO - 'PWD': '/builds/slave/test', 18:26:47 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:26:47 INFO - 'SHELL': '/bin/bash', 18:26:47 INFO - 'SHLVL': '1', 18:26:47 INFO - 'TERM': 'linux', 18:26:47 INFO - 'TMOUT': '86400', 18:26:47 INFO - 'USER': 'cltbld', 18:26:47 INFO - 'XDG_SESSION_COOKIE': '934fc3100db09dcb9af4d4b6000001ab-1474421154.699289-1923519824', 18:26:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:26:47 INFO - '_': '/tools/buildbot/bin/python'} 18:26:47 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1474410604/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-057', '--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 18:26:47 INFO - mozversion application_buildid: 20160920153004 18:26:47 INFO - mozversion application_changeset: d619a8596986fe0c8d3eee7bf1d904eb4b32a664 18:26:47 INFO - mozversion application_display_name: Nightly 18:26:47 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:26:47 INFO - mozversion application_name: Firefox 18:26:47 INFO - mozversion application_remotingname: firefox 18:26:47 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 18:26:47 INFO - mozversion application_vendor: Mozilla 18:26:47 INFO - mozversion application_version: 52.0a1 18:26:47 INFO - mozversion platform_buildid: 20160920153004 18:26:47 INFO - mozversion platform_changeset: d619a8596986fe0c8d3eee7bf1d904eb4b32a664 18:26:47 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 18:26:47 INFO - mozversion platform_version: 52.0a1 18:26:47 INFO - using testdate: 1474421207 18:26:47 INFO - actual date: 1474421207 18:26:47 INFO - starting webserver on 'localhost:42024' 18:26:47 INFO - SUITE-START | Running 2 tests 18:26:47 INFO - TEST-START | dromaeo_css 18:26:47 INFO - operating with platform_type : linux_ 18:26:47 INFO - Initialising browser for dromaeo_css test... 18:26:47 INFO - TEST-INFO | started process 7992 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPvwjsp/profile http://localhost:42024/getInfo.html) 18:26:52 INFO - PROCESS | 7992 | __metrics Screen width/height:1600/1200 18:26:52 INFO - PROCESS | 7992 | colorDepth:24 18:26:52 INFO - PROCESS | 7992 | Browser inner width/height: 1024/697 18:26:52 INFO - PROCESS | 7992 | __metrics 18:26:53 ERROR - PROCESS | 7992 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3018: TypeError: this.tabs is undefined 18:26:54 INFO - TEST-INFO | 7992: exit 0 18:26:54 INFO - Browser initialized. 18:26:54 INFO - Running cycle 1/1 for dromaeo_css test... 18:26:54 INFO - TEST-INFO | started process 8113 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPvwjsp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:27:06 INFO - PROCESS | 8113 | RSS: Main: 184881152 18:27:06 INFO - PROCESS | 8113 | 18:27:55 INFO - PROCESS | 8113 | 1474421275928 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] 18:30:05 INFO - PROCESS | 8113 | Cycle 1(1): loaded http://localhost:42024/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42024/tests/dromaeo/cssquery-ext.html) 18:30:06 INFO - PROCESS | 8113 | RSS: Main: 201547776 18:30:06 INFO - PROCESS | 8113 | 18:33:08 INFO - PROCESS | 8113 | Cycle 1(1): loaded http://localhost:42024/tests/dromaeo/cssquery-ext.html (next: http://localhost:42024/tests/dromaeo/cssquery-jquery.html) 18:33:08 INFO - PROCESS | 8113 | RSS: Main: 196861952 18:33:08 INFO - PROCESS | 8113 | 18:36:10 INFO - PROCESS | 8113 | Cycle 1(1): loaded http://localhost:42024/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42024/tests/dromaeo/cssquery-mootools.html) 18:36:11 INFO - PROCESS | 8113 | RSS: Main: 197480448 18:36:11 INFO - PROCESS | 8113 | 18:39:13 INFO - PROCESS | 8113 | Cycle 1(1): loaded http://localhost:42024/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42024/tests/dromaeo/cssquery-prototype.html) 18:39:13 INFO - PROCESS | 8113 | RSS: Main: 194101248 18:39:13 INFO - PROCESS | 8113 | 18:42:16 INFO - PROCESS | 8113 | Cycle 1(1): loaded http://localhost:42024/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42024/tests/dromaeo/cssquery-yui.html) 18:42:17 INFO - PROCESS | 8113 | RSS: Main: 197869568 18:42:17 INFO - PROCESS | 8113 | 18:45:19 INFO - PROCESS | 8113 | Cycle 1(1): loaded http://localhost:42024/tests/dromaeo/cssquery-yui.html (next: http://localhost:42024/tests/dromaeo/cssquery-dojo.html) 18:45:20 INFO - PROCESS | 8113 | RSS: Main: 198696960 18:45:20 INFO - PROCESS | 8113 | 18:45:20 INFO - PROCESS | 8113 | __start_tp_report 18:45:20 INFO - PROCESS | 8113 | _x_x_mozilla_page_load 18:45:20 INFO - PROCESS | 8113 | _x_x_mozilla_page_load_details 18:45:20 INFO - PROCESS | 8113 | |i|pagename|runs| 18:45:20 INFO - PROCESS | 8113 | |0;dojo.html;2996.3707621399503;3024.5765592817;3029.6061512003434;3031.878724851005;3038.6809385014585;5174.223866420039;5198.714070726113;5238.8690282742855;5291.391489978653;5389.595780316472;5141.331626888508;5175.120229560975;5221.660592061513;5228.058949389108;5263.473652634734;4708.788104535304;4789.832355867546;4792.6405519586;4860.902781944359;4924.113659541299;4904.877378065541;4944.258361245806;4947.431045429786;4951.801927922878;4967.230079337708;4736.8578942631775;4758.833440829554;4775.212090005145;4795.664303498756;4864.659473836833;4782.545658162504;4786.856394308176;4807.711537307773;4867.464578896319;4871.342368780205;4729.574338309569;4779.283107533898;4791.257355109963;4797.40032495938;4820.228763397839;5221.242919776611;5236.764345604419;5257;5263.999840030382;5294.311739473882;5591.077472217079;5659.60382773206;5665.858353541194;5715.885682286331;5726.3414707308775;5663.320401551799;5675.460831221028;5684.34630017545;5689.6586204827845;5689.9146512802345;5153.948460515422;5181.4041385240425;5281.260623512711;5303.7348132593215;5359.196120581944;5642.153676948408;5645.463680950304;5680.091185410314;5696.231008813757;5771.624844385102;5460.563154947595;5472.972635136799;5475.698836564027;5479.890402191933;5480.780768769205;5491.588130890119;5511.366192887869;5531.668099914018;5561.694106824163;5628.296462942132;5545.750441230154;5584.748686309126;5605.075162598126;5617.494425501724;5729.9713501432225;5623.634463759842;5637.3235211774845;5639.464250896158;5642.830715078554;5666.943330566724;4411.073674528385;4417.359482874966;4421.182081314967;4425.468943726709;4467.173572889026;3804.714646401531;3827.1771569112216;3861.5559210690567;3875.379939209713;3921.2941670499013;5394.865128371822;5419.241306217133;5429.538489228381;5430.429804870431;5472.398036216013;5579.7489112990015;5621.1287250475425;5636.04187288162;5637.43223287114;5637.746301416446;5315.069862773999;5345.732713364317;5361.463853614608;5409.756560954766;5478.91781623276;4911.68074075184;4945.727984960861;4950.381202349707;4996.325496058058;4997.425296090996;5906.40935906406;5907.852303692442;5913.881722365529;5915.260592425947;5924.5852790305125;5565.833025009256;5569.19246709233;5652.406497317723;5664.601239256578;5673.0639444492845;5913.822585322448;5936.643801371759;5961.195238642727;6016.458518733335;6091.269047714125;5600.831975040755;5633.943660563342;5654.095344744821;5658.575606829422;5663.065594176915;5602.439756024528;5715.142728590745;5770.105633626795;5783.16144159103;5791.9131213031;5499.450054994469;5499.945000549943;5530;5541.750621221974;5652.830415087554;5560.805371812129;5574.303212098488;5575.1915972184615;5576.498115169654;5581.972090139523;5349.812756553502;5376.865578360573;5393.83818485446;5489.39616642177;5494.2582751328055;5516.889662206653;5571;5573.749181286933;5635.0702134147405;5639.182318563868;5418.241446197614;5422.48486393792;5447.237386765777;5453.291072160594;5461.0716178248995 18:45:20 INFO - PROCESS | 8113 | |1;ext.html;577.2697537614918;580.2456806152003;581.1167026120299;593.9435753603408;619.2970977940042;39700.40449393261;43596.346054809124;43684.78157609215;43738.12523749527;43858.78070609646;43299;43703;43717.562824371744;43725.78137109318;43995.78002109993;8790.384673072904;8948.194662480375;8975.775605609879;8976.41653292534;9020.639174433014;8808.911910880874;8911.465312081264;8922.464652120894;8925.687600933968;8935.374523783337;8962.37263391563;8987.191152796247;8999.595018224163;9008.504532250723;9015.954920225422;8851.424657397249;8862.11378862115;8934;8968.058353872848;8981.146791054905;8818.206361427438;8821.691240806605;8839.867401988975;8871.334649901282;8914.286857051486;40440.39339409911;40571.18857622831;40792.59207407918;40806.183876322306;40831.591684083374;3038.1796914833094;3155.9053228403186;3167.303193297471;3220.22714548509;3299.1752061984503;33339.6666033339;33608.15979600505;33948;33959.4906076409;34282.48576271358;3784.3933693276713;3840.6543411093135;3853.920902147403;3889.436031775405;3892.065904182976;352245.23877380707;353939;356588;357705;358165;59215.111773323435;59301.703491482265;59829;59878.70060649669;59973;36117.45823812645;36629.08427289339;36879.63120368816;38567.614323856964;63091;17038.82961170397;17365.392211272545;17369.392071277696;17397.217125229396;17453.38913138034;13094.934525327313;13124.278164701032;13202.141860779018;13306.933465332611;13317.800232996318;19006.61986760257;19103;19160.71258931117;19271.710924336145;19275.4217373479;6911.861762764716;7109.75115870942;7135.3263612334;7201.603911784798;7235.167955685163;915.697819719491;942.7454587261539;969.4522594733953;971.703630392737;1050.7163065972145;29491.705082948894;30074.097777066723;30894.84552577268;31371.843140784607;31489.37021259562;1009.8232809258498;1029.1818004686293;1029.3772267777886;1125.3416751200639;1190.4166958190597;15610.68778624421;16159.192040398168;16580;16705.6658866822;16762.742794290476;511801;512928;515217;518760;519739;57091.42908570944;57681.423185767606;57761.42238577561;57901.420985789606;57945.13082303769;1257.811328300744;1297.3383574377135;1333.8932885369147;1351.1015174908575;1360.3946243921557;28742.22764260078;29072;29300;30049.849750751106;30522.84738576293;42531.3620295702;42839.571604283556;42902.78548607237;42914.57085429106;42983.355249670654;458840.99851512996;461415;464095;464402;466420;26049.218523444328;27287;28316.85841570779;28358.29104272327;30084.690684024303;46927;47312.05375892394;47316.7634161827;47429;48140.759296203294;39240.25318227697;39422.408663870636;39880.80059599799;40338.57968521898;41353.278204961694;39967.40048899327;40022.39966400448;41040.1791964165;42058.78970605128;42290.788546057076;39922.40116398198;39931.40102898401;40117.59882401139;40139;40884.18231635291;34750.13124671904;36745.448818267214;37173.814130929175;37184.44223336598;37611.81194094012;27780;27816.16551503458;28026.006086743495;28028.579571306855;28209.652828114333 18:45:20 INFO - PROCESS | 8113 | |2;jquery.html;396.7916843657078;397.0688734916621;399.8760384280875;403.11918458168896;421.5792778337003;16456;16646;18174.818251817476;19842;19867.40397788065;17160.31358745652;17887.821121788777;18463.35378261761;18741.34405295815;18860.717089243673;5326.840194794153;5472.480114389146;5509.228707980866;5585.8603534911545;5901.439363260483;5815.592908496407;5843.912341314884;5878.794242201524;5882.735276912549;5893.44012318829;5640.802571909984;5836.6206196597295;5846.327672317695;5855;5866.384029676865;5819.330776960662;5829.387914269004;5854.356020837705;5898.41015898411;5899.469047785677;5175.974120129413;5264.552513036397;5272.156454967225;5310;5316.521513063804;14253;14393.064450810769;14602.977791554595;14784.186869722162;14827.184504852228;2356.7525409832065;2434.1237154624323;2451.901923923059;2539.898404063835;2881.5965764792945;10264.281500294983;10607.363558186533;10783.6225732099;10820.404877731722;11089.05743011845;1831.8626103042325;1854.332440321483;1897.2126567474481;1961.137099676138;1962.3720409468976;77716.11419429006;86585.56707216424;87202.56398717966;90377.54811225967;92847.53576232075;11081.501332440059;11243.044341230923;11300.265482743594;11301.886981130248;11462;15859.762103568455;15958.601034973986;15991.600209994844;16025.67627693978;16058.75911861323;7857.7249796258;7927.722529711433;8297.419180657416;8570.271526920156;8656.91343086561;7894.565798881002;7992.3606111510935;8066.878996815052;8226.465279756796;8231.95884020576;4755.406938675514;4833.419989601271;4834.709917404967;4929.2359684248995;4955.4301255356095;1847.8059803720685;1872.5412273992958;1934.6300781542498;1953.327743841597;2089.707440958267;857.652650676477;899.2536194958169;912.6440688131634;937.2127412972999;968.0271327316143;18800.153993070344;18977.620447590973;19276.614467710566;19365.709514357295;19508.414747557596;860.7675927499665;893.3567831161554;896.287451476065;914.3919293669635;922.589447695769;8152.347812175011;10322.48387580618;10852.186086043579;10913.181511386678;11038.779224415628;443030;446424;446826;465275;465437;85236.57381713051;85742.57128714316;93151.53424232971;96490;97416.51291743496;1080.4543705428866;1081.9729506762237;1084.2789544952675;1089.6894385100368;1114.437209209344;17639.470815875546;17660.293588256325;17812.55468613295;18069.638607228044;18179.909100454413;40668.59331406648;40870.59129408787;41392.1721565573;42558;43007.569924301606;54656;59959.40040599538;60297.397026030936;61977.69011154916;62664;8572;8654.394192406722;8907.510086945022;8908.376413650982;8932;12941.676458088623;13367.933160334136;13402.195868247936;13622.38699258516;13803.723925521232;11582.6525204244;11602.18784685064;11613.5354585819;11932.284062955903;12127.514899403925;11207.551697931991;11517.366544840113;11572.537098515964;11575.189736718348;11622.593209237637;11291.491882865126;11762.3530705812;11780.52877884875;12268.631941041784;12400.937995309965;7352.926470735224;7817.921820781719;7900.170482099296;8491.872621910552;8768.736937891874;8869.290456763572;11118.444077796239;11415.486303116546;11606.593769218374;11645.59240426581 18:45:20 INFO - PROCESS | 8113 | |3;mootools.html;1430.871221590057;1432.212283244216;1497.44594500035;1630.8858379913404;1642.3266460751095;7984.720534781284;8276.462029968048;8553.529555874424;9242.815143697122;9251.352405331629;8654.43746156501;8943.50810705411;8953.91046089539;9121.589528471219;9220.354575179741;2435.622478515833;2480.8635525046116;2483.7019557653016;2485.1177831869695;2488.22864911877;2390.282915125464;2431.744666809986;2469.987650061747;2496.862672553018;2499;2388.4387169015267;2398.0887262840097;2418.177819541356;2437.110454684045;2448.0574978633267;2350.4828937633692;2355.2463211772238;2361.138184562631;2366.065404165354;2370.277065495032;2331.5803155432013;2331.801796847253;2335.719713634375;2343.215022967308;2343.69531960844;9050.683226087122;9055.230305424047;9064.501452420114;9074.500902450363;9127.5436228189;5273.841784746463;5382.354117505885;5390.757415916293;5453.700046497441;5499.1476321169885;3435.639257877912;3481.56480439945;3512.8594856205978;3547.8935631931085;3638.2905333459985;1175.7883580955424;1202.5730865542782;1209.848768903887;1220.3166226912867;1234.4691782533507;12391.814122788166;12405.75188496225;12421.31682757448;12444.937775311157;12456.252624842447;4639.847076201244;4668.95331046692;4780.139574876555;4790.976045119752;4890.779914903838;10315.638952636622;10478.73803154912;10498.842517362245;10500.369977801203;10503.894961050291;5392.703401312965;5393.083175860113;5394.514493695508;5441.863953401196;5446.455354464521;4339.5443478434945;4502.347159661831;4779.235322348408;4857.562819346276;4892.730899800474;4103.097318589906;4103.358656537409;4119.608637179464;4158.126793373365;4246.336978229463;1317.914335568185;1358.9264481059852;1363.7272545490941;1379.1793882639813;1392.3108061509415;833.8957630296213;836.8159005018886;895.2032690905099;901.0493928904937;911.0616065452595;5860.413958604106;5877.735501902424;5978.103284507271;6002.54980876436;6200.937990620127;873.5806812729925;905.3798148268457;905.4341036851968;921.3734660430837;939.2016785732073;3949.861754838567;3956.287868183697;3992.5208974922616;4038.676905847525;4158.750474971512;10599.894001060045;11061.336319820837;11065.114790816715;11369.886301137049;11424.828627570592;11198.384088875027;11262.155338349656;11278.097752179807;11283.210175287652;11307.434628268553;8288.958555207186;8464.280536154496;8503.107173746792;8514.616842242238;8556.443831150955;5852.356240813592;5994.910076348771;6031.939680603138;6055.72749226277;6100.511959043355;9777.706668799947;10267.537960791633;10285.84571231447;10300.793984120426;10469.9476502617;10392.06471417576;10562.471876406302;10574.89425105739;10599.205059620404;10674.946625266824;6832.248452670302;7263.273672632695;7726.6136693166245;7765;7862;8462.915370846458;8606.354523410644;8643.697470588499;8645.092265312052;8651.913480865363;7652.120006199136;7687.577183254974;7788.9610551949145;7923.168067352845;7924.960375198318;7433.962830185815;7435.405167586472;7441.962790186014;7457.888131677921;7534.924650753423;6613.371729685672;6665.766698165541;6665.766698165735;6673.8998915015345;6737.124173857367;5019.64862459639;5033.446320904624;5082.161443361804;5134.460881607378;5310.734463276744;5133.743312834269;5191.740412979411;5197.870053248699;5219.373675159005;5275.54922396344 18:45:20 INFO - PROCESS | 8113 | |4;prototype.html;327.9442494775888;330.0823710085961;338.4973314627777;345.15437178911674;347.405935849697;5415.187721841721;5447;5454.672719636825;5477.917831232529;5504.394516603181;5374.274472946151;5430.402655707869;5437.510624043835;5439.619226654136;5446;4198.475190601175;4246.171996460692;4279.058607106432;4314.288142456491;4314.913701725964;4201.978990105045;4247.171801498709;4248.065425606362;4262.445882035331;4290.54949230331;4223.577642235768;4244.936325955113;4255.87232383029;4256.4463970650795;4256.893577660552;3960.386140148282;4100.5489396166395;4102.159057393227;4188.225178341986;4251.978740106295;3702.740808143431;3703.833327500242;3717.75834570752;3724.3854763963914;3735.1595890924596;5255.527002569749;5304.098303288451;5305.973470132663;5306.575473962073;5312.681239125626;4706.22347312693;4797.40032495938;4798.448178459452;4803.078768492596;4805.558332500236;5553.16702494625;5576;5589.301337332833;5600.18797274397;5609.242752228438;4093.5292441369324;4103.692223083281;4105.3020986432375;4109.91780164395;4111.814968326433;5624.55003599711;5768.682722450264;5795.855103622401;5823.2138661280605;5916.378780228057;4178.707490475637;4196.223698615766;4199.790010499462;4217.093324935154;4217.493900731932;4240.575942405796;4253.425787518708;4270.850520231839;4273.893152671208;4282.593153650399;4534.387857639243;4746.121967436035;4766.261229509431;4800.543948324974;4819.108464933998;5577.553795696415;5620.831375058755;5622.85942851432;5623.718814059281;5625.831225063254;1418.3830033935271;1444.0180677139647;1445.6819499710048;1453.4985430026625;1455.5997100797154;923.2383283790765;937.0395344771528;943.7357539888842;959.1559427703576;1007.6876168387823;5517.282753242133;5528.364238112668;5538.141588053858;5540.9168862467095;5542.196381524656;5765.4522820332;5783.537317014629;5787.276590426197;5794.971025144847;5798.9130163047585;5289.867753306121;5457.508824205841;5552.194931734956;5565.443455654483;5606.495415412633;3046.8933587324336;3086.42901063304;3086.9228269293;3088.7953698057777;3091.5053591425262;6079.872044784379;6092.964196086676;6096.634201947809;6113.99119145345;6132.724027418777;5657.264555607745;5907.261592300963;5933.762649494059;5971.581989260797;5990.341062483123;6024.939750602438;6086.3305036446845;6114.449699527064;6117.063809371438;6121.255442199041;5542.224088627676;5792.420757924174;5861.706914654335;5868.970655146697;5873.882522349614;5683.204351390726;5697.800576979786;5777.653340799566;5783.710814459176;5815.4184581543195;6071.783798913453;6079.209702738615;6080.939190608215;6086;6131.4744022188315;3900.239453306578;4091.9386209207482;4130.277201489787;4136.21411931732;4143.15065411596;5862.6842397253695;5882.941170588239;5892.616979896293;5908.911366329595;5919.904817608756;5465.6447330923365;5761.366249712612;5765.884682306414;5773.480386765212;5777.2200752897825;5701.688611619434;5708.115242137475;5709.771609135588;5712.828615141552;5715.628484148683;5613.915791263216;5614.354349249888;5616.634918730433;5652.547796176378;5655;5618.452389831151;5630.577706671934;5729.799457018984;5737.139429085671;5772.451617096369;5593.244911936837;5594.328680558359;5614.326280846324;5627.212190293444;5630.774769009194 18:45:20 INFO - PROCESS | 8113 | |5;yui.html;664.3688495928866;708.1254650506627;717.5479447947793;737.513241260768;751.1249394455459;15438.845611543895;16894.49316520506;16937.745933811002;16945.068021258827;16956.406525771617;15104.471343502979;15132.848671513282;15168.696626067473;15218.467353642625;15284.312205950731;634.879372919145;653.7352372289207;775.8293175501381;790.1900551934256;801.4309840013568;800.2917418085008;802.0736049862389;802.6027116577302;804.2239239134234;806.6894245715413;806.1495122645606;810.2221867007651;813.4915677701437;813.5647428625687;815.2173913043486;814.9307308878753;817.0073360866546;817.497239197892;820.5322965909434;823.5882058970515;596.8567543789503;599.5383554662928;601.362555690969;602.6835911146683;602.8402473344568;14919.552413427615;15134.167620780852;15159.317830697644;15162.31769570361;15186.848131518764;12561.497540098386;13357.33213339329;13793.24137172455;13906.791398129037;13938.58184254474;10646.57413703451;10744.838827417596;10830.620928267552;11037.613683521118;11090.55637774496;3758.849646014156;3805.752626079296;3827.4641550182996;3831.3103641344546;3877.941830872539;67850;68856.6557167221;83232.58383708043;85729;86433;9823.165030972448;10663.84004239937;10697.946510267398;10796.190285728602;10850;19796.208151674058;20717;20740.688889666668;20841.68737468939;20869.582608347748;7528.096628404626;7963.283304502623;8039.276465118168;8125.9187408126345;8142.063662678867;4295.763732994653;4326.2212801696;4331.935020974688;4336.284513055373;4412.117576484716;3217.790843595159;3295.5715756951445;3311.1556553079295;3342.615599206074;3357.5635167428077;561.5619816543103;564.0833645326345;564.9435056494318;574.7298769578375;587.2893798503858;572.6907469966171;586.3432955090326;608.3095686395973;635.8378613453632;639.2009987515605;8504.234618884206;8622.827543449095;8908.376413650982;9086;9380;509.41671785805045;604.64628192507;607.1590846677295;650.1223348479609;669.7856685860576;4001.1197536541913;4112.547619761824;4457.732536047847;4501.279795232747;4600.332951721982;123080.38459807822;124728.37635811763;126395.3680231593;128681;133086.33456832654;86478;97750;99601;102551.4872425648;103016;76262;77994.61002694951;78094.21905780984;86472.56763716141;87050.56474717586;8893.73318800437;9151.816963660822;9156.542694591491;9473.52632368365;9704.272179586418;38903;45029.32456013228;45484.77257613691;49261;49922.75038624783;76736.61631692029;76829.23170768445;77147;78035;78509.60745196238;11964.820527692265;12003.879961200626;12060.819087713868;12144.939275303566;12216.694582635506;13482.865171348554;14034.789478157632;14251.928740356232;14313.785293220402;14721.484748033767;11544.826827597424;11609.419529023684;11878.703032424259;12189.329586872807;12319.44562494672;11698.181127321006;12183.451744671334;12322.938385308016;12484.87515124837;12736.872631273569;12020.33888136126;12106.152569320064;12270.447829847857;12400.19398739079;12483.812742809047;9999.200063994718;10095.646652367132;10403.172768400082;11047.779044419227;11234.662960111209;10932.781344373227;11059;11092.778144437227;11151.832722509007;11200.887991119984 18:45:20 INFO - PROCESS | 8113 | __end_tp_report 18:45:20 INFO - PROCESS | 8113 | __start_cc_report 18:45:20 INFO - PROCESS | 8113 | _x_x_mozilla_cycle_collect,306 18:45:20 INFO - PROCESS | 8113 | __end_cc_report 18:45:20 INFO - PROCESS | 8113 | __startTimestamp1474422320211__endTimestamp 18:45:20 INFO - PROCESS | 8113 | 18:45:20 INFO - PROCESS | 8113 | ------- Summary: start ------- 18:45:20 INFO - PROCESS | 8113 | Number of tests: 6 18:45:20 INFO - PROCESS | 8113 | 18:45:20 INFO - PROCESS | 8113 | [#0] dojo.html Cycles:165 Average:5260.98 Median:5472.40 stddev:596.11 (10.9%) stddev-sans-first:570.85 18:45:20 INFO - PROCESS | 8113 | Values: 2996.4 3024.6 3029.6 3031.9 3038.7 5174.2 5198.7 5238.9 5291.4 5389.6 5141.3 5175.1 5221.7 5228.1 5263.5 4708.8 4789.8 4792.6 4860.9 4924.1 4904.9 4944.3 4947.4 4951.8 4967.2 4736.9 4758.8 4775.2 4795.7 4864.7 4782.5 4786.9 4807.7 4867.5 4871.3 4729.6 4779.3 4791.3 4797.4 4820.2 5221.2 5236.8 5257.0 5264.0 5294.3 5591.1 5659.6 5665.9 5715.9 5726.3 5663.3 5675.5 5684.3 5689.7 5689.9 5153.9 5181.4 5281.3 5303.7 5359.2 5642.2 5645.5 5680.1 5696.2 5771.6 5460.6 5473.0 5475.7 5479.9 5480.8 5491.6 5511.4 5531.7 5561.7 5628.3 5545.8 5584.7 5605.1 5617.5 5730.0 5623.6 5637.3 5639.5 5642.8 5666.9 4411.1 4417.4 4421.2 4425.5 4467.2 3804.7 3827.2 3861.6 3875.4 3921.3 5394.9 5419.2 5429.5 5430.4 5472.4 5579.7 5621.1 5636.0 5637.4 5637.7 5315.1 5345.7 5361.5 5409.8 5478.9 4911.7 4945.7 4950.4 4996.3 4997.4 5906.4 5907.9 5913.9 5915.3 5924.6 5565.8 5569.2 5652.4 5664.6 5673.1 5913.8 5936.6 5961.2 6016.5 6091.3 5600.8 5633.9 5654.1 5658.6 5663.1 5602.4 5715.1 5770.1 5783.2 5791.9 5499.5 5499.9 5530.0 5541.8 5652.8 5560.8 5574.3 5575.2 5576.5 5582.0 5349.8 5376.9 5393.8 5489.4 5494.3 5516.9 5571.0 5573.7 5635.1 5639.2 5418.2 5422.5 5447.2 5453.3 5461.1 18:45:20 INFO - PROCESS | 8113 | 18:45:20 INFO - PROCESS | 8113 | [#1] ext.html Cycles:180 Average:59677.44 Median:40389.49 stddev:119277.73 (295.3%) stddev-sans-first:119529.80 18:45:20 INFO - PROCESS | 8113 | Values: 577.3 580.2 581.1 593.9 619.3 39700.4 43596.3 43684.8 43738.1 43858.8 43299.0 43703.0 43717.6 43725.8 43995.8 8790.4 8948.2 8975.8 8976.4 9020.6 8808.9 8911.5 8922.5 8925.7 8935.4 8962.4 8987.2 8999.6 9008.5 9016.0 8851.4 8862.1 8934.0 8968.1 8981.1 8818.2 8821.7 8839.9 8871.3 8914.3 40440.4 40571.2 40792.6 40806.2 40831.6 3038.2 3155.9 3167.3 3220.2 3299.2 33339.7 33608.2 33948.0 33959.5 34282.5 3784.4 3840.7 3853.9 3889.4 3892.1 352245.2 353939.0 356588.0 357705.0 358165.0 59215.1 59301.7 59829.0 59878.7 59973.0 36117.5 36629.1 36879.6 38567.6 63091.0 17038.8 17365.4 17369.4 17397.2 17453.4 13094.9 13124.3 13202.1 13306.9 13317.8 19006.6 19103.0 19160.7 19271.7 19275.4 6911.9 7109.8 7135.3 7201.6 7235.2 915.7 942.7 969.5 971.7 1050.7 29491.7 30074.1 30894.8 31371.8 31489.4 1009.8 1029.2 1029.4 1125.3 1190.4 15610.7 16159.2 16580.0 16705.7 16762.7 511801.0 512928.0 515217.0 518760.0 519739.0 57091.4 57681.4 57761.4 57901.4 57945.1 1257.8 1297.3 1333.9 1351.1 1360.4 28742.2 29072.0 29300.0 30049.8 30522.8 42531.4 42839.6 42902.8 42914.6 42983.4 458841.0 461415.0 464095.0 464402.0 466420.0 26049.2 27287.0 28316.9 28358.3 30084.7 46927.0 47312.1 47316.8 47429.0 48140.8 39240.3 39422.4 39880.8 40338.6 41353.3 39967.4 40022.4 41040.2 42058.8 42290.8 39922.4 39931.4 40117.6 40139.0 40884.2 34750.1 36745.4 37173.8 37184.4 37611.8 27780.0 27816.2 28026.0 28028.6 28209.7 18:45:20 INFO - PROCESS | 8113 | 18:45:20 INFO - PROCESS | 8113 | [#2] jquery.html Cycles:180 Average:27929.84 Median:401.50 stddev:75169.73 (18722.3%) stddev-sans-first:75352.17 18:45:20 INFO - PROCESS | 8113 | Values: 396.8 397.1 399.9 403.1 421.6 16456.0 16646.0 18174.8 19842.0 19867.4 17160.3 17887.8 18463.4 18741.3 18860.7 5326.8 5472.5 5509.2 5585.9 5901.4 5815.6 5843.9 5878.8 5882.7 5893.4 5640.8 5836.6 5846.3 5855.0 5866.4 5819.3 5829.4 5854.4 5898.4 5899.5 5176.0 5264.6 5272.2 5310.0 5316.5 14253.0 14393.1 14603.0 14784.2 14827.2 2356.8 2434.1 2451.9 2539.9 2881.6 10264.3 10607.4 10783.6 10820.4 11089.1 1831.9 1854.3 1897.2 1961.1 1962.4 77716.1 86585.6 87202.6 90377.5 92847.5 11081.5 11243.0 11300.3 11301.9 11462.0 15859.8 15958.6 15991.6 16025.7 16058.8 7857.7 7927.7 8297.4 8570.3 8656.9 7894.6 7992.4 8066.9 8226.5 8232.0 4755.4 4833.4 4834.7 4929.2 4955.4 1847.8 1872.5 1934.6 1953.3 2089.7 857.7 899.3 912.6 937.2 968.0 18800.2 18977.6 19276.6 19365.7 19508.4 860.8 893.4 896.3 914.4 922.6 8152.3 10322.5 10852.2 10913.2 11038.8 443030.0 446424.0 446826.0 465275.0 465437.0 85236.6 85742.6 93151.5 96490.0 97416.5 1080.5 1082.0 1084.3 1089.7 1114.4 17639.5 17660.3 17812.6 18069.6 18179.9 40668.6 40870.6 41392.2 42558.0 43007.6 54656.0 59959.4 60297.4 61977.7 62664.0 8572.0 8654.4 8907.5 8908.4 8932.0 12941.7 13367.9 13402.2 13622.4 13803.7 11582.7 11602.2 11613.5 11932.3 12127.5 11207.6 11517.4 11572.5 11575.2 11622.6 11291.5 11762.4 11780.5 12268.6 12400.9 7352.9 7817.9 7900.2 8491.9 8768.7 8869.3 11118.4 11415.5 11606.6 11645.6 18:45:20 INFO - PROCESS | 8113 | 18:45:20 INFO - PROCESS | 8113 | [#3] mootools.html Cycles:180 Average:5872.40 Median:4824.27 stddev:3342.86 (69.3%) stddev-sans-first:3335.57 18:45:20 INFO - PROCESS | 8113 | Values: 1430.9 1432.2 1497.4 1630.9 1642.3 7984.7 8276.5 8553.5 9242.8 9251.4 8654.4 8943.5 8953.9 9121.6 9220.4 2435.6 2480.9 2483.7 2485.1 2488.2 2390.3 2431.7 2470.0 2496.9 2499.0 2388.4 2398.1 2418.2 2437.1 2448.1 2350.5 2355.2 2361.1 2366.1 2370.3 2331.6 2331.8 2335.7 2343.2 2343.7 9050.7 9055.2 9064.5 9074.5 9127.5 5273.8 5382.4 5390.8 5453.7 5499.1 3435.6 3481.6 3512.9 3547.9 3638.3 1175.8 1202.6 1209.8 1220.3 1234.5 12391.8 12405.8 12421.3 12444.9 12456.3 4639.8 4669.0 4780.1 4791.0 4890.8 10315.6 10478.7 10498.8 10500.4 10503.9 5392.7 5393.1 5394.5 5441.9 5446.5 4339.5 4502.3 4779.2 4857.6 4892.7 4103.1 4103.4 4119.6 4158.1 4246.3 1317.9 1358.9 1363.7 1379.2 1392.3 833.9 836.8 895.2 901.0 911.1 5860.4 5877.7 5978.1 6002.5 6200.9 873.6 905.4 905.4 921.4 939.2 3949.9 3956.3 3992.5 4038.7 4158.8 10599.9 11061.3 11065.1 11369.9 11424.8 11198.4 11262.2 11278.1 11283.2 11307.4 8289.0 8464.3 8503.1 8514.6 8556.4 5852.4 5994.9 6031.9 6055.7 6100.5 9777.7 10267.5 10285.8 10300.8 10469.9 10392.1 10562.5 10574.9 10599.2 10674.9 6832.2 7263.3 7726.6 7765.0 7862.0 8462.9 8606.4 8643.7 8645.1 8651.9 7652.1 7687.6 7789.0 7923.2 7925.0 7434.0 7435.4 7442.0 7457.9 7534.9 6613.4 6665.8 6665.8 6673.9 6737.1 5019.6 5033.4 5082.2 5134.5 5310.7 5133.7 5191.7 5197.9 5219.4 5275.5 18:45:20 INFO - PROCESS | 8113 | 18:45:20 INFO - PROCESS | 8113 | [#4] prototype.html Cycles:180 Average:4792.74 Median:5533.25 stddev:1414.62 (25.6%) stddev-sans-first:1378.32 18:45:20 INFO - PROCESS | 8113 | Values: 327.9 330.1 338.5 345.2 347.4 5415.2 5447.0 5454.7 5477.9 5504.4 5374.3 5430.4 5437.5 5439.6 5446.0 4198.5 4246.2 4279.1 4314.3 4314.9 4202.0 4247.2 4248.1 4262.4 4290.5 4223.6 4244.9 4255.9 4256.4 4256.9 3960.4 4100.5 4102.2 4188.2 4252.0 3702.7 3703.8 3717.8 3724.4 3735.2 5255.5 5304.1 5306.0 5306.6 5312.7 4706.2 4797.4 4798.4 4803.1 4805.6 5553.2 5576.0 5589.3 5600.2 5609.2 4093.5 4103.7 4105.3 4109.9 4111.8 5624.6 5768.7 5795.9 5823.2 5916.4 4178.7 4196.2 4199.8 4217.1 4217.5 4240.6 4253.4 4270.9 4273.9 4282.6 4534.4 4746.1 4766.3 4800.5 4819.1 5577.6 5620.8 5622.9 5623.7 5625.8 1418.4 1444.0 1445.7 1453.5 1455.6 923.2 937.0 943.7 959.2 1007.7 5517.3 5528.4 5538.1 5540.9 5542.2 5765.5 5783.5 5787.3 5795.0 5798.9 5289.9 5457.5 5552.2 5565.4 5606.5 3046.9 3086.4 3086.9 3088.8 3091.5 6079.9 6093.0 6096.6 6114.0 6132.7 5657.3 5907.3 5933.8 5971.6 5990.3 6024.9 6086.3 6114.4 6117.1 6121.3 5542.2 5792.4 5861.7 5869.0 5873.9 5683.2 5697.8 5777.7 5783.7 5815.4 6071.8 6079.2 6080.9 6086.0 6131.5 3900.2 4091.9 4130.3 4136.2 4143.2 5862.7 5882.9 5892.6 5908.9 5919.9 5465.6 5761.4 5765.9 5773.5 5777.2 5701.7 5708.1 5709.8 5712.8 5715.6 5613.9 5614.4 5616.6 5652.5 5655.0 5618.5 5630.6 5729.8 5737.1 5772.5 5593.2 5594.3 5614.3 5627.2 5630.8 18:45:20 INFO - PROCESS | 8113 | 18:45:20 INFO - PROCESS | 8113 | [#5] yui.html Cycles:180 Average:20634.64 Median:4334.11 stddev:30956.25 (714.2%) stddev-sans-first:31006.77 18:45:20 INFO - PROCESS | 8113 | Values: 664.4 708.1 717.5 737.5 751.1 15438.8 16894.5 16937.7 16945.1 16956.4 15104.5 15132.8 15168.7 15218.5 15284.3 634.9 653.7 775.8 790.2 801.4 800.3 802.1 802.6 804.2 806.7 806.1 810.2 813.5 813.6 815.2 814.9 817.0 817.5 820.5 823.6 596.9 599.5 601.4 602.7 602.8 14919.6 15134.2 15159.3 15162.3 15186.8 12561.5 13357.3 13793.2 13906.8 13938.6 10646.6 10744.8 10830.6 11037.6 11090.6 3758.8 3805.8 3827.5 3831.3 3877.9 67850.0 68856.7 83232.6 85729.0 86433.0 9823.2 10663.8 10697.9 10796.2 10850.0 19796.2 20717.0 20740.7 20841.7 20869.6 7528.1 7963.3 8039.3 8125.9 8142.1 4295.8 4326.2 4331.9 4336.3 4412.1 3217.8 3295.6 3311.2 3342.6 3357.6 561.6 564.1 564.9 574.7 587.3 572.7 586.3 608.3 635.8 639.2 8504.2 8622.8 8908.4 9086.0 9380.0 509.4 604.6 607.2 650.1 669.8 4001.1 4112.5 4457.7 4501.3 4600.3 123080.4 124728.4 126395.4 128681.0 133086.3 86478.0 97750.0 99601.0 102551.5 103016.0 76262.0 77994.6 78094.2 86472.6 87050.6 8893.7 9151.8 9156.5 9473.5 9704.3 38903.0 45029.3 45484.8 49261.0 49922.8 76736.6 76829.2 77147.0 78035.0 78509.6 11964.8 12003.9 12060.8 12144.9 12216.7 13482.9 14034.8 14251.9 14313.8 14721.5 11544.8 11609.4 11878.7 12189.3 12319.4 11698.2 12183.5 12322.9 12484.9 12736.9 12020.3 12106.2 12270.4 12400.2 12483.8 9999.2 10095.6 10403.2 11047.8 11234.7 10932.8 11059.0 11092.8 11151.8 11200.9 18:45:20 INFO - PROCESS | 8113 | -------- Summary: end -------- 18:45:20 INFO - PROCESS | 8113 | 18:45:21 INFO - TEST-INFO | 8113: exit 0 18:45:21 INFO - TEST-OK | dromaeo_css | took 1113430ms 18:45:21 INFO - TEST-START | kraken 18:45:21 INFO - operating with platform_type : linux_ 18:45:21 INFO - Initialising browser for kraken test... 18:45:21 INFO - TEST-INFO | started process 8470 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3dMMa6/profile http://localhost:42024/getInfo.html) 18:45:25 INFO - PROCESS | 8470 | __metrics Screen width/height:1600/1200 18:45:25 INFO - PROCESS | 8470 | colorDepth:24 18:45:25 INFO - PROCESS | 8470 | Browser inner width/height: 1024/697 18:45:25 INFO - PROCESS | 8470 | __metrics 18:45:26 ERROR - PROCESS | 8470 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3018: TypeError: this.tabs is undefined 18:45:27 INFO - TEST-INFO | 8470: exit 0 18:45:27 INFO - Browser initialized. 18:45:27 INFO - Running cycle 1/1 for kraken test... 18:45:27 INFO - TEST-INFO | started process 8593 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3dMMa6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:45:39 INFO - PROCESS | 8593 | RSS: Main: 184926208 18:45:39 INFO - PROCESS | 8593 | 18:45:42 INFO - PROCESS | 8593 | Cycle 1(1): loaded http://localhost:42024/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42024/tests/kraken/driver.html?testName=audio-beat-detection) 18:45:43 INFO - PROCESS | 8593 | RSS: Main: 198782976 18:45:43 INFO - PROCESS | 8593 | 18:45:45 INFO - PROCESS | 8593 | Cycle 1(1): loaded http://localhost:42024/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42024/tests/kraken/driver.html?testName=audio-dft) 18:45:46 INFO - PROCESS | 8593 | RSS: Main: 196411392 18:45:46 INFO - PROCESS | 8593 | 18:45:49 INFO - PROCESS | 8593 | Cycle 1(1): loaded http://localhost:42024/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42024/tests/kraken/driver.html?testName=audio-fft) 18:45:49 INFO - PROCESS | 8593 | RSS: Main: 192536576 18:45:49 INFO - PROCESS | 8593 | 18:45:52 INFO - PROCESS | 8593 | Cycle 1(1): loaded http://localhost:42024/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42024/tests/kraken/driver.html?testName=audio-oscillator) 18:45:52 INFO - PROCESS | 8593 | RSS: Main: 192921600 18:45:52 INFO - PROCESS | 8593 | 18:45:54 INFO - PROCESS | 8593 | Cycle 1(1): loaded http://localhost:42024/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42024/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:45:55 INFO - PROCESS | 8593 | RSS: Main: 192913408 18:45:55 INFO - PROCESS | 8593 | 18:45:58 INFO - PROCESS | 8593 | Cycle 1(1): loaded http://localhost:42024/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42024/tests/kraken/driver.html?testName=imaging-darkroom) 18:45:59 INFO - PROCESS | 8593 | RSS: Main: 193388544 18:45:59 INFO - PROCESS | 8593 | 18:46:02 INFO - PROCESS | 8593 | Cycle 1(1): loaded http://localhost:42024/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42024/tests/kraken/driver.html?testName=imaging-desaturate) 18:46:03 INFO - PROCESS | 8593 | RSS: Main: 191614976 18:46:03 INFO - PROCESS | 8593 | 18:46:06 INFO - PROCESS | 8593 | Cycle 1(1): loaded http://localhost:42024/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42024/tests/kraken/driver.html?testName=json-parse-financial) 18:46:06 INFO - PROCESS | 8593 | RSS: Main: 193044480 18:46:06 INFO - PROCESS | 8593 | 18:46:08 INFO - PROCESS | 8593 | Cycle 1(1): loaded http://localhost:42024/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42024/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:46:08 INFO - PROCESS | 8593 | RSS: Main: 194101248 18:46:08 INFO - PROCESS | 8593 | 18:46:10 INFO - PROCESS | 8593 | Cycle 1(1): loaded http://localhost:42024/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42024/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:46:11 INFO - PROCESS | 8593 | RSS: Main: 194187264 18:46:11 INFO - PROCESS | 8593 | 18:46:13 INFO - PROCESS | 8593 | Cycle 1(1): loaded http://localhost:42024/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42024/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:46:14 INFO - PROCESS | 8593 | RSS: Main: 194052096 18:46:14 INFO - PROCESS | 8593 | 18:46:16 INFO - PROCESS | 8593 | Cycle 1(1): loaded http://localhost:42024/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42024/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:46:17 INFO - PROCESS | 8593 | RSS: Main: 194142208 18:46:17 INFO - PROCESS | 8593 | 18:46:20 INFO - PROCESS | 8593 | Cycle 1(1): loaded http://localhost:42024/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42024/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:46:20 INFO - PROCESS | 8593 | RSS: Main: 194437120 18:46:20 INFO - PROCESS | 8593 | 18:46:22 INFO - PROCESS | 8593 | Cycle 1(1): loaded http://localhost:42024/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42024/tests/kraken/driver.html?testName=ai-astar) 18:46:22 INFO - PROCESS | 8593 | RSS: Main: 195772416 18:46:22 INFO - PROCESS | 8593 | 18:46:22 INFO - PROCESS | 8593 | __start_tp_report 18:46:22 INFO - PROCESS | 8593 | _x_x_mozilla_page_load 18:46:22 INFO - PROCESS | 8593 | _x_x_mozilla_page_load_details 18:46:22 INFO - PROCESS | 8593 | |i|pagename|runs| 18:46:22 INFO - PROCESS | 8593 | |0;ai-astar;106;114;113;115;114;114;114;113;115;112 18:46:22 INFO - PROCESS | 8593 | |1;audio-beat-detection;150;121;129;159;124;120;122;121;157;126 18:46:22 INFO - PROCESS | 8593 | |2;audio-dft;163;165;164;168;168;163;165;163;161;163 18:46:22 INFO - PROCESS | 8593 | |3;audio-fft;78;75;77;105;87;77;76;76;105;75 18:46:22 INFO - PROCESS | 8593 | |4;audio-oscillator;82;82;104;83;82;83;104;82;82;100 18:46:22 INFO - PROCESS | 8593 | |5;imaging-gaussian-blur;118;117;119;119;118;118;117;118;119;119 18:46:22 INFO - PROCESS | 8593 | |6;imaging-darkroom;147;147;147;146;149;150;149;149;149;147 18:46:22 INFO - PROCESS | 8593 | |7;imaging-desaturate;95;96;96;95;96;97;97;96;96;97 18:46:22 INFO - PROCESS | 8593 | |8;json-parse-financial;53;53;53;52;54;65;54;54;57;59 18:46:22 INFO - PROCESS | 8593 | |9;json-stringify-tinderbox;61;61;62;61;61;60;60;61;61;61 18:46:22 INFO - PROCESS | 8593 | |10;stanford-crypto-aes;80;79;80;81;85;80;79;79;79;79 18:46:22 INFO - PROCESS | 8593 | |11;stanford-crypto-ccm;136;134;138;126;140;125;138;135;162;132 18:46:22 INFO - PROCESS | 8593 | |12;stanford-crypto-pbkdf2;165;166;169;166;161;165;163;165;166;166 18:46:22 INFO - PROCESS | 8593 | |13;stanford-crypto-sha256-iterative;66;67;73;73;66;65;65;67;65;70 18:46:22 INFO - PROCESS | 8593 | __end_tp_report 18:46:22 INFO - PROCESS | 8593 | __start_cc_report 18:46:22 INFO - PROCESS | 8593 | _x_x_mozilla_cycle_collect,800 18:46:22 INFO - PROCESS | 8593 | __end_cc_report 18:46:22 INFO - PROCESS | 8593 | __startTimestamp1474422382759__endTimestamp 18:46:22 INFO - PROCESS | 8593 | 18:46:22 INFO - PROCESS | 8593 | ------- Summary: start ------- 18:46:22 INFO - PROCESS | 8593 | Number of tests: 14 18:46:22 INFO - PROCESS | 8593 | 18:46:22 INFO - PROCESS | 8593 | [#0] ai-astar Cycles:10 Average:113.00 Median:114.00 stddev:2.62 (2.3%) stddev-sans-first:0.97 18:46:22 INFO - PROCESS | 8593 | Values: 106.0 114.0 113.0 115.0 114.0 114.0 114.0 113.0 115.0 112.0 18:46:22 INFO - PROCESS | 8593 | 18:46:22 INFO - PROCESS | 8593 | [#1] audio-beat-detection Cycles:10 Average:132.90 Median:127.50 stddev:15.86 (12.4%) stddev-sans-first:15.57 18:46:22 INFO - PROCESS | 8593 | Values: 150.0 121.0 129.0 159.0 124.0 120.0 122.0 121.0 157.0 126.0 18:46:22 INFO - PROCESS | 8593 | 18:46:22 INFO - PROCESS | 8593 | [#2] audio-dft Cycles:10 Average:164.30 Median:164.50 stddev:2.26 (1.4%) stddev-sans-first:2.35 18:46:22 INFO - PROCESS | 8593 | Values: 163.0 165.0 164.0 168.0 168.0 163.0 165.0 163.0 161.0 163.0 18:46:22 INFO - PROCESS | 8593 | 18:46:22 INFO - PROCESS | 8593 | [#3] audio-fft Cycles:10 Average:83.10 Median:76.50 stddev:12.05 (15.8%) stddev-sans-first:12.64 18:46:22 INFO - PROCESS | 8593 | Values: 78.0 75.0 77.0 105.0 87.0 77.0 76.0 76.0 105.0 75.0 18:46:22 INFO - PROCESS | 8593 | 18:46:22 INFO - PROCESS | 8593 | [#4] audio-oscillator Cycles:10 Average:88.40 Median:82.00 stddev:9.91 (12.1%) stddev-sans-first:10.24 18:46:22 INFO - PROCESS | 8593 | Values: 82.0 82.0 104.0 83.0 82.0 83.0 104.0 82.0 82.0 100.0 18:46:22 INFO - PROCESS | 8593 | 18:46:22 INFO - PROCESS | 8593 | [#5] imaging-gaussian-blur Cycles:10 Average:118.20 Median:118.50 stddev:0.79 (0.7%) stddev-sans-first:0.83 18:46:22 INFO - PROCESS | 8593 | Values: 118.0 117.0 119.0 119.0 118.0 118.0 117.0 118.0 119.0 119.0 18:46:22 INFO - PROCESS | 8593 | 18:46:22 INFO - PROCESS | 8593 | [#6] imaging-darkroom Cycles:10 Average:148.00 Median:149.00 stddev:1.33 (0.9%) stddev-sans-first:1.36 18:46:22 INFO - PROCESS | 8593 | Values: 147.0 147.0 147.0 146.0 149.0 150.0 149.0 149.0 149.0 147.0 18:46:22 INFO - PROCESS | 8593 | 18:46:22 INFO - PROCESS | 8593 | [#7] imaging-desaturate Cycles:10 Average:96.10 Median:96.00 stddev:0.74 (0.8%) stddev-sans-first:0.67 18:46:22 INFO - PROCESS | 8593 | Values: 95.0 96.0 96.0 95.0 96.0 97.0 97.0 96.0 96.0 97.0 18:46:22 INFO - PROCESS | 8593 | 18:46:22 INFO - PROCESS | 8593 | [#8] json-parse-financial Cycles:10 Average:55.40 Median:54.00 stddev:3.98 (7.4%) stddev-sans-first:4.12 18:46:22 INFO - PROCESS | 8593 | Values: 53.0 53.0 53.0 52.0 54.0 65.0 54.0 54.0 57.0 59.0 18:46:22 INFO - PROCESS | 8593 | 18:46:22 INFO - PROCESS | 8593 | [#9] json-stringify-tinderbox Cycles:10 Average:60.90 Median:61.00 stddev:0.57 (0.9%) stddev-sans-first:0.60 18:46:22 INFO - PROCESS | 8593 | Values: 61.0 61.0 62.0 61.0 61.0 60.0 60.0 61.0 61.0 61.0 18:46:22 INFO - PROCESS | 8593 | 18:46:22 INFO - PROCESS | 8593 | [#10] stanford-crypto-aes Cycles:10 Average:80.10 Median:80.00 stddev:1.85 (2.3%) stddev-sans-first:1.96 18:46:22 INFO - PROCESS | 8593 | Values: 80.0 79.0 80.0 81.0 85.0 80.0 79.0 79.0 79.0 79.0 18:46:22 INFO - PROCESS | 8593 | 18:46:22 INFO - PROCESS | 8593 | [#11] stanford-crypto-ccm Cycles:10 Average:136.60 Median:137.00 stddev:10.21 (7.5%) stddev-sans-first:10.83 18:46:22 INFO - PROCESS | 8593 | Values: 136.0 134.0 138.0 126.0 140.0 125.0 138.0 135.0 162.0 132.0 18:46:22 INFO - PROCESS | 8593 | 18:46:22 INFO - PROCESS | 8593 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.20 Median:166.00 stddev:2.10 (1.3%) stddev-sans-first:2.22 18:46:22 INFO - PROCESS | 8593 | Values: 165.0 166.0 169.0 166.0 161.0 165.0 163.0 165.0 166.0 166.0 18:46:22 INFO - PROCESS | 8593 | 18:46:22 INFO - PROCESS | 8593 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.70 Median:67.00 stddev:3.16 (4.7%) stddev-sans-first:3.30 18:46:22 INFO - PROCESS | 8593 | Values: 66.0 67.0 73.0 73.0 66.0 65.0 65.0 67.0 65.0 70.0 18:46:22 INFO - PROCESS | 8593 | -------- Summary: end -------- 18:46:22 INFO - PROCESS | 8593 | 18:46:22 INFO - PROCESS | 8593 | 18:46:22 INFO - PROCESS | 8593 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 18:46:22 INFO - PROCESS | 8593 | 18:46:22 INFO - PROCESS | 8593 | 18:46:22 INFO - PROCESS | 8593 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 18:46:22 INFO - PROCESS | 8593 | 18:46:22 INFO - PROCESS | 8593 | 18:46:22 INFO - PROCESS | 8593 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 18:46:22 INFO - PROCESS | 8593 | 18:46:22 INFO - PROCESS | 8593 | 18:46:22 INFO - PROCESS | 8593 | ###!!! [Parent][MessageChannel] Error: (msgtype=0x2000C,name=PAPZ::Msg_Destroy) Channel error: cannot send/recv 18:46:22 INFO - PROCESS | 8593 | 18:46:22 INFO - PROCESS | 8593 | 18:46:22 INFO - PROCESS | 8593 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 18:46:22 INFO - PROCESS | 8593 | 18:46:23 INFO - TEST-INFO | 8593: exit 0 18:46:23 INFO - TEST-OK | kraken | took 62672ms 18:46:23 INFO - SUITE-END | took 1176s 18:46:24 INFO - Completed test suite (00:19:36) 18:46:24 INFO - javascript benchmark 18:46:24 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7172.826294012328, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2996.3707621399503, 3024.5765592817, 3029.6061512003434, 3031.878724851005, 3038.6809385014585, 5174.223866420039, 5198.714070726113, 5238.8690282742855, 5291.391489978653, 5389.595780316472, 5141.331626888508, 5175.120229560975, 5221.660592061513, 5228.058949389108, 5263.473652634734, 4708.788104535304, 4789.832355867546, 4792.6405519586, 4860.902781944359, 4924.113659541299, 4904.877378065541, 4944.258361245806, 4947.431045429786, 4951.801927922878, 4967.230079337708, 4736.8578942631775, 4758.833440829554, 4775.212090005145, 4795.664303498756, 4864.659473836833, 4782.545658162504, 4786.856394308176, 4807.711537307773, 4867.464578896319, 4871.342368780205, 4729.574338309569, 4779.283107533898, 4791.257355109963, 4797.40032495938, 4820.228763397839, 5221.242919776611, 5236.764345604419, 5257.0, 5263.999840030382, 5294.311739473882, 5591.077472217079, 5659.60382773206, 5665.858353541194, 5715.885682286331, 5726.3414707308775, 5663.320401551799, 5675.460831221028, 5684.34630017545, 5689.6586204827845, 5689.9146512802345, 5153.948460515422, 5181.4041385240425, 5281.260623512711, 5303.7348132593215, 5359.196120581944, 5642.153676948408, 5645.463680950304, 5680.091185410314, 5696.231008813757, 5771.624844385102, 5460.563154947595, 5472.972635136799, 5475.698836564027, 5479.890402191933, 5480.780768769205, 5491.588130890119, 5511.366192887869, 5531.668099914018, 5561.694106824163, 5628.296462942132, 5545.750441230154, 5584.748686309126, 5605.075162598126, 5617.494425501724, 5729.9713501432225, 5623.634463759842, 5637.3235211774845, 5639.464250896158, 5642.830715078554, 5666.943330566724, 4411.073674528385, 4417.359482874966, 4421.182081314967, 4425.468943726709, 4467.173572889026, 3804.714646401531, 3827.1771569112216, 3861.5559210690567, 3875.379939209713, 3921.2941670499013, 5394.865128371822, 5419.241306217133, 5429.538489228381, 5430.429804870431, 5472.398036216013, 5579.7489112990015, 5621.1287250475425, 5636.04187288162, 5637.43223287114, 5637.746301416446, 5315.069862773999, 5345.732713364317, 5361.463853614608, 5409.756560954766, 5478.91781623276, 4911.68074075184, 4945.727984960861, 4950.381202349707, 4996.325496058058, 4997.425296090996, 5906.40935906406, 5907.852303692442, 5913.881722365529, 5915.260592425947, 5924.5852790305125, 5565.833025009256, 5569.19246709233, 5652.406497317723, 5664.601239256578, 5673.0639444492845, 5913.822585322448, 5936.643801371759, 5961.195238642727, 6016.458518733335, 6091.269047714125, 5600.831975040755, 5633.943660563342, 5654.095344744821, 5658.575606829422, 5663.065594176915, 5602.439756024528, 5715.142728590745, 5770.105633626795, 5783.16144159103, 5791.9131213031, 5499.450054994469, 5499.945000549943, 5530.0, 5541.750621221974, 5652.830415087554, 5560.805371812129, 5574.303212098488, 5575.1915972184615, 5576.498115169654, 5581.972090139523, 5349.812756553502, 5376.865578360573, 5393.83818485446, 5489.39616642177, 5494.2582751328055, 5516.889662206653, 5571.0, 5573.749181286933, 5635.0702134147405, 5639.182318563868, 5418.241446197614, 5422.48486393792, 5447.237386765777, 5453.291072160594, 5461.0716178248995], "value": 5220.475470104182, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [577.2697537614918, 580.2456806152003, 581.1167026120299, 593.9435753603408, 619.2970977940042, 39700.40449393261, 43596.346054809124, 43684.78157609215, 43738.12523749527, 43858.78070609646, 43299.0, 43703.0, 43717.562824371744, 43725.78137109318, 43995.78002109993, 8790.384673072904, 8948.194662480375, 8975.775605609879, 8976.41653292534, 9020.639174433014, 8808.911910880874, 8911.465312081264, 8922.464652120894, 8925.687600933968, 8935.374523783337, 8962.37263391563, 8987.191152796247, 8999.595018224163, 9008.504532250723, 9015.954920225422, 8851.424657397249, 8862.11378862115, 8934.0, 8968.058353872848, 8981.146791054905, 8818.206361427438, 8821.691240806605, 8839.867401988975, 8871.334649901282, 8914.286857051486, 40440.39339409911, 40571.18857622831, 40792.59207407918, 40806.183876322306, 40831.591684083374, 3038.1796914833094, 3155.9053228403186, 3167.303193297471, 3220.22714548509, 3299.1752061984503, 33339.6666033339, 33608.15979600505, 33948.0, 33959.4906076409, 34282.48576271358, 3784.3933693276713, 3840.6543411093135, 3853.920902147403, 3889.436031775405, 3892.065904182976, 352245.23877380707, 353939.0, 356588.0, 357705.0, 358165.0, 59215.111773323435, 59301.703491482265, 59829.0, 59878.70060649669, 59973.0, 36117.45823812645, 36629.08427289339, 36879.63120368816, 38567.614323856964, 63091.0, 17038.82961170397, 17365.392211272545, 17369.392071277696, 17397.217125229396, 17453.38913138034, 13094.934525327313, 13124.278164701032, 13202.141860779018, 13306.933465332611, 13317.800232996318, 19006.61986760257, 19103.0, 19160.71258931117, 19271.710924336145, 19275.4217373479, 6911.861762764716, 7109.75115870942, 7135.3263612334, 7201.603911784798, 7235.167955685163, 915.697819719491, 942.7454587261539, 969.4522594733953, 971.703630392737, 1050.7163065972145, 29491.705082948894, 30074.097777066723, 30894.84552577268, 31371.843140784607, 31489.37021259562, 1009.8232809258498, 1029.1818004686293, 1029.3772267777886, 1125.3416751200639, 1190.4166958190597, 15610.68778624421, 16159.192040398168, 16580.0, 16705.6658866822, 16762.742794290476, 511801.0, 512928.0, 515217.0, 518760.0, 519739.0, 57091.42908570944, 57681.423185767606, 57761.42238577561, 57901.420985789606, 57945.13082303769, 1257.811328300744, 1297.3383574377135, 1333.8932885369147, 1351.1015174908575, 1360.3946243921557, 28742.22764260078, 29072.0, 29300.0, 30049.849750751106, 30522.84738576293, 42531.3620295702, 42839.571604283556, 42902.78548607237, 42914.57085429106, 42983.355249670654, 458840.99851512996, 461415.0, 464095.0, 464402.0, 466420.0, 26049.218523444328, 27287.0, 28316.85841570779, 28358.29104272327, 30084.690684024303, 46927.0, 47312.05375892394, 47316.7634161827, 47429.0, 48140.759296203294, 39240.25318227697, 39422.408663870636, 39880.80059599799, 40338.57968521898, 41353.278204961694, 39967.40048899327, 40022.39966400448, 41040.1791964165, 42058.78970605128, 42290.788546057076, 39922.40116398198, 39931.40102898401, 40117.59882401139, 40139.0, 40884.18231635291, 34750.13124671904, 36745.448818267214, 37173.814130929175, 37184.44223336598, 37611.81194094012, 27780.0, 27816.16551503458, 28026.006086743495, 28028.579571306855, 28209.652828114333], "value": 19583.517510723203, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [396.7916843657078, 397.0688734916621, 399.8760384280875, 403.11918458168896, 421.5792778337003, 16456.0, 16646.0, 18174.818251817476, 19842.0, 19867.40397788065, 17160.31358745652, 17887.821121788777, 18463.35378261761, 18741.34405295815, 18860.717089243673, 5326.840194794153, 5472.480114389146, 5509.228707980866, 5585.8603534911545, 5901.439363260483, 5815.592908496407, 5843.912341314884, 5878.794242201524, 5882.735276912549, 5893.44012318829, 5640.802571909984, 5836.6206196597295, 5846.327672317695, 5855.0, 5866.384029676865, 5819.330776960662, 5829.387914269004, 5854.356020837705, 5898.41015898411, 5899.469047785677, 5175.974120129413, 5264.552513036397, 5272.156454967225, 5310.0, 5316.521513063804, 14253.0, 14393.064450810769, 14602.977791554595, 14784.186869722162, 14827.184504852228, 2356.7525409832065, 2434.1237154624323, 2451.901923923059, 2539.898404063835, 2881.5965764792945, 10264.281500294983, 10607.363558186533, 10783.6225732099, 10820.404877731722, 11089.05743011845, 1831.8626103042325, 1854.332440321483, 1897.2126567474481, 1961.137099676138, 1962.3720409468976, 77716.11419429006, 86585.56707216424, 87202.56398717966, 90377.54811225967, 92847.53576232075, 11081.501332440059, 11243.044341230923, 11300.265482743594, 11301.886981130248, 11462.0, 15859.762103568455, 15958.601034973986, 15991.600209994844, 16025.67627693978, 16058.75911861323, 7857.7249796258, 7927.722529711433, 8297.419180657416, 8570.271526920156, 8656.91343086561, 7894.565798881002, 7992.3606111510935, 8066.878996815052, 8226.465279756796, 8231.95884020576, 4755.406938675514, 4833.419989601271, 4834.709917404967, 4929.2359684248995, 4955.4301255356095, 1847.8059803720685, 1872.5412273992958, 1934.6300781542498, 1953.327743841597, 2089.707440958267, 857.652650676477, 899.2536194958169, 912.6440688131634, 937.2127412972999, 968.0271327316143, 18800.153993070344, 18977.620447590973, 19276.614467710566, 19365.709514357295, 19508.414747557596, 860.7675927499665, 893.3567831161554, 896.287451476065, 914.3919293669635, 922.589447695769, 8152.347812175011, 10322.48387580618, 10852.186086043579, 10913.181511386678, 11038.779224415628, 443030.0, 446424.0, 446826.0, 465275.0, 465437.0, 85236.57381713051, 85742.57128714316, 93151.53424232971, 96490.0, 97416.51291743496, 1080.4543705428866, 1081.9729506762237, 1084.2789544952675, 1089.6894385100368, 1114.437209209344, 17639.470815875546, 17660.293588256325, 17812.55468613295, 18069.638607228044, 18179.909100454413, 40668.59331406648, 40870.59129408787, 41392.1721565573, 42558.0, 43007.569924301606, 54656.0, 59959.40040599538, 60297.397026030936, 61977.69011154916, 62664.0, 8572.0, 8654.394192406722, 8907.510086945022, 8908.376413650982, 8932.0, 12941.676458088623, 13367.933160334136, 13402.195868247936, 13622.38699258516, 13803.723925521232, 11582.6525204244, 11602.18784685064, 11613.5354585819, 11932.284062955903, 12127.514899403925, 11207.551697931991, 11517.366544840113, 11572.537098515964, 11575.189736718348, 11622.593209237637, 11291.491882865126, 11762.3530705812, 11780.52877884875, 12268.631941041784, 12400.937995309965, 7352.926470735224, 7817.921820781719, 7900.170482099296, 8491.872621910552, 8768.736937891874, 8869.290456763572, 11118.444077796239, 11415.486303116546, 11606.593769218374, 11645.59240426581], "value": 9088.03501268467, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1430.871221590057, 1432.212283244216, 1497.44594500035, 1630.8858379913404, 1642.3266460751095, 7984.720534781284, 8276.462029968048, 8553.529555874424, 9242.815143697122, 9251.352405331629, 8654.43746156501, 8943.50810705411, 8953.91046089539, 9121.589528471219, 9220.354575179741, 2435.622478515833, 2480.8635525046116, 2483.7019557653016, 2485.1177831869695, 2488.22864911877, 2390.282915125464, 2431.744666809986, 2469.987650061747, 2496.862672553018, 2499.0, 2388.4387169015267, 2398.0887262840097, 2418.177819541356, 2437.110454684045, 2448.0574978633267, 2350.4828937633692, 2355.2463211772238, 2361.138184562631, 2366.065404165354, 2370.277065495032, 2331.5803155432013, 2331.801796847253, 2335.719713634375, 2343.215022967308, 2343.69531960844, 9050.683226087122, 9055.230305424047, 9064.501452420114, 9074.500902450363, 9127.5436228189, 5273.841784746463, 5382.354117505885, 5390.757415916293, 5453.700046497441, 5499.1476321169885, 3435.639257877912, 3481.56480439945, 3512.8594856205978, 3547.8935631931085, 3638.2905333459985, 1175.7883580955424, 1202.5730865542782, 1209.848768903887, 1220.3166226912867, 1234.4691782533507, 12391.814122788166, 12405.75188496225, 12421.31682757448, 12444.937775311157, 12456.252624842447, 4639.847076201244, 4668.95331046692, 4780.139574876555, 4790.976045119752, 4890.779914903838, 10315.638952636622, 10478.73803154912, 10498.842517362245, 10500.369977801203, 10503.894961050291, 5392.703401312965, 5393.083175860113, 5394.514493695508, 5441.863953401196, 5446.455354464521, 4339.5443478434945, 4502.347159661831, 4779.235322348408, 4857.562819346276, 4892.730899800474, 4103.097318589906, 4103.358656537409, 4119.608637179464, 4158.126793373365, 4246.336978229463, 1317.914335568185, 1358.9264481059852, 1363.7272545490941, 1379.1793882639813, 1392.3108061509415, 833.8957630296213, 836.8159005018886, 895.2032690905099, 901.0493928904937, 911.0616065452595, 5860.413958604106, 5877.735501902424, 5978.103284507271, 6002.54980876436, 6200.937990620127, 873.5806812729925, 905.3798148268457, 905.4341036851968, 921.3734660430837, 939.2016785732073, 3949.861754838567, 3956.287868183697, 3992.5208974922616, 4038.676905847525, 4158.750474971512, 10599.894001060045, 11061.336319820837, 11065.114790816715, 11369.886301137049, 11424.828627570592, 11198.384088875027, 11262.155338349656, 11278.097752179807, 11283.210175287652, 11307.434628268553, 8288.958555207186, 8464.280536154496, 8503.107173746792, 8514.616842242238, 8556.443831150955, 5852.356240813592, 5994.910076348771, 6031.939680603138, 6055.72749226277, 6100.511959043355, 9777.706668799947, 10267.537960791633, 10285.84571231447, 10300.793984120426, 10469.9476502617, 10392.06471417576, 10562.471876406302, 10574.89425105739, 10599.205059620404, 10674.946625266824, 6832.248452670302, 7263.273672632695, 7726.6136693166245, 7765.0, 7862.0, 8462.915370846458, 8606.354523410644, 8643.697470588499, 8645.092265312052, 8651.913480865363, 7652.120006199136, 7687.577183254974, 7788.9610551949145, 7923.168067352845, 7924.960375198318, 7433.962830185815, 7435.405167586472, 7441.962790186014, 7457.888131677921, 7534.924650753423, 6613.371729685672, 6665.766698165541, 6665.766698165735, 6673.8998915015345, 6737.124173857367, 5019.64862459639, 5033.446320904624, 5082.161443361804, 5134.460881607378, 5310.734463276744, 5133.743312834269, 5191.740412979411, 5197.870053248699, 5219.373675159005, 5275.54922396344], "value": 4699.043275643956, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [327.9442494775888, 330.0823710085961, 338.4973314627777, 345.15437178911674, 347.405935849697, 5415.187721841721, 5447.0, 5454.672719636825, 5477.917831232529, 5504.394516603181, 5374.274472946151, 5430.402655707869, 5437.510624043835, 5439.619226654136, 5446.0, 4198.475190601175, 4246.171996460692, 4279.058607106432, 4314.288142456491, 4314.913701725964, 4201.978990105045, 4247.171801498709, 4248.065425606362, 4262.445882035331, 4290.54949230331, 4223.577642235768, 4244.936325955113, 4255.87232383029, 4256.4463970650795, 4256.893577660552, 3960.386140148282, 4100.5489396166395, 4102.159057393227, 4188.225178341986, 4251.978740106295, 3702.740808143431, 3703.833327500242, 3717.75834570752, 3724.3854763963914, 3735.1595890924596, 5255.527002569749, 5304.098303288451, 5305.973470132663, 5306.575473962073, 5312.681239125626, 4706.22347312693, 4797.40032495938, 4798.448178459452, 4803.078768492596, 4805.558332500236, 5553.16702494625, 5576.0, 5589.301337332833, 5600.18797274397, 5609.242752228438, 4093.5292441369324, 4103.692223083281, 4105.3020986432375, 4109.91780164395, 4111.814968326433, 5624.55003599711, 5768.682722450264, 5795.855103622401, 5823.2138661280605, 5916.378780228057, 4178.707490475637, 4196.223698615766, 4199.790010499462, 4217.093324935154, 4217.493900731932, 4240.575942405796, 4253.425787518708, 4270.850520231839, 4273.893152671208, 4282.593153650399, 4534.387857639243, 4746.121967436035, 4766.261229509431, 4800.543948324974, 4819.108464933998, 5577.553795696415, 5620.831375058755, 5622.85942851432, 5623.718814059281, 5625.831225063254, 1418.3830033935271, 1444.0180677139647, 1445.6819499710048, 1453.4985430026625, 1455.5997100797154, 923.2383283790765, 937.0395344771528, 943.7357539888842, 959.1559427703576, 1007.6876168387823, 5517.282753242133, 5528.364238112668, 5538.141588053858, 5540.9168862467095, 5542.196381524656, 5765.4522820332, 5783.537317014629, 5787.276590426197, 5794.971025144847, 5798.9130163047585, 5289.867753306121, 5457.508824205841, 5552.194931734956, 5565.443455654483, 5606.495415412633, 3046.8933587324336, 3086.42901063304, 3086.9228269293, 3088.7953698057777, 3091.5053591425262, 6079.872044784379, 6092.964196086676, 6096.634201947809, 6113.99119145345, 6132.724027418777, 5657.264555607745, 5907.261592300963, 5933.762649494059, 5971.581989260797, 5990.341062483123, 6024.939750602438, 6086.3305036446845, 6114.449699527064, 6117.063809371438, 6121.255442199041, 5542.224088627676, 5792.420757924174, 5861.706914654335, 5868.970655146697, 5873.882522349614, 5683.204351390726, 5697.800576979786, 5777.653340799566, 5783.710814459176, 5815.4184581543195, 6071.783798913453, 6079.209702738615, 6080.939190608215, 6086.0, 6131.4744022188315, 3900.239453306578, 4091.9386209207482, 4130.277201489787, 4136.21411931732, 4143.15065411596, 5862.6842397253695, 5882.941170588239, 5892.616979896293, 5908.911366329595, 5919.904817608756, 5465.6447330923365, 5761.366249712612, 5765.884682306414, 5773.480386765212, 5777.2200752897825, 5701.688611619434, 5708.115242137475, 5709.771609135588, 5712.828615141552, 5715.628484148683, 5613.915791263216, 5614.354349249888, 5616.634918730433, 5652.547796176378, 5655.0, 5618.452389831151, 5630.577706671934, 5729.799457018984, 5737.139429085671, 5772.451617096369, 5593.244911936837, 5594.328680558359, 5614.326280846324, 5627.212190293444, 5630.774769009194], "value": 4339.511149506591, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [664.3688495928866, 708.1254650506627, 717.5479447947793, 737.513241260768, 751.1249394455459, 15438.845611543895, 16894.49316520506, 16937.745933811002, 16945.068021258827, 16956.406525771617, 15104.471343502979, 15132.848671513282, 15168.696626067473, 15218.467353642625, 15284.312205950731, 634.879372919145, 653.7352372289207, 775.8293175501381, 790.1900551934256, 801.4309840013568, 800.2917418085008, 802.0736049862389, 802.6027116577302, 804.2239239134234, 806.6894245715413, 806.1495122645606, 810.2221867007651, 813.4915677701437, 813.5647428625687, 815.2173913043486, 814.9307308878753, 817.0073360866546, 817.497239197892, 820.5322965909434, 823.5882058970515, 596.8567543789503, 599.5383554662928, 601.362555690969, 602.6835911146683, 602.8402473344568, 14919.552413427615, 15134.167620780852, 15159.317830697644, 15162.31769570361, 15186.848131518764, 12561.497540098386, 13357.33213339329, 13793.24137172455, 13906.791398129037, 13938.58184254474, 10646.57413703451, 10744.838827417596, 10830.620928267552, 11037.613683521118, 11090.55637774496, 3758.849646014156, 3805.752626079296, 3827.4641550182996, 3831.3103641344546, 3877.941830872539, 67850.0, 68856.6557167221, 83232.58383708043, 85729.0, 86433.0, 9823.165030972448, 10663.84004239937, 10697.946510267398, 10796.190285728602, 10850.0, 19796.208151674058, 20717.0, 20740.688889666668, 20841.68737468939, 20869.582608347748, 7528.096628404626, 7963.283304502623, 8039.276465118168, 8125.9187408126345, 8142.063662678867, 4295.763732994653, 4326.2212801696, 4331.935020974688, 4336.284513055373, 4412.117576484716, 3217.790843595159, 3295.5715756951445, 3311.1556553079295, 3342.615599206074, 3357.5635167428077, 561.5619816543103, 564.0833645326345, 564.9435056494318, 574.7298769578375, 587.2893798503858, 572.6907469966171, 586.3432955090326, 608.3095686395973, 635.8378613453632, 639.2009987515605, 8504.234618884206, 8622.827543449095, 8908.376413650982, 9086.0, 9380.0, 509.41671785805045, 604.64628192507, 607.1590846677295, 650.1223348479609, 669.7856685860576, 4001.1197536541913, 4112.547619761824, 4457.732536047847, 4501.279795232747, 4600.332951721982, 123080.38459807822, 124728.37635811763, 126395.3680231593, 128681.0, 133086.33456832654, 86478.0, 97750.0, 99601.0, 102551.4872425648, 103016.0, 76262.0, 77994.61002694951, 78094.21905780984, 86472.56763716141, 87050.56474717586, 8893.73318800437, 9151.816963660822, 9156.542694591491, 9473.52632368365, 9704.272179586418, 38903.0, 45029.32456013228, 45484.77257613691, 49261.0, 49922.75038624783, 76736.61631692029, 76829.23170768445, 77147.0, 78035.0, 78509.60745196238, 11964.820527692265, 12003.879961200626, 12060.819087713868, 12144.939275303566, 12216.694582635506, 13482.865171348554, 14034.789478157632, 14251.928740356232, 14313.785293220402, 14721.484748033767, 11544.826827597424, 11609.419529023684, 11878.703032424259, 12189.329586872807, 12319.44562494672, 11698.181127321006, 12183.451744671334, 12322.938385308016, 12484.87515124837, 12736.872631273569, 12020.33888136126, 12106.152569320064, 12270.447829847857, 12400.19398739079, 12483.812742809047, 9999.200063994718, 10095.646652367132, 10403.172768400082, 11047.779044419227, 11234.662960111209, 10932.781344373227, 11059.0, 11092.778144437227, 11151.832722509007, 11200.887991119984], "value": 7187.503874855173, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1509.9, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 114.0, 113.0, 115.0, 114.0, 114.0, 114.0, 113.0, 115.0, 112.0], "value": 113.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 121.0, 129.0, 159.0, 124.0, 120.0, 122.0, 121.0, 157.0, 126.0], "value": 132.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 165.0, 164.0, 168.0, 168.0, 163.0, 165.0, 163.0, 161.0, 163.0], "value": 164.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 75.0, 77.0, 105.0, 87.0, 77.0, 76.0, 76.0, 105.0, 75.0], "value": 83.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 104.0, 83.0, 82.0, 83.0, 104.0, 82.0, 82.0, 100.0], "value": 88.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 119.0, 119.0, 118.0, 118.0, 117.0, 118.0, 119.0, 119.0], "value": 118.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 146.0, 149.0, 150.0, 149.0, 149.0, 149.0, 147.0], "value": 148.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 96.0, 95.0, 96.0, 97.0, 97.0, 96.0, 96.0, 97.0], "value": 96.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 53.0, 53.0, 52.0, 54.0, 65.0, 54.0, 54.0, 57.0, 59.0], "value": 55.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 62.0, 61.0, 61.0, 60.0, 60.0, 61.0, 61.0, 61.0], "value": 60.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 79.0, 80.0, 81.0, 85.0, 80.0, 79.0, 79.0, 79.0, 79.0], "value": 80.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 134.0, 138.0, 126.0, 140.0, 125.0, 138.0, 135.0, 162.0, 132.0], "value": 136.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 166.0, 169.0, 166.0, 161.0, 165.0, 163.0, 165.0, 166.0, 166.0], "value": 165.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 73.0, 73.0, 66.0, 65.0, 65.0, 67.0, 65.0, 70.0], "value": 67.7, "unit": "score"}]}]} 18:46:24 INFO - Return code: 0 18:46:24 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:46:24 ERROR - # TBPL SUCCESS # 18:46:24 INFO - Running post-action listener: _resource_record_post_action 18:46:24 INFO - [mozharness: 2016-09-21 01:46:24.548777Z] Finished run-tests step (success) 18:46:24 INFO - Running post-run listener: _resource_record_post_run 18:46:24 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 0; Write bytes: 392617984; Read time: 0; Write time: 269236 18:46:24 INFO - TinderboxPrint: CPU usage
13.3% 18:46:24 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 18:46:24 INFO - TinderboxPrint: I/O write bytes / time
392,617,984 / 269,236 18:46:24 INFO - TinderboxPrint: CPU idle
8,251.9 (86.7%) 18:46:24 INFO - TinderboxPrint: CPU user
1,206.2 (12.7%) 18:46:24 INFO - TinderboxPrint: Swap in / out
0 / 0 18:46:24 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 103153664; Read time: 0; Write time: 78396 18:46:24 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 0; Write bytes: 289464320; Read time: 0; Write time: 190840 18:46:25 INFO - Running post-run listener: _upload_blobber_files 18:46:25 INFO - Blob upload gear active. 18:46:25 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:46:25 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 18:46:25 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', 'Autoland', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 18:46:25 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 Autoland -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 18:46:25 INFO - (blobuploader) - INFO - Open directory for files ... 18:46:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:46:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:46:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:46:29 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:46:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:46:29 INFO - (blobuploader) - INFO - Done attempting. 18:46:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 18:46:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:46:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:46:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 18:46:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:46:29 INFO - (blobuploader) - INFO - Done attempting. 18:46:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 18:46:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:46:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:46:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 18:46:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:46:30 INFO - (blobuploader) - INFO - Done attempting. 18:46:30 INFO - (blobuploader) - INFO - Iteration through files over. 18:46:30 INFO - Return code: 0 18:46:30 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:46:30 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:46:30 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/b5b8431b14d621f06ef8a2230ca30eabfa2b226cc9bc90a7f107c9b3f75a09fe69d3d153170ae3a6c971afa117f5dd3acc2d6ba722391a9b27195daeb3837b53", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/5ebb01102544f98c8815677a3ea8e51ed85fa4f687066abda8ccdfb10a82989bc09d672ad45bfb8dadf32f0a7190468b0149cc2477a4846b45996712e8b92fcd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/072a1cfe5bebded8cf079c59b584a54aea15cafac74c7ef8714b4bf4ec55c54715b5863458be12fe2a721a324011eb78e6264ed87d9c3cf072b1726226ebd19e"} 18:46:30 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:46:30 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:46:30 INFO - Contents: 18:46:30 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/b5b8431b14d621f06ef8a2230ca30eabfa2b226cc9bc90a7f107c9b3f75a09fe69d3d153170ae3a6c971afa117f5dd3acc2d6ba722391a9b27195daeb3837b53", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/5ebb01102544f98c8815677a3ea8e51ed85fa4f687066abda8ccdfb10a82989bc09d672ad45bfb8dadf32f0a7190468b0149cc2477a4846b45996712e8b92fcd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/072a1cfe5bebded8cf079c59b584a54aea15cafac74c7ef8714b4bf4ec55c54715b5863458be12fe2a721a324011eb78e6264ed87d9c3cf072b1726226ebd19e"} 18:46:30 INFO - Running post-run listener: copy_logs_to_upload_dir 18:46:30 INFO - Copying logs to upload dir... 18:46:30 INFO - mkdir: /builds/slave/test/build/upload/logs 18:46:30 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.369504 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-09-20 18:46:30.498842) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-20 18:46:30.502053) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1474421154.699289-1923519824 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/Autoland/sha512/b5b8431b14d621f06ef8a2230ca30eabfa2b226cc9bc90a7f107c9b3f75a09fe69d3d153170ae3a6c971afa117f5dd3acc2d6ba722391a9b27195daeb3837b53", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/5ebb01102544f98c8815677a3ea8e51ed85fa4f687066abda8ccdfb10a82989bc09d672ad45bfb8dadf32f0a7190468b0149cc2477a4846b45996712e8b92fcd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/072a1cfe5bebded8cf079c59b584a54aea15cafac74c7ef8714b4bf4ec55c54715b5863458be12fe2a721a324011eb78e6264ed87d9c3cf072b1726226ebd19e"} build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1474410604/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011461 build_url: 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/autoland-linux64-pgo/1474410604/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/b5b8431b14d621f06ef8a2230ca30eabfa2b226cc9bc90a7f107c9b3f75a09fe69d3d153170ae3a6c971afa117f5dd3acc2d6ba722391a9b27195daeb3837b53", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/5ebb01102544f98c8815677a3ea8e51ed85fa4f687066abda8ccdfb10a82989bc09d672ad45bfb8dadf32f0a7190468b0149cc2477a4846b45996712e8b92fcd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/072a1cfe5bebded8cf079c59b584a54aea15cafac74c7ef8714b4bf4ec55c54715b5863458be12fe2a721a324011eb78e6264ed87d9c3cf072b1726226ebd19e"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-20 18:46:30.530441) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-20 18:46:30.530850) ========= 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=934fc3100db09dcb9af4d4b6000001ab-1474421154.699289-1923519824 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004410 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-20 18:46:30.612714) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-20 18:46:30.613053) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-20 18:46:30.613367) ========= ========= Total master_lag: 0.18 =========