builder: graphics_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-058 starttime: 1480558804.03 results: success (0) buildid: 20161130160344 builduid: 4bfa983a756443d2adf9ffb1753f2c54 revision: 69bd424d84eef49f8bc87f0dcf402f4b6e7d5fba ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-30 18:20:04.029695) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-30 18:20:04.030144) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-30 18:20:04.030414) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-30 18:20:04.086478) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-30 18:20:04.087138) ========= 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=0e2a256762fed810e2f0f810000001b3-1480557492.143370-1954135831 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-30 18:20:04-- 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: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.1M=0s 2016-11-30 18:20:04 (46.1 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.089186 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-30 18:20:04.193189) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-30 18:20:04.193618) ========= 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=0e2a256762fed810e2f0f810000001b3-1480557492.143370-1954135831 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018053 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-30 18:20:04.248145) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-30 18:20:04.248562) ========= bash -c 'python archiver_client.py mozharness --repo projects/graphics --rev 69bd424d84eef49f8bc87f0dcf402f4b6e7d5fba --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo projects/graphics --rev 69bd424d84eef49f8bc87f0dcf402f4b6e7d5fba --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=0e2a256762fed810e2f0f810000001b3-1480557492.143370-1954135831 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-30 18:20:04,388 truncating revision to first 12 chars 2016-11-30 18:20:04,388 Setting DEBUG logging. 2016-11-30 18:20:04,388 attempt 1/10 2016-11-30 18:20:04,388 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/graphics/69bd424d84ee?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-30 18:20:04,910 unpacking tar archive at: graphics-69bd424d84ee/testing/mozharness/ program finished with exit code 0 elapsedTime=0.825435 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-30 18:20:05.089201) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-30 18:20:05.089530) ========= script_repo_revision: 69bd424d84eef49f8bc87f0dcf402f4b6e7d5fba ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-30 18:20:05.089954) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-30 18:20:05.090225) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-30 18:20:05.098464) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-11-30 18:20:05.098862) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Graphics --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Graphics 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', 'Graphics', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Graphics'] 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=0e2a256762fed810e2f0f810000001b3-1480557492.143370-1954135831 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:20:05 INFO - MultiFileLogger online at 20161130 18:20:05 in /builds/slave/test 18:20:05 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Graphics --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Graphics 18:20:05 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:20:05 INFO - {'append_to_log': False, 18:20:05 INFO - 'base_work_dir': '/builds/slave/test', 18:20:05 INFO - 'blob_upload_branch': 'Graphics', 18:20:05 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:20:05 INFO - 'branch': 'Graphics', 18:20:05 INFO - 'buildbot_json_path': 'buildprops.json', 18:20:05 INFO - 'config_files': ('talos/linux_config.py',), 18:20:05 INFO - 'default_actions': ('clobber', 18:20:05 INFO - 'read-buildbot-config', 18:20:05 INFO - 'download-and-extract', 18:20:05 INFO - 'populate-webroot', 18:20:05 INFO - 'create-virtualenv', 18:20:05 INFO - 'install', 18:20:05 INFO - 'run-tests'), 18:20:05 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:20:05 INFO - 'download_minidump_stackwalk': True, 18:20:05 INFO - 'download_symbols': 'ondemand', 18:20:05 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:20:05 INFO - 'tooltool.py': '/tools/tooltool.py', 18:20:05 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:20:05 INFO - '/tools/misc-python/virtualenv.py')}, 18:20:05 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:20:05 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:20:05 INFO - 'installer_path': 'installer.exe', 18:20:05 INFO - 'log_level': 'info', 18:20:05 INFO - 'log_name': 'talos', 18:20:05 INFO - 'log_to_console': True, 18:20:05 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:20:05 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:20:05 INFO - 'opt_config_files': (), 18:20:05 INFO - 'pip_index': False, 18:20:05 INFO - 'sps_profile': False, 18:20:05 INFO - 'sps_profile_interval': 0, 18:20:05 INFO - 'suite': 'dromaeojs-e10s', 18:20:05 INFO - 'system_bits': '32', 18:20:05 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:20:05 INFO - 'title': 'talos-linux64-ix-058', 18:20:05 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:20:05 INFO - 'use_talos_json': True, 18:20:05 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:20:05 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:20:05 INFO - 'work_dir': 'build'} 18:20:05 INFO - [mozharness: 2016-12-01 02:20:05.331833Z] Running clobber step. 18:20:05 INFO - Running pre-action listener: _resource_record_pre_action 18:20:05 INFO - Running main action method: clobber 18:20:05 INFO - rmtree: /builds/slave/test/build 18:20:05 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:20:06 INFO - Running post-action listener: _resource_record_post_action 18:20:06 INFO - [mozharness: 2016-12-01 02:20:06.304376Z] Finished clobber step (success) 18:20:06 INFO - [mozharness: 2016-12-01 02:20:06.304474Z] Running read-buildbot-config step. 18:20:06 INFO - Running pre-action listener: _resource_record_pre_action 18:20:06 INFO - Running main action method: read_buildbot_config 18:20:06 INFO - Using buildbot properties: 18:20:06 INFO - { 18:20:06 INFO - "project": "", 18:20:06 INFO - "product": "firefox", 18:20:06 INFO - "script_repo_revision": "default", 18:20:06 INFO - "builddir": "graphics_ubuntu64_hw_test-dromaeojs-e10s", 18:20:06 INFO - "repository": "", 18:20:06 INFO - "buildername": "Ubuntu HW 12.04 x64 graphics talos dromaeojs-e10s", 18:20:06 INFO - "buildid": "20161130160344", 18:20:06 INFO - "pgo_build": "False", 18:20:06 INFO - "basedir": "/builds/slave/test", 18:20:06 INFO - "buildnumber": 22, 18:20:06 INFO - "slavename": "talos-linux64-ix-058", 18:20:06 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 18:20:06 INFO - "platform": "ubuntu64_hw", 18:20:06 INFO - "scheduler": "tests-graphics-linux64-talos-8-3600", 18:20:06 INFO - "branch": "graphics", 18:20:06 INFO - "repo_path": "projects/graphics", 18:20:06 INFO - "revision": "69bd424d84eef49f8bc87f0dcf402f4b6e7d5fba", 18:20:06 INFO - "stage_platform": "linux64", 18:20:06 INFO - "builduid": "4bfa983a756443d2adf9ffb1753f2c54", 18:20:06 INFO - "slavebuilddir": "test" 18:20:06 INFO - } 18:20:06 INFO - Found installer url https://queue.taskcluster.net/v1/task/ULaXp8t_S42T1DoUQDxk8g/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2. 18:20:06 INFO - Running post-action listener: _resource_record_post_action 18:20:06 INFO - [mozharness: 2016-12-01 02:20:06.306915Z] Finished read-buildbot-config step (success) 18:20:06 INFO - [mozharness: 2016-12-01 02:20:06.307003Z] Running download-and-extract step. 18:20:06 INFO - Running pre-action listener: _resource_record_pre_action 18:20:06 INFO - Running main action method: download_and_extract 18:20:06 INFO - mkdir: /builds/slave/test/build/tests 18:20:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:20:06 INFO - trying https://queue.taskcluster.net/v1/task/ULaXp8t_S42T1DoUQDxk8g/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 18:20:06 INFO - Downloading https://queue.taskcluster.net/v1/task/ULaXp8t_S42T1DoUQDxk8g/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 18:20:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ULaXp8t_S42T1DoUQDxk8g/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 18:20:06 INFO - Downloaded 1361 bytes. 18:20:06 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 18:20:06 INFO - Using the following test package requirements: 18:20:06 INFO - {u'common': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 18:20:06 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 18:20:06 INFO - u'firefox-53.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 18:20:06 INFO - u'gtest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 18:20:06 INFO - u'firefox-53.0a1.en-US.linux-x86_64.gtest.tests.zip'], 18:20:06 INFO - u'jittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 18:20:06 INFO - u'jsshell-linux-x86_64.zip'], 18:20:06 INFO - u'mochitest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 18:20:06 INFO - u'firefox-53.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 18:20:06 INFO - u'mozbase': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 18:20:06 INFO - u'reftest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 18:20:06 INFO - u'firefox-53.0a1.en-US.linux-x86_64.reftest.tests.zip'], 18:20:06 INFO - u'talos': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 18:20:06 INFO - u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'], 18:20:06 INFO - u'web-platform': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 18:20:06 INFO - u'firefox-53.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 18:20:06 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 18:20:06 INFO - u'firefox-53.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 18:20:06 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 18:20:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ULaXp8t_S42T1DoUQDxk8g/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 18:20:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ULaXp8t_S42T1DoUQDxk8g/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 18:20:06 INFO - Fetch https://queue.taskcluster.net/v1/task/ULaXp8t_S42T1DoUQDxk8g/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 18:20:07 INFO - Http code: 200 18:20:07 INFO - via: 1.1 5c2ff4ca1e447265402af29264e83497.cloudfront.net (CloudFront) 18:20:07 INFO - x-amz-cf-id: IsNeku3PIBFz7LSDjG5XaMbNS4y9sS-XO_byEDmhp2gt6WC5kN31OA== 18:20:07 INFO - x-amz-version-id: JqMeBTpjf_yggegjbndmZKfsVNahZGn8 18:20:07 INFO - Expected file size: 20217576 18:20:07 INFO - Obtained file size: 20217576 18:20:11 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 18:20:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ULaXp8t_S42T1DoUQDxk8g/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 18:20:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ULaXp8t_S42T1DoUQDxk8g/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 18:20:11 INFO - Fetch https://queue.taskcluster.net/v1/task/ULaXp8t_S42T1DoUQDxk8g/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 18:20:12 INFO - Http code: 200 18:20:12 INFO - via: 1.1 a75342fa94ff4a9431476624fe74f02e.cloudfront.net (CloudFront) 18:20:12 INFO - x-amz-cf-id: OKIcA3gKVLcrinWt8vq9GUyjBvdijXOmO-0v1R8IFT71AHHZTXy_cA== 18:20:12 INFO - x-amz-version-id: JqMeBTpjf_yggegjbndmZKfsVNahZGn8 18:20:12 INFO - Expected file size: 20217576 18:20:12 INFO - Obtained file size: 20217576 18:20:16 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ULaXp8t_S42T1DoUQDxk8g/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip 18:20:16 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ULaXp8t_S42T1DoUQDxk8g/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 18:20:16 INFO - Fetch https://queue.taskcluster.net/v1/task/ULaXp8t_S42T1DoUQDxk8g/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip into memory 18:20:17 INFO - Http code: 200 18:20:17 INFO - via: 1.1 1b52a5dd431f9e3c81753e61dfdf467a.cloudfront.net (CloudFront) 18:20:17 INFO - x-amz-cf-id: IJ9cwNsJSa6Bi-7jjTtFmx6kHASxQzUQKYGKt26XNksZjOQqi1Widg== 18:20:17 INFO - x-amz-version-id: 1tCBTgQ.5r.cfLGX9bmiSQFzSgMQeKXU 18:20:17 INFO - Expected file size: 14409702 18:20:17 INFO - Obtained file size: 14409702 18:20:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:20:17 INFO - trying https://queue.taskcluster.net/v1/task/ULaXp8t_S42T1DoUQDxk8g/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 18:20:17 INFO - Downloading https://queue.taskcluster.net/v1/task/ULaXp8t_S42T1DoUQDxk8g/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 18:20:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ULaXp8t_S42T1DoUQDxk8g/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 18:20:18 INFO - Downloaded 55690397 bytes. 18:20:18 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ULaXp8t_S42T1DoUQDxk8g/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 18:20:18 INFO - mkdir: /builds/slave/test/properties 18:20:18 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:20:18 INFO - Writing to file /builds/slave/test/properties/build_url 18:20:18 INFO - Contents: 18:20:18 INFO - build_url:https://queue.taskcluster.net/v1/task/ULaXp8t_S42T1DoUQDxk8g/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 18:20:19 INFO - Running post-action listener: _resource_record_post_action 18:20:19 INFO - Running post-action listener: set_extra_try_arguments 18:20:19 INFO - [mozharness: 2016-12-01 02:20:19.572486Z] Finished download-and-extract step (success) 18:20:19 INFO - [mozharness: 2016-12-01 02:20:19.572711Z] Running populate-webroot step. 18:20:19 INFO - Running pre-action listener: _resource_record_pre_action 18:20:19 INFO - Running main action method: populate_webroot 18:20:19 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:20:19 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:20:19 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:20:19 INFO - '--tppagecycles', 18:20:19 INFO - '7'], 18:20:19 INFO - 'tests': ['tsvgm']}}, 18:20:19 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 18:20:19 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:20:19 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:20:19 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:20:19 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:20:19 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:20:19 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 18:20:19 INFO - 'talos_options': ['--disable-e10s'], 18:20:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:20:19 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 18:20:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:20:19 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 18:20:19 INFO - 'talos_options': ['--disable-e10s'], 18:20:19 INFO - 'tests': ['damp', 'tps']}, 18:20:19 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 18:20:19 INFO - 'tests': ['damp', 'tps']}, 18:20:19 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:20:19 INFO - 'tests': ['dromaeo_dom']}, 18:20:19 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:20:19 INFO - 'g4': {'talos_options': ['--disable-e10s'], 18:20:19 INFO - 'tests': ['basic_compositor_video']}, 18:20:19 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 18:20:19 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:20:19 INFO - 'tests': ['a11yr', 18:20:19 INFO - 'ts_paint', 18:20:19 INFO - 'tpaint', 18:20:19 INFO - 'sessionrestore', 18:20:19 INFO - 'sessionrestore_no_auto_restore', 18:20:19 INFO - 'tabpaint']}, 18:20:19 INFO - 'other-e10s': {'tests': ['a11yr', 18:20:19 INFO - 'ts_paint', 18:20:19 INFO - 'tpaint', 18:20:19 INFO - 'sessionrestore', 18:20:19 INFO - 'sessionrestore_no_auto_restore', 18:20:19 INFO - 'tabpaint']}, 18:20:19 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:20:19 INFO - 'ts_paint', 18:20:19 INFO - 'tpaint', 18:20:19 INFO - 'sessionrestore', 18:20:19 INFO - 'sessionrestore_no_auto_restore', 18:20:19 INFO - 'tabpaint']}, 18:20:19 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:20:19 INFO - 'ts_paint', 18:20:19 INFO - 'tpaint', 18:20:19 INFO - 'sessionrestore', 18:20:19 INFO - 'sessionrestore_no_auto_restore', 18:20:19 INFO - 'tabpaint']}, 18:20:19 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:20:19 INFO - 'tests': ['a11yr', 18:20:19 INFO - 'ts_paint', 18:20:19 INFO - 'tpaint', 18:20:19 INFO - 'sessionrestore', 18:20:19 INFO - 'sessionrestore_no_auto_restore', 18:20:19 INFO - 'tabpaint']}, 18:20:19 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:20:19 INFO - 'tests': ['a11yr', 18:20:19 INFO - 'ts_paint', 18:20:19 INFO - 'tpaint', 18:20:19 INFO - 'sessionrestore', 18:20:19 INFO - 'sessionrestore_no_auto_restore', 18:20:19 INFO - 'tabpaint']}, 18:20:19 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:20:19 INFO - 'tests': ['tsvgx', 18:20:19 INFO - 'tsvgr_opacity', 18:20:19 INFO - 'tart', 18:20:19 INFO - 'tscrollx', 18:20:19 INFO - 'cart', 18:20:19 INFO - 'tsvg_static']}, 18:20:19 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:20:19 INFO - 'tsvgr_opacity', 18:20:19 INFO - 'tart', 18:20:19 INFO - 'tscrollx', 18:20:19 INFO - 'cart', 18:20:19 INFO - 'tsvg_static']}, 18:20:19 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 18:20:19 INFO - 'talos_options': ['--disable-e10s'], 18:20:19 INFO - 'tests': ['tp5o']}, 18:20:19 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 18:20:19 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 18:20:19 INFO - 'talos_options': ['--disable-e10s', 18:20:19 INFO - '--xperf_path', 18:20:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:20:19 INFO - 'tests': ['tp5n']}, 18:20:19 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 18:20:19 INFO - 'talos_options': ['--xperf_path', 18:20:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:20:19 INFO - 'tests': ['tp5n']}}, 18:20:19 INFO - 'talos.zip': {'path': '', 18:20:19 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:20:19 INFO - Running post-action listener: _resource_record_post_action 18:20:19 INFO - [mozharness: 2016-12-01 02:20:19.591542Z] Finished populate-webroot step (success) 18:20:19 INFO - [mozharness: 2016-12-01 02:20:19.591630Z] Running create-virtualenv step. 18:20:19 INFO - Running pre-action listener: _resource_record_pre_action 18:20:19 INFO - Running main action method: create_virtualenv 18:20:19 INFO - Creating virtualenv /builds/slave/test/build/venv 18:20:19 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 18:20:19 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:20:19 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:20:19 INFO - Using real prefix '/usr' 18:20:19 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:20:20 INFO - Installing distribute.............................................................................................................................................................................................done. 18:20:22 INFO - Installing pip.................done. 18:20:22 INFO - Return code: 0 18:20:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 18:20:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 18:20:22 INFO - Reading from file tmpfile_stdout 18:20:22 INFO - Output received: 18:20:22 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) 18:20:22 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:20:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:20:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:20:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:20:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:20:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:20:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:20:22 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 0x7f168a829e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc08b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xda4130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe32fc0>, '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 0xe33ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe34350>, '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': '0e2a256762fed810e2f0f810000001b3-1480557492.143370-1954135831', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:20:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 18:20:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 18:20:22 INFO - Using env: {'DISPLAY': ':0', 18:20:22 INFO - 'HOME': '/home/cltbld', 18:20:22 INFO - 'LANG': 'en_US.UTF-8', 18:20:22 INFO - 'LANGUAGE': 'en_US:en', 18:20:22 INFO - 'LOGNAME': 'cltbld', 18:20:22 INFO - 'MAIL': '/var/mail/cltbld', 18:20:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:20:22 INFO - 'MOZ_NO_REMOTE': '1', 18:20:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:20:22 INFO - 'NO_EM_RESTART': '1', 18:20:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:20:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:20:22 INFO - 'PWD': '/builds/slave/test', 18:20:22 INFO - 'SHELL': '/bin/bash', 18:20:22 INFO - 'SHLVL': '1', 18:20:22 INFO - 'TERM': 'linux', 18:20:22 INFO - 'TMOUT': '86400', 18:20:22 INFO - 'USER': 'cltbld', 18:20:22 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1480557492.143370-1954135831', 18:20:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:20:22 INFO - '_': '/tools/buildbot/bin/python'} 18:20:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:20:22 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 18:20:22 INFO - Cleaning up... 18:20:22 INFO - Return code: 0 18:20:22 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:20:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:20:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:20:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:20:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:20:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:20:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:20:22 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 0x7f168a829e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc08b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xda4130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe32fc0>, '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 0xe33ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe34350>, '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': '0e2a256762fed810e2f0f810000001b3-1480557492.143370-1954135831', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:20:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 18:20:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 18:20:22 INFO - Using env: {'DISPLAY': ':0', 18:20:22 INFO - 'HOME': '/home/cltbld', 18:20:22 INFO - 'LANG': 'en_US.UTF-8', 18:20:22 INFO - 'LANGUAGE': 'en_US:en', 18:20:22 INFO - 'LOGNAME': 'cltbld', 18:20:22 INFO - 'MAIL': '/var/mail/cltbld', 18:20:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:20:22 INFO - 'MOZ_NO_REMOTE': '1', 18:20:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:20:22 INFO - 'NO_EM_RESTART': '1', 18:20:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:20:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:20:22 INFO - 'PWD': '/builds/slave/test', 18:20:22 INFO - 'SHELL': '/bin/bash', 18:20:22 INFO - 'SHLVL': '1', 18:20:22 INFO - 'TERM': 'linux', 18:20:22 INFO - 'TMOUT': '86400', 18:20:22 INFO - 'USER': 'cltbld', 18:20:22 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1480557492.143370-1954135831', 18:20:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:20:22 INFO - '_': '/tools/buildbot/bin/python'} 18:20:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:20:22 INFO - Downloading/unpacking psutil>=3.1.1 18:20:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:20:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:20:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:20:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:20:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:20:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:20:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:20:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:20:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:20:24 INFO - Installing collected packages: psutil 18:20:24 INFO - Running setup.py install for psutil 18:20:25 INFO - building 'psutil._psutil_linux' extension 18:20:25 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 18:20:25 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 18:20:25 INFO - building 'psutil._psutil_posix' extension 18:20:25 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 18:20:25 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 18:20:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:20:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:20:25 INFO - Successfully installed psutil 18:20:25 INFO - Cleaning up... 18:20:25 INFO - Return code: 0 18:20:25 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:20:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:20:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:20:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:20:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:20:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:20:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:20:25 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 0x7f168a829e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc08b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xda4130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe32fc0>, '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 0xe33ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe34350>, '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': '0e2a256762fed810e2f0f810000001b3-1480557492.143370-1954135831', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:20:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 18:20:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 18:20:25 INFO - Using env: {'DISPLAY': ':0', 18:20:25 INFO - 'HOME': '/home/cltbld', 18:20:25 INFO - 'LANG': 'en_US.UTF-8', 18:20:25 INFO - 'LANGUAGE': 'en_US:en', 18:20:25 INFO - 'LOGNAME': 'cltbld', 18:20:25 INFO - 'MAIL': '/var/mail/cltbld', 18:20:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:20:25 INFO - 'MOZ_NO_REMOTE': '1', 18:20:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:20:25 INFO - 'NO_EM_RESTART': '1', 18:20:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:20:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:20:25 INFO - 'PWD': '/builds/slave/test', 18:20:25 INFO - 'SHELL': '/bin/bash', 18:20:25 INFO - 'SHLVL': '1', 18:20:25 INFO - 'TERM': 'linux', 18:20:25 INFO - 'TMOUT': '86400', 18:20:25 INFO - 'USER': 'cltbld', 18:20:25 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1480557492.143370-1954135831', 18:20:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:20:25 INFO - '_': '/tools/buildbot/bin/python'} 18:20:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:20:25 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:20:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:20:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:20:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:20:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:20:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:20:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:20:27 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:20:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:20:27 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:20:27 INFO - Installing collected packages: mozsystemmonitor 18:20:27 INFO - Running setup.py install for mozsystemmonitor 18:20:27 INFO - Successfully installed mozsystemmonitor 18:20:27 INFO - Cleaning up... 18:20:27 INFO - Return code: 0 18:20:27 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:20:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:20:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:20:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:20:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:20:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:20:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:20:27 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 0x7f168a829e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc08b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xda4130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe32fc0>, '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 0xe33ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe34350>, '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': '0e2a256762fed810e2f0f810000001b3-1480557492.143370-1954135831', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:20:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 18:20:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 18:20:27 INFO - Using env: {'DISPLAY': ':0', 18:20:27 INFO - 'HOME': '/home/cltbld', 18:20:27 INFO - 'LANG': 'en_US.UTF-8', 18:20:27 INFO - 'LANGUAGE': 'en_US:en', 18:20:27 INFO - 'LOGNAME': 'cltbld', 18:20:27 INFO - 'MAIL': '/var/mail/cltbld', 18:20:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:20:27 INFO - 'MOZ_NO_REMOTE': '1', 18:20:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:20:27 INFO - 'NO_EM_RESTART': '1', 18:20:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:20:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:20:27 INFO - 'PWD': '/builds/slave/test', 18:20:27 INFO - 'SHELL': '/bin/bash', 18:20:27 INFO - 'SHLVL': '1', 18:20:27 INFO - 'TERM': 'linux', 18:20:27 INFO - 'TMOUT': '86400', 18:20:27 INFO - 'USER': 'cltbld', 18:20:27 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1480557492.143370-1954135831', 18:20:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:20:27 INFO - '_': '/tools/buildbot/bin/python'} 18:20:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:20:28 INFO - Downloading/unpacking jsonschema==2.5.1 18:20:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:20:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:20:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:20:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:20:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:20:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:20:30 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:20:30 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:20:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:20:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:20:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:20:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:20:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:20:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:20:30 INFO - Downloading functools32-3.2.3-2.tar.gz 18:20:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:20:30 INFO - warning: no files found matching '*.txt' 18:20:30 INFO - no previously-included directories found matching 'build' 18:20:30 INFO - no previously-included directories found matching 'dist' 18:20:30 INFO - no previously-included directories found matching '.git*' 18:20:30 INFO - Installing collected packages: jsonschema, functools32 18:20:30 INFO - Running setup.py install for functools32 18:20:30 INFO - warning: no files found matching '*.txt' 18:20:30 INFO - no previously-included directories found matching 'build' 18:20:30 INFO - no previously-included directories found matching 'dist' 18:20:30 INFO - no previously-included directories found matching '.git*' 18:20:30 INFO - Successfully installed jsonschema functools32 18:20:30 INFO - Cleaning up... 18:20:30 INFO - Return code: 0 18:20:30 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 18:20: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')]} 18:20:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:20:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:20: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')]} 18:20:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:20:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:20:30 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 0x7f168a829e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc08b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xda4130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe32fc0>, '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 0xe33ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe34350>, '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': '0e2a256762fed810e2f0f810000001b3-1480557492.143370-1954135831', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:20:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 18:20:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 18:20:30 INFO - Using env: {'DISPLAY': ':0', 18:20:30 INFO - 'HOME': '/home/cltbld', 18:20:30 INFO - 'LANG': 'en_US.UTF-8', 18:20:30 INFO - 'LANGUAGE': 'en_US:en', 18:20:30 INFO - 'LOGNAME': 'cltbld', 18:20:30 INFO - 'MAIL': '/var/mail/cltbld', 18:20:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:20:30 INFO - 'MOZ_NO_REMOTE': '1', 18:20:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:20:30 INFO - 'NO_EM_RESTART': '1', 18:20:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:20:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:20:30 INFO - 'PWD': '/builds/slave/test', 18:20:30 INFO - 'SHELL': '/bin/bash', 18:20:30 INFO - 'SHLVL': '1', 18:20:30 INFO - 'TERM': 'linux', 18:20:30 INFO - 'TMOUT': '86400', 18:20:30 INFO - 'USER': 'cltbld', 18:20:30 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1480557492.143370-1954135831', 18:20:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:20:30 INFO - '_': '/tools/buildbot/bin/python'} 18:20:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:20:30 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 18:20:30 INFO - Cleaning up... 18:20:30 INFO - Return code: 0 18:20:30 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:20: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')]} 18:20:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:20:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:20: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')]} 18:20:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:20:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:20:30 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 0x7f168a829e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc08b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xda4130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe32fc0>, '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 0xe33ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe34350>, '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': '0e2a256762fed810e2f0f810000001b3-1480557492.143370-1954135831', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:20:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 18:20:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 18:20:30 INFO - Using env: {'DISPLAY': ':0', 18:20:30 INFO - 'HOME': '/home/cltbld', 18:20:30 INFO - 'LANG': 'en_US.UTF-8', 18:20:30 INFO - 'LANGUAGE': 'en_US:en', 18:20:30 INFO - 'LOGNAME': 'cltbld', 18:20:30 INFO - 'MAIL': '/var/mail/cltbld', 18:20:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:20:30 INFO - 'MOZ_NO_REMOTE': '1', 18:20:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:20:30 INFO - 'NO_EM_RESTART': '1', 18:20:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:20:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:20:30 INFO - 'PWD': '/builds/slave/test', 18:20:30 INFO - 'SHELL': '/bin/bash', 18:20:30 INFO - 'SHLVL': '1', 18:20:30 INFO - 'TERM': 'linux', 18:20:30 INFO - 'TMOUT': '86400', 18:20:30 INFO - 'USER': 'cltbld', 18:20:30 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1480557492.143370-1954135831', 18:20:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:20:30 INFO - '_': '/tools/buildbot/bin/python'} 18:20:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:20:31 INFO - Downloading/unpacking blobuploader==1.2.4 18:20:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:20:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:20:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:20:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:20:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:20:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:20:33 INFO - Downloading blobuploader-1.2.4.tar.gz 18:20:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:20:33 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:20:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:20:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:20:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:20:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:20:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:20:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:20:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:20:33 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:20:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:20:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:20:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:20:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:20:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:20:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:20:33 INFO - Downloading docopt-0.6.1.tar.gz 18:20:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:20:33 INFO - Installing collected packages: blobuploader, requests, docopt 18:20:33 INFO - Running setup.py install for blobuploader 18:20:33 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:20:33 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:20:34 INFO - Running setup.py install for requests 18:20:34 INFO - Running setup.py install for docopt 18:20:34 INFO - Successfully installed blobuploader requests docopt 18:20:34 INFO - Cleaning up... 18:20:34 INFO - Return code: 0 18:20:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:20:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:20:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:20:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:20:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:20:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:20:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:20:34 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 0x7f168a829e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc08b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xda4130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe32fc0>, '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 0xe33ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe34350>, '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': '0e2a256762fed810e2f0f810000001b3-1480557492.143370-1954135831', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:20:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 18:20:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:20:34 INFO - Using env: {'DISPLAY': ':0', 18:20:34 INFO - 'HOME': '/home/cltbld', 18:20:34 INFO - 'LANG': 'en_US.UTF-8', 18:20:34 INFO - 'LANGUAGE': 'en_US:en', 18:20:34 INFO - 'LOGNAME': 'cltbld', 18:20:34 INFO - 'MAIL': '/var/mail/cltbld', 18:20:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:20:34 INFO - 'MOZ_NO_REMOTE': '1', 18:20:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:20:34 INFO - 'NO_EM_RESTART': '1', 18:20:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:20:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:20:34 INFO - 'PWD': '/builds/slave/test', 18:20:34 INFO - 'SHELL': '/bin/bash', 18:20:34 INFO - 'SHLVL': '1', 18:20:34 INFO - 'TERM': 'linux', 18:20:34 INFO - 'TMOUT': '86400', 18:20:34 INFO - 'USER': 'cltbld', 18:20:34 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1480557492.143370-1954135831', 18:20:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:20:34 INFO - '_': '/tools/buildbot/bin/python'} 18:20:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:20:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:20:34 INFO - Running setup.py (path:/tmp/pip-hX73OB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:20:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:20:34 INFO - Running setup.py (path:/tmp/pip-AXW9Xg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:20:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:20:34 INFO - Running setup.py (path:/tmp/pip-JKhCg9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:20:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:20:34 INFO - Running setup.py (path:/tmp/pip-zMGBfQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:20:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:20:35 INFO - Running setup.py (path:/tmp/pip-Mazn3F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:20:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:20:35 INFO - Running setup.py (path:/tmp/pip-2dogfL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:20:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:20:35 INFO - Running setup.py (path:/tmp/pip-EP8WeH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:20:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:20:35 INFO - Running setup.py (path:/tmp/pip-3OGHXi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:20:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:20:35 INFO - Running setup.py (path:/tmp/pip-KBqoiF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:20:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:20:35 INFO - Running setup.py (path:/tmp/pip-6lq5mO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:20:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:20:35 INFO - Running setup.py (path:/tmp/pip-rVQ1nm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:20:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:20:35 INFO - Running setup.py (path:/tmp/pip-KIuliK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:20:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:20:35 INFO - Running setup.py (path:/tmp/pip-8vR9Vr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:20:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:20:35 INFO - Running setup.py (path:/tmp/pip-hjliwI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:20:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:20:35 INFO - Running setup.py (path:/tmp/pip-hx_VsQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:20:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:20:35 INFO - Running setup.py (path:/tmp/pip-fVt28O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:20:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:20:35 INFO - Running setup.py (path:/tmp/pip-_A392s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:20:35 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:20:35 INFO - Running setup.py install for manifestparser 18:20:36 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:20:36 INFO - Running setup.py install for mozcrash 18:20:36 INFO - Running setup.py install for mozdebug 18:20:36 INFO - Running setup.py install for mozdevice 18:20:36 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:20:36 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:20:36 INFO - Running setup.py install for mozfile 18:20:36 INFO - Running setup.py install for mozhttpd 18:20:36 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:20:36 INFO - Running setup.py install for mozinfo 18:20:36 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:20:36 INFO - Running setup.py install for mozInstall 18:20:36 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:20:36 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:20:36 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:20:36 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:20:36 INFO - Running setup.py install for mozleak 18:20:36 INFO - Running setup.py install for mozlog 18:20:37 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:20:37 INFO - Running setup.py install for moznetwork 18:20:37 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:20:37 INFO - Running setup.py install for mozprocess 18:20:37 INFO - Running setup.py install for mozprofile 18:20:37 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:20:37 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:20:37 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:20:37 INFO - Running setup.py install for mozrunner 18:20:37 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:20:37 INFO - Running setup.py install for mozscreenshot 18:20:37 INFO - Running setup.py install for moztest 18:20:37 INFO - Running setup.py install for mozversion 18:20:37 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:20:37 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:20:37 INFO - Cleaning up... 18:20:37 INFO - Return code: 0 18:20:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:20:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:20:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:20:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:20:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:20:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:20:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:20:37 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 0x7f168a829e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc08b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xda4130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe32fc0>, '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 0xe33ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe34350>, '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': '0e2a256762fed810e2f0f810000001b3-1480557492.143370-1954135831', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:20:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 18:20:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:20:37 INFO - Using env: {'DISPLAY': ':0', 18:20:37 INFO - 'HOME': '/home/cltbld', 18:20:37 INFO - 'LANG': 'en_US.UTF-8', 18:20:37 INFO - 'LANGUAGE': 'en_US:en', 18:20:37 INFO - 'LOGNAME': 'cltbld', 18:20:37 INFO - 'MAIL': '/var/mail/cltbld', 18:20:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:20:37 INFO - 'MOZ_NO_REMOTE': '1', 18:20:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:20:37 INFO - 'NO_EM_RESTART': '1', 18:20:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:20:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:20:37 INFO - 'PWD': '/builds/slave/test', 18:20:37 INFO - 'SHELL': '/bin/bash', 18:20:37 INFO - 'SHLVL': '1', 18:20:37 INFO - 'TERM': 'linux', 18:20:37 INFO - 'TMOUT': '86400', 18:20:37 INFO - 'USER': 'cltbld', 18:20:37 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1480557492.143370-1954135831', 18:20:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:20:37 INFO - '_': '/tools/buildbot/bin/python'} 18:20:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:20:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:20:38 INFO - Running setup.py (path:/tmp/pip-PVIumv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:20:38 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 18:20:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:20:38 INFO - Running setup.py (path:/tmp/pip-iMNOCp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:20:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:20:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:20:38 INFO - Running setup.py (path:/tmp/pip-Hd2hRW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:20:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 18:20:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:20:38 INFO - Running setup.py (path:/tmp/pip-GT_zEt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:20:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:20:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:20:38 INFO - Running setup.py (path:/tmp/pip-qwBq9c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:20:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 18:20:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:20:38 INFO - Running setup.py (path:/tmp/pip-CpK4kh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:20:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 18:20:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:20:38 INFO - Running setup.py (path:/tmp/pip-D57cEm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:20:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 18:20:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:20:38 INFO - Running setup.py (path:/tmp/pip-zQ25I0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:20:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 18:20:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:20:38 INFO - Running setup.py (path:/tmp/pip-71W3b3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:20:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 18:20:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:20:38 INFO - Running setup.py (path:/tmp/pip-JRe2wi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:20:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:20:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:20:38 INFO - Running setup.py (path:/tmp/pip-2ktuYE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:20:38 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 18:20:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:20:38 INFO - Running setup.py (path:/tmp/pip-PlqwPi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:20:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 18:20:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:20:38 INFO - Running setup.py (path:/tmp/pip-xmaVOX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:20:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 18:20:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:20:39 INFO - Running setup.py (path:/tmp/pip-KnXqZd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:20:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 18:20:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:20:39 INFO - Running setup.py (path:/tmp/pip-QvOvD5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:20:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 18:20:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:20:39 INFO - Running setup.py (path:/tmp/pip-UJlnIY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:20:39 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 18:20:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:20:39 INFO - Running setup.py (path:/tmp/pip-QjGSIW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:20:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 18:20:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:20:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:20:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 18:20:39 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:20:39 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:20:39 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:20:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:20:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:20:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:20:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:20:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:20:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:20:41 INFO - Downloading blessings-1.6.tar.gz 18:20:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:20:41 INFO - Installing collected packages: blessings 18:20:41 INFO - Running setup.py install for blessings 18:20:41 INFO - Successfully installed blessings 18:20:41 INFO - Cleaning up... 18:20:41 INFO - Return code: 0 18:20:41 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:20:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:20:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:20:41 INFO - Reading from file tmpfile_stdout 18:20:41 INFO - Current package versions: 18:20:41 INFO - argparse == 1.2.1 18:20:41 INFO - blessings == 1.6 18:20:41 INFO - blobuploader == 1.2.4 18:20:41 INFO - docopt == 0.6.1 18:20:41 INFO - functools32 == 3.2.3-2 18:20:41 INFO - jsonschema == 2.5.1 18:20:41 INFO - manifestparser == 1.1 18:20:41 INFO - mozInstall == 1.12 18:20:41 INFO - mozcrash == 1.0 18:20:41 INFO - mozdebug == 0.1 18:20:41 INFO - mozdevice == 0.49 18:20:41 INFO - mozfile == 1.2 18:20:41 INFO - mozhttpd == 0.7 18:20:41 INFO - mozinfo == 0.9 18:20:41 INFO - mozleak == 0.1 18:20:41 INFO - mozlog == 3.4 18:20:41 INFO - moznetwork == 0.27 18:20:41 INFO - mozprocess == 0.23 18:20:41 INFO - mozprofile == 0.28 18:20:41 INFO - mozrunner == 6.13 18:20:41 INFO - mozscreenshot == 0.1 18:20:41 INFO - mozsystemmonitor == 0.3 18:20:41 INFO - moztest == 0.7 18:20:41 INFO - mozversion == 1.4 18:20:41 INFO - psutil == 3.1.1 18:20:41 INFO - requests == 1.2.3 18:20:41 INFO - wsgiref == 0.1.2 18:20:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:20:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:20:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:20:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:20:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:20:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:20:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:20:41 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 0x7f168a829e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc08b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xda4130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe32fc0>, '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 0xe33ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe34350>, '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': '0e2a256762fed810e2f0f810000001b3-1480557492.143370-1954135831', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:20:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 18:20:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:20:41 INFO - Using env: {'DISPLAY': ':0', 18:20:41 INFO - 'HOME': '/home/cltbld', 18:20:41 INFO - 'LANG': 'en_US.UTF-8', 18:20:41 INFO - 'LANGUAGE': 'en_US:en', 18:20:41 INFO - 'LOGNAME': 'cltbld', 18:20:41 INFO - 'MAIL': '/var/mail/cltbld', 18:20:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:20:41 INFO - 'MOZ_NO_REMOTE': '1', 18:20:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:20:41 INFO - 'NO_EM_RESTART': '1', 18:20:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:20:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:20:41 INFO - 'PWD': '/builds/slave/test', 18:20:41 INFO - 'SHELL': '/bin/bash', 18:20:41 INFO - 'SHLVL': '1', 18:20:41 INFO - 'TERM': 'linux', 18:20:41 INFO - 'TMOUT': '86400', 18:20:41 INFO - 'USER': 'cltbld', 18:20:41 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1480557492.143370-1954135831', 18:20:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:20:41 INFO - '_': '/tools/buildbot/bin/python'} 18:20:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:20:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 18:20:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 18:20:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 18:20:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 18:20:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 18:20:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 18:20:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 18:20:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 18:20:41 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 18:20:41 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 18:20:41 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 18:20:41 INFO - Cleaning up... 18:20:41 INFO - Return code: 0 18:20:41 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:20:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:20:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:20:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:20:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:20:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:20:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:20:41 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 0x7f168a829e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc08b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xda4130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe32fc0>, '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 0xe33ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe34350>, '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': '0e2a256762fed810e2f0f810000001b3-1480557492.143370-1954135831', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 18:20:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 18:20:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 18:20:41 INFO - Using env: {'DISPLAY': ':0', 18:20:41 INFO - 'HOME': '/home/cltbld', 18:20:41 INFO - 'LANG': 'en_US.UTF-8', 18:20:41 INFO - 'LANGUAGE': 'en_US:en', 18:20:41 INFO - 'LOGNAME': 'cltbld', 18:20:41 INFO - 'MAIL': '/var/mail/cltbld', 18:20:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:20:41 INFO - 'MOZ_NO_REMOTE': '1', 18:20:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:20:41 INFO - 'NO_EM_RESTART': '1', 18:20:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:20:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:20:41 INFO - 'PWD': '/builds/slave/test', 18:20:41 INFO - 'SHELL': '/bin/bash', 18:20:41 INFO - 'SHLVL': '1', 18:20:41 INFO - 'TERM': 'linux', 18:20:41 INFO - 'TMOUT': '86400', 18:20:41 INFO - 'USER': 'cltbld', 18:20:41 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1480557492.143370-1954135831', 18:20:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:20:41 INFO - '_': '/tools/buildbot/bin/python'} 18:20:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:20:42 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:20:42 INFO - Cleaning up... 18:20:42 INFO - Return code: 0 18:20:42 INFO - Running post-action listener: _resource_record_post_action 18:20:42 INFO - Running post-action listener: _start_resource_monitoring 18:20:42 INFO - Starting resource monitoring. 18:20:42 INFO - [mozharness: 2016-12-01 02:20:42.244113Z] Finished create-virtualenv step (success) 18:20:42 INFO - [mozharness: 2016-12-01 02:20:42.244595Z] Running install step. 18:20:42 INFO - Running pre-action listener: _resource_record_pre_action 18:20:42 INFO - Running main action method: install 18:20:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:20:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:20:42 INFO - Reading from file tmpfile_stdout 18:20:42 INFO - Detecting whether we're running mozinstall >=1.0... 18:20:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:20:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:20:42 INFO - Reading from file tmpfile_stdout 18:20:42 INFO - Output received: 18:20:42 INFO - Usage: mozinstall [options] installer 18:20:42 INFO - Options: 18:20:42 INFO - -h, --help show this help message and exit 18:20:42 INFO - -d DEST, --destination=DEST 18:20:42 INFO - Directory to install application into. [default: 18:20:42 INFO - "/builds/slave/test"] 18:20:42 INFO - --app=APP Application being installed. [default: firefox] 18:20:42 INFO - mkdir: /builds/slave/test/build/application 18:20:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 18:20:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 18:20:58 INFO - Reading from file tmpfile_stdout 18:20:58 INFO - Output received: 18:20:58 INFO - /builds/slave/test/build/application/firefox/firefox 18:20:58 INFO - Running post-action listener: _resource_record_post_action 18:20:58 INFO - [mozharness: 2016-12-01 02:20:58.587490Z] Finished install step (success) 18:20:58 INFO - [mozharness: 2016-12-01 02:20:58.587731Z] Running run-tests step. 18:20:58 INFO - Running pre-action listener: _resource_record_pre_action 18:20:58 INFO - Running main action method: run_tests 18:20:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:20:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:20:58 INFO - Python 2.7.3 18:20:58 INFO - Return code: 0 18:20:58 INFO - grabbing minidump binary from tooltool 18:20: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')]} 18:20:58 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 0xe32fc0>, '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 0xe33ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe34350>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:20:58 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 18:20:58 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 18:20:58 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 18:20:58 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:20:58 INFO - Return code: 0 18:20:58 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:20:58 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:20:58 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:20:58 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:20:58 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:20:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Graphics', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ULaXp8t_S42T1DoUQDxk8g/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-058', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 18:20:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Graphics --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ULaXp8t_S42T1DoUQDxk8g/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-058 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 18:20:58 INFO - Using env: {'DISPLAY': ':0', 18:20:58 INFO - 'HOME': '/home/cltbld', 18:20:58 INFO - 'LANG': 'en_US.UTF-8', 18:20:58 INFO - 'LANGUAGE': 'en_US:en', 18:20:58 INFO - 'LOGNAME': 'cltbld', 18:20:58 INFO - 'MAIL': '/var/mail/cltbld', 18:20:58 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:20:58 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:20:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:20:58 INFO - 'MOZ_NO_REMOTE': '1', 18:20:58 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:20:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:20:58 INFO - 'NO_EM_RESTART': '1', 18:20:58 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:20:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:20:58 INFO - 'PWD': '/builds/slave/test', 18:20:58 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:20:58 INFO - 'SHELL': '/bin/bash', 18:20:58 INFO - 'SHLVL': '1', 18:20:58 INFO - 'TERM': 'linux', 18:20:58 INFO - 'TMOUT': '86400', 18:20:58 INFO - 'USER': 'cltbld', 18:20:58 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1480557492.143370-1954135831', 18:20:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:20:58 INFO - '_': '/tools/buildbot/bin/python'} 18:20:58 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Graphics', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ULaXp8t_S42T1DoUQDxk8g/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-058', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 18:20:58 INFO - mozversion application_buildid: 20161130160344 18:20:58 INFO - mozversion application_changeset: 69bd424d84eef49f8bc87f0dcf402f4b6e7d5fba 18:20:58 INFO - mozversion application_display_name: Nightly 18:20:58 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:20:58 INFO - mozversion application_name: Firefox 18:20:58 INFO - mozversion application_remotingname: firefox 18:20:58 INFO - mozversion application_repository: https://hg.mozilla.org/projects/graphics 18:20:58 INFO - mozversion application_vendor: Mozilla 18:20:58 INFO - mozversion application_version: 53.0a1 18:20:58 INFO - mozversion platform_buildid: 20161130160344 18:20:58 INFO - mozversion platform_changeset: 69bd424d84eef49f8bc87f0dcf402f4b6e7d5fba 18:20:58 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/graphics 18:20:58 INFO - mozversion platform_version: 53.0a1 18:20:58 INFO - using testdate: 1480558858 18:20:58 INFO - actual date: 1480558858 18:20:58 INFO - starting webserver on 'localhost:46561' 18:20:58 INFO - SUITE-START | Running 2 tests 18:20:58 INFO - TEST-START | dromaeo_css 18:20:58 INFO - operating with platform_type : linux_ 18:20:58 INFO - Initialising browser for dromaeo_css test... 18:20:58 INFO - TEST-INFO | started process 1029 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpu_Gqyl/profile http://localhost:46561/getInfo.html) 18:21:03 INFO - PROCESS | 1029 | __metrics Screen width/height:1600/1200 18:21:03 INFO - PROCESS | 1029 | colorDepth:24 18:21:03 INFO - PROCESS | 1029 | Browser inner width/height: 1024/697 18:21:03 INFO - PROCESS | 1029 | __metrics 18:21:04 ERROR - PROCESS | 1029 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3220: TypeError: this.tabs is undefined 18:21:05 INFO - TEST-INFO | 1029: exit 0 18:21:05 INFO - Browser initialized. 18:21:05 INFO - Running cycle 1/1 for dromaeo_css test... 18:21:05 INFO - TEST-INFO | started process 1234 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpu_Gqyl/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:21:17 INFO - PROCESS | 1234 | RSS: Main: 187539456 18:21:17 INFO - PROCESS | 1234 | 18:22:07 INFO - PROCESS | 1234 | 1480558927138 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 18:24:20 INFO - PROCESS | 1234 | Cycle 1(1): loaded http://localhost:46561/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46561/tests/dromaeo/cssquery-ext.html) 18:24:23 INFO - PROCESS | 1234 | RSS: Main: 197795840 18:24:23 INFO - PROCESS | 1234 | 18:27:25 INFO - PROCESS | 1234 | Cycle 1(1): loaded http://localhost:46561/tests/dromaeo/cssquery-ext.html (next: http://localhost:46561/tests/dromaeo/cssquery-jquery.html) 18:27:26 INFO - PROCESS | 1234 | RSS: Main: 196866048 18:27:26 INFO - PROCESS | 1234 | 18:30:28 INFO - PROCESS | 1234 | Cycle 1(1): loaded http://localhost:46561/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46561/tests/dromaeo/cssquery-mootools.html) 18:30:29 INFO - PROCESS | 1234 | RSS: Main: 199237632 18:30:29 INFO - PROCESS | 1234 | 18:33:31 INFO - PROCESS | 1234 | Cycle 1(1): loaded http://localhost:46561/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46561/tests/dromaeo/cssquery-prototype.html) 18:33:31 INFO - PROCESS | 1234 | RSS: Main: 195760128 18:33:31 INFO - PROCESS | 1234 | 18:36:34 INFO - PROCESS | 1234 | Cycle 1(1): loaded http://localhost:46561/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46561/tests/dromaeo/cssquery-yui.html) 18:36:35 INFO - PROCESS | 1234 | RSS: Main: 198737920 18:36:35 INFO - PROCESS | 1234 | 18:39:38 INFO - PROCESS | 1234 | Cycle 1(1): loaded http://localhost:46561/tests/dromaeo/cssquery-yui.html (next: http://localhost:46561/tests/dromaeo/cssquery-dojo.html) 18:39:38 INFO - PROCESS | 1234 | RSS: Main: 199278592 18:39:38 INFO - PROCESS | 1234 | 18:39:38 INFO - PROCESS | 1234 | __start_tp_report 18:39:38 INFO - PROCESS | 1234 | _x_x_mozilla_page_load 18:39:38 INFO - PROCESS | 1234 | _x_x_mozilla_page_load_details 18:39:38 INFO - PROCESS | 1234 | |i|pagename|runs| 18:39:38 INFO - PROCESS | 1234 | |0;dojo.html;2583.5607946649075;2599.909003184889;2606;2625.159948816379;2632.2629663694174;4592.816287348502;4717.339572459854;4720.291956206566;4726.220173671344;4737.597304229136;4631.3516107744945;4708.505606911268;4739.573438390544;4741.075490279397;4826.372571565692;4316.179925814093;4357.716748411359;4372.934405983913;4433.556644335573;4452.332150177467;3971.245463361952;4384.714993525411;4413.7793110344355;4432.290833466646;4439.223135951212;4240.300350442173;4354.08564201518;4385.057212699285;4409.228385032622;4450.443694538183;4239.788010599457;4282.528921818597;4316.6546676265825;4355.7822108894425;4390.319500477399;4286.3784751211215;4308.612224899743;4320.567943205686;4339.891502712426;4357.716748411375;4696.154692155411;4710.480919760275;4727.385439892826;4727.692699974491;4761.2382018876815;4862.878428039292;4872.707637541759;4889.902201955976;4897.069556784199;4929.507049295042;4955.98402327522;4958.801647934079;4961.305417241589;4968.925466118011;4980.87547811304;4595.678302518859;4632.305154226826;4661.930071048937;4682.742449165295;4716.410448693913;4979.4771548987555;5018.673786203885;5067.163917953497;5093.694378337312;5105.821296254688;4915.18899381598;4947.109520286311;4947.802087916515;4960;4961.82633607822;4904.117258893433;5077.060743762342;5089.796408143707;5100.48995100487;5131.409887862944;4914.459409464956;4941.950580494221;4983.07813054586;4991.376077990251;5003.72479513623;4933.827316043921;4939.209726443752;4971.65198436106;4988.077205716954;5006.449290578106;4437.622802061796;4438.245498265303;4476.127155204704;4482.551744825557;4491.461024676994;3768.1144930941205;3793.677537409296;3820.522434695663;3874.767513949172;3892.805359732002;4316.805743741539;4323.978380108142;4353.804078816461;4419.11617676466;4422.955770442319;5058.570021548136;5060.898782024339;5072.340595722532;5073.923891141636;5106;4365.257906155961;4365.628921541641;4375.759333236702;4381.3208952612395;4408.55914408563;4518.570735780096;4550.522195169526;4551.3173024046655;4624.075184963021;4628.490866004737;4688.2030054890065;4729.17239483096;4736.526347365236;4737.265723812815;4741.2651039089;5031.9245211322595;5063.670861393997;5065.544101030925;5068.518490743373;5070.746462676778;4708.152532544175;4710.1757192490495;4742.715437073786;4746.810127594996;4830.710157390427;5016.473270306566;5016.849494515171;5017.422996355466;5025.723585202849;5057.797688092435;5110.029094472038;5110.97444512775;5111.923321150261;5127.179651255781;5128.1794912813775;4754.310624959292;4786.545278198566;4790;4847.103285892122;4858.27125931099;4841;4848.296996935495;4850.248211527219;4855.417349918032;4889.975550122226;4791.664583479123;4842.15262329084;4853.611711063177;4884.316195732671;4892.217245240744;4779.784909679003;4828.66199366055;4861.902761944671;4886.291487734187;4906.288588154769;4792.353032340589;4797.952020479751;4799.616030717464;4809.134355815987;4817.397825271841 18:39:38 INFO - PROCESS | 1234 | |1;ext.html;536.8738346488575;551.6938099354859;555.9138333558298;557.7840308128278;582.3710392775803;33151.66848331516;36624.45063324052;36653.26693466129;36701.81649091754;36744.816275918616;35981.46027809585;36181.276374472494;36201;36244;36376;7375.893615957609;7503.362214211771;7594.164641889415;9359.95320023399;9701.90298097017;9911;9975.152112070482;9984.45085520296;9999;10024.59901603935;10000.59997600095;10047.397156170617;10049.89950100497;10069.496525173749;10077.949610251939;9837.311388202828;9893.90106098937;9900.900990990142;9914.454704991223;9918.702438926772;9839.065288797625;9883.604655813759;9884.80230395388;9888.752781180456;9932.702018939442;36620.26759464823;36710.449343259876;36766.44850327247;36800.079997999994;36812.44781328282;2861.413410250894;2997.1607949774098;3039.2553824312963;3043.5434684797237;3046.9847650761603;26691.733082669314;27229.45541089167;27568.172954811387;27730;28154.577681334795;3278.967210327914;3403.727701783876;3436.6391528889358;3456.412409890325;3456.412409890325;237717.81141094357;240068.79965600235;240452;240911;241258;50212.49787502078;50706.74646626743;50812.745936270825;50856.491435085176;50974;53814.46185538094;53981;54007.45992540103;54077;54248.45751542513;11666.650000499998;11970.82043769344;11976.640700778991;12000.159988800875;12008.579699710468;7549.2073332300415;7801.063872335242;9339.859902101474;9466.810663786686;9517.90482095184;16679.583010424594;16901.661966760596;16974;17128.229229684694;17306.567335816704;6319.894018546736;6460.612363258219;6558.179737892645;6566.277709451956;6710.194776626836;765.8008917681332;828.8176601147737;858.7037472072125;867.2324992381788;952.2715122930963;26308.21075367742;27646.447071058465;27764;27997.44005119886;28085.157445276673;932.7901222225081;965.165132160676;980.2403137568441;980.2745967983641;1000.7848312612823;14601;14622.341994610268;14652.113506651856;14663.780043299359;14781.187034712979;349937;351920;353414;356320;357684;48135.75932120317;48342.516574833804;48487.27269090967;48537;48780.75609622;1121.7307846117037;1153.6827372472637;1157.548556063136;1158.0561842098662;1162.2619636530694;24843.62734558947;25646.487070258117;27048;27146.185614431597;27259.86370068137;40950;44994;46768.766156169004;47033;51999;326458;330024;330043;330496;330525;30889;31787.6821231794;33335.49996750099;35356.292874142884;36930.26139477249;37423;37627.623723762415;37725.4341184877;38804.223915522096;38918.80540597279;32126;32571.34857302888;32573.674263258014;32915;33053;32623.510647340783;33339;33629.83185084059;34174.65825341814;34638.82680586581;32985.67014329826;33257.66742332546;33458.66541334653;33603.83198083994;33926.830365848014;27987.58018629763;30392.392152157274;30856.537151943186;30990.845045774626;31063.689363106983;23371.88314058487;23488.765112348658;23701.28896133119;23702.407439814142;23774 18:39:38 INFO - PROCESS | 1234 | |2;jquery.html;343.63746247708656;354.2613650538627;355.957045855643;361.2738395824392;361.5950135847851;15298.694026119485;16011.27949242284;16816;16954;17049.57376065599;13938.790918136236;14798.556043318691;15530.37878484862;15659.921700391511;16292.918535407307;4551.544845515455;5123.180291153416;5205.86985325368;5215.791368345262;5217.947820521803;3345.4145524533233;5141.15170996785;5141.897162056756;5179.8446046618665;5184.351956005499;3510.7366947478913;5105.132127538327;5352.277442545265;5378.838634840941;5430.864228394302;5077.49225077493;5420.24116623673;5430.266913966603;5437.972810135963;5445.9727701361435;5146.150885103953;5250.842474725764;5276.657017293864;5277.208418737182;5278.392984806719;19279.614407711906;19454.124564394635;19607.607847842963;19700.80299197004;19875.60248795016;1744.9127543622894;1778.0931724820434;1956.628240634289;2078.418042947977;2351.0478256306224;8600.483970961763;8858.955705221497;8931.106889311017;9092.454452732858;12218.20581662189;1666.7916510436196;1687.1817168673183;1711.1358763824314;1737.3832289537158;1746.1007581095746;65284;65857;66427.3357266426;66514;68570;9932.851007234898;9939.850902236472;9961.452120133463;10713.089387402159;10818.350898946088;13657.453701852013;13684.657883552793;13689.110207836458;13706.109102908278;13741.312934353242;6527.608343499405;6603.70283337251;6694.389188216599;6713.0937323461685;6802.829929251809;5856.94143058564;6146.262448506208;6300.842478938063;6320.336364681642;6321.841953951096;4170.35359519275;4256.6807489438415;4300.37644541546;4344.1311737652595;4363.607275345171;1760.7094829353268;1819.2995696656883;1821.6629923463936;1862.320253107606;1869.2242719271621;821.9424640275123;841.6449516278786;870;912.9543522823832;918.0498184379136;15863.762043569355;16289.755653665205;16351.918240408722;16489.587760305847;16783.83216167847;815.404754529197;822.9300509456643;874.8775171475999;880.8722735203488;922.4972390047441;8931.151540603632;9274.629014839466;9304.488253146143;9443.716688499357;9490.861096668306;345067;348580;352156;353159;357220;52272.738636306574;56230.71884640632;74523.25476745272;75326.62336688282;75421.62289188518;862.9395942283979;892.7143314139543;894.3784070071238;895.359817730326;897.3090720145582;14677;14867.776983345475;14920;14933.253337333308;15194.088354698753;35819.462708058876;37286.25427491489;38022;38322.616773831905;38701.22597547977;49362.75318623384;51248.23127653014;51252.74373628108;52188.217176743135;52315.73842130765;6998;7344.9632751838035;7356.705731770883;7493.100827900686;7880.487768295043;10353;11121.388323642277;11316.773664526829;11548.076153907836;11764.882351176379;10038.498075096362;10049.69850904474;10162.74593135148;10383.84424233622;10621.309614875008;9809.558569864515;10055.547500362354;10089.747756306151;10105.242106842163;10115.494225288854;10242.283040187116;10393.480325983519;10488.160947124059;10922.726931826768;11074.944625276821;7420.480566360303;7525.2098529653595;7679.155292917886;7734.8839767402405;7853.214678532101;9153.359264851397;10151.796964060824;10174.745631359276;10385.792284154124;10715.196360273167 18:39:38 INFO - PROCESS | 1234 | |3;mootools.html;1302.9153105048174;1350.4598160735707;1371.7873729571913;1569.136974663936;1581.7073841339354;5987.610805297652;6196.287426945903;6646.4682825373975;7060.1880783709885;7086.114235720535;6635.336466353362;6887.4834387421015;6920.4809639277;6992.5454845435015;7082.752103676372;2074.595453886489;2110.4407332057017;2112.683097535374;2113.355426594888;2114.2811444109;1768.8673349498774;1832.2029916986087;2049.463682515854;2092.1003968293626;2092.790720927903;1980.861339706221;2044.417341057799;2047.2015913793632;2065.5455799724036;2065.5868826234814;2021.070307658479;2047.938561843147;2059.2483743433613;2071.6892466130053;2079.2722547108465;2081.6773400123006;2093.1731965873396;2097.1716172112083;2104.200403846544;2105.200023990874;6611.6033038017395;6683.064370988066;6719.361660642231;6800.387965083166;6835.897461538081;4070.1656160487028;4168.312228482297;4168.458100446953;4174.979125104385;4203.810828512694;2540.872956352175;2618.2537976676554;2830.815996960191;2839.346950201465;2856.7714582833323;899.9460032398077;925.4354843545432;926.8887733472027;927.8793756811639;946.2760987844305;9114.908850911472;9126.680566180152;9155.40489868163;9155.496447695374;9162.083791620851;3747.3254814133174;3881.146147847469;3905.7070719696135;3926.9018274543364;3953.367461206193;7910.090339610903;7962.840743185104;7974.641141148662;7983.12185659577;7984.24149705777;4102;4106.733062350938;4106.815193316308;4106.938395924063;4113.177364527047;3703.703703703697;3743.6817870481314;3747.2130852521277;3747.3442147624055;3750.3436898542645;3246.951295730566;3316.3201543683485;3336.8164750938445;3361.5125806758374;3413.1467133216697;984.6504490905626;1032.8863824979246;1095.315427857589;1103.448275862069;1103.8013157631542;630.5901164243279;676.6785776756002;697.8429853282971;762.3786613909646;778.875379939207;4334.891627709332;4368.890777730582;4451.221036318631;4508.661850361236;4564.064366804797;741.9035525381665;749.4491548711693;755.0712623473158;794.1780257433528;811.9391045671598;3009.5786589877434;3029.5910052143117;3066.7853250272715;3069.4628440022907;3131.2171957010746;7816.960915195387;8039.638216280281;8093.716719914774;8150.877736833952;8163.591820408956;8099.595020248964;8104.878426823602;8118.675252989932;8131.227533384319;8135.227153420416;6343.9682801585695;6367.204099487564;6384.52116091295;6460.903086453707;6472.708728107246;4155.937660935028;4192.140611174763;4210.136921930935;4303.354496825376;4380.846670366522;7512.211217822269;7532.623368831646;7563.848723025399;7586.582737949466;7625.084989801259;7585.393168546393;7671.693132274647;7671.69313227487;7686.116096648957;7700.114486834086;5850.444207800252;6024.7288872001745;6037.094435834484;6101.420365065312;6106;6699.19609646826;6855.897161542681;6859.897101543581;6870.416014638811;6880.793576192722;6213.471854892385;6276;6349.460295874902;6467.967660161669;6548.967255163694;6199.411055949678;6233.314335423191;6279.686015699288;6284.968575157278;6353.7140828661895;5819.5053420459735;5907.172995780508;5918.911216331672;5935.495482883831;5945.791897283574;3751.4560388742934;3761.9435708464944;3856.9228615428096;3913.2173565287626;3921.588233235469;4110.219058378899;4116.835326586903;4183.121544475573;4209.305464598307;4242.109157076925 18:39:38 INFO - PROCESS | 1234 | |4;prototype.html;257.66889546932185;269.68042869199985;271.7269144509767;280.8974724225658;286.32855952790703;4804.399450068741;4939.259111133323;4962.925556116661;5011.148104822179;5026.849194524166;4732.2428411454175;4867.707937523742;4873;4885.828995985141;4891.4374846892615;3822.8661996830115;3824.5984171661994;3834.789086600236;3840.4047372657283;3858.7105967052585;3852.268069066882;3855.768653880762;3859.6333348332005;3862.86479973201;3874.9850077959445;3574.5889222739456;3725.88822335329;3774.830132644038;3782.6595606395417;3783.451399547064;3758.49260349852;3774.1508160663907;3776.244751049801;3777.7166712496537;3783.735138540303;3249.5613092232484;3288.3722557334036;3294;3294.8352582371026;3309.271960168783;4707.199776038082;4767.475577686451;4793.411557758806;4797.904041919142;4809.422869255677;4247.68142389322;4280.743155410654;4282.336237883133;4282.635975942048;4290.541215986579;5116.948830511685;5117.897642047138;5123.538881500683;5132.948670513284;5142.3829140503;3541.0793193769805;3574.5889222739456;3582.42681171014;3583.140046388874;3583.552055993001;5166.844994650167;5297.708626025567;5366.9069063065435;5413.188021796723;5413.593980451443;3634.637959887094;3640.3265395901844;3640.5449318835144;3645.8906232813056;3654.14127679995;3691.520102386726;3693.6121707220354;3699.8520059197867;3707.7219208558927;3712.406015037581;4053.412255222976;4262.786860656955;4275.508316543637;4285.892852678708;4292.785360731951;5167.803683434526;5182;5184.481551844785;5185.377754669464;5199.66202196856;1212.8120141378101;1242.8508578970582;1253.7116463213329;1255.3848614178987;1261.9621411357673;808.878668199763;829.701307529289;839.3075712537182;839.7816567692444;841.6885752271576;4421.071574969228;4422.601965823027;4429.224885645063;4449.933251001173;4477.32840073985;5159.948400516022;5185.159268459718;5191.844244672666;5193.091209038404;5199.4540573239265;4324.675649326313;4400.317950717644;4407.118576284692;4421.425214722066;4433.889152771207;2599.9032318584523;2702.473017761557;2715.91852244433;2717.6331195288385;2731.7541421271785;4763.95236047642;4774.350235619265;4820.3847114664;4849.878753031202;4855.465898751135;5056;5182.714950677749;5195.610329225323;5202.892828404502;5207.479252074762;4650.4186976627925;4714.363560919301;4738.00501894606;4773.618110551217;4783.804048987753;5092.261622064854;5112.903709479096;5116.676408434867;5126.53861152498;5153.4073581538605;4849.563539281482;4987.576056035277;5013.448520662651;5021.347224860745;5063.518965698253;4759.286107083965;4773.785179666854;4779.880502987314;4799;4819.734724679395;3501.614822369588;3528.594211665691;3535.4343305071066;3540.1149712571855;3545.734069944816;5088.338515992898;5106.565941894981;5113.846584602468;5114.578546740467;5124.436312005751;4690.695104818176;5143.974280128576;5198.816497071163;5198.870028249324;5199.246109314053;5161.66449180802;5169.81905633301;5175.508326708957;5177.663451875616;5184.662996905189;4902.289168070681;5093.745312734274;5118.74406279692;5123.513266239701;5145.61407894402;5140.820071297487;5175.042617115695;5197.194434862451;5199.71401572902;5209.505097015777;5080.593552515864;5083.72039537829;5090.974545127251;5093.388793344822;5093.516115968977 18:39:38 INFO - PROCESS | 1234 | |5;yui.html;635.2789583822362;661.6096503063192;679.7654809090861;714.5034201230147;724.6195747232704;11619.709507262312;12377.628671139857;12677.556285530009;12739.872601273984;12930.159539629918;11672.591459298927;11811.291322520654;11811.881881181185;11915.0467962563;11939.641810745692;594.2126682146152;743.4089898530667;757.696921231509;760.1524300405064;766.5400759544284;619.4332186049782;737.4211244173325;756.9318761311481;765.9042619672541;767.2365995834125;802.7591722483261;804.6539987805241;805.2269820971874;805.4040010392326;805.8509175802495;804.6057431858377;804.7867315161487;805.480465100013;805.5529181304373;806.1535387842741;587.8971180043518;588.5674029588249;589.2398805540847;589.8997170481028;590.344717363726;12213.206141600767;12372.381380931007;12385;12401.069919755964;12445.564405245863;12886.54897078607;13086.934565327208;13098.803517947143;13134.540291089861;13434.798478022838;9853.310268281222;9925.652602158962;10012.499375031291;10317.896821031769;10381.42902140382;4015.15681706839;4026.355783074723;4117.464729585165;4123.793810309502;4143.502779666429;62868.371316286706;63408;63799.448022079065;64166.358336416975;66472.33527664759;9899.356541824758;9953.701388958343;10109.64616238428;10124.240681948737;10166.135878450266;17058;17116.486505404857;17137.143142842808;17150.828491715172;17191;6385.361463853577;6484.1246431731115;6611.933880661228;6616.86766264672;6641.369069938348;3500.0899766060497;3506.403911335079;3538.1862171700654;3583.1937813991644;3604.4773507841214;2809.873555689958;2923.6053132826796;2941.352902361477;2941.57347184657;2942.5586162075433;457.70478041662943;464.39860380806937;467.87367410798896;474.69382248450245;487.4029314090282;497.3807609526163;595.2440400691098;607.4138456389605;610.4231501231383;613.2977740487206;7578.204288549623;7711.380610071836;7836.294733474015;7921.366290696846;8112.716054938167;475.28469653171754;588.5960747071831;595.6694034810722;598.964062156272;620.7268801727225;3935.980320098381;4002.2795896738867;4097.959020409758;4108.157827645326;4279.801655536455;62096;67533;72964;73696.63151684315;74177.6291118541;54974;55679.164812527844;56249.7187514068;56700.43299567034;57632.71183644139;50328.748356258715;50417;51652.74173629108;52791.472085278656;53295.467045329824;7622.9716719958005;7818.413618978486;7985.281324680806;8111.472754270953;8146.877796833171;35331.82334088313;35462.645373545936;35894;36217.81891090528;36362.09103271679;44800.55199447964;46434;49732;49977.25034124418;51312.486875132265;10963.561457541928;11082.61210857616;11082.72276292621;11419.689844222476;11477.253978491372;12628.242305461701;13082.607521774362;13207.933960330136;13618.659533511345;14086.366113524711;11462.828057578976;11809;11921.165518413627;12186;12395.256284622952;11939.164258501822;12256.325902075472;12306.031574686449;12615.243085414904;12836.871631283568;11709.180357375242;11894.286342819458;12104.75790484203;12412;12497;9357.53212339394;9490.572924218564;9546.713598591776;9801.85297220528;9824.557894894604;8597.828043439222;8599.82800343977;9040.819183616422;9430.481323527272;9729.367591106555 18:39:38 INFO - PROCESS | 1234 | __end_tp_report 18:39:38 INFO - PROCESS | 1234 | __start_cc_report 18:39:38 INFO - PROCESS | 1234 | _x_x_mozilla_cycle_collect,350 18:39:38 INFO - PROCESS | 1234 | __end_cc_report 18:39:38 INFO - PROCESS | 1234 | __startTimestamp1480559978613__endTimestamp 18:39:38 INFO - PROCESS | 1234 | 18:39:38 INFO - PROCESS | 1234 | ------- Summary: start ------- 18:39:38 INFO - PROCESS | 1234 | Number of tests: 6 18:39:38 INFO - PROCESS | 1234 | 18:39:38 INFO - PROCESS | 1234 | [#0] dojo.html Cycles:165 Average:4652.58 Median:4754.31 stddev:470.75 (9.9%) stddev-sans-first:443.33 18:39:38 INFO - PROCESS | 1234 | Values: 2583.6 2599.9 2606.0 2625.2 2632.3 4592.8 4717.3 4720.3 4726.2 4737.6 4631.4 4708.5 4739.6 4741.1 4826.4 4316.2 4357.7 4372.9 4433.6 4452.3 3971.2 4384.7 4413.8 4432.3 4439.2 4240.3 4354.1 4385.1 4409.2 4450.4 4239.8 4282.5 4316.7 4355.8 4390.3 4286.4 4308.6 4320.6 4339.9 4357.7 4696.2 4710.5 4727.4 4727.7 4761.2 4862.9 4872.7 4889.9 4897.1 4929.5 4956.0 4958.8 4961.3 4968.9 4980.9 4595.7 4632.3 4661.9 4682.7 4716.4 4979.5 5018.7 5067.2 5093.7 5105.8 4915.2 4947.1 4947.8 4960.0 4961.8 4904.1 5077.1 5089.8 5100.5 5131.4 4914.5 4942.0 4983.1 4991.4 5003.7 4933.8 4939.2 4971.7 4988.1 5006.4 4437.6 4438.2 4476.1 4482.6 4491.5 3768.1 3793.7 3820.5 3874.8 3892.8 4316.8 4324.0 4353.8 4419.1 4423.0 5058.6 5060.9 5072.3 5073.9 5106.0 4365.3 4365.6 4375.8 4381.3 4408.6 4518.6 4550.5 4551.3 4624.1 4628.5 4688.2 4729.2 4736.5 4737.3 4741.3 5031.9 5063.7 5065.5 5068.5 5070.7 4708.2 4710.2 4742.7 4746.8 4830.7 5016.5 5016.8 5017.4 5025.7 5057.8 5110.0 5111.0 5111.9 5127.2 5128.2 4754.3 4786.5 4790.0 4847.1 4858.3 4841.0 4848.3 4850.2 4855.4 4890.0 4791.7 4842.2 4853.6 4884.3 4892.2 4779.8 4828.7 4861.9 4886.3 4906.3 4792.4 4798.0 4799.6 4809.1 4817.4 18:39:38 INFO - PROCESS | 1234 | 18:39:38 INFO - PROCESS | 1234 | [#1] ext.html Cycles:180 Average:45989.58 Median:192287.91 stddev:81895.75 (42.6%) stddev-sans-first:82054.38 18:39:38 INFO - PROCESS | 1234 | Values: 536.9 551.7 555.9 557.8 582.4 33151.7 36624.5 36653.3 36701.8 36744.8 35981.5 36181.3 36201.0 36244.0 36376.0 7375.9 7503.4 7594.2 9360.0 9701.9 9911.0 9975.2 9984.5 9999.0 10024.6 10000.6 10047.4 10049.9 10069.5 10077.9 9837.3 9893.9 9900.9 9914.5 9918.7 9839.1 9883.6 9884.8 9888.8 9932.7 36620.3 36710.4 36766.4 36800.1 36812.4 2861.4 2997.2 3039.3 3043.5 3047.0 26691.7 27229.5 27568.2 27730.0 28154.6 3279.0 3403.7 3436.6 3456.4 3456.4 237717.8 240068.8 240452.0 240911.0 241258.0 50212.5 50706.7 50812.7 50856.5 50974.0 53814.5 53981.0 54007.5 54077.0 54248.5 11666.7 11970.8 11976.6 12000.2 12008.6 7549.2 7801.1 9339.9 9466.8 9517.9 16679.6 16901.7 16974.0 17128.2 17306.6 6319.9 6460.6 6558.2 6566.3 6710.2 765.8 828.8 858.7 867.2 952.3 26308.2 27646.4 27764.0 27997.4 28085.2 932.8 965.2 980.2 980.3 1000.8 14601.0 14622.3 14652.1 14663.8 14781.2 349937.0 351920.0 353414.0 356320.0 357684.0 48135.8 48342.5 48487.3 48537.0 48780.8 1121.7 1153.7 1157.5 1158.1 1162.3 24843.6 25646.5 27048.0 27146.2 27259.9 40950.0 44994.0 46768.8 47033.0 51999.0 326458.0 330024.0 330043.0 330496.0 330525.0 30889.0 31787.7 33335.5 35356.3 36930.3 37423.0 37627.6 37725.4 38804.2 38918.8 32126.0 32571.3 32573.7 32915.0 33053.0 32623.5 33339.0 33629.8 34174.7 34638.8 32985.7 33257.7 33458.7 33603.8 33926.8 27987.6 30392.4 30856.5 30990.8 31063.7 23371.9 23488.8 23701.3 23702.4 23774.0 18:39:38 INFO - PROCESS | 1234 | 18:39:38 INFO - PROCESS | 1234 | [#2] jquery.html Cycles:180 Average:22697.90 Median:4322.25 stddev:58047.60 (1343.0%) stddev-sans-first:58186.17 18:39:38 INFO - PROCESS | 1234 | Values: 343.6 354.3 356.0 361.3 361.6 15298.7 16011.3 16816.0 16954.0 17049.6 13938.8 14798.6 15530.4 15659.9 16292.9 4551.5 5123.2 5205.9 5215.8 5217.9 3345.4 5141.2 5141.9 5179.8 5184.4 3510.7 5105.1 5352.3 5378.8 5430.9 5077.5 5420.2 5430.3 5438.0 5446.0 5146.2 5250.8 5276.7 5277.2 5278.4 19279.6 19454.1 19607.6 19700.8 19875.6 1744.9 1778.1 1956.6 2078.4 2351.0 8600.5 8859.0 8931.1 9092.5 12218.2 1666.8 1687.2 1711.1 1737.4 1746.1 65284.0 65857.0 66427.3 66514.0 68570.0 9932.9 9939.9 9961.5 10713.1 10818.4 13657.5 13684.7 13689.1 13706.1 13741.3 6527.6 6603.7 6694.4 6713.1 6802.8 5856.9 6146.3 6300.8 6320.3 6321.8 4170.4 4256.7 4300.4 4344.1 4363.6 1760.7 1819.3 1821.7 1862.3 1869.2 821.9 841.6 870.0 913.0 918.0 15863.8 16289.8 16351.9 16489.6 16783.8 815.4 822.9 874.9 880.9 922.5 8931.2 9274.6 9304.5 9443.7 9490.9 345067.0 348580.0 352156.0 353159.0 357220.0 52272.7 56230.7 74523.3 75326.6 75421.6 862.9 892.7 894.4 895.4 897.3 14677.0 14867.8 14920.0 14933.3 15194.1 35819.5 37286.3 38022.0 38322.6 38701.2 49362.8 51248.2 51252.7 52188.2 52315.7 6998.0 7345.0 7356.7 7493.1 7880.5 10353.0 11121.4 11316.8 11548.1 11764.9 10038.5 10049.7 10162.7 10383.8 10621.3 9809.6 10055.5 10089.7 10105.2 10115.5 10242.3 10393.5 10488.2 10922.7 11074.9 7420.5 7525.2 7679.2 7734.9 7853.2 9153.4 10151.8 10174.7 10385.8 10715.2 18:39:38 INFO - PROCESS | 1234 | 18:39:38 INFO - PROCESS | 1234 | [#3] mootools.html Cycles:180 Average:4539.96 Median:5878.81 stddev:2448.95 (41.7%) stddev-sans-first:2443.73 18:39:38 INFO - PROCESS | 1234 | Values: 1302.9 1350.5 1371.8 1569.1 1581.7 5987.6 6196.3 6646.5 7060.2 7086.1 6635.3 6887.5 6920.5 6992.5 7082.8 2074.6 2110.4 2112.7 2113.4 2114.3 1768.9 1832.2 2049.5 2092.1 2092.8 1980.9 2044.4 2047.2 2065.5 2065.6 2021.1 2047.9 2059.2 2071.7 2079.3 2081.7 2093.2 2097.2 2104.2 2105.2 6611.6 6683.1 6719.4 6800.4 6835.9 4070.2 4168.3 4168.5 4175.0 4203.8 2540.9 2618.3 2830.8 2839.3 2856.8 899.9 925.4 926.9 927.9 946.3 9114.9 9126.7 9155.4 9155.5 9162.1 3747.3 3881.1 3905.7 3926.9 3953.4 7910.1 7962.8 7974.6 7983.1 7984.2 4102.0 4106.7 4106.8 4106.9 4113.2 3703.7 3743.7 3747.2 3747.3 3750.3 3247.0 3316.3 3336.8 3361.5 3413.1 984.7 1032.9 1095.3 1103.4 1103.8 630.6 676.7 697.8 762.4 778.9 4334.9 4368.9 4451.2 4508.7 4564.1 741.9 749.4 755.1 794.2 811.9 3009.6 3029.6 3066.8 3069.5 3131.2 7817.0 8039.6 8093.7 8150.9 8163.6 8099.6 8104.9 8118.7 8131.2 8135.2 6344.0 6367.2 6384.5 6460.9 6472.7 4155.9 4192.1 4210.1 4303.4 4380.8 7512.2 7532.6 7563.8 7586.6 7625.1 7585.4 7671.7 7671.7 7686.1 7700.1 5850.4 6024.7 6037.1 6101.4 6106.0 6699.2 6855.9 6859.9 6870.4 6880.8 6213.5 6276.0 6349.5 6468.0 6549.0 6199.4 6233.3 6279.7 6285.0 6353.7 5819.5 5907.2 5918.9 5935.5 5945.8 3751.5 3761.9 3856.9 3913.2 3921.6 4110.2 4116.8 4183.1 4209.3 4242.1 18:39:38 INFO - PROCESS | 1234 | 18:39:38 INFO - PROCESS | 1234 | [#4] prototype.html Cycles:180 Average:4196.00 Median:4774.07 stddev:1236.59 (25.9%) stddev-sans-first:1204.21 18:39:38 INFO - PROCESS | 1234 | Values: 257.7 269.7 271.7 280.9 286.3 4804.4 4939.3 4962.9 5011.1 5026.8 4732.2 4867.7 4873.0 4885.8 4891.4 3822.9 3824.6 3834.8 3840.4 3858.7 3852.3 3855.8 3859.6 3862.9 3875.0 3574.6 3725.9 3774.8 3782.7 3783.5 3758.5 3774.2 3776.2 3777.7 3783.7 3249.6 3288.4 3294.0 3294.8 3309.3 4707.2 4767.5 4793.4 4797.9 4809.4 4247.7 4280.7 4282.3 4282.6 4290.5 5116.9 5117.9 5123.5 5132.9 5142.4 3541.1 3574.6 3582.4 3583.1 3583.6 5166.8 5297.7 5366.9 5413.2 5413.6 3634.6 3640.3 3640.5 3645.9 3654.1 3691.5 3693.6 3699.9 3707.7 3712.4 4053.4 4262.8 4275.5 4285.9 4292.8 5167.8 5182.0 5184.5 5185.4 5199.7 1212.8 1242.9 1253.7 1255.4 1262.0 808.9 829.7 839.3 839.8 841.7 4421.1 4422.6 4429.2 4449.9 4477.3 5159.9 5185.2 5191.8 5193.1 5199.5 4324.7 4400.3 4407.1 4421.4 4433.9 2599.9 2702.5 2715.9 2717.6 2731.8 4764.0 4774.4 4820.4 4849.9 4855.5 5056.0 5182.7 5195.6 5202.9 5207.5 4650.4 4714.4 4738.0 4773.6 4783.8 5092.3 5112.9 5116.7 5126.5 5153.4 4849.6 4987.6 5013.4 5021.3 5063.5 4759.3 4773.8 4779.9 4799.0 4819.7 3501.6 3528.6 3535.4 3540.1 3545.7 5088.3 5106.6 5113.8 5114.6 5124.4 4690.7 5144.0 5198.8 5198.9 5199.2 5161.7 5169.8 5175.5 5177.7 5184.7 4902.3 5093.7 5118.7 5123.5 5145.6 5140.8 5175.0 5197.2 5199.7 5209.5 5080.6 5083.7 5091.0 5093.4 5093.5 18:39:38 INFO - PROCESS | 1234 | 18:39:38 INFO - PROCESS | 1234 | [#5] yui.html Cycles:180 Average:14893.09 Median:49854.63 stddev:18915.14 (37.9%) stddev-sans-first:18937.90 18:39:38 INFO - PROCESS | 1234 | Values: 635.3 661.6 679.8 714.5 724.6 11619.7 12377.6 12677.6 12739.9 12930.2 11672.6 11811.3 11811.9 11915.0 11939.6 594.2 743.4 757.7 760.2 766.5 619.4 737.4 756.9 765.9 767.2 802.8 804.7 805.2 805.4 805.9 804.6 804.8 805.5 805.6 806.2 587.9 588.6 589.2 589.9 590.3 12213.2 12372.4 12385.0 12401.1 12445.6 12886.5 13086.9 13098.8 13134.5 13434.8 9853.3 9925.7 10012.5 10317.9 10381.4 4015.2 4026.4 4117.5 4123.8 4143.5 62868.4 63408.0 63799.4 64166.4 66472.3 9899.4 9953.7 10109.6 10124.2 10166.1 17058.0 17116.5 17137.1 17150.8 17191.0 6385.4 6484.1 6611.9 6616.9 6641.4 3500.1 3506.4 3538.2 3583.2 3604.5 2809.9 2923.6 2941.4 2941.6 2942.6 457.7 464.4 467.9 474.7 487.4 497.4 595.2 607.4 610.4 613.3 7578.2 7711.4 7836.3 7921.4 8112.7 475.3 588.6 595.7 599.0 620.7 3936.0 4002.3 4098.0 4108.2 4279.8 62096.0 67533.0 72964.0 73696.6 74177.6 54974.0 55679.2 56249.7 56700.4 57632.7 50328.7 50417.0 51652.7 52791.5 53295.5 7623.0 7818.4 7985.3 8111.5 8146.9 35331.8 35462.6 35894.0 36217.8 36362.1 44800.6 46434.0 49732.0 49977.3 51312.5 10963.6 11082.6 11082.7 11419.7 11477.3 12628.2 13082.6 13207.9 13618.7 14086.4 11462.8 11809.0 11921.2 12186.0 12395.3 11939.2 12256.3 12306.0 12615.2 12836.9 11709.2 11894.3 12104.8 12412.0 12497.0 9357.5 9490.6 9546.7 9801.9 9824.6 8597.8 8599.8 9040.8 9430.5 9729.4 18:39:38 INFO - PROCESS | 1234 | -------- Summary: end -------- 18:39:38 INFO - PROCESS | 1234 | 18:39:39 INFO - TEST-INFO | 1234: exit 0 18:39:39 INFO - TEST-OK | dromaeo_css | took 1120829ms 18:39:39 INFO - TEST-START | kraken 18:39:39 INFO - operating with platform_type : linux_ 18:39:39 INFO - Initialising browser for kraken test... 18:39:39 INFO - TEST-INFO | started process 1592 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTvfwJf/profile http://localhost:46561/getInfo.html) 18:39:44 INFO - PROCESS | 1592 | __metrics Screen width/height:1600/1200 18:39:44 INFO - PROCESS | 1592 | colorDepth:24 18:39:44 INFO - PROCESS | 1592 | Browser inner width/height: 1024/697 18:39:44 INFO - PROCESS | 1592 | __metrics 18:39:45 ERROR - PROCESS | 1592 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3220: TypeError: this.tabs is undefined 18:39:46 INFO - TEST-INFO | 1592: exit 0 18:39:46 INFO - Browser initialized. 18:39:46 INFO - Running cycle 1/1 for kraken test... 18:39:46 INFO - TEST-INFO | started process 1719 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTvfwJf/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:39:58 INFO - PROCESS | 1719 | RSS: Main: 187453440 18:39:58 INFO - PROCESS | 1719 | 18:40:01 INFO - PROCESS | 1719 | Cycle 1(1): loaded http://localhost:46561/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46561/tests/kraken/driver.html?testName=audio-beat-detection) 18:40:02 INFO - PROCESS | 1719 | RSS: Main: 199598080 18:40:02 INFO - PROCESS | 1719 | 18:40:05 INFO - PROCESS | 1719 | Cycle 1(1): loaded http://localhost:46561/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46561/tests/kraken/driver.html?testName=audio-dft) 18:40:05 INFO - PROCESS | 1719 | RSS: Main: 198152192 18:40:05 INFO - PROCESS | 1719 | 18:40:08 INFO - PROCESS | 1719 | Cycle 1(1): loaded http://localhost:46561/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46561/tests/kraken/driver.html?testName=audio-fft) 18:40:09 INFO - PROCESS | 1719 | RSS: Main: 194342912 18:40:09 INFO - PROCESS | 1719 | 18:40:11 INFO - PROCESS | 1719 | Cycle 1(1): loaded http://localhost:46561/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46561/tests/kraken/driver.html?testName=audio-oscillator) 18:40:12 INFO - PROCESS | 1719 | RSS: Main: 194961408 18:40:12 INFO - PROCESS | 1719 | 18:40:14 INFO - PROCESS | 1719 | Cycle 1(1): loaded http://localhost:46561/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46561/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:40:15 INFO - PROCESS | 1719 | RSS: Main: 195416064 18:40:15 INFO - PROCESS | 1719 | 18:40:18 INFO - PROCESS | 1719 | Cycle 1(1): loaded http://localhost:46561/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46561/tests/kraken/driver.html?testName=imaging-darkroom) 18:40:18 INFO - PROCESS | 1719 | RSS: Main: 200454144 18:40:18 INFO - PROCESS | 1719 | 18:40:22 INFO - PROCESS | 1719 | Cycle 1(1): loaded http://localhost:46561/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46561/tests/kraken/driver.html?testName=imaging-desaturate) 18:40:23 INFO - PROCESS | 1719 | RSS: Main: 196923392 18:40:23 INFO - PROCESS | 1719 | 18:40:26 INFO - PROCESS | 1719 | Cycle 1(1): loaded http://localhost:46561/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46561/tests/kraken/driver.html?testName=json-parse-financial) 18:40:26 INFO - PROCESS | 1719 | RSS: Main: 198361088 18:40:26 INFO - PROCESS | 1719 | 18:40:28 INFO - PROCESS | 1719 | Cycle 1(1): loaded http://localhost:46561/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46561/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:40:29 INFO - PROCESS | 1719 | RSS: Main: 198017024 18:40:29 INFO - PROCESS | 1719 | 18:40:30 INFO - PROCESS | 1719 | Cycle 1(1): loaded http://localhost:46561/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46561/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:40:31 INFO - PROCESS | 1719 | RSS: Main: 198172672 18:40:31 INFO - PROCESS | 1719 | 18:40:33 INFO - PROCESS | 1719 | Cycle 1(1): loaded http://localhost:46561/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46561/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:40:34 INFO - PROCESS | 1719 | RSS: Main: 198197248 18:40:34 INFO - PROCESS | 1719 | 18:40:37 INFO - PROCESS | 1719 | Cycle 1(1): loaded http://localhost:46561/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46561/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:40:38 INFO - PROCESS | 1719 | RSS: Main: 198656000 18:40:38 INFO - PROCESS | 1719 | 18:40:41 INFO - PROCESS | 1719 | Cycle 1(1): loaded http://localhost:46561/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46561/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:40:41 INFO - PROCESS | 1719 | RSS: Main: 198459392 18:40:41 INFO - PROCESS | 1719 | 18:40:43 INFO - PROCESS | 1719 | Cycle 1(1): loaded http://localhost:46561/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46561/tests/kraken/driver.html?testName=ai-astar) 18:40:43 INFO - PROCESS | 1719 | RSS: Main: 201478144 18:40:43 INFO - PROCESS | 1719 | 18:40:43 INFO - PROCESS | 1719 | __start_tp_report 18:40:43 INFO - PROCESS | 1719 | _x_x_mozilla_page_load 18:40:43 INFO - PROCESS | 1719 | _x_x_mozilla_page_load_details 18:40:43 INFO - PROCESS | 1719 | |i|pagename|runs| 18:40:43 INFO - PROCESS | 1719 | |0;ai-astar;111;119;118;119;121;117;119;119;119;118 18:40:43 INFO - PROCESS | 1719 | |1;audio-beat-detection;158;131;137;168;134;138;135;131;158;137 18:40:43 INFO - PROCESS | 1719 | |2;audio-dft;166;177;164;163;162;162;165;166;163;164 18:40:43 INFO - PROCESS | 1719 | |3;audio-fft;77;76;79;113;77;77;76;77;101;76 18:40:43 INFO - PROCESS | 1719 | |4;audio-oscillator;85;87;109;83;83;84;97;83;84;106 18:40:43 INFO - PROCESS | 1719 | |5;imaging-gaussian-blur;118;119;119;122;118;117;120;120;118;119 18:40:43 INFO - PROCESS | 1719 | |6;imaging-darkroom;149;147;149;149;148;151;147;152;149;149 18:40:43 INFO - PROCESS | 1719 | |7;imaging-desaturate;96;97;96;96;96;97;98;98;96;97 18:40:44 INFO - PROCESS | 1719 | |8;json-parse-financial;65;66;66;64;67;67;70;67;67;67 18:40:44 INFO - PROCESS | 1719 | |9;json-stringify-tinderbox;66;68;67;66;67;66;66;67;67;68 18:40:44 INFO - PROCESS | 1719 | |10;stanford-crypto-aes;86;92;92;86;86;100;92;86;87;87 18:40:44 INFO - PROCESS | 1719 | |11;stanford-crypto-ccm;150;150;148;158;150;157;146;145;197;146 18:40:44 INFO - PROCESS | 1719 | |12;stanford-crypto-pbkdf2;185;184;182;181;183;180;184;188;187;183 18:40:44 INFO - PROCESS | 1719 | |13;stanford-crypto-sha256-iterative;79;75;73;73;72;71;75;71;75;72 18:40:44 INFO - PROCESS | 1719 | __end_tp_report 18:40:44 INFO - PROCESS | 1719 | __start_cc_report 18:40:44 INFO - PROCESS | 1719 | _x_x_mozilla_cycle_collect,892 18:40:44 INFO - PROCESS | 1719 | __end_cc_report 18:40:44 INFO - PROCESS | 1719 | __startTimestamp1480560043992__endTimestamp 18:40:44 INFO - PROCESS | 1719 | 18:40:44 INFO - PROCESS | 1719 | ------- Summary: start ------- 18:40:44 INFO - PROCESS | 1719 | Number of tests: 14 18:40:44 INFO - PROCESS | 1719 | 18:40:44 INFO - PROCESS | 1719 | [#0] ai-astar Cycles:10 Average:118.00 Median:119.00 stddev:2.67 (2.2%) stddev-sans-first:1.09 18:40:44 INFO - PROCESS | 1719 | Values: 111.0 119.0 118.0 119.0 121.0 117.0 119.0 119.0 119.0 118.0 18:40:44 INFO - PROCESS | 1719 | 18:40:44 INFO - PROCESS | 1719 | [#1] audio-beat-detection Cycles:10 Average:142.70 Median:137.50 stddev:13.35 (9.7%) stddev-sans-first:12.96 18:40:44 INFO - PROCESS | 1719 | Values: 158.0 131.0 137.0 168.0 134.0 138.0 135.0 131.0 158.0 137.0 18:40:44 INFO - PROCESS | 1719 | 18:40:44 INFO - PROCESS | 1719 | [#2] audio-dft Cycles:10 Average:165.20 Median:164.50 stddev:4.39 (2.7%) stddev-sans-first:4.65 18:40:44 INFO - PROCESS | 1719 | Values: 166.0 177.0 164.0 163.0 162.0 162.0 165.0 166.0 163.0 164.0 18:40:44 INFO - PROCESS | 1719 | 18:40:44 INFO - PROCESS | 1719 | [#3] audio-fft Cycles:10 Average:82.90 Median:77.00 stddev:13.04 (16.9%) stddev-sans-first:13.66 18:40:44 INFO - PROCESS | 1719 | Values: 77.0 76.0 79.0 113.0 77.0 77.0 76.0 77.0 101.0 76.0 18:40:44 INFO - PROCESS | 1719 | 18:40:44 INFO - PROCESS | 1719 | [#4] audio-oscillator Cycles:10 Average:90.10 Median:84.00 stddev:10.10 (12.0%) stddev-sans-first:10.55 18:40:44 INFO - PROCESS | 1719 | Values: 85.0 87.0 109.0 83.0 83.0 84.0 97.0 83.0 84.0 106.0 18:40:44 INFO - PROCESS | 1719 | 18:40:44 INFO - PROCESS | 1719 | [#5] imaging-gaussian-blur Cycles:10 Average:119.00 Median:119.00 stddev:1.41 (1.2%) stddev-sans-first:1.45 18:40:44 INFO - PROCESS | 1719 | Values: 118.0 119.0 119.0 122.0 118.0 117.0 120.0 120.0 118.0 119.0 18:40:44 INFO - PROCESS | 1719 | 18:40:44 INFO - PROCESS | 1719 | [#6] imaging-darkroom Cycles:10 Average:149.00 Median:149.00 stddev:1.56 (1.0%) stddev-sans-first:1.66 18:40:44 INFO - PROCESS | 1719 | Values: 149.0 147.0 149.0 149.0 148.0 151.0 147.0 152.0 149.0 149.0 18:40:44 INFO - PROCESS | 1719 | 18:40:44 INFO - PROCESS | 1719 | [#7] imaging-desaturate Cycles:10 Average:96.70 Median:97.00 stddev:0.82 (0.8%) stddev-sans-first:0.83 18:40:44 INFO - PROCESS | 1719 | Values: 96.0 97.0 96.0 96.0 96.0 97.0 98.0 98.0 96.0 97.0 18:40:44 INFO - PROCESS | 1719 | 18:40:44 INFO - PROCESS | 1719 | [#8] json-parse-financial Cycles:10 Average:66.60 Median:67.00 stddev:1.58 (2.4%) stddev-sans-first:1.56 18:40:44 INFO - PROCESS | 1719 | Values: 65.0 66.0 66.0 64.0 67.0 67.0 70.0 67.0 67.0 67.0 18:40:44 INFO - PROCESS | 1719 | 18:40:44 INFO - PROCESS | 1719 | [#9] json-stringify-tinderbox Cycles:10 Average:66.80 Median:67.00 stddev:0.79 (1.2%) stddev-sans-first:0.78 18:40:44 INFO - PROCESS | 1719 | Values: 66.0 68.0 67.0 66.0 67.0 66.0 66.0 67.0 67.0 68.0 18:40:44 INFO - PROCESS | 1719 | 18:40:44 INFO - PROCESS | 1719 | [#10] stanford-crypto-aes Cycles:10 Average:89.40 Median:87.00 stddev:4.60 (5.3%) stddev-sans-first:4.71 18:40:44 INFO - PROCESS | 1719 | Values: 86.0 92.0 92.0 86.0 86.0 100.0 92.0 86.0 87.0 87.0 18:40:44 INFO - PROCESS | 1719 | 18:40:44 INFO - PROCESS | 1719 | [#11] stanford-crypto-ccm Cycles:10 Average:154.70 Median:150.00 stddev:15.50 (10.3%) stddev-sans-first:16.35 18:40:44 INFO - PROCESS | 1719 | Values: 150.0 150.0 148.0 158.0 150.0 157.0 146.0 145.0 197.0 146.0 18:40:44 INFO - PROCESS | 1719 | 18:40:44 INFO - PROCESS | 1719 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:183.70 Median:184.00 stddev:2.50 (1.4%) stddev-sans-first:2.60 18:40:44 INFO - PROCESS | 1719 | Values: 185.0 184.0 182.0 181.0 183.0 180.0 184.0 188.0 187.0 183.0 18:40:44 INFO - PROCESS | 1719 | 18:40:44 INFO - PROCESS | 1719 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.60 Median:74.00 stddev:2.46 (3.3%) stddev-sans-first:1.66 18:40:44 INFO - PROCESS | 1719 | Values: 79.0 75.0 73.0 73.0 72.0 71.0 75.0 71.0 75.0 72.0 18:40:44 INFO - PROCESS | 1719 | -------- Summary: end -------- 18:40:44 INFO - PROCESS | 1719 | 18:40:45 INFO - TEST-INFO | 1719: exit 0 18:40:45 INFO - TEST-OK | kraken | took 65605ms 18:40:45 INFO - SUITE-END | took 1186s 18:40:45 INFO - Completed test suite (00:19:46) 18:40:45 INFO - javascript benchmark 18:40:45 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6181.304750704458, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2583.5607946649075, 2599.909003184889, 2606.0, 2625.159948816379, 2632.2629663694174, 4592.816287348502, 4717.339572459854, 4720.291956206566, 4726.220173671344, 4737.597304229136, 4631.3516107744945, 4708.505606911268, 4739.573438390544, 4741.075490279397, 4826.372571565692, 4316.179925814093, 4357.716748411359, 4372.934405983913, 4433.556644335573, 4452.332150177467, 3971.245463361952, 4384.714993525411, 4413.7793110344355, 4432.290833466646, 4439.223135951212, 4240.300350442173, 4354.08564201518, 4385.057212699285, 4409.228385032622, 4450.443694538183, 4239.788010599457, 4282.528921818597, 4316.6546676265825, 4355.7822108894425, 4390.319500477399, 4286.3784751211215, 4308.612224899743, 4320.567943205686, 4339.891502712426, 4357.716748411375, 4696.154692155411, 4710.480919760275, 4727.385439892826, 4727.692699974491, 4761.2382018876815, 4862.878428039292, 4872.707637541759, 4889.902201955976, 4897.069556784199, 4929.507049295042, 4955.98402327522, 4958.801647934079, 4961.305417241589, 4968.925466118011, 4980.87547811304, 4595.678302518859, 4632.305154226826, 4661.930071048937, 4682.742449165295, 4716.410448693913, 4979.4771548987555, 5018.673786203885, 5067.163917953497, 5093.694378337312, 5105.821296254688, 4915.18899381598, 4947.109520286311, 4947.802087916515, 4960.0, 4961.82633607822, 4904.117258893433, 5077.060743762342, 5089.796408143707, 5100.48995100487, 5131.409887862944, 4914.459409464956, 4941.950580494221, 4983.07813054586, 4991.376077990251, 5003.72479513623, 4933.827316043921, 4939.209726443752, 4971.65198436106, 4988.077205716954, 5006.449290578106, 4437.622802061796, 4438.245498265303, 4476.127155204704, 4482.551744825557, 4491.461024676994, 3768.1144930941205, 3793.677537409296, 3820.522434695663, 3874.767513949172, 3892.805359732002, 4316.805743741539, 4323.978380108142, 4353.804078816461, 4419.11617676466, 4422.955770442319, 5058.570021548136, 5060.898782024339, 5072.340595722532, 5073.923891141636, 5106.0, 4365.257906155961, 4365.628921541641, 4375.759333236702, 4381.3208952612395, 4408.55914408563, 4518.570735780096, 4550.522195169526, 4551.3173024046655, 4624.075184963021, 4628.490866004737, 4688.2030054890065, 4729.17239483096, 4736.526347365236, 4737.265723812815, 4741.2651039089, 5031.9245211322595, 5063.670861393997, 5065.544101030925, 5068.518490743373, 5070.746462676778, 4708.152532544175, 4710.1757192490495, 4742.715437073786, 4746.810127594996, 4830.710157390427, 5016.473270306566, 5016.849494515171, 5017.422996355466, 5025.723585202849, 5057.797688092435, 5110.029094472038, 5110.97444512775, 5111.923321150261, 5127.179651255781, 5128.1794912813775, 4754.310624959292, 4786.545278198566, 4790.0, 4847.103285892122, 4858.27125931099, 4841.0, 4848.296996935495, 4850.248211527219, 4855.417349918032, 4889.975550122226, 4791.664583479123, 4842.15262329084, 4853.611711063177, 4884.316195732671, 4892.217245240744, 4779.784909679003, 4828.66199366055, 4861.902761944671, 4886.291487734187, 4906.288588154769, 4792.353032340589, 4797.952020479751, 4799.616030717464, 4809.134355815987, 4817.397825271841], "value": 4623.104519742681, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [536.8738346488575, 551.6938099354859, 555.9138333558298, 557.7840308128278, 582.3710392775803, 33151.66848331516, 36624.45063324052, 36653.26693466129, 36701.81649091754, 36744.816275918616, 35981.46027809585, 36181.276374472494, 36201.0, 36244.0, 36376.0, 7375.893615957609, 7503.362214211771, 7594.164641889415, 9359.95320023399, 9701.90298097017, 9911.0, 9975.152112070482, 9984.45085520296, 9999.0, 10024.59901603935, 10000.59997600095, 10047.397156170617, 10049.89950100497, 10069.496525173749, 10077.949610251939, 9837.311388202828, 9893.90106098937, 9900.900990990142, 9914.454704991223, 9918.702438926772, 9839.065288797625, 9883.604655813759, 9884.80230395388, 9888.752781180456, 9932.702018939442, 36620.26759464823, 36710.449343259876, 36766.44850327247, 36800.079997999994, 36812.44781328282, 2861.413410250894, 2997.1607949774098, 3039.2553824312963, 3043.5434684797237, 3046.9847650761603, 26691.733082669314, 27229.45541089167, 27568.172954811387, 27730.0, 28154.577681334795, 3278.967210327914, 3403.727701783876, 3436.6391528889358, 3456.412409890325, 3456.412409890325, 237717.81141094357, 240068.79965600235, 240452.0, 240911.0, 241258.0, 50212.49787502078, 50706.74646626743, 50812.745936270825, 50856.491435085176, 50974.0, 53814.46185538094, 53981.0, 54007.45992540103, 54077.0, 54248.45751542513, 11666.650000499998, 11970.82043769344, 11976.640700778991, 12000.159988800875, 12008.579699710468, 7549.2073332300415, 7801.063872335242, 9339.859902101474, 9466.810663786686, 9517.90482095184, 16679.583010424594, 16901.661966760596, 16974.0, 17128.229229684694, 17306.567335816704, 6319.894018546736, 6460.612363258219, 6558.179737892645, 6566.277709451956, 6710.194776626836, 765.8008917681332, 828.8176601147737, 858.7037472072125, 867.2324992381788, 952.2715122930963, 26308.21075367742, 27646.447071058465, 27764.0, 27997.44005119886, 28085.157445276673, 932.7901222225081, 965.165132160676, 980.2403137568441, 980.2745967983641, 1000.7848312612823, 14601.0, 14622.341994610268, 14652.113506651856, 14663.780043299359, 14781.187034712979, 349937.0, 351920.0, 353414.0, 356320.0, 357684.0, 48135.75932120317, 48342.516574833804, 48487.27269090967, 48537.0, 48780.75609622, 1121.7307846117037, 1153.6827372472637, 1157.548556063136, 1158.0561842098662, 1162.2619636530694, 24843.62734558947, 25646.487070258117, 27048.0, 27146.185614431597, 27259.86370068137, 40950.0, 44994.0, 46768.766156169004, 47033.0, 51999.0, 326458.0, 330024.0, 330043.0, 330496.0, 330525.0, 30889.0, 31787.6821231794, 33335.49996750099, 35356.292874142884, 36930.26139477249, 37423.0, 37627.623723762415, 37725.4341184877, 38804.223915522096, 38918.80540597279, 32126.0, 32571.34857302888, 32573.674263258014, 32915.0, 33053.0, 32623.510647340783, 33339.0, 33629.83185084059, 34174.65825341814, 34638.82680586581, 32985.67014329826, 33257.66742332546, 33458.66541334653, 33603.83198083994, 33926.830365848014, 27987.58018629763, 30392.392152157274, 30856.537151943186, 30990.845045774626, 31063.689363106983, 23371.88314058487, 23488.765112348658, 23701.28896133119, 23702.407439814142, 23774.0], "value": 17357.197281766013, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [343.63746247708656, 354.2613650538627, 355.957045855643, 361.2738395824392, 361.5950135847851, 15298.694026119485, 16011.27949242284, 16816.0, 16954.0, 17049.57376065599, 13938.790918136236, 14798.556043318691, 15530.37878484862, 15659.921700391511, 16292.918535407307, 4551.544845515455, 5123.180291153416, 5205.86985325368, 5215.791368345262, 5217.947820521803, 3345.4145524533233, 5141.15170996785, 5141.897162056756, 5179.8446046618665, 5184.351956005499, 3510.7366947478913, 5105.132127538327, 5352.277442545265, 5378.838634840941, 5430.864228394302, 5077.49225077493, 5420.24116623673, 5430.266913966603, 5437.972810135963, 5445.9727701361435, 5146.150885103953, 5250.842474725764, 5276.657017293864, 5277.208418737182, 5278.392984806719, 19279.614407711906, 19454.124564394635, 19607.607847842963, 19700.80299197004, 19875.60248795016, 1744.9127543622894, 1778.0931724820434, 1956.628240634289, 2078.418042947977, 2351.0478256306224, 8600.483970961763, 8858.955705221497, 8931.106889311017, 9092.454452732858, 12218.20581662189, 1666.7916510436196, 1687.1817168673183, 1711.1358763824314, 1737.3832289537158, 1746.1007581095746, 65284.0, 65857.0, 66427.3357266426, 66514.0, 68570.0, 9932.851007234898, 9939.850902236472, 9961.452120133463, 10713.089387402159, 10818.350898946088, 13657.453701852013, 13684.657883552793, 13689.110207836458, 13706.109102908278, 13741.312934353242, 6527.608343499405, 6603.70283337251, 6694.389188216599, 6713.0937323461685, 6802.829929251809, 5856.94143058564, 6146.262448506208, 6300.842478938063, 6320.336364681642, 6321.841953951096, 4170.35359519275, 4256.6807489438415, 4300.37644541546, 4344.1311737652595, 4363.607275345171, 1760.7094829353268, 1819.2995696656883, 1821.6629923463936, 1862.320253107606, 1869.2242719271621, 821.9424640275123, 841.6449516278786, 870.0, 912.9543522823832, 918.0498184379136, 15863.762043569355, 16289.755653665205, 16351.918240408722, 16489.587760305847, 16783.83216167847, 815.404754529197, 822.9300509456643, 874.8775171475999, 880.8722735203488, 922.4972390047441, 8931.151540603632, 9274.629014839466, 9304.488253146143, 9443.716688499357, 9490.861096668306, 345067.0, 348580.0, 352156.0, 353159.0, 357220.0, 52272.738636306574, 56230.71884640632, 74523.25476745272, 75326.62336688282, 75421.62289188518, 862.9395942283979, 892.7143314139543, 894.3784070071238, 895.359817730326, 897.3090720145582, 14677.0, 14867.776983345475, 14920.0, 14933.253337333308, 15194.088354698753, 35819.462708058876, 37286.25427491489, 38022.0, 38322.616773831905, 38701.22597547977, 49362.75318623384, 51248.23127653014, 51252.74373628108, 52188.217176743135, 52315.73842130765, 6998.0, 7344.9632751838035, 7356.705731770883, 7493.100827900686, 7880.487768295043, 10353.0, 11121.388323642277, 11316.773664526829, 11548.076153907836, 11764.882351176379, 10038.498075096362, 10049.69850904474, 10162.74593135148, 10383.84424233622, 10621.309614875008, 9809.558569864515, 10055.547500362354, 10089.747756306151, 10105.242106842163, 10115.494225288854, 10242.283040187116, 10393.480325983519, 10488.160947124059, 10922.726931826768, 11074.944625276821, 7420.480566360303, 7525.2098529653595, 7679.155292917886, 7734.8839767402405, 7853.214678532101, 9153.359264851397, 10151.796964060824, 10174.745631359276, 10385.792284154124, 10715.196360273167], "value": 7967.560602807505, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1302.9153105048174, 1350.4598160735707, 1371.7873729571913, 1569.136974663936, 1581.7073841339354, 5987.610805297652, 6196.287426945903, 6646.4682825373975, 7060.1880783709885, 7086.114235720535, 6635.336466353362, 6887.4834387421015, 6920.4809639277, 6992.5454845435015, 7082.752103676372, 2074.595453886489, 2110.4407332057017, 2112.683097535374, 2113.355426594888, 2114.2811444109, 1768.8673349498774, 1832.2029916986087, 2049.463682515854, 2092.1003968293626, 2092.790720927903, 1980.861339706221, 2044.417341057799, 2047.2015913793632, 2065.5455799724036, 2065.5868826234814, 2021.070307658479, 2047.938561843147, 2059.2483743433613, 2071.6892466130053, 2079.2722547108465, 2081.6773400123006, 2093.1731965873396, 2097.1716172112083, 2104.200403846544, 2105.200023990874, 6611.6033038017395, 6683.064370988066, 6719.361660642231, 6800.387965083166, 6835.897461538081, 4070.1656160487028, 4168.312228482297, 4168.458100446953, 4174.979125104385, 4203.810828512694, 2540.872956352175, 2618.2537976676554, 2830.815996960191, 2839.346950201465, 2856.7714582833323, 899.9460032398077, 925.4354843545432, 926.8887733472027, 927.8793756811639, 946.2760987844305, 9114.908850911472, 9126.680566180152, 9155.40489868163, 9155.496447695374, 9162.083791620851, 3747.3254814133174, 3881.146147847469, 3905.7070719696135, 3926.9018274543364, 3953.367461206193, 7910.090339610903, 7962.840743185104, 7974.641141148662, 7983.12185659577, 7984.24149705777, 4102.0, 4106.733062350938, 4106.815193316308, 4106.938395924063, 4113.177364527047, 3703.703703703697, 3743.6817870481314, 3747.2130852521277, 3747.3442147624055, 3750.3436898542645, 3246.951295730566, 3316.3201543683485, 3336.8164750938445, 3361.5125806758374, 3413.1467133216697, 984.6504490905626, 1032.8863824979246, 1095.315427857589, 1103.448275862069, 1103.8013157631542, 630.5901164243279, 676.6785776756002, 697.8429853282971, 762.3786613909646, 778.875379939207, 4334.891627709332, 4368.890777730582, 4451.221036318631, 4508.661850361236, 4564.064366804797, 741.9035525381665, 749.4491548711693, 755.0712623473158, 794.1780257433528, 811.9391045671598, 3009.5786589877434, 3029.5910052143117, 3066.7853250272715, 3069.4628440022907, 3131.2171957010746, 7816.960915195387, 8039.638216280281, 8093.716719914774, 8150.877736833952, 8163.591820408956, 8099.595020248964, 8104.878426823602, 8118.675252989932, 8131.227533384319, 8135.227153420416, 6343.9682801585695, 6367.204099487564, 6384.52116091295, 6460.903086453707, 6472.708728107246, 4155.937660935028, 4192.140611174763, 4210.136921930935, 4303.354496825376, 4380.846670366522, 7512.211217822269, 7532.623368831646, 7563.848723025399, 7586.582737949466, 7625.084989801259, 7585.393168546393, 7671.693132274647, 7671.69313227487, 7686.116096648957, 7700.114486834086, 5850.444207800252, 6024.7288872001745, 6037.094435834484, 6101.420365065312, 6106.0, 6699.19609646826, 6855.897161542681, 6859.897101543581, 6870.416014638811, 6880.793576192722, 6213.471854892385, 6276.0, 6349.460295874902, 6467.967660161669, 6548.967255163694, 6199.411055949678, 6233.314335423191, 6279.686015699288, 6284.968575157278, 6353.7140828661895, 5819.5053420459735, 5907.172995780508, 5918.911216331672, 5935.495482883831, 5945.791897283574, 3751.4560388742934, 3761.9435708464944, 3856.9228615428096, 3913.2173565287626, 3921.588233235469, 4110.219058378899, 4116.835326586903, 4183.121544475573, 4209.305464598307, 4242.109157076925], "value": 3708.8988424433082, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [257.66889546932185, 269.68042869199985, 271.7269144509767, 280.8974724225658, 286.32855952790703, 4804.399450068741, 4939.259111133323, 4962.925556116661, 5011.148104822179, 5026.849194524166, 4732.2428411454175, 4867.707937523742, 4873.0, 4885.828995985141, 4891.4374846892615, 3822.8661996830115, 3824.5984171661994, 3834.789086600236, 3840.4047372657283, 3858.7105967052585, 3852.268069066882, 3855.768653880762, 3859.6333348332005, 3862.86479973201, 3874.9850077959445, 3574.5889222739456, 3725.88822335329, 3774.830132644038, 3782.6595606395417, 3783.451399547064, 3758.49260349852, 3774.1508160663907, 3776.244751049801, 3777.7166712496537, 3783.735138540303, 3249.5613092232484, 3288.3722557334036, 3294.0, 3294.8352582371026, 3309.271960168783, 4707.199776038082, 4767.475577686451, 4793.411557758806, 4797.904041919142, 4809.422869255677, 4247.68142389322, 4280.743155410654, 4282.336237883133, 4282.635975942048, 4290.541215986579, 5116.948830511685, 5117.897642047138, 5123.538881500683, 5132.948670513284, 5142.3829140503, 3541.0793193769805, 3574.5889222739456, 3582.42681171014, 3583.140046388874, 3583.552055993001, 5166.844994650167, 5297.708626025567, 5366.9069063065435, 5413.188021796723, 5413.593980451443, 3634.637959887094, 3640.3265395901844, 3640.5449318835144, 3645.8906232813056, 3654.14127679995, 3691.520102386726, 3693.6121707220354, 3699.8520059197867, 3707.7219208558927, 3712.406015037581, 4053.412255222976, 4262.786860656955, 4275.508316543637, 4285.892852678708, 4292.785360731951, 5167.803683434526, 5182.0, 5184.481551844785, 5185.377754669464, 5199.66202196856, 1212.8120141378101, 1242.8508578970582, 1253.7116463213329, 1255.3848614178987, 1261.9621411357673, 808.878668199763, 829.701307529289, 839.3075712537182, 839.7816567692444, 841.6885752271576, 4421.071574969228, 4422.601965823027, 4429.224885645063, 4449.933251001173, 4477.32840073985, 5159.948400516022, 5185.159268459718, 5191.844244672666, 5193.091209038404, 5199.4540573239265, 4324.675649326313, 4400.317950717644, 4407.118576284692, 4421.425214722066, 4433.889152771207, 2599.9032318584523, 2702.473017761557, 2715.91852244433, 2717.6331195288385, 2731.7541421271785, 4763.95236047642, 4774.350235619265, 4820.3847114664, 4849.878753031202, 4855.465898751135, 5056.0, 5182.714950677749, 5195.610329225323, 5202.892828404502, 5207.479252074762, 4650.4186976627925, 4714.363560919301, 4738.00501894606, 4773.618110551217, 4783.804048987753, 5092.261622064854, 5112.903709479096, 5116.676408434867, 5126.53861152498, 5153.4073581538605, 4849.563539281482, 4987.576056035277, 5013.448520662651, 5021.347224860745, 5063.518965698253, 4759.286107083965, 4773.785179666854, 4779.880502987314, 4799.0, 4819.734724679395, 3501.614822369588, 3528.594211665691, 3535.4343305071066, 3540.1149712571855, 3545.734069944816, 5088.338515992898, 5106.565941894981, 5113.846584602468, 5114.578546740467, 5124.436312005751, 4690.695104818176, 5143.974280128576, 5198.816497071163, 5198.870028249324, 5199.246109314053, 5161.66449180802, 5169.81905633301, 5175.508326708957, 5177.663451875616, 5184.662996905189, 4902.289168070681, 5093.745312734274, 5118.74406279692, 5123.513266239701, 5145.61407894402, 5140.820071297487, 5175.042617115695, 5197.194434862451, 5199.71401572902, 5209.505097015777, 5080.593552515864, 5083.72039537829, 5090.974545127251, 5093.388793344822, 5093.516115968977], "value": 3791.6004296033584, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [635.2789583822362, 661.6096503063192, 679.7654809090861, 714.5034201230147, 724.6195747232704, 11619.709507262312, 12377.628671139857, 12677.556285530009, 12739.872601273984, 12930.159539629918, 11672.591459298927, 11811.291322520654, 11811.881881181185, 11915.0467962563, 11939.641810745692, 594.2126682146152, 743.4089898530667, 757.696921231509, 760.1524300405064, 766.5400759544284, 619.4332186049782, 737.4211244173325, 756.9318761311481, 765.9042619672541, 767.2365995834125, 802.7591722483261, 804.6539987805241, 805.2269820971874, 805.4040010392326, 805.8509175802495, 804.6057431858377, 804.7867315161487, 805.480465100013, 805.5529181304373, 806.1535387842741, 587.8971180043518, 588.5674029588249, 589.2398805540847, 589.8997170481028, 590.344717363726, 12213.206141600767, 12372.381380931007, 12385.0, 12401.069919755964, 12445.564405245863, 12886.54897078607, 13086.934565327208, 13098.803517947143, 13134.540291089861, 13434.798478022838, 9853.310268281222, 9925.652602158962, 10012.499375031291, 10317.896821031769, 10381.42902140382, 4015.15681706839, 4026.355783074723, 4117.464729585165, 4123.793810309502, 4143.502779666429, 62868.371316286706, 63408.0, 63799.448022079065, 64166.358336416975, 66472.33527664759, 9899.356541824758, 9953.701388958343, 10109.64616238428, 10124.240681948737, 10166.135878450266, 17058.0, 17116.486505404857, 17137.143142842808, 17150.828491715172, 17191.0, 6385.361463853577, 6484.1246431731115, 6611.933880661228, 6616.86766264672, 6641.369069938348, 3500.0899766060497, 3506.403911335079, 3538.1862171700654, 3583.1937813991644, 3604.4773507841214, 2809.873555689958, 2923.6053132826796, 2941.352902361477, 2941.57347184657, 2942.5586162075433, 457.70478041662943, 464.39860380806937, 467.87367410798896, 474.69382248450245, 487.4029314090282, 497.3807609526163, 595.2440400691098, 607.4138456389605, 610.4231501231383, 613.2977740487206, 7578.204288549623, 7711.380610071836, 7836.294733474015, 7921.366290696846, 8112.716054938167, 475.28469653171754, 588.5960747071831, 595.6694034810722, 598.964062156272, 620.7268801727225, 3935.980320098381, 4002.2795896738867, 4097.959020409758, 4108.157827645326, 4279.801655536455, 62096.0, 67533.0, 72964.0, 73696.63151684315, 74177.6291118541, 54974.0, 55679.164812527844, 56249.7187514068, 56700.43299567034, 57632.71183644139, 50328.748356258715, 50417.0, 51652.74173629108, 52791.472085278656, 53295.467045329824, 7622.9716719958005, 7818.413618978486, 7985.281324680806, 8111.472754270953, 8146.877796833171, 35331.82334088313, 35462.645373545936, 35894.0, 36217.81891090528, 36362.09103271679, 44800.55199447964, 46434.0, 49732.0, 49977.25034124418, 51312.486875132265, 10963.561457541928, 11082.61210857616, 11082.72276292621, 11419.689844222476, 11477.253978491372, 12628.242305461701, 13082.607521774362, 13207.933960330136, 13618.659533511345, 14086.366113524711, 11462.828057578976, 11809.0, 11921.165518413627, 12186.0, 12395.256284622952, 11939.164258501822, 12256.325902075472, 12306.031574686449, 12615.243085414904, 12836.871631283568, 11709.180357375242, 11894.286342819458, 12104.75790484203, 12412.0, 12497.0, 9357.53212339394, 9490.572924218564, 9546.713598591776, 9801.85297220528, 9824.557894894604, 8597.828043439222, 8599.82800343977, 9040.819183616422, 9430.481323527272, 9729.367591106555], "value": 6203.276675233847, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1598.4, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 119.0, 118.0, 119.0, 121.0, 117.0, 119.0, 119.0, 119.0, 118.0], "value": 118.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 131.0, 137.0, 168.0, 134.0, 138.0, 135.0, 131.0, 158.0, 137.0], "value": 142.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 177.0, 164.0, 163.0, 162.0, 162.0, 165.0, 166.0, 163.0, 164.0], "value": 165.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 79.0, 113.0, 77.0, 77.0, 76.0, 77.0, 101.0, 76.0], "value": 82.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 87.0, 109.0, 83.0, 83.0, 84.0, 97.0, 83.0, 84.0, 106.0], "value": 90.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 119.0, 119.0, 122.0, 118.0, 117.0, 120.0, 120.0, 118.0, 119.0], "value": 119.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 147.0, 149.0, 149.0, 148.0, 151.0, 147.0, 152.0, 149.0, 149.0], "value": 149.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 97.0, 96.0, 96.0, 96.0, 97.0, 98.0, 98.0, 96.0, 97.0], "value": 96.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 66.0, 64.0, 67.0, 67.0, 70.0, 67.0, 67.0, 67.0], "value": 66.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 68.0, 67.0, 66.0, 67.0, 66.0, 66.0, 67.0, 67.0, 68.0], "value": 66.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 92.0, 92.0, 86.0, 86.0, 100.0, 92.0, 86.0, 87.0, 87.0], "value": 89.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 150.0, 148.0, 158.0, 150.0, 157.0, 146.0, 145.0, 197.0, 146.0], "value": 154.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 184.0, 182.0, 181.0, 183.0, 180.0, 184.0, 188.0, 187.0, 183.0], "value": 183.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 75.0, 73.0, 73.0, 72.0, 71.0, 75.0, 71.0, 75.0, 72.0], "value": 73.6, "unit": "score"}]}]} 18:40:45 INFO - Return code: 0 18:40:45 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:40:45 ERROR - # TBPL SUCCESS # 18:40:45 INFO - Running post-action listener: _resource_record_post_action 18:40:45 INFO - [mozharness: 2016-12-01 02:40:45.809401Z] Finished run-tests step (success) 18:40:45 INFO - Running post-run listener: _resource_record_post_run 18:40:45 INFO - Total resource usage - Wall time: 1203s; CPU: 13.0%; Read bytes: 4096; Write bytes: 407502848; Read time: 8; Write time: 270536 18:40:45 INFO - TinderboxPrint: CPU usage
13.5% 18:40:45 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 18:40:45 INFO - TinderboxPrint: I/O write bytes / time
407,502,848 / 270,536 18:40:45 INFO - TinderboxPrint: CPU idle
8,298.7 (86.5%) 18:40:45 INFO - TinderboxPrint: CPU user
1,232.9 (12.8%) 18:40:45 INFO - TinderboxPrint: Swap in / out
0 / 0 18:40:45 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 115814400; Read time: 0; Write time: 63112 18:40:45 INFO - run-tests - Wall time: 1187s; CPU: 14.0%; Read bytes: 0; Write bytes: 290521088; Read time: 0; Write time: 207392 18:40:46 INFO - Running post-run listener: _upload_blobber_files 18:40:46 INFO - Blob upload gear active. 18:40:46 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:40:46 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 18:40:46 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', 'Graphics', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 18:40:46 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 Graphics -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 18:40:46 INFO - (blobuploader) - INFO - Open directory for files ... 18:40:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:40:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:40:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:40:49 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:40:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:40:49 INFO - (blobuploader) - INFO - Done attempting. 18:40:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 18:40:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:40:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:40:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 18:40:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:40:50 INFO - (blobuploader) - INFO - Done attempting. 18:40:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 18:40:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:40:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:40:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 18:40:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:40:52 INFO - (blobuploader) - INFO - Done attempting. 18:40:52 INFO - (blobuploader) - INFO - Iteration through files over. 18:40:52 INFO - Return code: 0 18:40:52 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:40:52 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:40:52 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/588e6be36d36c3bb3b7a25ac823b197d5fd7bf426a0c45d5b98f66ac215b851fa7ca1b5d84001e2105237cb871e572bbba66e7ad74a46dafd48bd4c941eff05b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/a0845b011e42385dc110a92f3b97410430ab7a9d692a982cdde99679d14cc0363c9a488d728ca167f77fefff11d952fc288be7379cfe696e8dbe96fccdea0ee0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/8cbef59f5217dc5d9967f271863e482b2e3839da9654810fddf4c0db62c1d570ad518edcdf5be5d081b13509b687b15911499170de372c9a316273ae6579ac2c"} 18:40:52 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:40:52 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:40:52 INFO - Contents: 18:40:52 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/588e6be36d36c3bb3b7a25ac823b197d5fd7bf426a0c45d5b98f66ac215b851fa7ca1b5d84001e2105237cb871e572bbba66e7ad74a46dafd48bd4c941eff05b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/a0845b011e42385dc110a92f3b97410430ab7a9d692a982cdde99679d14cc0363c9a488d728ca167f77fefff11d952fc288be7379cfe696e8dbe96fccdea0ee0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/8cbef59f5217dc5d9967f271863e482b2e3839da9654810fddf4c0db62c1d570ad518edcdf5be5d081b13509b687b15911499170de372c9a316273ae6579ac2c"} 18:40:52 INFO - Running post-run listener: copy_logs_to_upload_dir 18:40:52 INFO - Copying logs to upload dir... 18:40:52 INFO - mkdir: /builds/slave/test/build/upload/logs 18:40:52 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.213263 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-11-30 18:40:52.330357) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-30 18:40:52.334219) ========= 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=0e2a256762fed810e2f0f810000001b3-1480557492.143370-1954135831 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/Graphics/sha512/588e6be36d36c3bb3b7a25ac823b197d5fd7bf426a0c45d5b98f66ac215b851fa7ca1b5d84001e2105237cb871e572bbba66e7ad74a46dafd48bd4c941eff05b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/a0845b011e42385dc110a92f3b97410430ab7a9d692a982cdde99679d14cc0363c9a488d728ca167f77fefff11d952fc288be7379cfe696e8dbe96fccdea0ee0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/8cbef59f5217dc5d9967f271863e482b2e3839da9654810fddf4c0db62c1d570ad518edcdf5be5d081b13509b687b15911499170de372c9a316273ae6579ac2c"} build_url:https://queue.taskcluster.net/v1/task/ULaXp8t_S42T1DoUQDxk8g/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011971 build_url: 'https://queue.taskcluster.net/v1/task/ULaXp8t_S42T1DoUQDxk8g/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/588e6be36d36c3bb3b7a25ac823b197d5fd7bf426a0c45d5b98f66ac215b851fa7ca1b5d84001e2105237cb871e572bbba66e7ad74a46dafd48bd4c941eff05b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/a0845b011e42385dc110a92f3b97410430ab7a9d692a982cdde99679d14cc0363c9a488d728ca167f77fefff11d952fc288be7379cfe696e8dbe96fccdea0ee0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Graphics/sha512/8cbef59f5217dc5d9967f271863e482b2e3839da9654810fddf4c0db62c1d570ad518edcdf5be5d081b13509b687b15911499170de372c9a316273ae6579ac2c"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-30 18:40:52.360849) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-30 18:40:52.361221) ========= 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=0e2a256762fed810e2f0f810000001b3-1480557492.143370-1954135831 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004586 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-30 18:40:52.445803) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-30 18:40:52.446172) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-30 18:40:52.446527) ========= ========= Total master_lag: 0.18 =========