builder: autoland_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-017 starttime: 1475625028.49 results: success (0) buildid: 20161004122910 builduid: 2c4a2ad0ec2247bc96245f44d1aaec53 revision: 3fff88de2f2d5194bc940ad67ca2187498d00243 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-04 16:50:28.488871) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-04 16:50:28.489302) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-04 16:50:28.489574) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-04 16:50:28.504119) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 16:50:28.504464) ========= 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=0333a256a5e4f052382dd180000001b1-1475625028.102668-1754744362 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-04 16:50:28-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 57.9K=0.2s 2016-10-04 16:50:29 (57.9 KB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.322457 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 16:50:28.840593) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 16:50:28.840938) ========= 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=0333a256a5e4f052382dd180000001b1-1475625028.102668-1754744362 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015279 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 16:50:28.890519) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 16:50:28.890909) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 3fff88de2f2d5194bc940ad67ca2187498d00243 --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 3fff88de2f2d5194bc940ad67ca2187498d00243 --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=0333a256a5e4f052382dd180000001b1-1475625028.102668-1754744362 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-04 16:50:29,186 truncating revision to first 12 chars 2016-10-04 16:50:29,186 Setting DEBUG logging. 2016-10-04 16:50:29,187 attempt 1/10 2016-10-04 16:50:29,187 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/3fff88de2f2d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-04 16:50:29,485 unpacking tar archive at: autoland-3fff88de2f2d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.657381 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 16:50:29.562090) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-04 16:50:29.562412) ========= script_repo_revision: 3fff88de2f2d5194bc940ad67ca2187498d00243 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-04 16:50:29.562816) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-04 16:50:29.563081) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-04 16:50:29.571790) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-10-04 16:50:29.572165) ========= /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=0333a256a5e4f052382dd180000001b1-1475625028.102668-1754744362 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:50:29 INFO - MultiFileLogger online at 20161004 16:50:29 in /builds/slave/test 16:50:29 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 16:50:29 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:50:29 INFO - {'append_to_log': False, 16:50:29 INFO - 'base_work_dir': '/builds/slave/test', 16:50:29 INFO - 'blob_upload_branch': 'Autoland', 16:50:29 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:50:29 INFO - 'branch': 'Autoland', 16:50:29 INFO - 'buildbot_json_path': 'buildprops.json', 16:50:29 INFO - 'config_files': ('talos/linux_config.py',), 16:50:29 INFO - 'default_actions': ('clobber', 16:50:29 INFO - 'read-buildbot-config', 16:50:29 INFO - 'download-and-extract', 16:50:29 INFO - 'populate-webroot', 16:50:29 INFO - 'create-virtualenv', 16:50:29 INFO - 'install', 16:50:29 INFO - 'run-tests'), 16:50:29 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:50:29 INFO - 'download_minidump_stackwalk': True, 16:50:29 INFO - 'download_symbols': 'ondemand', 16:50:29 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:50:29 INFO - 'tooltool.py': '/tools/tooltool.py', 16:50:29 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:50:29 INFO - '/tools/misc-python/virtualenv.py')}, 16:50:29 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:50:29 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:50:29 INFO - 'installer_path': 'installer.exe', 16:50:29 INFO - 'log_level': 'info', 16:50:29 INFO - 'log_name': 'talos', 16:50:29 INFO - 'log_to_console': True, 16:50:29 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:50:29 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:50:29 INFO - 'opt_config_files': (), 16:50:29 INFO - 'pip_index': False, 16:50:29 INFO - 'sps_profile': False, 16:50:29 INFO - 'sps_profile_interval': 0, 16:50:29 INFO - 'suite': 'dromaeojs-e10s', 16:50:29 INFO - 'system_bits': '32', 16:50:29 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:50:29 INFO - 'title': 'talos-linux64-ix-017', 16:50:29 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:50:29 INFO - 'use_talos_json': True, 16:50:29 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:50:29 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:50:29 INFO - 'work_dir': 'build'} 16:50:29 INFO - [mozharness: 2016-10-04 23:50:29.953334Z] Running clobber step. 16:50:29 INFO - Running pre-action listener: _resource_record_pre_action 16:50:29 INFO - Running main action method: clobber 16:50:29 INFO - rmtree: /builds/slave/test/build 16:50:29 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:50:30 INFO - Running post-action listener: _resource_record_post_action 16:50:30 INFO - [mozharness: 2016-10-04 23:50:30.423027Z] Finished clobber step (success) 16:50:30 INFO - [mozharness: 2016-10-04 23:50:30.423128Z] Running read-buildbot-config step. 16:50:30 INFO - Running pre-action listener: _resource_record_pre_action 16:50:30 INFO - Running main action method: read_buildbot_config 16:50:30 INFO - Using buildbot properties: 16:50:30 INFO - { 16:50:30 INFO - "project": "", 16:50:30 INFO - "product": "firefox", 16:50:30 INFO - "script_repo_revision": "production", 16:50:30 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs-e10s", 16:50:30 INFO - "repository": "", 16:50:30 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland pgo talos dromaeojs-e10s", 16:50:30 INFO - "buildid": "20161004122910", 16:50:30 INFO - "pgo_build": "True", 16:50:30 INFO - "basedir": "/builds/slave/test", 16:50:30 INFO - "buildnumber": 322, 16:50:30 INFO - "slavename": "talos-linux64-ix-017", 16:50:30 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 16:50:30 INFO - "platform": "ubuntu64_hw", 16:50:30 INFO - "scheduler": "tests-autoland-linux64-pgo-talos", 16:50:30 INFO - "branch": "autoland", 16:50:30 INFO - "repo_path": "integration/autoland", 16:50:30 INFO - "revision": "3fff88de2f2d5194bc940ad67ca2187498d00243", 16:50:30 INFO - "stage_platform": "linux64-pgo", 16:50:30 INFO - "builduid": "2c4a2ad0ec2247bc96245f44d1aaec53", 16:50:30 INFO - "slavebuilddir": "test" 16:50:30 INFO - } 16:50:30 INFO - Found installer url https://queue.taskcluster.net/v1/task/WddpZyHqTAqIG43rQlMd6Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 16:50:30 INFO - Running post-action listener: _resource_record_post_action 16:50:30 INFO - [mozharness: 2016-10-04 23:50:30.425590Z] Finished read-buildbot-config step (success) 16:50:30 INFO - [mozharness: 2016-10-04 23:50:30.425677Z] Running download-and-extract step. 16:50:30 INFO - Running pre-action listener: _resource_record_pre_action 16:50:30 INFO - Running main action method: download_and_extract 16:50:30 INFO - mkdir: /builds/slave/test/build/tests 16:50:30 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')]} 16:50:30 INFO - trying https://queue.taskcluster.net/v1/task/WddpZyHqTAqIG43rQlMd6Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 16:50:30 INFO - Downloading https://queue.taskcluster.net/v1/task/WddpZyHqTAqIG43rQlMd6Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 16:50:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WddpZyHqTAqIG43rQlMd6Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 16:50:30 INFO - Downloaded 1201 bytes. 16:50:30 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 16:50:30 INFO - Using the following test package requirements: 16:50:30 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 16:50:30 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 16:50:30 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 16:50:30 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 16:50:30 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 16:50:30 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 16:50:30 INFO - u'jsshell-linux-x86_64.zip'], 16:50:30 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 16:50:30 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 16:50:30 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 16:50:31 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 16:50:31 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 16:50:31 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 16:50:31 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 16:50:31 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 16:50:31 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 16:50:31 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:50:31 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WddpZyHqTAqIG43rQlMd6Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 16:50:31 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WddpZyHqTAqIG43rQlMd6Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:50:31 INFO - Fetch https://queue.taskcluster.net/v1/task/WddpZyHqTAqIG43rQlMd6Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 16:50:31 INFO - Http code: 200 16:50:31 INFO - via: 1.1 f46e4d7bc5419470a70eb57aa9c935c8.cloudfront.net (CloudFront) 16:50:31 INFO - x-amz-cf-id: PM_Y5rO3Vt2BA6Y96JuQjiy3OXpEbTI_funvhjxeEsIMolIzAFQARg== 16:50:31 INFO - x-amz-version-id: UO0DQJAgYk3Pc3litkY.3x3CPCA7um.N 16:50:31 INFO - Expected file size: 21992460 16:50:31 INFO - Obtained file size: 21992460 16:50:35 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 16:50:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WddpZyHqTAqIG43rQlMd6Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 16:50:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WddpZyHqTAqIG43rQlMd6Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:50:35 INFO - Fetch https://queue.taskcluster.net/v1/task/WddpZyHqTAqIG43rQlMd6Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 16:50:36 INFO - Http code: 200 16:50:36 INFO - via: 1.1 2239f0bfe6d7427183a4e375c4638619.cloudfront.net (CloudFront) 16:50:36 INFO - x-amz-cf-id: Jie3Cfo7p1sZdO9jkkhNCX-lMk9YPwg9bF4vdboIDYUANmaY6e74oA== 16:50:36 INFO - x-amz-version-id: UO0DQJAgYk3Pc3litkY.3x3CPCA7um.N 16:50:36 INFO - Expected file size: 21992460 16:50:36 INFO - Obtained file size: 21992460 16:50:41 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WddpZyHqTAqIG43rQlMd6Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 16:50:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WddpZyHqTAqIG43rQlMd6Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 16:50:41 INFO - Fetch https://queue.taskcluster.net/v1/task/WddpZyHqTAqIG43rQlMd6Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 16:50:41 INFO - Http code: 200 16:50:41 INFO - via: 1.1 aa89533ad2ec5e0edba466c9920bd000.cloudfront.net (CloudFront) 16:50:41 INFO - x-amz-cf-id: xdd4Ib_iao1fHNOzXWIdiCJXUlI9Z1IOQa6iRX44Am_TvkJeTHnwXw== 16:50:41 INFO - x-amz-version-id: zr856J6Lqmy33guSFJYe5OUV7Wo3DHRX 16:50:41 INFO - Expected file size: 14409006 16:50:41 INFO - Obtained file size: 14409006 16:50:42 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')]} 16:50:42 INFO - trying https://queue.taskcluster.net/v1/task/WddpZyHqTAqIG43rQlMd6Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 16:50:42 INFO - Downloading https://queue.taskcluster.net/v1/task/WddpZyHqTAqIG43rQlMd6Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 16:50:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WddpZyHqTAqIG43rQlMd6Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 16:50:43 INFO - Downloaded 59702429 bytes. 16:50:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WddpZyHqTAqIG43rQlMd6Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 16:50:43 INFO - mkdir: /builds/slave/test/properties 16:50:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:50:43 INFO - Writing to file /builds/slave/test/properties/build_url 16:50:43 INFO - Contents: 16:50:43 INFO - build_url:https://queue.taskcluster.net/v1/task/WddpZyHqTAqIG43rQlMd6Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 16:50:44 INFO - Running post-action listener: _resource_record_post_action 16:50:44 INFO - Running post-action listener: set_extra_try_arguments 16:50:44 INFO - [mozharness: 2016-10-04 23:50:44.055940Z] Finished download-and-extract step (success) 16:50:44 INFO - [mozharness: 2016-10-04 23:50:44.056166Z] Running populate-webroot step. 16:50:44 INFO - Running pre-action listener: _resource_record_pre_action 16:50:44 INFO - Running main action method: populate_webroot 16:50:44 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:50:44 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:50:44 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:50:44 INFO - '--tppagecycles', 16:50:44 INFO - '7'], 16:50:44 INFO - 'tests': ['tsvgm']}}, 16:50:44 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:50:44 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:50:44 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:50:44 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:50:44 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:50:44 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:50:44 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:50:44 INFO - 'talos_options': ['--disable-e10s'], 16:50:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:50:44 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:50:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:50:44 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:50:44 INFO - 'talos_options': ['--disable-e10s'], 16:50:44 INFO - 'tests': ['damp', 'tps']}, 16:50:44 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:50:44 INFO - 'tests': ['damp', 'tps']}, 16:50:44 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:50:44 INFO - 'tests': ['dromaeo_dom']}, 16:50:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:50:44 INFO - 'g4': {'talos_options': ['--disable-e10s'], 16:50:44 INFO - 'tests': ['basic_compositor_video']}, 16:50:44 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 16:50:44 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:50:44 INFO - 'tests': ['a11yr', 16:50:44 INFO - 'ts_paint', 16:50:44 INFO - 'tpaint', 16:50:44 INFO - 'sessionrestore', 16:50:44 INFO - 'sessionrestore_no_auto_restore', 16:50:44 INFO - 'tabpaint']}, 16:50:44 INFO - 'other-e10s': {'tests': ['a11yr', 16:50:44 INFO - 'ts_paint', 16:50:44 INFO - 'tpaint', 16:50:44 INFO - 'sessionrestore', 16:50:44 INFO - 'sessionrestore_no_auto_restore', 16:50:44 INFO - 'tabpaint']}, 16:50:44 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:50:44 INFO - 'ts_paint', 16:50:44 INFO - 'tpaint', 16:50:44 INFO - 'sessionrestore', 16:50:44 INFO - 'sessionrestore_no_auto_restore', 16:50:44 INFO - 'tabpaint']}, 16:50:44 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:50:44 INFO - 'ts_paint', 16:50:44 INFO - 'tpaint', 16:50:44 INFO - 'sessionrestore', 16:50:44 INFO - 'sessionrestore_no_auto_restore', 16:50:44 INFO - 'tabpaint']}, 16:50:44 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:50:44 INFO - 'tests': ['a11yr', 16:50:44 INFO - 'ts_paint', 16:50:44 INFO - 'tpaint', 16:50:44 INFO - 'sessionrestore', 16:50:44 INFO - 'sessionrestore_no_auto_restore', 16:50:44 INFO - 'tabpaint']}, 16:50:44 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:50:44 INFO - 'tests': ['a11yr', 16:50:44 INFO - 'ts_paint', 16:50:44 INFO - 'tpaint', 16:50:44 INFO - 'sessionrestore', 16:50:44 INFO - 'sessionrestore_no_auto_restore', 16:50:44 INFO - 'tabpaint']}, 16:50:44 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:50:44 INFO - 'tests': ['tsvgx', 16:50:44 INFO - 'tsvgr_opacity', 16:50:44 INFO - 'tart', 16:50:44 INFO - 'tscrollx', 16:50:44 INFO - 'cart']}, 16:50:44 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:50:44 INFO - 'tsvgr_opacity', 16:50:44 INFO - 'tart', 16:50:44 INFO - 'tscrollx', 16:50:44 INFO - 'cart']}, 16:50:44 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:50:44 INFO - 'talos_options': ['--disable-e10s'], 16:50:44 INFO - 'tests': ['tp5o']}, 16:50:44 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:50:44 INFO - 'tests': ['tp5o']}, 16:50:44 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:50:44 INFO - 'talos_options': ['--disable-e10s', 16:50:44 INFO - '--xperf_path', 16:50:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:50:44 INFO - 'tests': ['tp5n']}, 16:50:44 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:50:44 INFO - 'talos_options': ['--xperf_path', 16:50:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:50:44 INFO - 'tests': ['tp5n']}}, 16:50:44 INFO - 'talos.zip': {'path': '', 16:50:44 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:50:44 INFO - Running post-action listener: _resource_record_post_action 16:50:44 INFO - [mozharness: 2016-10-04 23:50:44.072765Z] Finished populate-webroot step (success) 16:50:44 INFO - [mozharness: 2016-10-04 23:50:44.072852Z] Running create-virtualenv step. 16:50:44 INFO - Running pre-action listener: _resource_record_pre_action 16:50:44 INFO - Running main action method: create_virtualenv 16:50:44 INFO - Creating virtualenv /builds/slave/test/build/venv 16:50:44 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 16:50:44 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:50:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:50:44 INFO - Using real prefix '/usr' 16:50:44 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:50:44 INFO - Installing distribute.............................................................................................................................................................................................done. 16:50:46 INFO - Installing pip.................done. 16:50:46 INFO - Return code: 0 16:50:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 16:50:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 16:50:46 INFO - Reading from file tmpfile_stdout 16:50:46 INFO - Output received: 16:50:46 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 16:50:46 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:50:46 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')]} 16:50:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:50:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:50:46 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')]} 16:50:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:50:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:50:46 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 0x7f4cc0c1ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a62790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a5f930>, '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 0x1a60830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a60cc0>, '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': '0333a256a5e4f052382dd180000001b1-1475625028.102668-1754744362', '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 16:50:46 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 16:50:46 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 16:50:46 INFO - Using env: {'DISPLAY': ':0', 16:50:46 INFO - 'HOME': '/home/cltbld', 16:50:46 INFO - 'LANG': 'en_US.UTF-8', 16:50:46 INFO - 'LANGUAGE': 'en_US:en', 16:50:46 INFO - 'LOGNAME': 'cltbld', 16:50:46 INFO - 'MAIL': '/var/mail/cltbld', 16:50:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:50:46 INFO - 'MOZ_NO_REMOTE': '1', 16:50:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:50:46 INFO - 'NO_EM_RESTART': '1', 16:50:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:50:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:50:46 INFO - 'PWD': '/builds/slave/test', 16:50:46 INFO - 'SHELL': '/bin/bash', 16:50:46 INFO - 'SHLVL': '1', 16:50:46 INFO - 'TERM': 'linux', 16:50:46 INFO - 'TMOUT': '86400', 16:50:46 INFO - 'USER': 'cltbld', 16:50:46 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1475625028.102668-1754744362', 16:50:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:50:46 INFO - '_': '/tools/buildbot/bin/python'} 16:50:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:50:47 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 16:50:47 INFO - Cleaning up... 16:50:47 INFO - Return code: 0 16:50:47 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:50: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')]} 16:50:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:50:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:50: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')]} 16:50:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:50:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:50:47 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 0x7f4cc0c1ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a62790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a5f930>, '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 0x1a60830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a60cc0>, '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': '0333a256a5e4f052382dd180000001b1-1475625028.102668-1754744362', '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 16:50:47 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 16:50:47 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 16:50:47 INFO - Using env: {'DISPLAY': ':0', 16:50:47 INFO - 'HOME': '/home/cltbld', 16:50:47 INFO - 'LANG': 'en_US.UTF-8', 16:50:47 INFO - 'LANGUAGE': 'en_US:en', 16:50:47 INFO - 'LOGNAME': 'cltbld', 16:50:47 INFO - 'MAIL': '/var/mail/cltbld', 16:50:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:50:47 INFO - 'MOZ_NO_REMOTE': '1', 16:50:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:50:47 INFO - 'NO_EM_RESTART': '1', 16:50:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:50:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:50:47 INFO - 'PWD': '/builds/slave/test', 16:50:47 INFO - 'SHELL': '/bin/bash', 16:50:47 INFO - 'SHLVL': '1', 16:50:47 INFO - 'TERM': 'linux', 16:50:47 INFO - 'TMOUT': '86400', 16:50:47 INFO - 'USER': 'cltbld', 16:50:47 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1475625028.102668-1754744362', 16:50:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:50:47 INFO - '_': '/tools/buildbot/bin/python'} 16:50:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:50:47 INFO - Downloading/unpacking psutil>=3.1.1 16:50:47 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 16:50:47 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 16:50:47 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 16:50:47 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 16:50:47 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 16:50:47 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 16:50:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:50:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:50:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:50:49 INFO - Installing collected packages: psutil 16:50:49 INFO - Running setup.py install for psutil 16:50:49 INFO - building 'psutil._psutil_linux' extension 16:50:49 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 16:50:49 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 16:50:49 INFO - building 'psutil._psutil_posix' extension 16:50:49 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 16:50:49 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 16:50:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:50:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:50:49 INFO - Successfully installed psutil 16:50:49 INFO - Cleaning up... 16:50:49 INFO - Return code: 0 16:50:49 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:50:49 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')]} 16:50:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:50:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:50:49 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')]} 16:50:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:50:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:50:49 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 0x7f4cc0c1ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a62790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a5f930>, '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 0x1a60830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a60cc0>, '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': '0333a256a5e4f052382dd180000001b1-1475625028.102668-1754744362', '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 16:50:49 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 16:50:49 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 16:50:49 INFO - Using env: {'DISPLAY': ':0', 16:50:49 INFO - 'HOME': '/home/cltbld', 16:50:49 INFO - 'LANG': 'en_US.UTF-8', 16:50:49 INFO - 'LANGUAGE': 'en_US:en', 16:50:49 INFO - 'LOGNAME': 'cltbld', 16:50:49 INFO - 'MAIL': '/var/mail/cltbld', 16:50:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:50:49 INFO - 'MOZ_NO_REMOTE': '1', 16:50:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:50:49 INFO - 'NO_EM_RESTART': '1', 16:50:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:50:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:50:49 INFO - 'PWD': '/builds/slave/test', 16:50:49 INFO - 'SHELL': '/bin/bash', 16:50:49 INFO - 'SHLVL': '1', 16:50:49 INFO - 'TERM': 'linux', 16:50:49 INFO - 'TMOUT': '86400', 16:50:49 INFO - 'USER': 'cltbld', 16:50:49 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1475625028.102668-1754744362', 16:50:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:50:49 INFO - '_': '/tools/buildbot/bin/python'} 16:50:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:50:50 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:50:50 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 16:50:50 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 16:50:50 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 16:50:50 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 16:50:50 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 16:50:50 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 16:50:51 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:50:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:50:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:50:52 INFO - Installing collected packages: mozsystemmonitor 16:50:52 INFO - Running setup.py install for mozsystemmonitor 16:50:52 INFO - Successfully installed mozsystemmonitor 16:50:52 INFO - Cleaning up... 16:50:52 INFO - Return code: 0 16:50:52 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:50:52 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')]} 16:50:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:50:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:50:52 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')]} 16:50:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:50:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:50:52 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 0x7f4cc0c1ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a62790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a5f930>, '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 0x1a60830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a60cc0>, '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': '0333a256a5e4f052382dd180000001b1-1475625028.102668-1754744362', '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 16:50:52 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 16:50:52 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 16:50:52 INFO - Using env: {'DISPLAY': ':0', 16:50:52 INFO - 'HOME': '/home/cltbld', 16:50:52 INFO - 'LANG': 'en_US.UTF-8', 16:50:52 INFO - 'LANGUAGE': 'en_US:en', 16:50:52 INFO - 'LOGNAME': 'cltbld', 16:50:52 INFO - 'MAIL': '/var/mail/cltbld', 16:50:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:50:52 INFO - 'MOZ_NO_REMOTE': '1', 16:50:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:50:52 INFO - 'NO_EM_RESTART': '1', 16:50:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:50:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:50:52 INFO - 'PWD': '/builds/slave/test', 16:50:52 INFO - 'SHELL': '/bin/bash', 16:50:52 INFO - 'SHLVL': '1', 16:50:52 INFO - 'TERM': 'linux', 16:50:52 INFO - 'TMOUT': '86400', 16:50:52 INFO - 'USER': 'cltbld', 16:50:52 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1475625028.102668-1754744362', 16:50:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:50:52 INFO - '_': '/tools/buildbot/bin/python'} 16:50:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:50:52 INFO - Downloading/unpacking jsonschema==2.5.1 16:50:52 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 16:50:52 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 16:50:52 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 16:50:52 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 16:50:52 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 16:50:52 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 16:50:54 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:50:54 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:50:54 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 16:50:54 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 16:50:54 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 16:50:54 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 16:50:54 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 16:50:54 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 16:50:54 INFO - Downloading functools32-3.2.3-2.tar.gz 16:50:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:50:54 INFO - warning: no files found matching '*.txt' 16:50:54 INFO - no previously-included directories found matching 'build' 16:50:54 INFO - no previously-included directories found matching 'dist' 16:50:54 INFO - no previously-included directories found matching '.git*' 16:50:54 INFO - Installing collected packages: jsonschema, functools32 16:50:54 INFO - Running setup.py install for functools32 16:50:54 INFO - warning: no files found matching '*.txt' 16:50:54 INFO - no previously-included directories found matching 'build' 16:50:54 INFO - no previously-included directories found matching 'dist' 16:50:54 INFO - no previously-included directories found matching '.git*' 16:50:54 INFO - Successfully installed jsonschema functools32 16:50:54 INFO - Cleaning up... 16:50:54 INFO - Return code: 0 16:50:54 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:50:54 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')]} 16:50:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:50:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:50:54 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')]} 16:50:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:50:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:50:54 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 0x7f4cc0c1ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a62790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a5f930>, '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 0x1a60830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a60cc0>, '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': '0333a256a5e4f052382dd180000001b1-1475625028.102668-1754744362', '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 16:50:54 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 16:50:54 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 16:50:54 INFO - Using env: {'DISPLAY': ':0', 16:50:54 INFO - 'HOME': '/home/cltbld', 16:50:54 INFO - 'LANG': 'en_US.UTF-8', 16:50:54 INFO - 'LANGUAGE': 'en_US:en', 16:50:54 INFO - 'LOGNAME': 'cltbld', 16:50:54 INFO - 'MAIL': '/var/mail/cltbld', 16:50:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:50:54 INFO - 'MOZ_NO_REMOTE': '1', 16:50:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:50:54 INFO - 'NO_EM_RESTART': '1', 16:50:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:50:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:50:54 INFO - 'PWD': '/builds/slave/test', 16:50:54 INFO - 'SHELL': '/bin/bash', 16:50:54 INFO - 'SHLVL': '1', 16:50:54 INFO - 'TERM': 'linux', 16:50:54 INFO - 'TMOUT': '86400', 16:50:54 INFO - 'USER': 'cltbld', 16:50:54 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1475625028.102668-1754744362', 16:50:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:50:54 INFO - '_': '/tools/buildbot/bin/python'} 16:50:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:50:54 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:50:55 INFO - Cleaning up... 16:50:55 INFO - Return code: 0 16:50:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:50:55 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')]} 16:50:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:50:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:50:55 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')]} 16:50:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:50:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:50:55 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 0x7f4cc0c1ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a62790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a5f930>, '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 0x1a60830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a60cc0>, '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': '0333a256a5e4f052382dd180000001b1-1475625028.102668-1754744362', '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 16:50:55 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 16:50:55 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 16:50:55 INFO - Using env: {'DISPLAY': ':0', 16:50:55 INFO - 'HOME': '/home/cltbld', 16:50:55 INFO - 'LANG': 'en_US.UTF-8', 16:50:55 INFO - 'LANGUAGE': 'en_US:en', 16:50:55 INFO - 'LOGNAME': 'cltbld', 16:50:55 INFO - 'MAIL': '/var/mail/cltbld', 16:50:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:50:55 INFO - 'MOZ_NO_REMOTE': '1', 16:50:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:50:55 INFO - 'NO_EM_RESTART': '1', 16:50:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:50:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:50:55 INFO - 'PWD': '/builds/slave/test', 16:50:55 INFO - 'SHELL': '/bin/bash', 16:50:55 INFO - 'SHLVL': '1', 16:50:55 INFO - 'TERM': 'linux', 16:50:55 INFO - 'TMOUT': '86400', 16:50:55 INFO - 'USER': 'cltbld', 16:50:55 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1475625028.102668-1754744362', 16:50:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:50:55 INFO - '_': '/tools/buildbot/bin/python'} 16:50:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:50:55 INFO - Downloading/unpacking blobuploader==1.2.4 16:50:55 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 16:50:55 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 16:50:55 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 16:50:55 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 16:50:55 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 16:50:55 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 16:50:57 INFO - Downloading blobuploader-1.2.4.tar.gz 16:50:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:50:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:50:57 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 16:50:57 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 16:50:57 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 16:50:57 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 16:50:57 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 16:50:57 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 16:50:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:50:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:50:57 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 16:50:57 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 16:50:57 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 16:50:57 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 16:50:57 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 16:50:57 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 16:50:57 INFO - Downloading docopt-0.6.1.tar.gz 16:50:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:50:57 INFO - Installing collected packages: blobuploader, requests, docopt 16:50:57 INFO - Running setup.py install for blobuploader 16:50:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:50:57 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:50:57 INFO - Running setup.py install for requests 16:50:58 INFO - Running setup.py install for docopt 16:50:58 INFO - Successfully installed blobuploader requests docopt 16:50:58 INFO - Cleaning up... 16:50:58 INFO - Return code: 0 16:50:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:50:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:50:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:50:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:50:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:50:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:50:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:50:58 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 0x7f4cc0c1ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a62790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a5f930>, '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 0x1a60830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a60cc0>, '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': '0333a256a5e4f052382dd180000001b1-1475625028.102668-1754744362', '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 16:50:58 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 16:50:58 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 16:50:58 INFO - Using env: {'DISPLAY': ':0', 16:50:58 INFO - 'HOME': '/home/cltbld', 16:50:58 INFO - 'LANG': 'en_US.UTF-8', 16:50:58 INFO - 'LANGUAGE': 'en_US:en', 16:50:58 INFO - 'LOGNAME': 'cltbld', 16:50:58 INFO - 'MAIL': '/var/mail/cltbld', 16:50:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:50:58 INFO - 'MOZ_NO_REMOTE': '1', 16:50:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:50:58 INFO - 'NO_EM_RESTART': '1', 16:50:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:50:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:50:58 INFO - 'PWD': '/builds/slave/test', 16:50:58 INFO - 'SHELL': '/bin/bash', 16:50:58 INFO - 'SHLVL': '1', 16:50:58 INFO - 'TERM': 'linux', 16:50:58 INFO - 'TMOUT': '86400', 16:50:58 INFO - 'USER': 'cltbld', 16:50:58 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1475625028.102668-1754744362', 16:50:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:50:58 INFO - '_': '/tools/buildbot/bin/python'} 16:50:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:50:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:50:58 INFO - Running setup.py (path:/tmp/pip-zAGUFf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:50:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:50:58 INFO - Running setup.py (path:/tmp/pip-YJPto8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:50:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:50:58 INFO - Running setup.py (path:/tmp/pip-TgGVn3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:50:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:50:58 INFO - Running setup.py (path:/tmp/pip-znzJNF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:50:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:50:59 INFO - Running setup.py (path:/tmp/pip-I9U3NO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:50:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:50:59 INFO - Running setup.py (path:/tmp/pip-Ixxs1x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:50:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:50:59 INFO - Running setup.py (path:/tmp/pip-7wG4mk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:50:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:50:59 INFO - Running setup.py (path:/tmp/pip-2sIiEg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:50:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:50:59 INFO - Running setup.py (path:/tmp/pip-kKlEi1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:50:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:50:59 INFO - Running setup.py (path:/tmp/pip-YCqZRO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:50:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:50:59 INFO - Running setup.py (path:/tmp/pip-UwrhOr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:50:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:50:59 INFO - Running setup.py (path:/tmp/pip-rx8DJo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:50:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:50:59 INFO - Running setup.py (path:/tmp/pip-eyYLDf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:50:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:50:59 INFO - Running setup.py (path:/tmp/pip-YdI0l7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:50:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:50:59 INFO - Running setup.py (path:/tmp/pip-1Sg3QQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:50:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:50:59 INFO - Running setup.py (path:/tmp/pip-DhpAuo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:50:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:50:59 INFO - Running setup.py (path:/tmp/pip-ujhfZD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:50:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:50:59 INFO - Running setup.py install for manifestparser 16:51:00 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:51:00 INFO - Running setup.py install for mozcrash 16:51:00 INFO - Running setup.py install for mozdebug 16:51:00 INFO - Running setup.py install for mozdevice 16:51:00 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:51:00 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:51:00 INFO - Running setup.py install for mozfile 16:51:00 INFO - Running setup.py install for mozhttpd 16:51:00 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:51:00 INFO - Running setup.py install for mozinfo 16:51:00 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:51:00 INFO - Running setup.py install for mozInstall 16:51:00 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:51:00 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:51:00 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:51:00 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:51:00 INFO - Running setup.py install for mozleak 16:51:00 INFO - Running setup.py install for mozlog 16:51:00 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:51:00 INFO - Running setup.py install for moznetwork 16:51:01 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:51:01 INFO - Running setup.py install for mozprocess 16:51:01 INFO - Running setup.py install for mozprofile 16:51:01 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:51:01 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:51:01 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:51:01 INFO - Running setup.py install for mozrunner 16:51:01 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:51:01 INFO - Running setup.py install for mozscreenshot 16:51:01 INFO - Running setup.py install for moztest 16:51:01 INFO - Running setup.py install for mozversion 16:51:01 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:51:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:51:01 INFO - Cleaning up... 16:51:01 INFO - Return code: 0 16:51:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:51:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:51:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:51:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:51:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:51:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:51:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:51:01 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 0x7f4cc0c1ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a62790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a5f930>, '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 0x1a60830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a60cc0>, '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': '0333a256a5e4f052382dd180000001b1-1475625028.102668-1754744362', '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 16:51:01 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 16:51:01 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 16:51:01 INFO - Using env: {'DISPLAY': ':0', 16:51:01 INFO - 'HOME': '/home/cltbld', 16:51:01 INFO - 'LANG': 'en_US.UTF-8', 16:51:01 INFO - 'LANGUAGE': 'en_US:en', 16:51:01 INFO - 'LOGNAME': 'cltbld', 16:51:01 INFO - 'MAIL': '/var/mail/cltbld', 16:51:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:51:01 INFO - 'MOZ_NO_REMOTE': '1', 16:51:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:51:01 INFO - 'NO_EM_RESTART': '1', 16:51:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:51:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:51:01 INFO - 'PWD': '/builds/slave/test', 16:51:01 INFO - 'SHELL': '/bin/bash', 16:51:01 INFO - 'SHLVL': '1', 16:51:01 INFO - 'TERM': 'linux', 16:51:01 INFO - 'TMOUT': '86400', 16:51:01 INFO - 'USER': 'cltbld', 16:51:01 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1475625028.102668-1754744362', 16:51:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:51:01 INFO - '_': '/tools/buildbot/bin/python'} 16:51:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:51:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:51:01 INFO - Running setup.py (path:/tmp/pip-emfjPr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:51:02 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)) 16:51:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:51:02 INFO - Running setup.py (path:/tmp/pip-2NiT3H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:51:02 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)) 16:51:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:51:02 INFO - Running setup.py (path:/tmp/pip-AUvb7M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:51:02 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)) 16:51:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:51:02 INFO - Running setup.py (path:/tmp/pip-xz1HOK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:51:02 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)) 16:51:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:51:02 INFO - Running setup.py (path:/tmp/pip-AoCReI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:51:02 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)) 16:51:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:51:02 INFO - Running setup.py (path:/tmp/pip-08VN1H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:51:02 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)) 16:51:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:51:02 INFO - Running setup.py (path:/tmp/pip-AdHrCy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:51:02 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)) 16:51:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:51:02 INFO - Running setup.py (path:/tmp/pip-YUSVvR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:51:02 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)) 16:51:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:51:02 INFO - Running setup.py (path:/tmp/pip-63UY6V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:51:02 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)) 16:51:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:51:02 INFO - Running setup.py (path:/tmp/pip-bKu17q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:51:02 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)) 16:51:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:51:02 INFO - Running setup.py (path:/tmp/pip-wxaKmQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:51:02 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)) 16:51:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:51:02 INFO - Running setup.py (path:/tmp/pip-jXGHsJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:51:02 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)) 16:51:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:51:02 INFO - Running setup.py (path:/tmp/pip-_PZNja-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:51:02 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)) 16:51:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:51:02 INFO - Running setup.py (path:/tmp/pip-_h538Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:51:03 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)) 16:51:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:51:03 INFO - Running setup.py (path:/tmp/pip-pFguW6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:51:03 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)) 16:51:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:51:03 INFO - Running setup.py (path:/tmp/pip-jikFmj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:51:03 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)) 16:51:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:51:03 INFO - Running setup.py (path:/tmp/pip-9agWga-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:51:03 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)) 16:51:03 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)) 16:51:03 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)) 16:51:03 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)) 16:51:03 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)) 16:51:03 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)) 16:51:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:51:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:51:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:51:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:51:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:51:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:51:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:51:05 INFO - Downloading blessings-1.6.tar.gz 16:51:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:51:05 INFO - Installing collected packages: blessings 16:51:05 INFO - Running setup.py install for blessings 16:51:05 INFO - Successfully installed blessings 16:51:05 INFO - Cleaning up... 16:51:05 INFO - Return code: 0 16:51:05 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:51:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:51:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:51:05 INFO - Reading from file tmpfile_stdout 16:51:05 INFO - Current package versions: 16:51:05 INFO - argparse == 1.2.1 16:51:05 INFO - blessings == 1.6 16:51:05 INFO - blobuploader == 1.2.4 16:51:05 INFO - docopt == 0.6.1 16:51:05 INFO - functools32 == 3.2.3-2 16:51:05 INFO - jsonschema == 2.5.1 16:51:05 INFO - manifestparser == 1.1 16:51:05 INFO - mozInstall == 1.12 16:51:05 INFO - mozcrash == 0.17 16:51:05 INFO - mozdebug == 0.1 16:51:05 INFO - mozdevice == 0.48 16:51:05 INFO - mozfile == 1.2 16:51:05 INFO - mozhttpd == 0.7 16:51:05 INFO - mozinfo == 0.9 16:51:05 INFO - mozleak == 0.1 16:51:05 INFO - mozlog == 3.4 16:51:05 INFO - moznetwork == 0.27 16:51:05 INFO - mozprocess == 0.23 16:51:05 INFO - mozprofile == 0.28 16:51:05 INFO - mozrunner == 6.12 16:51:05 INFO - mozscreenshot == 0.1 16:51:05 INFO - mozsystemmonitor == 0.3 16:51:05 INFO - moztest == 0.7 16:51:05 INFO - mozversion == 1.4 16:51:05 INFO - psutil == 3.1.1 16:51:05 INFO - requests == 1.2.3 16:51:05 INFO - wsgiref == 0.1.2 16:51:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:51:05 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')]} 16:51:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:51:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:51:05 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')]} 16:51:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:51:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:51:05 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 0x7f4cc0c1ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a62790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a5f930>, '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 0x1a60830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a60cc0>, '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': '0333a256a5e4f052382dd180000001b1-1475625028.102668-1754744362', '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 16:51:05 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 16:51:05 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 16:51:05 INFO - Using env: {'DISPLAY': ':0', 16:51:05 INFO - 'HOME': '/home/cltbld', 16:51:05 INFO - 'LANG': 'en_US.UTF-8', 16:51:05 INFO - 'LANGUAGE': 'en_US:en', 16:51:05 INFO - 'LOGNAME': 'cltbld', 16:51:05 INFO - 'MAIL': '/var/mail/cltbld', 16:51:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:51:05 INFO - 'MOZ_NO_REMOTE': '1', 16:51:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:51:05 INFO - 'NO_EM_RESTART': '1', 16:51:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:51:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:51:05 INFO - 'PWD': '/builds/slave/test', 16:51:05 INFO - 'SHELL': '/bin/bash', 16:51:05 INFO - 'SHLVL': '1', 16:51:05 INFO - 'TERM': 'linux', 16:51:05 INFO - 'TMOUT': '86400', 16:51:05 INFO - 'USER': 'cltbld', 16:51:05 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1475625028.102668-1754744362', 16:51:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:51:05 INFO - '_': '/tools/buildbot/bin/python'} 16:51:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:51:05 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)) 16:51:05 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)) 16:51:05 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)) 16:51:05 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)) 16:51:05 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)) 16:51:05 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)) 16:51:05 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)) 16:51:05 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)) 16:51:05 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)) 16:51:05 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)) 16:51:05 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)) 16:51:05 INFO - Cleaning up... 16:51:05 INFO - Return code: 0 16:51:05 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:51:05 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')]} 16:51:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:51:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:51:05 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')]} 16:51:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:51:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:51:05 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 0x7f4cc0c1ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a62790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a5f930>, '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 0x1a60830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a60cc0>, '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': '0333a256a5e4f052382dd180000001b1-1475625028.102668-1754744362', '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 16:51:05 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 16:51:05 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 16:51:05 INFO - Using env: {'DISPLAY': ':0', 16:51:05 INFO - 'HOME': '/home/cltbld', 16:51:05 INFO - 'LANG': 'en_US.UTF-8', 16:51:05 INFO - 'LANGUAGE': 'en_US:en', 16:51:05 INFO - 'LOGNAME': 'cltbld', 16:51:05 INFO - 'MAIL': '/var/mail/cltbld', 16:51:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:51:05 INFO - 'MOZ_NO_REMOTE': '1', 16:51:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:51:05 INFO - 'NO_EM_RESTART': '1', 16:51:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:51:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:51:05 INFO - 'PWD': '/builds/slave/test', 16:51:05 INFO - 'SHELL': '/bin/bash', 16:51:05 INFO - 'SHLVL': '1', 16:51:05 INFO - 'TERM': 'linux', 16:51:05 INFO - 'TMOUT': '86400', 16:51:05 INFO - 'USER': 'cltbld', 16:51:05 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1475625028.102668-1754744362', 16:51:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:51:05 INFO - '_': '/tools/buildbot/bin/python'} 16:51:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:51:06 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:51:06 INFO - Cleaning up... 16:51:06 INFO - Return code: 0 16:51:06 INFO - Running post-action listener: _resource_record_post_action 16:51:06 INFO - Running post-action listener: _start_resource_monitoring 16:51:06 INFO - Starting resource monitoring. 16:51:06 INFO - [mozharness: 2016-10-04 23:51:06.086390Z] Finished create-virtualenv step (success) 16:51:06 INFO - [mozharness: 2016-10-04 23:51:06.086859Z] Running install step. 16:51:06 INFO - Running pre-action listener: _resource_record_pre_action 16:51:06 INFO - Running main action method: install 16:51:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:51:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:51:06 INFO - Reading from file tmpfile_stdout 16:51:06 INFO - Detecting whether we're running mozinstall >=1.0... 16:51:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:51:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:51:06 INFO - Reading from file tmpfile_stdout 16:51:06 INFO - Output received: 16:51:06 INFO - Usage: mozinstall [options] installer 16:51:06 INFO - Options: 16:51:06 INFO - -h, --help show this help message and exit 16:51:06 INFO - -d DEST, --destination=DEST 16:51:06 INFO - Directory to install application into. [default: 16:51:06 INFO - "/builds/slave/test"] 16:51:06 INFO - --app=APP Application being installed. [default: firefox] 16:51:06 INFO - mkdir: /builds/slave/test/build/application 16:51:06 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'] 16:51:06 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 16:51:23 INFO - Reading from file tmpfile_stdout 16:51:23 INFO - Output received: 16:51:23 INFO - /builds/slave/test/build/application/firefox/firefox 16:51:23 INFO - Running post-action listener: _resource_record_post_action 16:51:23 INFO - [mozharness: 2016-10-04 23:51:23.384475Z] Finished install step (success) 16:51:23 INFO - [mozharness: 2016-10-04 23:51:23.384721Z] Running run-tests step. 16:51:23 INFO - Running pre-action listener: _resource_record_pre_action 16:51:23 INFO - Running main action method: run_tests 16:51:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:51:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:51:23 INFO - Python 2.7.3 16:51:23 INFO - Return code: 0 16:51:23 INFO - grabbing minidump binary from tooltool 16:51:23 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')]} 16:51:23 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 0x1a5f930>, '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 0x1a60830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a60cc0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:51:23 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 16:51:23 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 16:51:23 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 16:51:23 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:51:23 INFO - Return code: 0 16:51:23 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:51:23 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:51:23 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:51:23 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:51:23 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:51:23 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://queue.taskcluster.net/v1/task/WddpZyHqTAqIG43rQlMd6Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--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 16:51:23 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://queue.taskcluster.net/v1/task/WddpZyHqTAqIG43rQlMd6Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-017 --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 16:51:23 INFO - Using env: {'DISPLAY': ':0', 16:51:23 INFO - 'HOME': '/home/cltbld', 16:51:23 INFO - 'LANG': 'en_US.UTF-8', 16:51:23 INFO - 'LANGUAGE': 'en_US:en', 16:51:23 INFO - 'LOGNAME': 'cltbld', 16:51:23 INFO - 'MAIL': '/var/mail/cltbld', 16:51:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:51:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:51:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:51:23 INFO - 'MOZ_NO_REMOTE': '1', 16:51:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:51:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:51:23 INFO - 'NO_EM_RESTART': '1', 16:51:23 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:51:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:51:23 INFO - 'PWD': '/builds/slave/test', 16:51:23 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:51:23 INFO - 'SHELL': '/bin/bash', 16:51:23 INFO - 'SHLVL': '1', 16:51:23 INFO - 'TERM': 'linux', 16:51:23 INFO - 'TMOUT': '86400', 16:51:23 INFO - 'USER': 'cltbld', 16:51:23 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1475625028.102668-1754744362', 16:51:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:51:23 INFO - '_': '/tools/buildbot/bin/python'} 16:51:23 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://queue.taskcluster.net/v1/task/WddpZyHqTAqIG43rQlMd6Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--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 16:51:23 INFO - mozversion application_buildid: 20161004122910 16:51:23 INFO - mozversion application_changeset: 3fff88de2f2d5194bc940ad67ca2187498d00243 16:51:23 INFO - mozversion application_display_name: Nightly 16:51:23 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:51:23 INFO - mozversion application_name: Firefox 16:51:23 INFO - mozversion application_remotingname: firefox 16:51:23 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 16:51:23 INFO - mozversion application_vendor: Mozilla 16:51:23 INFO - mozversion application_version: 52.0a1 16:51:23 INFO - mozversion platform_buildid: 20161004122910 16:51:23 INFO - mozversion platform_changeset: 3fff88de2f2d5194bc940ad67ca2187498d00243 16:51:23 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 16:51:23 INFO - mozversion platform_version: 52.0a1 16:51:23 INFO - using testdate: 1475625083 16:51:23 INFO - actual date: 1475625083 16:51:23 INFO - starting webserver on 'localhost:60988' 16:51:23 INFO - SUITE-START | Running 2 tests 16:51:23 INFO - TEST-START | dromaeo_css 16:51:23 INFO - operating with platform_type : linux_ 16:51:23 INFO - Initialising browser for dromaeo_css test... 16:51:23 INFO - TEST-INFO | started process 3702 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4MHfsg/profile http://localhost:60988/getInfo.html) 16:51:28 INFO - PROCESS | 3702 | __metrics Screen width/height:1600/1200 16:51:28 INFO - PROCESS | 3702 | colorDepth:24 16:51:28 INFO - PROCESS | 3702 | Browser inner width/height: 1024/697 16:51:28 INFO - PROCESS | 3702 | __metrics 16:51:28 ERROR - PROCESS | 3702 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3079: TypeError: this.tabs is undefined 16:51:29 INFO - TEST-INFO | 3702: exit 0 16:51:29 INFO - Browser initialized. 16:51:29 INFO - Running cycle 1/1 for dromaeo_css test... 16:51:29 INFO - TEST-INFO | started process 3820 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4MHfsg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:51:41 INFO - PROCESS | 3820 | RSS: Main: 185577472 16:51:41 INFO - PROCESS | 3820 | 16:52:31 INFO - PROCESS | 3820 | 1475625151235 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] 16:54:42 INFO - PROCESS | 3820 | Cycle 1(1): loaded http://localhost:60988/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60988/tests/dromaeo/cssquery-ext.html) 16:54:43 INFO - PROCESS | 3820 | RSS: Main: 200044544 16:54:43 INFO - PROCESS | 3820 | 16:57:45 INFO - PROCESS | 3820 | Cycle 1(1): loaded http://localhost:60988/tests/dromaeo/cssquery-ext.html (next: http://localhost:60988/tests/dromaeo/cssquery-jquery.html) 16:57:46 INFO - PROCESS | 3820 | RSS: Main: 197513216 16:57:46 INFO - PROCESS | 3820 | 17:00:48 INFO - PROCESS | 3820 | Cycle 1(1): loaded http://localhost:60988/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60988/tests/dromaeo/cssquery-mootools.html) 17:00:48 INFO - PROCESS | 3820 | RSS: Main: 199196672 17:00:48 INFO - PROCESS | 3820 | 17:03:50 INFO - PROCESS | 3820 | Cycle 1(1): loaded http://localhost:60988/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60988/tests/dromaeo/cssquery-prototype.html) 17:03:51 INFO - PROCESS | 3820 | RSS: Main: 195940352 17:03:51 INFO - PROCESS | 3820 | 17:06:53 INFO - PROCESS | 3820 | Cycle 1(1): loaded http://localhost:60988/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60988/tests/dromaeo/cssquery-yui.html) 17:06:54 INFO - PROCESS | 3820 | RSS: Main: 199389184 17:06:54 INFO - PROCESS | 3820 | 17:09:56 INFO - PROCESS | 3820 | Cycle 1(1): loaded http://localhost:60988/tests/dromaeo/cssquery-yui.html (next: http://localhost:60988/tests/dromaeo/cssquery-dojo.html) 17:09:57 INFO - PROCESS | 3820 | RSS: Main: 199999488 17:09:57 INFO - PROCESS | 3820 | 17:09:57 INFO - PROCESS | 3820 | __start_tp_report 17:09:57 INFO - PROCESS | 3820 | _x_x_mozilla_page_load 17:09:57 INFO - PROCESS | 3820 | _x_x_mozilla_page_load_details 17:09:57 INFO - PROCESS | 3820 | |i|pagename|runs| 17:09:57 INFO - PROCESS | 3820 | |0;dojo.html;3021.108772911991;3035.6660767315607;3060.4491191585507;3077.1999280187147;3095.2726109364294;5130.974345128278;5292.655977361469;5320.733963301834;5361.195820626908;5398.2982212312445;5225.86935326617;5253.264542963979;5293.841184764463;5320.574354051676;5389.326334208224;4733.668643194977;4797.088553174903;4839.612830973514;4850.5877000455;4933.235348520967;4843;4859.368282123337;4883.780229889663;4889.926651100236;4949.480304568023;4652.511486293958;4682.391289132425;4793.472718001017;4836.492168322346;4842.055799119174;4772.7136371817805;4788.090262850047;4792.808287668489;4845.70925744453;4934.605231581465;4792.257200133985;4798.136335459616;4803.639727020487;4830.4203495580405;4882.951170488285;5149.30484384607;5191.558717508979;5323.494268044529;5363.436839131913;5377.892442151135;5576.052071147874;5582.7766889324375;5587.217789509472;5600.0759874620635;5626.324841019063;5553;5588.469095435927;5605.663660180361;5606.383297837235;5616.382197958222;5153.845384638467;5187.35158105233;5218.2955301034635;5257.78968841242;5313.760880760375;5772.249607551075;5773.8556536086935;5785.132230165509;5802.448767367094;5833.649981001068;5519.862003449946;5532.1425179097305;5539.418361072029;5544.63959842617;5544.861378465571;5558.388577256498;5600.131979543177;5620.859478512988;5625.718714064362;5632.070708333161;5625.38120806711;5626.324841019104;5634.774609015593;5686.317641882918;5711.45741154598;5643.5203007743985;5652.519535839418;5658.971705141448;5667.546596272288;5673.574481913873;4154.044569748975;4177.8328866845595;4230.725002874803;4250.53244143144;4266.466691663542;3790.6209379062425;3796.544414670202;3828.8085595720104;3854.4411060396087;3864.7487913285545;5278.234655974862;5346.492083252085;5398.541124004503;5404.162354835007;5420.214068959979;5568.610197286151;5655.858603534863;5722.198892155018;5726.541876649858;5730.36965933747;5335.866603334947;5364.356277246756;5374.516293533601;5387.4073851876265;5461.617686761968;4902.656814022984;4907.877303067452;4912.69813499423;4920.75396230187;4971.726555039508;5742.971285143548;5887.823365298962;5913.674747888821;5926.288845338587;5934.465898069195;5595.524380427709;5683.914741278967;5722.570807189394;5735.9388513125205;5807.564432667482;5936.762529498772;5940.97029514867;5949.077892926603;5966.224390829165;5973.074173503114;5409.432009638931;5446.237526746179;5566.77732890696;5640.407757185437;5690.800821971211;5668.149777533403;5714.114312281603;5714.828555143353;5742.827715168552;5767.971160144172;5595.412481689364;5609.467100625434;5611.74747136388;5615.326160860723;5633.915491267716;5408.188771684121;5564.443555644403;5590;5591.888162236651;5612.747426365905;5413.269208656781;5449.754761035683;5486.286782718221;5492;5505.779768809363;5606.018946684232;5608.663480191201;5622;5624.85937851557;5639.661620302795;5474.069408200695;5482.753276102505;5483.643563168382;5495.780168793363;5514.5864060194845 17:09:57 INFO - PROCESS | 3820 | |1;ext.html;536.3965538768884;562.4937556199421;567.0190570313358;571.1119209629028;579.7101449275362;41703.74888753339;43762.34356484652;44309.33535996963;47194.76402617982;47266.99999999991;44517.7774111129;44603.33095003577;44972.55027449725;45106;45257.54742452574;8729.301655867515;8780.209781119698;8917.554122293892;8950.283977281802;8964.372493925395;8770.473771573694;8790.252828509552;8837.160469755363;8871.290296776242;8883.067277935821;8815.911840881605;8865.955670221672;8906.465612063264;8915.509646969414;8945.194932456077;8849.955750221272;8853.42452740573;8876.112388761137;8900.154485323885;8919.73240802777;8810.251128654072;8855.380123391365;8887.422317549403;8892.021877593459;8904.8664270036;41295.38056929148;41587;41592.37611435831;41650.58349416528;41670.1665966682;3377.105067157205;3616.3129005489136;3624.9275014499826;3742.36379815432;3856.132370216707;30869;31560.684393156003;32167.51748723771;32813.507797383056;32949.17627059319;4344.196323680129;4349.934750978738;4399.5160532341415;4523.185826551252;4679.415073115861;331946;334068;334224;334986;335544;52686;57835.481387419364;58041.709791450776;58048.709756450946;58109;61022.694886525285;61177.38822611806;61281.38718612757;61675;61804.69097654483;15727.292271847795;15830.28763705636;15849.128297943724;15962.600934976486;15983.760243596354;11726.296422214695;11773.234739741889;11819.586314479124;11837.88162118385;11907.583234586747;17223.827761722474;17280;17401.56260153678;17521.29914803419;17653.646927061385;6015.608985415934;6018.398160183947;6085.421884920926;6107.450329470369;6223.190985171989;902.6208992223281;987.5309228116731;1032.6334151376154;1100.867895852503;1116.3692513729716;30867.69132308648;30875.69124308728;31684;31859.68140318567;31930.521042184388;1013.690824298596;1075.0432115417284;1090.9781804363868;1103.6578660615075;1133.6542354581766;15280.31238594266;15426;15521.611959701098;15529.912906096464;15709.21453927299;548172;549840;551713;556174;558986;54802;55324.72337638286;55375.44624553703;55401.445985540435;55551.16673249904;1290.4128621477205;1295.2099219476113;1331.3676003898072;1343.516334119716;1345.3744009035845;28722.281942951595;29006.27484312909;29131.41737165287;29678.55482167726;29878;47498.76250618863;47694.761526192146;47761.28358074701;47765.283520747915;47988.520114798404;434746;437848;438165;438635;439118;26663.20010399691;26841.463170736868;27717.44565108727;27801.860990694917;27858;44851.327230092225;45551.31673024974;45976.31035534403;46575.30137048015;46737;37674.246515070095;37819.81090094532;38031.42952855654;38675.61324386833;39957.60042399655;37856.43215351717;38564.22871542497;38645.420318694676;39782.403263951644;40777.796111019255;39041.60958390493;39220.80389598034;39384.40923386094;39436.2112757749;40529.1894162121;31887.84056079705;33708.49437258394;33756;33933.3213335727;34261;27521.724782752717;27624.58563121595;27719;27833.16500504988;27921.301967450978 17:09:57 INFO - PROCESS | 3820 | |2;jquery.html;385.98070096495167;386.239108955358;398.9441478193053;412.75028607692343;422.1219862685612;13910.234937078456;14850.48023319184;17722.73415898761;19389.22443102276;19416.514587135312;15632;18739.437816865517;18830.34093806717;19032.714509282338;19052.61894762104;5601.159826026088;5626.212330273765;5851.6196447231005;5870.501007414375;5885.911711324312;5658.43415658435;5785.074388097905;5786.189933409326;5791.913121303184;5795.449432303924;5556.16657501374;5702.230198923155;5767.509761670263;5782.277215348082;5803.477687008169;5712.771489140429;5752.338481074688;5765.913511297334;5770.19217309577;5782.392848750884;4933.260010998379;5116.925445656417;5124.461931497176;5126.231065340229;5131.692098474104;22614.98232579538;22652.886735566382;22884.54230915389;22928.31215063551;22933.88533057341;2405.855648661086;2490.838095523803;2494.451220731436;2770.141256210581;2795.454886297173;14172.858271417257;14502.637434064127;14537.345819438151;14540.563783086523;14627;1889.1970912362328;1898.4020033689483;1953.5897461533095;2008.9698654520193;2009.387136923238;48060.51939480595;48493;77211.22788772153;77719.61140194263;78303.21696783073;10687.572497100184;10784.89215107839;10853.51159197838;10957.83563246552;11263.098952083978;15194.620134496505;15235.542933712006;15324.616884577752;15380.15409152485;15389.769153462707;7637.083549974039;7739.34215591681;7951.204879512118;8096.757097287091;8244.628991695388;7531.397488201041;7586.203448637813;7626.42801789868;7754.263344982218;7852.764417067498;6424.967875160594;6463.192100987377;6483.768084064012;6626.701798418986;6654.061666026561;1926.364299781069;1951.6194342103154;1964.3321270768008;1970.5664753754152;2036.7657719362462;906.0712769411406;924.916757491829;952.514217748953;989.4113002763344;1006.0945149365483;17946.64106717858;18233.817661823214;18921.337753178846;18976.81023189778;20508;902.634433054614;987.9703608891745;1028.1723212813756;1029.897010298964;1068.7061058209056;10282.228832837418;10591.788164236672;10629.149668026694;10652.680419587425;10785.245032847626;405520;406010;407331;407538;431532;87696;92781.5360923191;93165.5341723287;96254.51872740731;96277;1046.6755305855056;1066.823974044274;1101.8347247912877;1116.6984914073155;1118.2675347647305;15898.68202635964;16129.274182662042;16192.271347789143;16848.241829117964;17031.48905532836;41913.58086419219;42990;43235.35146972861;43456.34815477707;44647.33029004503;50141;51169.48830511647;54702.179467308815;55307.44692553023;55936.44063559312;7379.704811807467;7697.153313135663;7799.298063174341;8129.146439623754;8169.754907352789;10691.25161238737;12261.754764904474;12367.9381603095;12656.114072015238;13391.330433478091;10217.74455638615;10228.386296822215;10614.257002009785;11471.483783229607;11474.082073434272;11318.886811131782;11537.365444900275;11544.88455115438;11681.474333654836;11959.402029898645;11377;11684;11915.285082895054;11965.581204657796;12079.154459188125;8042.316403105801;8085.878711819445;8097.797555061171;8112.310453611273;8244.175582441709;11180.385078820744;11561.595344162914;11633;11879.168458208189;11922.761544768882 17:09:57 INFO - PROCESS | 3820 | |3;mootools.html;1426.3937826423771;1451.1655797916198;1591.6737068900877;1725.6289897671998;1761.427536050783;7531.548107113564;7793.688252469909;8122.837543249138;8741.868871966917;8744.912550874496;8064.677412903477;8412.411131220802;8414.495130292187;8596.1403859614;8643.524606146659;2253.752087270399;2257.2325409360815;2274.4996100857866;2277.8633282003134;2279.452931296485;2262.502249505106;2276.0668126068317;2329.1731435340466;2331.0442718485424;2338.3803292127513;2292.1519037955895;2299.2872209615075;2300.1834348806183;2322.094383190557;2333.78643105585;2192.375173075674;2196.791304826039;2207.9116835326568;2212.8782916939563;2221.133757834446;2216.3240211735415;2219.700340454034;2221.611218036853;2224.688543603897;2229.4872179398667;8597.656093756243;8607.784805379853;8615.526146061964;8668.046514883357;8670.609822558;4904.926426103611;5035.723035233061;5058.924116138261;5110.718910459923;5128.820491282787;3165.3511030238747;3205.1346136543234;3329.8335083245743;3335.7831740936763;3336.2993771308056;1137.2153214282118;1141.57191053355;1144.1876267849836;1167.7664467106529;1176.6822957801346;11708.53165873364;11717.414129293502;11761.647150585582;11787.351695656735;11836.585719499777;4246.554111818276;4268.765217912983;4488.192125417456;4492.505824359318;4496.280595104768;9906.55420506079;9915.661385712981;9966.950165249127;9969.202463802878;10051.69844904654;5191.065608190562;5206.97396513015;5208.8437346879655;5245.186996015547;5245.921311180336;3931.488906442144;3935.5080614923136;4641.651876109306;4755.500672429414;4794.544518270759;3818.1481981239076;3819.7899115548357;3897.142628621699;3938.389549619756;3960.5643379228263;1279.4882047181015;1284.5760898903527;1286.0676009892752;1286.9099163058495;1295.546558704446;828.6809578312393;873.668006157656;916.5921165081475;944.6410364061612;954.4130359828655;5372.462753724596;5374;5460.126379779216;5615.101583746581;5665.1502274658305;384.6192269653079;392.2194832283792;416.0846138495322;427.8010725012884;428.2890401932777;3667.2482141161;3702.629737026276;3711.7030637548933;3760.4735337052834;3834.2331533693373;10214.131798797036;10790.78418431627;10945.781084378268;10994.34033957965;11104.111671066295;10499.527521261562;10967.122630189566;10991.61529346485;10997.61508347204;11014.614488493025;7860.528368297921;7876.17300183484;7926.286634202949;7934.960325198337;8000.479968801893;5442.12925931849;5485.862853428696;5564.887022595416;5604.103343465026;5623.971880140737;9268.675596354095;9527.571259293487;9573.377730447499;9616.182624476998;9644.083812037845;9814.509274536387;9819.36174148678;9899.20806335477;9929.702108936743;10137;6780.1524809398825;6997.230304666381;7028.859422811617;7455.627218639155;7539.698412063456;7774.144844067261;8137.145599711945;8165.1018387978465;8170.632321545663;8177.182281771775;7023.33278338557;7204.603746793977;7230.45771567124;7231.927680723125;7315.122185337794;6814.284500127415;6983.930160698531;6987.406070484066;7059.71761129549;7117.786466406016;6297.937020629918;6545.5090868184125;6588;6608.8347791305605;6618.338166183343;4260.360945858022;4603.470600880942;4692.53074692528;4696.037312350892;4789.640776941674;4844.854654360375;4899.926501102557;4928.334674818853;4993.126202914548;5067.923981140212 17:09:57 INFO - PROCESS | 3820 | |4;prototype.html;321.32682031144753;321.96136463624384;329.43337459569534;333.8681220917737;334.807485695725;5276.314079169702;5384.488473595002;5493.478119578639;5551.806361632248;5603.2435621191125;5228.2680424740565;5334.759935802888;5337.653052551591;5391.73041347932;5413.53984911283;4230.302000169976;4234.386014027964;4258.212230737308;4260.233158031553;4292.849750258742;4215.494140703105;4246.7896649454915;4297.290946993742;4303.591158839905;4311.525732169474;4232.640225580829;4235.639970602487;4239.872803815891;4241.406203131564;4254.893627659318;4229.767362795045;4258.084511829956;4266.679999000087;4270.551592082848;4297.699161058727;3710.035390798385;3809;3812.5996770338993;3814.19901820618;3821.923561528754;5258.763355648966;5284.392294886099;5308.150695888639;5316.680999140025;5318;4823.421189457253;4830.637702172316;4833.299171620095;4834.202356611155;4840.903181936342;5540.113581826929;5642.407547207526;5663.688497132656;5690.459406356389;5693.259876216065;4048.39274108886;4071.470708807836;4076.2051399977017;4078.2659121358142;4094.078832262747;5872.882542349129;5905.793297234576;5910.556708246856;5952.434518720715;5963.403659634046;3848.7690738555775;4212.578742125825;4223.809928553223;4230.111676547959;4231.20740311393;4112.938305925353;4116.444280022159;4121.464209652726;4127.6904232182105;4132.752034877917;4711.717296962193;4723.7401942893475;4742.644301677388;4744.525547445228;4768.546988036131;5531.612787104864;5751.971240143773;5777.942220577825;5784.421557844266;5791.333996590446;1405.7539930512119;1439.5537383411177;1439.985600143985;1445.3929349673163;1449.8260208775014;883.5626364949392;900.5362238447204;918.7657147427497;929.7722058095675;936.1761649748178;4760.547747963938;4782.832600858953;4789.640776941674;4811.78346974387;4815.470298267188;5078.873028174326;5117.309163262987;5120.667156634807;5131.281620573122;5199.610029247821;4830.975845120822;4852.8786780330065;4883.389576302962;4900.901981960341;5171.818986335536;3046.826971615944;3114.1903105192814;3115.750739940799;3117.703818137273;3128;6053.939460605426;6076.756929722762;6080.14877917092;6145.631262124287;6159.583295841981;5700.857478562986;5975.671338076448;5991.850203744942;6018.465291350765;6020.839059493714;6091.593820440901;6119.724612392453;6126.785562505291;6128.540359473057;6148.923938310778;5585.218069470358;5901.5213610284645;5902.911456328245;5924.259467566554;6003.309619393651;5857.47282744555;5880.8235752927485;5883.352831188651;5905.911411328748;5914.4381283777975;5975.25309336333;6002.669853158118;6118.60229085108;6137.619035716928;6155.353687862889;4053.290674132074;4219.852305169305;4220.472440944882;4231.23837709203;4239.901248881823;5873.353931067664;5877.4122587742595;5892.823215303548;5934.910976335272;5940.138679891478;5605.859853503695;5638.436156384329;5692.715364231854;5723;5811.360750317546;5614.915776263278;5623.718814059363;5628.889166562539;5654.943450565606;5658.801941932013;5581.972090139523;5598.384177740527;5602.355729091044;5622.409646987171;5658.5473162147755;5461.590380721541;5711.743416448375;5737.483626473638;5756.30924289088;5756.453136951983;5550.084236100998;5562.721863906708;5573.21974923503;5597.272354593877;5633.605647604629 17:09:57 INFO - PROCESS | 3820 | |5;yui.html;703.458337080448;711.6939715922151;774.5894675821817;820.5363969357309;824.2581676491159;15798.60503487412;16472.258748356322;16562.089085100313;16618.25217865196;16735.163241837905;14860.182689952047;14887.18120503372;14902.552923412288;14950.476733314335;14965.102093874348;780.1418439716309;793.436659971421;795.4829360915394;797.9122296547375;802.8314054048657;780.6331024418514;790.8734602463607;795.5266616363255;797.4298376660687;798.2456578533288;829.0424559633602;836.6026137584629;837.0959363887018;838.2916435611899;842.3808500751942;825.4634487583058;827.4952279109739;830.8255266394034;830.9584520773938;831.767105210542;612.696715126011;613.7422282641302;613.9447449729546;615.5629503052838;618.0451202891498;13909.234992075431;13958.58124256274;13981.231032293219;14016.159030458102;14019;11913.880861191365;12639;12772.042096842773;12908.677283067904;12934.870651293555;11051.17116216279;11101.611443599435;11173.050290725298;11261.493232804543;11447.885521144764;3709.703223742094;3794.354959656865;3827.9808600957094;3898.8440462381473;3954.130091379892;75362;81983.59008204921;82237.58881205616;82528;82561.58719206425;9290.291645230614;9361.761233418918;9502.477363744922;9607.90392096084;9727;20002.89998550027;20081.196752129752;20256.79743202549;20305.898470507553;20385.490362740755;8231.888695026215;8271.95864020676;8335.041470230879;8635.784105397415;8759.2992560595;4190.769507677046;4447.3329000650165;4452.0873220989615;4484.798184081724;4555.385023021916;3546.8935931922083;3656.6160553142067;3677.9264414711556;3709.536307961505;3709.962900370962;576.6223123853882;586.6919867069822;596.9970150149221;602.9698515074228;603.9396060393925;599.2629066248452;674.3762020131359;702.2977022977022;703.033329172388;706.787963610925;8847.955760221286;8995.820083598423;9068.093190681011;9243.676471323606;9627.759306017266;665.6971078159426;667.4460198035716;687.594319351585;688.5490004047357;690.0546251635292;3572.7677700949357;4385.386045953569;4427.822887084545;4446.466424029137;4558.9772051139535;124795;125477.37261313635;126261;127397.36301318434;131941;82881;85967;103412;107816;110759;86026.56986715151;86181;86222;87187.56406217928;87788.56105719558;8598.957005214934;8600.09698981598;8740.562971851255;8775.736727897918;8837.469751814911;48500.272495911886;49630.4423719521;49980.500194997585;50117;50710.23934641057;44042.898927525785;44429.77785111183;44869;69755.6512217456;74446.88329674951;11360.54557817678;11408.486618102039;11531.711707207387;11625.418729063682;11748;12616.87383126157;12772.978161747224;13101.73796524045;13203.735925281633;13225;12111.939440302742;12309.75380492403;12615.180013299107;13308.93345533266;13479.19124852512;12760.170588911691;13182.60452186436;13223.603291901258;14385.712285754016;14403.711925761636;12842.229466232056;13054.804177937149;13309.866901330863;14022.158670479805;14260.42958281657;10333.225008124271;10611.41637209961;11429.59996400122;11554.48004839801;11673.591424300108;9658.420494770337;10759.515821787882;10906.454677265947;10929.344239345664;11186.496607652838 17:09:57 INFO - PROCESS | 3820 | __end_tp_report 17:09:57 INFO - PROCESS | 3820 | __start_cc_report 17:09:57 INFO - PROCESS | 3820 | _x_x_mozilla_cycle_collect,292 17:09:57 INFO - PROCESS | 3820 | __end_cc_report 17:09:57 INFO - PROCESS | 3820 | __startTimestamp1475626197118__endTimestamp 17:09:57 INFO - PROCESS | 3820 | 17:09:57 INFO - PROCESS | 3820 | ------- Summary: start ------- 17:09:57 INFO - PROCESS | 3820 | Number of tests: 6 17:09:57 INFO - PROCESS | 3820 | 17:09:57 INFO - PROCESS | 3820 | [#0] dojo.html Cycles:165 Average:5263.43 Median:5483.64 stddev:609.35 (11.1%) stddev-sans-first:585.28 17:09:57 INFO - PROCESS | 3820 | Values: 3021.1 3035.7 3060.4 3077.2 3095.3 5131.0 5292.7 5320.7 5361.2 5398.3 5225.9 5253.3 5293.8 5320.6 5389.3 4733.7 4797.1 4839.6 4850.6 4933.2 4843.0 4859.4 4883.8 4889.9 4949.5 4652.5 4682.4 4793.5 4836.5 4842.1 4772.7 4788.1 4792.8 4845.7 4934.6 4792.3 4798.1 4803.6 4830.4 4883.0 5149.3 5191.6 5323.5 5363.4 5377.9 5576.1 5582.8 5587.2 5600.1 5626.3 5553.0 5588.5 5605.7 5606.4 5616.4 5153.8 5187.4 5218.3 5257.8 5313.8 5772.2 5773.9 5785.1 5802.4 5833.6 5519.9 5532.1 5539.4 5544.6 5544.9 5558.4 5600.1 5620.9 5625.7 5632.1 5625.4 5626.3 5634.8 5686.3 5711.5 5643.5 5652.5 5659.0 5667.5 5673.6 4154.0 4177.8 4230.7 4250.5 4266.5 3790.6 3796.5 3828.8 3854.4 3864.7 5278.2 5346.5 5398.5 5404.2 5420.2 5568.6 5655.9 5722.2 5726.5 5730.4 5335.9 5364.4 5374.5 5387.4 5461.6 4902.7 4907.9 4912.7 4920.8 4971.7 5743.0 5887.8 5913.7 5926.3 5934.5 5595.5 5683.9 5722.6 5735.9 5807.6 5936.8 5941.0 5949.1 5966.2 5973.1 5409.4 5446.2 5566.8 5640.4 5690.8 5668.1 5714.1 5714.8 5742.8 5768.0 5595.4 5609.5 5611.7 5615.3 5633.9 5408.2 5564.4 5590.0 5591.9 5612.7 5413.3 5449.8 5486.3 5492.0 5505.8 5606.0 5608.7 5622.0 5624.9 5639.7 5474.1 5482.8 5483.6 5495.8 5514.6 17:09:57 INFO - PROCESS | 3820 | 17:09:57 INFO - PROCESS | 3820 | [#1] ext.html Cycles:180 Average:59584.62 Median:41621.48 stddev:119700.27 (287.6%) stddev-sans-first:119953.96 17:09:57 INFO - PROCESS | 3820 | Values: 536.4 562.5 567.0 571.1 579.7 41703.7 43762.3 44309.3 47194.8 47267.0 44517.8 44603.3 44972.6 45106.0 45257.5 8729.3 8780.2 8917.6 8950.3 8964.4 8770.5 8790.3 8837.2 8871.3 8883.1 8815.9 8866.0 8906.5 8915.5 8945.2 8850.0 8853.4 8876.1 8900.2 8919.7 8810.3 8855.4 8887.4 8892.0 8904.9 41295.4 41587.0 41592.4 41650.6 41670.2 3377.1 3616.3 3624.9 3742.4 3856.1 30869.0 31560.7 32167.5 32813.5 32949.2 4344.2 4349.9 4399.5 4523.2 4679.4 331946.0 334068.0 334224.0 334986.0 335544.0 52686.0 57835.5 58041.7 58048.7 58109.0 61022.7 61177.4 61281.4 61675.0 61804.7 15727.3 15830.3 15849.1 15962.6 15983.8 11726.3 11773.2 11819.6 11837.9 11907.6 17223.8 17280.0 17401.6 17521.3 17653.6 6015.6 6018.4 6085.4 6107.5 6223.2 902.6 987.5 1032.6 1100.9 1116.4 30867.7 30875.7 31684.0 31859.7 31930.5 1013.7 1075.0 1091.0 1103.7 1133.7 15280.3 15426.0 15521.6 15529.9 15709.2 548172.0 549840.0 551713.0 556174.0 558986.0 54802.0 55324.7 55375.4 55401.4 55551.2 1290.4 1295.2 1331.4 1343.5 1345.4 28722.3 29006.3 29131.4 29678.6 29878.0 47498.8 47694.8 47761.3 47765.3 47988.5 434746.0 437848.0 438165.0 438635.0 439118.0 26663.2 26841.5 27717.4 27801.9 27858.0 44851.3 45551.3 45976.3 46575.3 46737.0 37674.2 37819.8 38031.4 38675.6 39957.6 37856.4 38564.2 38645.4 39782.4 40777.8 39041.6 39220.8 39384.4 39436.2 40529.2 31887.8 33708.5 33756.0 33933.3 34261.0 27521.7 27624.6 27719.0 27833.2 27921.3 17:09:57 INFO - PROCESS | 3820 | 17:09:57 INFO - PROCESS | 3820 | [#2] jquery.html Cycles:180 Average:26291.15 Median:2492.64 stddev:68138.68 (2733.6%) stddev-sans-first:68302.06 17:09:57 INFO - PROCESS | 3820 | Values: 386.0 386.2 398.9 412.8 422.1 13910.2 14850.5 17722.7 19389.2 19416.5 15632.0 18739.4 18830.3 19032.7 19052.6 5601.2 5626.2 5851.6 5870.5 5885.9 5658.4 5785.1 5786.2 5791.9 5795.4 5556.2 5702.2 5767.5 5782.3 5803.5 5712.8 5752.3 5765.9 5770.2 5782.4 4933.3 5116.9 5124.5 5126.2 5131.7 22615.0 22652.9 22884.5 22928.3 22933.9 2405.9 2490.8 2494.5 2770.1 2795.5 14172.9 14502.6 14537.3 14540.6 14627.0 1889.2 1898.4 1953.6 2009.0 2009.4 48060.5 48493.0 77211.2 77719.6 78303.2 10687.6 10784.9 10853.5 10957.8 11263.1 15194.6 15235.5 15324.6 15380.2 15389.8 7637.1 7739.3 7951.2 8096.8 8244.6 7531.4 7586.2 7626.4 7754.3 7852.8 6425.0 6463.2 6483.8 6626.7 6654.1 1926.4 1951.6 1964.3 1970.6 2036.8 906.1 924.9 952.5 989.4 1006.1 17946.6 18233.8 18921.3 18976.8 20508.0 902.6 988.0 1028.2 1029.9 1068.7 10282.2 10591.8 10629.1 10652.7 10785.2 405520.0 406010.0 407331.0 407538.0 431532.0 87696.0 92781.5 93165.5 96254.5 96277.0 1046.7 1066.8 1101.8 1116.7 1118.3 15898.7 16129.3 16192.3 16848.2 17031.5 41913.6 42990.0 43235.4 43456.3 44647.3 50141.0 51169.5 54702.2 55307.4 55936.4 7379.7 7697.2 7799.3 8129.1 8169.8 10691.3 12261.8 12367.9 12656.1 13391.3 10217.7 10228.4 10614.3 11471.5 11474.1 11318.9 11537.4 11544.9 11681.5 11959.4 11377.0 11684.0 11915.3 11965.6 12079.2 8042.3 8085.9 8097.8 8112.3 8244.2 11180.4 11561.6 11633.0 11879.2 11922.8 17:09:57 INFO - PROCESS | 3820 | 17:09:57 INFO - PROCESS | 3820 | [#3] mootools.html Cycles:180 Average:5534.43 Median:4792.09 stddev:3196.90 (66.7%) stddev-sans-first:3190.96 17:09:57 INFO - PROCESS | 3820 | Values: 1426.4 1451.2 1591.7 1725.6 1761.4 7531.5 7793.7 8122.8 8741.9 8744.9 8064.7 8412.4 8414.5 8596.1 8643.5 2253.8 2257.2 2274.5 2277.9 2279.5 2262.5 2276.1 2329.2 2331.0 2338.4 2292.2 2299.3 2300.2 2322.1 2333.8 2192.4 2196.8 2207.9 2212.9 2221.1 2216.3 2219.7 2221.6 2224.7 2229.5 8597.7 8607.8 8615.5 8668.0 8670.6 4904.9 5035.7 5058.9 5110.7 5128.8 3165.4 3205.1 3329.8 3335.8 3336.3 1137.2 1141.6 1144.2 1167.8 1176.7 11708.5 11717.4 11761.6 11787.4 11836.6 4246.6 4268.8 4488.2 4492.5 4496.3 9906.6 9915.7 9967.0 9969.2 10051.7 5191.1 5207.0 5208.8 5245.2 5245.9 3931.5 3935.5 4641.7 4755.5 4794.5 3818.1 3819.8 3897.1 3938.4 3960.6 1279.5 1284.6 1286.1 1286.9 1295.5 828.7 873.7 916.6 944.6 954.4 5372.5 5374.0 5460.1 5615.1 5665.2 384.6 392.2 416.1 427.8 428.3 3667.2 3702.6 3711.7 3760.5 3834.2 10214.1 10790.8 10945.8 10994.3 11104.1 10499.5 10967.1 10991.6 10997.6 11014.6 7860.5 7876.2 7926.3 7935.0 8000.5 5442.1 5485.9 5564.9 5604.1 5624.0 9268.7 9527.6 9573.4 9616.2 9644.1 9814.5 9819.4 9899.2 9929.7 10137.0 6780.2 6997.2 7028.9 7455.6 7539.7 7774.1 8137.1 8165.1 8170.6 8177.2 7023.3 7204.6 7230.5 7231.9 7315.1 6814.3 6983.9 6987.4 7059.7 7117.8 6297.9 6545.5 6588.0 6608.8 6618.3 4260.4 4603.5 4692.5 4696.0 4789.6 4844.9 4899.9 4928.3 4993.1 5067.9 17:09:57 INFO - PROCESS | 3820 | 17:09:57 INFO - PROCESS | 3820 | [#4] prototype.html Cycles:180 Average:4752.16 Median:5317.34 stddev:1405.64 (26.4%) stddev-sans-first:1369.67 17:09:57 INFO - PROCESS | 3820 | Values: 321.3 322.0 329.4 333.9 334.8 5276.3 5384.5 5493.5 5551.8 5603.2 5228.3 5334.8 5337.7 5391.7 5413.5 4230.3 4234.4 4258.2 4260.2 4292.8 4215.5 4246.8 4297.3 4303.6 4311.5 4232.6 4235.6 4239.9 4241.4 4254.9 4229.8 4258.1 4266.7 4270.6 4297.7 3710.0 3809.0 3812.6 3814.2 3821.9 5258.8 5284.4 5308.2 5316.7 5318.0 4823.4 4830.6 4833.3 4834.2 4840.9 5540.1 5642.4 5663.7 5690.5 5693.3 4048.4 4071.5 4076.2 4078.3 4094.1 5872.9 5905.8 5910.6 5952.4 5963.4 3848.8 4212.6 4223.8 4230.1 4231.2 4112.9 4116.4 4121.5 4127.7 4132.8 4711.7 4723.7 4742.6 4744.5 4768.5 5531.6 5752.0 5777.9 5784.4 5791.3 1405.8 1439.6 1440.0 1445.4 1449.8 883.6 900.5 918.8 929.8 936.2 4760.5 4782.8 4789.6 4811.8 4815.5 5078.9 5117.3 5120.7 5131.3 5199.6 4831.0 4852.9 4883.4 4900.9 5171.8 3046.8 3114.2 3115.8 3117.7 3128.0 6053.9 6076.8 6080.1 6145.6 6159.6 5700.9 5975.7 5991.9 6018.5 6020.8 6091.6 6119.7 6126.8 6128.5 6148.9 5585.2 5901.5 5902.9 5924.3 6003.3 5857.5 5880.8 5883.4 5905.9 5914.4 5975.3 6002.7 6118.6 6137.6 6155.4 4053.3 4219.9 4220.5 4231.2 4239.9 5873.4 5877.4 5892.8 5934.9 5940.1 5605.9 5638.4 5692.7 5723.0 5811.4 5614.9 5623.7 5628.9 5654.9 5658.8 5582.0 5598.4 5602.4 5622.4 5658.5 5461.6 5711.7 5737.5 5756.3 5756.5 5550.1 5562.7 5573.2 5597.3 5633.6 17:09:57 INFO - PROCESS | 3820 | 17:09:57 INFO - PROCESS | 3820 | [#5] yui.html Cycles:180 Average:20344.65 Median:4468.44 stddev:30686.87 (686.7%) stddev-sans-first:30737.51 17:09:57 INFO - PROCESS | 3820 | Values: 703.5 711.7 774.6 820.5 824.3 15798.6 16472.3 16562.1 16618.3 16735.2 14860.2 14887.2 14902.6 14950.5 14965.1 780.1 793.4 795.5 797.9 802.8 780.6 790.9 795.5 797.4 798.2 829.0 836.6 837.1 838.3 842.4 825.5 827.5 830.8 831.0 831.8 612.7 613.7 613.9 615.6 618.0 13909.2 13958.6 13981.2 14016.2 14019.0 11913.9 12639.0 12772.0 12908.7 12934.9 11051.2 11101.6 11173.1 11261.5 11447.9 3709.7 3794.4 3828.0 3898.8 3954.1 75362.0 81983.6 82237.6 82528.0 82561.6 9290.3 9361.8 9502.5 9607.9 9727.0 20002.9 20081.2 20256.8 20305.9 20385.5 8231.9 8272.0 8335.0 8635.8 8759.3 4190.8 4447.3 4452.1 4484.8 4555.4 3546.9 3656.6 3677.9 3709.5 3710.0 576.6 586.7 597.0 603.0 603.9 599.3 674.4 702.3 703.0 706.8 8848.0 8995.8 9068.1 9243.7 9627.8 665.7 667.4 687.6 688.5 690.1 3572.8 4385.4 4427.8 4446.5 4559.0 124795.0 125477.4 126261.0 127397.4 131941.0 82881.0 85967.0 103412.0 107816.0 110759.0 86026.6 86181.0 86222.0 87187.6 87788.6 8599.0 8600.1 8740.6 8775.7 8837.5 48500.3 49630.4 49980.5 50117.0 50710.2 44042.9 44429.8 44869.0 69755.7 74446.9 11360.5 11408.5 11531.7 11625.4 11748.0 12616.9 12773.0 13101.7 13203.7 13225.0 12111.9 12309.8 12615.2 13308.9 13479.2 12760.2 13182.6 13223.6 14385.7 14403.7 12842.2 13054.8 13309.9 14022.2 14260.4 10333.2 10611.4 11429.6 11554.5 11673.6 9658.4 10759.5 10906.5 10929.3 11186.5 17:09:57 INFO - PROCESS | 3820 | -------- Summary: end -------- 17:09:57 INFO - PROCESS | 3820 | 17:09:58 INFO - TEST-INFO | 3820: exit 0 17:09:58 INFO - TEST-OK | dromaeo_css | took 1114549ms 17:09:58 INFO - TEST-START | kraken 17:09:58 INFO - operating with platform_type : linux_ 17:09:58 INFO - Initialising browser for kraken test... 17:09:58 INFO - TEST-INFO | started process 4182 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpypA6KX/profile http://localhost:60988/getInfo.html) 17:10:02 INFO - PROCESS | 4182 | __metrics Screen width/height:1600/1200 17:10:02 INFO - PROCESS | 4182 | colorDepth:24 17:10:02 INFO - PROCESS | 4182 | Browser inner width/height: 1024/697 17:10:02 INFO - PROCESS | 4182 | __metrics 17:10:03 ERROR - PROCESS | 4182 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3079: TypeError: this.tabs is undefined 17:10:03 INFO - TEST-INFO | 4182: exit 0 17:10:03 INFO - Browser initialized. 17:10:03 INFO - Running cycle 1/1 for kraken test... 17:10:03 INFO - TEST-INFO | started process 4302 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpypA6KX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:10:16 INFO - PROCESS | 4302 | RSS: Main: 185245696 17:10:16 INFO - PROCESS | 4302 | 17:10:18 INFO - PROCESS | 4302 | Cycle 1(1): loaded http://localhost:60988/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60988/tests/kraken/driver.html?testName=audio-beat-detection) 17:10:19 INFO - PROCESS | 4302 | RSS: Main: 199499776 17:10:19 INFO - PROCESS | 4302 | 17:10:22 INFO - PROCESS | 4302 | Cycle 1(1): loaded http://localhost:60988/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60988/tests/kraken/driver.html?testName=audio-dft) 17:10:22 INFO - PROCESS | 4302 | RSS: Main: 197599232 17:10:22 INFO - PROCESS | 4302 | 17:10:25 INFO - PROCESS | 4302 | Cycle 1(1): loaded http://localhost:60988/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60988/tests/kraken/driver.html?testName=audio-fft) 17:10:26 INFO - PROCESS | 4302 | RSS: Main: 192602112 17:10:26 INFO - PROCESS | 4302 | 17:10:28 INFO - PROCESS | 4302 | Cycle 1(1): loaded http://localhost:60988/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60988/tests/kraken/driver.html?testName=audio-oscillator) 17:10:29 INFO - PROCESS | 4302 | RSS: Main: 193425408 17:10:29 INFO - PROCESS | 4302 | 17:10:31 INFO - PROCESS | 4302 | Cycle 1(1): loaded http://localhost:60988/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60988/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:10:31 INFO - PROCESS | 4302 | RSS: Main: 193613824 17:10:31 INFO - PROCESS | 4302 | 17:10:35 INFO - PROCESS | 4302 | Cycle 1(1): loaded http://localhost:60988/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60988/tests/kraken/driver.html?testName=imaging-darkroom) 17:10:35 INFO - PROCESS | 4302 | RSS: Main: 193888256 17:10:35 INFO - PROCESS | 4302 | 17:10:39 INFO - PROCESS | 4302 | Cycle 1(1): loaded http://localhost:60988/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60988/tests/kraken/driver.html?testName=imaging-desaturate) 17:10:39 INFO - PROCESS | 4302 | RSS: Main: 191930368 17:10:39 INFO - PROCESS | 4302 | 17:10:42 INFO - PROCESS | 4302 | Cycle 1(1): loaded http://localhost:60988/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60988/tests/kraken/driver.html?testName=json-parse-financial) 17:10:43 INFO - PROCESS | 4302 | RSS: Main: 193781760 17:10:43 INFO - PROCESS | 4302 | 17:10:44 INFO - PROCESS | 4302 | Cycle 1(1): loaded http://localhost:60988/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60988/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:10:45 INFO - PROCESS | 4302 | RSS: Main: 193835008 17:10:45 INFO - PROCESS | 4302 | 17:10:47 INFO - PROCESS | 4302 | Cycle 1(1): loaded http://localhost:60988/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60988/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:10:47 INFO - PROCESS | 4302 | RSS: Main: 193769472 17:10:47 INFO - PROCESS | 4302 | 17:10:49 INFO - PROCESS | 4302 | Cycle 1(1): loaded http://localhost:60988/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60988/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:10:50 INFO - PROCESS | 4302 | RSS: Main: 193949696 17:10:50 INFO - PROCESS | 4302 | 17:10:53 INFO - PROCESS | 4302 | Cycle 1(1): loaded http://localhost:60988/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60988/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:10:54 INFO - PROCESS | 4302 | RSS: Main: 194170880 17:10:54 INFO - PROCESS | 4302 | 17:10:56 INFO - PROCESS | 4302 | Cycle 1(1): loaded http://localhost:60988/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60988/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:10:57 INFO - PROCESS | 4302 | RSS: Main: 194379776 17:10:57 INFO - PROCESS | 4302 | 17:10:59 INFO - PROCESS | 4302 | Cycle 1(1): loaded http://localhost:60988/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60988/tests/kraken/driver.html?testName=ai-astar) 17:10:59 INFO - PROCESS | 4302 | RSS: Main: 195547136 17:10:59 INFO - PROCESS | 4302 | 17:10:59 INFO - PROCESS | 4302 | __start_tp_report 17:10:59 INFO - PROCESS | 4302 | _x_x_mozilla_page_load 17:10:59 INFO - PROCESS | 4302 | _x_x_mozilla_page_load_details 17:10:59 INFO - PROCESS | 4302 | |i|pagename|runs| 17:10:59 INFO - PROCESS | 4302 | |0;ai-astar;106;110;111;111;111;111;112;110;112;113 17:10:59 INFO - PROCESS | 4302 | |1;audio-beat-detection;159;131;131;176;127;126;127;135;153;131 17:10:59 INFO - PROCESS | 4302 | |2;audio-dft;161;166;163;166;169;163;163;163;164;163 17:10:59 INFO - PROCESS | 4302 | |3;audio-fft;76;76;76;106;75;75;76;74;120;76 17:10:59 INFO - PROCESS | 4302 | |4;audio-oscillator;84;83;108;84;83;82;97;82;82;104 17:10:59 INFO - PROCESS | 4302 | |5;imaging-gaussian-blur;117;119;119;118;118;118;118;118;117;118 17:10:59 INFO - PROCESS | 4302 | |6;imaging-darkroom;147;147;150;147;149;148;146;146;146;146 17:10:59 INFO - PROCESS | 4302 | |7;imaging-desaturate;97;96;99;95;97;96;96;97;95;96 17:10:59 INFO - PROCESS | 4302 | |8;json-parse-financial;57;52;53;54;54;57;67;57;58;55 17:10:59 INFO - PROCESS | 4302 | |9;json-stringify-tinderbox;61;62;61;63;63;61;61;62;62;65 17:10:59 INFO - PROCESS | 4302 | |10;stanford-crypto-aes;89;80;81;81;81;81;85;93;80;80 17:10:59 INFO - PROCESS | 4302 | |11;stanford-crypto-ccm;138;138;136;134;132;140;140;145;169;143 17:10:59 INFO - PROCESS | 4302 | |12;stanford-crypto-pbkdf2;172;177;171;169;172;171;167;170;175;173 17:10:59 INFO - PROCESS | 4302 | |13;stanford-crypto-sha256-iterative;66;68;71;67;66;68;68;65;67;66 17:10:59 INFO - PROCESS | 4302 | __end_tp_report 17:10:59 INFO - PROCESS | 4302 | __start_cc_report 17:10:59 INFO - PROCESS | 4302 | _x_x_mozilla_cycle_collect,777 17:10:59 INFO - PROCESS | 4302 | __end_cc_report 17:10:59 INFO - PROCESS | 4302 | __startTimestamp1475626259465__endTimestamp 17:10:59 INFO - PROCESS | 4302 | 17:10:59 INFO - PROCESS | 4302 | ------- Summary: start ------- 17:10:59 INFO - PROCESS | 4302 | Number of tests: 14 17:10:59 INFO - PROCESS | 4302 | 17:10:59 INFO - PROCESS | 4302 | [#0] ai-astar Cycles:10 Average:110.70 Median:111.00 stddev:1.89 (1.7%) stddev-sans-first:0.97 17:10:59 INFO - PROCESS | 4302 | Values: 106.0 110.0 111.0 111.0 111.0 111.0 112.0 110.0 112.0 113.0 17:10:59 INFO - PROCESS | 4302 | 17:10:59 INFO - PROCESS | 4302 | [#1] audio-beat-detection Cycles:10 Average:139.60 Median:133.00 stddev:17.08 (12.8%) stddev-sans-first:16.61 17:10:59 INFO - PROCESS | 4302 | Values: 159.0 131.0 131.0 176.0 127.0 126.0 127.0 135.0 153.0 131.0 17:10:59 INFO - PROCESS | 4302 | 17:10:59 INFO - PROCESS | 4302 | [#2] audio-dft Cycles:10 Average:164.10 Median:163.50 stddev:2.28 (1.4%) stddev-sans-first:2.13 17:10:59 INFO - PROCESS | 4302 | Values: 161.0 166.0 163.0 166.0 169.0 163.0 163.0 163.0 164.0 163.0 17:10:59 INFO - PROCESS | 4302 | 17:10:59 INFO - PROCESS | 4302 | [#3] audio-fft Cycles:10 Average:83.00 Median:76.00 stddev:16.17 (21.3%) stddev-sans-first:16.95 17:10:59 INFO - PROCESS | 4302 | Values: 76.0 76.0 76.0 106.0 75.0 75.0 76.0 74.0 120.0 76.0 17:10:59 INFO - PROCESS | 4302 | 17:10:59 INFO - PROCESS | 4302 | [#4] audio-oscillator Cycles:10 Average:88.90 Median:83.00 stddev:10.10 (12.2%) stddev-sans-first:10.56 17:10:59 INFO - PROCESS | 4302 | Values: 84.0 83.0 108.0 84.0 83.0 82.0 97.0 82.0 82.0 104.0 17:10:59 INFO - PROCESS | 4302 | 17:10:59 INFO - PROCESS | 4302 | [#5] imaging-gaussian-blur Cycles:10 Average:118.00 Median:118.00 stddev:0.67 (0.6%) stddev-sans-first:0.60 17:10:59 INFO - PROCESS | 4302 | Values: 117.0 119.0 119.0 118.0 118.0 118.0 118.0 118.0 117.0 118.0 17:10:59 INFO - PROCESS | 4302 | 17:10:59 INFO - PROCESS | 4302 | [#6] imaging-darkroom Cycles:10 Average:147.20 Median:147.00 stddev:1.40 (1.0%) stddev-sans-first:1.48 17:10:59 INFO - PROCESS | 4302 | Values: 147.0 147.0 150.0 147.0 149.0 148.0 146.0 146.0 146.0 146.0 17:10:59 INFO - PROCESS | 4302 | 17:10:59 INFO - PROCESS | 4302 | [#7] imaging-desaturate Cycles:10 Average:96.40 Median:96.50 stddev:1.17 (1.2%) stddev-sans-first:1.22 17:10:59 INFO - PROCESS | 4302 | Values: 97.0 96.0 99.0 95.0 97.0 96.0 96.0 97.0 95.0 96.0 17:10:59 INFO - PROCESS | 4302 | 17:10:59 INFO - PROCESS | 4302 | [#8] json-parse-financial Cycles:10 Average:56.40 Median:57.00 stddev:4.22 (7.4%) stddev-sans-first:4.47 17:10:59 INFO - PROCESS | 4302 | Values: 57.0 52.0 53.0 54.0 54.0 57.0 67.0 57.0 58.0 55.0 17:10:59 INFO - PROCESS | 4302 | 17:10:59 INFO - PROCESS | 4302 | [#9] json-stringify-tinderbox Cycles:10 Average:62.10 Median:62.00 stddev:1.29 (2.1%) stddev-sans-first:1.30 17:10:59 INFO - PROCESS | 4302 | Values: 61.0 62.0 61.0 63.0 63.0 61.0 61.0 62.0 62.0 65.0 17:10:59 INFO - PROCESS | 4302 | 17:10:59 INFO - PROCESS | 4302 | [#10] stanford-crypto-aes Cycles:10 Average:83.10 Median:81.00 stddev:4.51 (5.6%) stddev-sans-first:4.25 17:10:59 INFO - PROCESS | 4302 | Values: 89.0 80.0 81.0 81.0 81.0 81.0 85.0 93.0 80.0 80.0 17:10:59 INFO - PROCESS | 4302 | 17:10:59 INFO - PROCESS | 4302 | [#11] stanford-crypto-ccm Cycles:10 Average:141.50 Median:140.00 stddev:10.42 (7.4%) stddev-sans-first:10.97 17:10:59 INFO - PROCESS | 4302 | Values: 138.0 138.0 136.0 134.0 132.0 140.0 140.0 145.0 169.0 143.0 17:10:59 INFO - PROCESS | 4302 | 17:10:59 INFO - PROCESS | 4302 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.70 Median:172.00 stddev:2.87 (1.7%) stddev-sans-first:3.04 17:10:59 INFO - PROCESS | 4302 | Values: 172.0 177.0 171.0 169.0 172.0 171.0 167.0 170.0 175.0 173.0 17:10:59 INFO - PROCESS | 4302 | 17:10:59 INFO - PROCESS | 4302 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.20 Median:67.50 stddev:1.69 (2.5%) stddev-sans-first:1.73 17:10:59 INFO - PROCESS | 4302 | Values: 66.0 68.0 71.0 67.0 66.0 68.0 68.0 65.0 67.0 66.0 17:10:59 INFO - PROCESS | 4302 | -------- Summary: end -------- 17:10:59 INFO - PROCESS | 4302 | 17:10:59 INFO - PROCESS | 4302 | 17:10:59 INFO - PROCESS | 4302 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 17:10:59 INFO - PROCESS | 4302 | 17:10:59 INFO - PROCESS | 4302 | 17:10:59 INFO - PROCESS | 4302 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 17:10:59 INFO - PROCESS | 4302 | 17:10:59 INFO - PROCESS | 4302 | 17:10:59 INFO - PROCESS | 4302 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 17:10:59 INFO - PROCESS | 4302 | 17:10:59 INFO - PROCESS | 4302 | 17:10:59 INFO - PROCESS | 4302 | ###!!! [Parent][MessageChannel] Error: (msgtype=0x2000B,name=PAPZ::Msg_Destroy) Channel error: cannot send/recv 17:10:59 INFO - PROCESS | 4302 | 17:10:59 INFO - PROCESS | 4302 | 17:10:59 INFO - PROCESS | 4302 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 17:10:59 INFO - PROCESS | 4302 | 17:11:00 INFO - TEST-INFO | 4302: exit 0 17:11:00 INFO - TEST-OK | kraken | took 62395ms 17:11:00 INFO - SUITE-END | took 1176s 17:11:00 INFO - Completed test suite (00:19:36) 17:11:00 INFO - javascript benchmark 17:11:00 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7088.338710829081, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3021.108772911991, 3035.6660767315607, 3060.4491191585507, 3077.1999280187147, 3095.2726109364294, 5130.974345128278, 5292.655977361469, 5320.733963301834, 5361.195820626908, 5398.2982212312445, 5225.86935326617, 5253.264542963979, 5293.841184764463, 5320.574354051676, 5389.326334208224, 4733.668643194977, 4797.088553174903, 4839.612830973514, 4850.5877000455, 4933.235348520967, 4843.0, 4859.368282123337, 4883.780229889663, 4889.926651100236, 4949.480304568023, 4652.511486293958, 4682.391289132425, 4793.472718001017, 4836.492168322346, 4842.055799119174, 4772.7136371817805, 4788.090262850047, 4792.808287668489, 4845.70925744453, 4934.605231581465, 4792.257200133985, 4798.136335459616, 4803.639727020487, 4830.4203495580405, 4882.951170488285, 5149.30484384607, 5191.558717508979, 5323.494268044529, 5363.436839131913, 5377.892442151135, 5576.052071147874, 5582.7766889324375, 5587.217789509472, 5600.0759874620635, 5626.324841019063, 5553.0, 5588.469095435927, 5605.663660180361, 5606.383297837235, 5616.382197958222, 5153.845384638467, 5187.35158105233, 5218.2955301034635, 5257.78968841242, 5313.760880760375, 5772.249607551075, 5773.8556536086935, 5785.132230165509, 5802.448767367094, 5833.649981001068, 5519.862003449946, 5532.1425179097305, 5539.418361072029, 5544.63959842617, 5544.861378465571, 5558.388577256498, 5600.131979543177, 5620.859478512988, 5625.718714064362, 5632.070708333161, 5625.38120806711, 5626.324841019104, 5634.774609015593, 5686.317641882918, 5711.45741154598, 5643.5203007743985, 5652.519535839418, 5658.971705141448, 5667.546596272288, 5673.574481913873, 4154.044569748975, 4177.8328866845595, 4230.725002874803, 4250.53244143144, 4266.466691663542, 3790.6209379062425, 3796.544414670202, 3828.8085595720104, 3854.4411060396087, 3864.7487913285545, 5278.234655974862, 5346.492083252085, 5398.541124004503, 5404.162354835007, 5420.214068959979, 5568.610197286151, 5655.858603534863, 5722.198892155018, 5726.541876649858, 5730.36965933747, 5335.866603334947, 5364.356277246756, 5374.516293533601, 5387.4073851876265, 5461.617686761968, 4902.656814022984, 4907.877303067452, 4912.69813499423, 4920.75396230187, 4971.726555039508, 5742.971285143548, 5887.823365298962, 5913.674747888821, 5926.288845338587, 5934.465898069195, 5595.524380427709, 5683.914741278967, 5722.570807189394, 5735.9388513125205, 5807.564432667482, 5936.762529498772, 5940.97029514867, 5949.077892926603, 5966.224390829165, 5973.074173503114, 5409.432009638931, 5446.237526746179, 5566.77732890696, 5640.407757185437, 5690.800821971211, 5668.149777533403, 5714.114312281603, 5714.828555143353, 5742.827715168552, 5767.971160144172, 5595.412481689364, 5609.467100625434, 5611.74747136388, 5615.326160860723, 5633.915491267716, 5408.188771684121, 5564.443555644403, 5590.0, 5591.888162236651, 5612.747426365905, 5413.269208656781, 5449.754761035683, 5486.286782718221, 5492.0, 5505.779768809363, 5606.018946684232, 5608.663480191201, 5622.0, 5624.85937851557, 5639.661620302795, 5474.069408200695, 5482.753276102505, 5483.643563168382, 5495.780168793363, 5514.5864060194845], "value": 5221.445728031754, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [536.3965538768884, 562.4937556199421, 567.0190570313358, 571.1119209629028, 579.7101449275362, 41703.74888753339, 43762.34356484652, 44309.33535996963, 47194.76402617982, 47266.99999999991, 44517.7774111129, 44603.33095003577, 44972.55027449725, 45106.0, 45257.54742452574, 8729.301655867515, 8780.209781119698, 8917.554122293892, 8950.283977281802, 8964.372493925395, 8770.473771573694, 8790.252828509552, 8837.160469755363, 8871.290296776242, 8883.067277935821, 8815.911840881605, 8865.955670221672, 8906.465612063264, 8915.509646969414, 8945.194932456077, 8849.955750221272, 8853.42452740573, 8876.112388761137, 8900.154485323885, 8919.73240802777, 8810.251128654072, 8855.380123391365, 8887.422317549403, 8892.021877593459, 8904.8664270036, 41295.38056929148, 41587.0, 41592.37611435831, 41650.58349416528, 41670.1665966682, 3377.105067157205, 3616.3129005489136, 3624.9275014499826, 3742.36379815432, 3856.132370216707, 30869.0, 31560.684393156003, 32167.51748723771, 32813.507797383056, 32949.17627059319, 4344.196323680129, 4349.934750978738, 4399.5160532341415, 4523.185826551252, 4679.415073115861, 331946.0, 334068.0, 334224.0, 334986.0, 335544.0, 52686.0, 57835.481387419364, 58041.709791450776, 58048.709756450946, 58109.0, 61022.694886525285, 61177.38822611806, 61281.38718612757, 61675.0, 61804.69097654483, 15727.292271847795, 15830.28763705636, 15849.128297943724, 15962.600934976486, 15983.760243596354, 11726.296422214695, 11773.234739741889, 11819.586314479124, 11837.88162118385, 11907.583234586747, 17223.827761722474, 17280.0, 17401.56260153678, 17521.29914803419, 17653.646927061385, 6015.608985415934, 6018.398160183947, 6085.421884920926, 6107.450329470369, 6223.190985171989, 902.6208992223281, 987.5309228116731, 1032.6334151376154, 1100.867895852503, 1116.3692513729716, 30867.69132308648, 30875.69124308728, 31684.0, 31859.68140318567, 31930.521042184388, 1013.690824298596, 1075.0432115417284, 1090.9781804363868, 1103.6578660615075, 1133.6542354581766, 15280.31238594266, 15426.0, 15521.611959701098, 15529.912906096464, 15709.21453927299, 548172.0, 549840.0, 551713.0, 556174.0, 558986.0, 54802.0, 55324.72337638286, 55375.44624553703, 55401.445985540435, 55551.16673249904, 1290.4128621477205, 1295.2099219476113, 1331.3676003898072, 1343.516334119716, 1345.3744009035845, 28722.281942951595, 29006.27484312909, 29131.41737165287, 29678.55482167726, 29878.0, 47498.76250618863, 47694.761526192146, 47761.28358074701, 47765.283520747915, 47988.520114798404, 434746.0, 437848.0, 438165.0, 438635.0, 439118.0, 26663.20010399691, 26841.463170736868, 27717.44565108727, 27801.860990694917, 27858.0, 44851.327230092225, 45551.31673024974, 45976.31035534403, 46575.30137048015, 46737.0, 37674.246515070095, 37819.81090094532, 38031.42952855654, 38675.61324386833, 39957.60042399655, 37856.43215351717, 38564.22871542497, 38645.420318694676, 39782.403263951644, 40777.796111019255, 39041.60958390493, 39220.80389598034, 39384.40923386094, 39436.2112757749, 40529.1894162121, 31887.84056079705, 33708.49437258394, 33756.0, 33933.3213335727, 34261.0, 27521.724782752717, 27624.58563121595, 27719.0, 27833.16500504988, 27921.301967450978], "value": 19531.298215721858, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [385.98070096495167, 386.239108955358, 398.9441478193053, 412.75028607692343, 422.1219862685612, 13910.234937078456, 14850.48023319184, 17722.73415898761, 19389.22443102276, 19416.514587135312, 15632.0, 18739.437816865517, 18830.34093806717, 19032.714509282338, 19052.61894762104, 5601.159826026088, 5626.212330273765, 5851.6196447231005, 5870.501007414375, 5885.911711324312, 5658.43415658435, 5785.074388097905, 5786.189933409326, 5791.913121303184, 5795.449432303924, 5556.16657501374, 5702.230198923155, 5767.509761670263, 5782.277215348082, 5803.477687008169, 5712.771489140429, 5752.338481074688, 5765.913511297334, 5770.19217309577, 5782.392848750884, 4933.260010998379, 5116.925445656417, 5124.461931497176, 5126.231065340229, 5131.692098474104, 22614.98232579538, 22652.886735566382, 22884.54230915389, 22928.31215063551, 22933.88533057341, 2405.855648661086, 2490.838095523803, 2494.451220731436, 2770.141256210581, 2795.454886297173, 14172.858271417257, 14502.637434064127, 14537.345819438151, 14540.563783086523, 14627.0, 1889.1970912362328, 1898.4020033689483, 1953.5897461533095, 2008.9698654520193, 2009.387136923238, 48060.51939480595, 48493.0, 77211.22788772153, 77719.61140194263, 78303.21696783073, 10687.572497100184, 10784.89215107839, 10853.51159197838, 10957.83563246552, 11263.098952083978, 15194.620134496505, 15235.542933712006, 15324.616884577752, 15380.15409152485, 15389.769153462707, 7637.083549974039, 7739.34215591681, 7951.204879512118, 8096.757097287091, 8244.628991695388, 7531.397488201041, 7586.203448637813, 7626.42801789868, 7754.263344982218, 7852.764417067498, 6424.967875160594, 6463.192100987377, 6483.768084064012, 6626.701798418986, 6654.061666026561, 1926.364299781069, 1951.6194342103154, 1964.3321270768008, 1970.5664753754152, 2036.7657719362462, 906.0712769411406, 924.916757491829, 952.514217748953, 989.4113002763344, 1006.0945149365483, 17946.64106717858, 18233.817661823214, 18921.337753178846, 18976.81023189778, 20508.0, 902.634433054614, 987.9703608891745, 1028.1723212813756, 1029.897010298964, 1068.7061058209056, 10282.228832837418, 10591.788164236672, 10629.149668026694, 10652.680419587425, 10785.245032847626, 405520.0, 406010.0, 407331.0, 407538.0, 431532.0, 87696.0, 92781.5360923191, 93165.5341723287, 96254.51872740731, 96277.0, 1046.6755305855056, 1066.823974044274, 1101.8347247912877, 1116.6984914073155, 1118.2675347647305, 15898.68202635964, 16129.274182662042, 16192.271347789143, 16848.241829117964, 17031.48905532836, 41913.58086419219, 42990.0, 43235.35146972861, 43456.34815477707, 44647.33029004503, 50141.0, 51169.48830511647, 54702.179467308815, 55307.44692553023, 55936.44063559312, 7379.704811807467, 7697.153313135663, 7799.298063174341, 8129.146439623754, 8169.754907352789, 10691.25161238737, 12261.754764904474, 12367.9381603095, 12656.114072015238, 13391.330433478091, 10217.74455638615, 10228.386296822215, 10614.257002009785, 11471.483783229607, 11474.082073434272, 11318.886811131782, 11537.365444900275, 11544.88455115438, 11681.474333654836, 11959.402029898645, 11377.0, 11684.0, 11915.285082895054, 11965.581204657796, 12079.154459188125, 8042.316403105801, 8085.878711819445, 8097.797555061171, 8112.310453611273, 8244.175582441709, 11180.385078820744, 11561.595344162914, 11633.0, 11879.168458208189, 11922.761544768882], "value": 9152.809350753145, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1426.3937826423771, 1451.1655797916198, 1591.6737068900877, 1725.6289897671998, 1761.427536050783, 7531.548107113564, 7793.688252469909, 8122.837543249138, 8741.868871966917, 8744.912550874496, 8064.677412903477, 8412.411131220802, 8414.495130292187, 8596.1403859614, 8643.524606146659, 2253.752087270399, 2257.2325409360815, 2274.4996100857866, 2277.8633282003134, 2279.452931296485, 2262.502249505106, 2276.0668126068317, 2329.1731435340466, 2331.0442718485424, 2338.3803292127513, 2292.1519037955895, 2299.2872209615075, 2300.1834348806183, 2322.094383190557, 2333.78643105585, 2192.375173075674, 2196.791304826039, 2207.9116835326568, 2212.8782916939563, 2221.133757834446, 2216.3240211735415, 2219.700340454034, 2221.611218036853, 2224.688543603897, 2229.4872179398667, 8597.656093756243, 8607.784805379853, 8615.526146061964, 8668.046514883357, 8670.609822558, 4904.926426103611, 5035.723035233061, 5058.924116138261, 5110.718910459923, 5128.820491282787, 3165.3511030238747, 3205.1346136543234, 3329.8335083245743, 3335.7831740936763, 3336.2993771308056, 1137.2153214282118, 1141.57191053355, 1144.1876267849836, 1167.7664467106529, 1176.6822957801346, 11708.53165873364, 11717.414129293502, 11761.647150585582, 11787.351695656735, 11836.585719499777, 4246.554111818276, 4268.765217912983, 4488.192125417456, 4492.505824359318, 4496.280595104768, 9906.55420506079, 9915.661385712981, 9966.950165249127, 9969.202463802878, 10051.69844904654, 5191.065608190562, 5206.97396513015, 5208.8437346879655, 5245.186996015547, 5245.921311180336, 3931.488906442144, 3935.5080614923136, 4641.651876109306, 4755.500672429414, 4794.544518270759, 3818.1481981239076, 3819.7899115548357, 3897.142628621699, 3938.389549619756, 3960.5643379228263, 1279.4882047181015, 1284.5760898903527, 1286.0676009892752, 1286.9099163058495, 1295.546558704446, 828.6809578312393, 873.668006157656, 916.5921165081475, 944.6410364061612, 954.4130359828655, 5372.462753724596, 5374.0, 5460.126379779216, 5615.101583746581, 5665.1502274658305, 384.6192269653079, 392.2194832283792, 416.0846138495322, 427.8010725012884, 428.2890401932777, 3667.2482141161, 3702.629737026276, 3711.7030637548933, 3760.4735337052834, 3834.2331533693373, 10214.131798797036, 10790.78418431627, 10945.781084378268, 10994.34033957965, 11104.111671066295, 10499.527521261562, 10967.122630189566, 10991.61529346485, 10997.61508347204, 11014.614488493025, 7860.528368297921, 7876.17300183484, 7926.286634202949, 7934.960325198337, 8000.479968801893, 5442.12925931849, 5485.862853428696, 5564.887022595416, 5604.103343465026, 5623.971880140737, 9268.675596354095, 9527.571259293487, 9573.377730447499, 9616.182624476998, 9644.083812037845, 9814.509274536387, 9819.36174148678, 9899.20806335477, 9929.702108936743, 10137.0, 6780.1524809398825, 6997.230304666381, 7028.859422811617, 7455.627218639155, 7539.698412063456, 7774.144844067261, 8137.145599711945, 8165.1018387978465, 8170.632321545663, 8177.182281771775, 7023.33278338557, 7204.603746793977, 7230.45771567124, 7231.927680723125, 7315.122185337794, 6814.284500127415, 6983.930160698531, 6987.406070484066, 7059.71761129549, 7117.786466406016, 6297.937020629918, 6545.5090868184125, 6588.0, 6608.8347791305605, 6618.338166183343, 4260.360945858022, 4603.470600880942, 4692.53074692528, 4696.037312350892, 4789.640776941674, 4844.854654360375, 4899.926501102557, 4928.334674818853, 4993.126202914548, 5067.923981140212], "value": 4357.458431574982, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [321.32682031144753, 321.96136463624384, 329.43337459569534, 333.8681220917737, 334.807485695725, 5276.314079169702, 5384.488473595002, 5493.478119578639, 5551.806361632248, 5603.2435621191125, 5228.2680424740565, 5334.759935802888, 5337.653052551591, 5391.73041347932, 5413.53984911283, 4230.302000169976, 4234.386014027964, 4258.212230737308, 4260.233158031553, 4292.849750258742, 4215.494140703105, 4246.7896649454915, 4297.290946993742, 4303.591158839905, 4311.525732169474, 4232.640225580829, 4235.639970602487, 4239.872803815891, 4241.406203131564, 4254.893627659318, 4229.767362795045, 4258.084511829956, 4266.679999000087, 4270.551592082848, 4297.699161058727, 3710.035390798385, 3809.0, 3812.5996770338993, 3814.19901820618, 3821.923561528754, 5258.763355648966, 5284.392294886099, 5308.150695888639, 5316.680999140025, 5318.0, 4823.421189457253, 4830.637702172316, 4833.299171620095, 4834.202356611155, 4840.903181936342, 5540.113581826929, 5642.407547207526, 5663.688497132656, 5690.459406356389, 5693.259876216065, 4048.39274108886, 4071.470708807836, 4076.2051399977017, 4078.2659121358142, 4094.078832262747, 5872.882542349129, 5905.793297234576, 5910.556708246856, 5952.434518720715, 5963.403659634046, 3848.7690738555775, 4212.578742125825, 4223.809928553223, 4230.111676547959, 4231.20740311393, 4112.938305925353, 4116.444280022159, 4121.464209652726, 4127.6904232182105, 4132.752034877917, 4711.717296962193, 4723.7401942893475, 4742.644301677388, 4744.525547445228, 4768.546988036131, 5531.612787104864, 5751.971240143773, 5777.942220577825, 5784.421557844266, 5791.333996590446, 1405.7539930512119, 1439.5537383411177, 1439.985600143985, 1445.3929349673163, 1449.8260208775014, 883.5626364949392, 900.5362238447204, 918.7657147427497, 929.7722058095675, 936.1761649748178, 4760.547747963938, 4782.832600858953, 4789.640776941674, 4811.78346974387, 4815.470298267188, 5078.873028174326, 5117.309163262987, 5120.667156634807, 5131.281620573122, 5199.610029247821, 4830.975845120822, 4852.8786780330065, 4883.389576302962, 4900.901981960341, 5171.818986335536, 3046.826971615944, 3114.1903105192814, 3115.750739940799, 3117.703818137273, 3128.0, 6053.939460605426, 6076.756929722762, 6080.14877917092, 6145.631262124287, 6159.583295841981, 5700.857478562986, 5975.671338076448, 5991.850203744942, 6018.465291350765, 6020.839059493714, 6091.593820440901, 6119.724612392453, 6126.785562505291, 6128.540359473057, 6148.923938310778, 5585.218069470358, 5901.5213610284645, 5902.911456328245, 5924.259467566554, 6003.309619393651, 5857.47282744555, 5880.8235752927485, 5883.352831188651, 5905.911411328748, 5914.4381283777975, 5975.25309336333, 6002.669853158118, 6118.60229085108, 6137.619035716928, 6155.353687862889, 4053.290674132074, 4219.852305169305, 4220.472440944882, 4231.23837709203, 4239.901248881823, 5873.353931067664, 5877.4122587742595, 5892.823215303548, 5934.910976335272, 5940.138679891478, 5605.859853503695, 5638.436156384329, 5692.715364231854, 5723.0, 5811.360750317546, 5614.915776263278, 5623.718814059363, 5628.889166562539, 5654.943450565606, 5658.801941932013, 5581.972090139523, 5598.384177740527, 5602.355729091044, 5622.409646987171, 5658.5473162147755, 5461.590380721541, 5711.743416448375, 5737.483626473638, 5756.30924289088, 5756.453136951983, 5550.084236100998, 5562.721863906708, 5573.21974923503, 5597.272354593877, 5633.605647604629], "value": 4298.744125506624, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [703.458337080448, 711.6939715922151, 774.5894675821817, 820.5363969357309, 824.2581676491159, 15798.60503487412, 16472.258748356322, 16562.089085100313, 16618.25217865196, 16735.163241837905, 14860.182689952047, 14887.18120503372, 14902.552923412288, 14950.476733314335, 14965.102093874348, 780.1418439716309, 793.436659971421, 795.4829360915394, 797.9122296547375, 802.8314054048657, 780.6331024418514, 790.8734602463607, 795.5266616363255, 797.4298376660687, 798.2456578533288, 829.0424559633602, 836.6026137584629, 837.0959363887018, 838.2916435611899, 842.3808500751942, 825.4634487583058, 827.4952279109739, 830.8255266394034, 830.9584520773938, 831.767105210542, 612.696715126011, 613.7422282641302, 613.9447449729546, 615.5629503052838, 618.0451202891498, 13909.234992075431, 13958.58124256274, 13981.231032293219, 14016.159030458102, 14019.0, 11913.880861191365, 12639.0, 12772.042096842773, 12908.677283067904, 12934.870651293555, 11051.17116216279, 11101.611443599435, 11173.050290725298, 11261.493232804543, 11447.885521144764, 3709.703223742094, 3794.354959656865, 3827.9808600957094, 3898.8440462381473, 3954.130091379892, 75362.0, 81983.59008204921, 82237.58881205616, 82528.0, 82561.58719206425, 9290.291645230614, 9361.761233418918, 9502.477363744922, 9607.90392096084, 9727.0, 20002.89998550027, 20081.196752129752, 20256.79743202549, 20305.898470507553, 20385.490362740755, 8231.888695026215, 8271.95864020676, 8335.041470230879, 8635.784105397415, 8759.2992560595, 4190.769507677046, 4447.3329000650165, 4452.0873220989615, 4484.798184081724, 4555.385023021916, 3546.8935931922083, 3656.6160553142067, 3677.9264414711556, 3709.536307961505, 3709.962900370962, 576.6223123853882, 586.6919867069822, 596.9970150149221, 602.9698515074228, 603.9396060393925, 599.2629066248452, 674.3762020131359, 702.2977022977022, 703.033329172388, 706.787963610925, 8847.955760221286, 8995.820083598423, 9068.093190681011, 9243.676471323606, 9627.759306017266, 665.6971078159426, 667.4460198035716, 687.594319351585, 688.5490004047357, 690.0546251635292, 3572.7677700949357, 4385.386045953569, 4427.822887084545, 4446.466424029137, 4558.9772051139535, 124795.0, 125477.37261313635, 126261.0, 127397.36301318434, 131941.0, 82881.0, 85967.0, 103412.0, 107816.0, 110759.0, 86026.56986715151, 86181.0, 86222.0, 87187.56406217928, 87788.56105719558, 8598.957005214934, 8600.09698981598, 8740.562971851255, 8775.736727897918, 8837.469751814911, 48500.272495911886, 49630.4423719521, 49980.500194997585, 50117.0, 50710.23934641057, 44042.898927525785, 44429.77785111183, 44869.0, 69755.6512217456, 74446.88329674951, 11360.54557817678, 11408.486618102039, 11531.711707207387, 11625.418729063682, 11748.0, 12616.87383126157, 12772.978161747224, 13101.73796524045, 13203.735925281633, 13225.0, 12111.939440302742, 12309.75380492403, 12615.180013299107, 13308.93345533266, 13479.19124852512, 12760.170588911691, 13182.60452186436, 13223.603291901258, 14385.712285754016, 14403.711925761636, 12842.229466232056, 13054.804177937149, 13309.866901330863, 14022.158670479805, 14260.42958281657, 10333.225008124271, 10611.41637209961, 11429.59996400122, 11554.48004839801, 11673.591424300108, 9658.420494770337, 10759.515821787882, 10906.454677265947, 10929.344239345664, 11186.496607652838], "value": 7253.870975706981, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1529.8999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 110.0, 111.0, 111.0, 111.0, 111.0, 112.0, 110.0, 112.0, 113.0], "value": 110.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 131.0, 131.0, 176.0, 127.0, 126.0, 127.0, 135.0, 153.0, 131.0], "value": 139.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 166.0, 163.0, 166.0, 169.0, 163.0, 163.0, 163.0, 164.0, 163.0], "value": 164.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 76.0, 106.0, 75.0, 75.0, 76.0, 74.0, 120.0, 76.0], "value": 83.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 108.0, 84.0, 83.0, 82.0, 97.0, 82.0, 82.0, 104.0], "value": 88.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 119.0, 119.0, 118.0, 118.0, 118.0, 118.0, 118.0, 117.0, 118.0], "value": 118.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 150.0, 147.0, 149.0, 148.0, 146.0, 146.0, 146.0, 146.0], "value": 147.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 96.0, 99.0, 95.0, 97.0, 96.0, 96.0, 97.0, 95.0, 96.0], "value": 96.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 52.0, 53.0, 54.0, 54.0, 57.0, 67.0, 57.0, 58.0, 55.0], "value": 56.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 61.0, 63.0, 63.0, 61.0, 61.0, 62.0, 62.0, 65.0], "value": 62.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 80.0, 81.0, 81.0, 81.0, 81.0, 85.0, 93.0, 80.0, 80.0], "value": 83.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 138.0, 136.0, 134.0, 132.0, 140.0, 140.0, 145.0, 169.0, 143.0], "value": 141.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 177.0, 171.0, 169.0, 172.0, 171.0, 167.0, 170.0, 175.0, 173.0], "value": 171.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 68.0, 71.0, 67.0, 66.0, 68.0, 68.0, 65.0, 67.0, 66.0], "value": 67.2, "unit": "score"}]}]} 17:11:00 INFO - Return code: 0 17:11:00 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:11:00 ERROR - # TBPL SUCCESS # 17:11:00 INFO - Running post-action listener: _resource_record_post_action 17:11:00 INFO - [mozharness: 2016-10-05 00:11:00.773929Z] Finished run-tests step (success) 17:11:00 INFO - Running post-run listener: _resource_record_post_run 17:11:00 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 4096; Write bytes: 399556608; Read time: 12; Write time: 313512 17:11:00 INFO - TinderboxPrint: CPU usage
13.3% 17:11:00 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 17:11:00 INFO - TinderboxPrint: I/O write bytes / time
399,556,608 / 313,512 17:11:00 INFO - TinderboxPrint: CPU idle
8,250.0 (86.6%) 17:11:00 INFO - TinderboxPrint: CPU user
1,210.9 (12.7%) 17:11:00 INFO - TinderboxPrint: Swap in / out
0 / 0 17:11:00 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 111165440; Read time: 0; Write time: 95788 17:11:00 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 0; Write bytes: 288391168; Read time: 0; Write time: 217724 17:11:01 INFO - Running post-run listener: _upload_blobber_files 17:11:01 INFO - Blob upload gear active. 17:11:01 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:11:01 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 17:11:01 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'] 17:11:01 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 17:11:01 INFO - (blobuploader) - INFO - Open directory for files ... 17:11:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:11:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:11:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:11:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:11:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:11:02 INFO - (blobuploader) - INFO - Done attempting. 17:11:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:11:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:11:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:11:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:11:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:11:03 INFO - (blobuploader) - INFO - Done attempting. 17:11:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:11:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:11:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:11:06 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:11:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:11:06 INFO - (blobuploader) - INFO - Done attempting. 17:11:06 INFO - (blobuploader) - INFO - Iteration through files over. 17:11:06 INFO - Return code: 0 17:11:06 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:11:06 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:11:06 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/f1e06d2ebe6f7b4499bb6cb91e2f813315e5df6fb1f2eab80ba166a84eabe3c18d61656d28997dc8633f4c4c9d9c28181112b74567746903d17fe26105e33cfd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/464225e83bb65b92c624cdab9e2341ba92539076309ed25e03f7c989c754a8a2230cfc933b553b8f13bf9f5ddf0017de4f14f0b84505e8b8ce9886af10224fd1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/c076d55aa29db8d0a3563e8db30d8010f7251c43d88b4a489f8d49395e3129400ab9bdfcebf76770de8b1c0e02d1d787fe4e0e34129dea20a29981fd12ca1ff4"} 17:11:06 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:11:06 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:11:06 INFO - Contents: 17:11:06 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/f1e06d2ebe6f7b4499bb6cb91e2f813315e5df6fb1f2eab80ba166a84eabe3c18d61656d28997dc8633f4c4c9d9c28181112b74567746903d17fe26105e33cfd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/464225e83bb65b92c624cdab9e2341ba92539076309ed25e03f7c989c754a8a2230cfc933b553b8f13bf9f5ddf0017de4f14f0b84505e8b8ce9886af10224fd1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/c076d55aa29db8d0a3563e8db30d8010f7251c43d88b4a489f8d49395e3129400ab9bdfcebf76770de8b1c0e02d1d787fe4e0e34129dea20a29981fd12ca1ff4"} 17:11:06 INFO - Running post-run listener: copy_logs_to_upload_dir 17:11:06 INFO - Copying logs to upload dir... 17:11:06 INFO - mkdir: /builds/slave/test/build/upload/logs 17:11:06 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.843342 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-10-04 17:11:06.437613) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-04 17:11:06.442374) ========= 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=0333a256a5e4f052382dd180000001b1-1475625028.102668-1754744362 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/f1e06d2ebe6f7b4499bb6cb91e2f813315e5df6fb1f2eab80ba166a84eabe3c18d61656d28997dc8633f4c4c9d9c28181112b74567746903d17fe26105e33cfd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/464225e83bb65b92c624cdab9e2341ba92539076309ed25e03f7c989c754a8a2230cfc933b553b8f13bf9f5ddf0017de4f14f0b84505e8b8ce9886af10224fd1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/c076d55aa29db8d0a3563e8db30d8010f7251c43d88b4a489f8d49395e3129400ab9bdfcebf76770de8b1c0e02d1d787fe4e0e34129dea20a29981fd12ca1ff4"} build_url:https://queue.taskcluster.net/v1/task/WddpZyHqTAqIG43rQlMd6Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011340 build_url: 'https://queue.taskcluster.net/v1/task/WddpZyHqTAqIG43rQlMd6Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/f1e06d2ebe6f7b4499bb6cb91e2f813315e5df6fb1f2eab80ba166a84eabe3c18d61656d28997dc8633f4c4c9d9c28181112b74567746903d17fe26105e33cfd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/464225e83bb65b92c624cdab9e2341ba92539076309ed25e03f7c989c754a8a2230cfc933b553b8f13bf9f5ddf0017de4f14f0b84505e8b8ce9886af10224fd1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/c076d55aa29db8d0a3563e8db30d8010f7251c43d88b4a489f8d49395e3129400ab9bdfcebf76770de8b1c0e02d1d787fe4e0e34129dea20a29981fd12ca1ff4"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-04 17:11:06.471764) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 17:11:06.472132) ========= 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=0333a256a5e4f052382dd180000001b1-1475625028.102668-1754744362 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004476 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 17:11:06.554651) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-04 17:11:06.555004) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-04 17:11:06.555305) ========= ========= Total master_lag: 0.18 =========