builder: autoland_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-031 starttime: 1476196699.17 results: success (0) buildid: 20161011054447 builduid: c53832506fe34e938dcc27786f2f98fe revision: 51dc2ac80cf14d15b60cd92d843f12c77b4b53b3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-11 07:38:19.171625) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-11 07:38:19.172149) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-11 07:38:19.172469) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-11 07:38:19.187396) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-11 07:38:19.187762) ========= 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=db0483c52d987ecb441a263b000001ad-1476196698.153023-1915257621 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-11 07:38:19-- 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% 227M=0s 2016-10-11 07:38:19 (227 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.076610 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-11 07:38:19.280938) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-11 07:38:19.281314) ========= 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=db0483c52d987ecb441a263b000001ad-1476196698.153023-1915257621 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016889 ========= master_lag: 0.26 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-11 07:38:19.559428) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-11 07:38:19.559784) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 51dc2ac80cf14d15b60cd92d843f12c77b4b53b3 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev 51dc2ac80cf14d15b60cd92d843f12c77b4b53b3 --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=db0483c52d987ecb441a263b000001ad-1476196698.153023-1915257621 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-11 07:38:20,347 truncating revision to first 12 chars 2016-10-11 07:38:20,347 Setting DEBUG logging. 2016-10-11 07:38:20,347 attempt 1/10 2016-10-11 07:38:20,347 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/51dc2ac80cf1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-11 07:38:21,140 unpacking tar archive at: autoland-51dc2ac80cf1/testing/mozharness/ program finished with exit code 0 elapsedTime=1.157368 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-11 07:38:20.733822) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-11 07:38:20.734236) ========= script_repo_revision: 51dc2ac80cf14d15b60cd92d843f12c77b4b53b3 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-11 07:38:20.734617) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-11 07:38:20.734895) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-11 07:38:20.745638) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-10-11 07:38:20.746038) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO 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', '--add-option', '--webServer,localhost', '--branch-name', 'Autoland-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland-Non-PGO'] 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=db0483c52d987ecb441a263b000001ad-1476196698.153023-1915257621 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:38:21 INFO - MultiFileLogger online at 20161011 07:38:21 in /builds/slave/test 07:38:21 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO 07:38:21 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:38:21 INFO - {'append_to_log': False, 07:38:21 INFO - 'base_work_dir': '/builds/slave/test', 07:38:21 INFO - 'blob_upload_branch': 'Autoland-Non-PGO', 07:38:21 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:38:21 INFO - 'branch': 'Autoland-Non-PGO', 07:38:21 INFO - 'buildbot_json_path': 'buildprops.json', 07:38:21 INFO - 'config_files': ('talos/linux_config.py',), 07:38:21 INFO - 'default_actions': ('clobber', 07:38:21 INFO - 'read-buildbot-config', 07:38:21 INFO - 'download-and-extract', 07:38:21 INFO - 'populate-webroot', 07:38:21 INFO - 'create-virtualenv', 07:38:21 INFO - 'install', 07:38:21 INFO - 'run-tests'), 07:38:21 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:38:21 INFO - 'download_minidump_stackwalk': True, 07:38:21 INFO - 'download_symbols': 'ondemand', 07:38:21 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:38:21 INFO - 'tooltool.py': '/tools/tooltool.py', 07:38:21 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:38:21 INFO - '/tools/misc-python/virtualenv.py')}, 07:38:21 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:38:21 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:38:21 INFO - 'installer_path': 'installer.exe', 07:38:21 INFO - 'log_level': 'info', 07:38:21 INFO - 'log_name': 'talos', 07:38:21 INFO - 'log_to_console': True, 07:38:21 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:38:21 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:38:21 INFO - 'opt_config_files': (), 07:38:21 INFO - 'pip_index': False, 07:38:21 INFO - 'sps_profile': False, 07:38:21 INFO - 'sps_profile_interval': 0, 07:38:21 INFO - 'suite': 'dromaeojs', 07:38:21 INFO - 'system_bits': '32', 07:38:21 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:38:21 INFO - 'title': 'talos-linux64-ix-031', 07:38:21 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:38:21 INFO - 'use_talos_json': True, 07:38:21 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:38:21 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:38:21 INFO - 'work_dir': 'build'} 07:38:21 INFO - [mozharness: 2016-10-11 14:38:21.625507Z] Running clobber step. 07:38:21 INFO - Running pre-action listener: _resource_record_pre_action 07:38:21 INFO - Running main action method: clobber 07:38:21 INFO - rmtree: /builds/slave/test/build 07:38:21 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:38:22 INFO - Running post-action listener: _resource_record_post_action 07:38:22 INFO - [mozharness: 2016-10-11 14:38:22.088148Z] Finished clobber step (success) 07:38:22 INFO - [mozharness: 2016-10-11 14:38:22.088248Z] Running read-buildbot-config step. 07:38:22 INFO - Running pre-action listener: _resource_record_pre_action 07:38:22 INFO - Running main action method: read_buildbot_config 07:38:22 INFO - Using buildbot properties: 07:38:22 INFO - { 07:38:22 INFO - "project": "", 07:38:22 INFO - "product": "firefox", 07:38:22 INFO - "script_repo_revision": "production", 07:38:22 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs", 07:38:22 INFO - "repository": "", 07:38:22 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland talos dromaeojs", 07:38:22 INFO - "buildid": "20161011054447", 07:38:22 INFO - "pgo_build": "False", 07:38:22 INFO - "basedir": "/builds/slave/test", 07:38:22 INFO - "buildnumber": 830, 07:38:22 INFO - "slavename": "talos-linux64-ix-031", 07:38:22 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 07:38:22 INFO - "platform": "ubuntu64_hw", 07:38:22 INFO - "scheduler": "tests-autoland-linux64-talos", 07:38:22 INFO - "branch": "autoland", 07:38:22 INFO - "repo_path": "integration/autoland", 07:38:22 INFO - "revision": "51dc2ac80cf14d15b60cd92d843f12c77b4b53b3", 07:38:22 INFO - "stage_platform": "linux64", 07:38:22 INFO - "builduid": "c53832506fe34e938dcc27786f2f98fe", 07:38:22 INFO - "slavebuilddir": "test" 07:38:22 INFO - } 07:38:22 INFO - Found installer url https://queue.taskcluster.net/v1/task/TTuzOZjmTMKDhzzut3S7lQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 07:38:22 INFO - Running post-action listener: _resource_record_post_action 07:38:22 INFO - [mozharness: 2016-10-11 14:38:22.090706Z] Finished read-buildbot-config step (success) 07:38:22 INFO - [mozharness: 2016-10-11 14:38:22.090795Z] Running download-and-extract step. 07:38:22 INFO - Running pre-action listener: _resource_record_pre_action 07:38:22 INFO - Running main action method: download_and_extract 07:38:22 INFO - mkdir: /builds/slave/test/build/tests 07:38: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')]} 07:38:22 INFO - trying https://queue.taskcluster.net/v1/task/TTuzOZjmTMKDhzzut3S7lQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 07:38:22 INFO - Downloading https://queue.taskcluster.net/v1/task/TTuzOZjmTMKDhzzut3S7lQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 07:38:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TTuzOZjmTMKDhzzut3S7lQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 07:38:22 INFO - Downloaded 1361 bytes. 07:38:22 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 07:38:22 INFO - Using the following test package requirements: 07:38:22 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 07:38:22 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 07:38:22 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:38:22 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 07:38:22 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:38:22 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 07:38:22 INFO - u'jsshell-linux-x86_64.zip'], 07:38:22 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 07:38:22 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:38:22 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 07:38:22 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 07:38:22 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:38:22 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 07:38:22 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:38:22 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 07:38:22 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:38:22 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 07:38:22 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:38:22 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:38:22 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TTuzOZjmTMKDhzzut3S7lQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 07:38:22 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TTuzOZjmTMKDhzzut3S7lQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:38:22 INFO - Fetch https://queue.taskcluster.net/v1/task/TTuzOZjmTMKDhzzut3S7lQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 07:38:23 INFO - Http code: 200 07:38:23 INFO - via: 1.1 ff555a0cc6346f82fe74596f8ed6cc33.cloudfront.net (CloudFront) 07:38:23 INFO - x-amz-cf-id: EGcwOozYY70zFwe8dkYseqEeo1QBYhzGqAicWx6pmDZfrObv7_VkeA== 07:38:23 INFO - x-amz-version-id: RI1yGORX.7D0tKrvN2w0CtS0zEILOU2w 07:38:23 INFO - Expected file size: 20528763 07:38:23 INFO - Obtained file size: 20528763 07:38:27 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 07:38:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TTuzOZjmTMKDhzzut3S7lQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 07:38:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TTuzOZjmTMKDhzzut3S7lQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:38:27 INFO - Fetch https://queue.taskcluster.net/v1/task/TTuzOZjmTMKDhzzut3S7lQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 07:38:28 INFO - Http code: 200 07:38:28 INFO - via: 1.1 ae162f6796e551002447afd7c07ec67a.cloudfront.net (CloudFront) 07:38:28 INFO - x-amz-cf-id: qL2MaZavpod1qCG6MpfOMsKSbnIrOfUGa7_04onqsvm65TlHHQX7nA== 07:38:28 INFO - x-amz-version-id: RI1yGORX.7D0tKrvN2w0CtS0zEILOU2w 07:38:28 INFO - Expected file size: 20528763 07:38:28 INFO - Obtained file size: 20528763 07:38:32 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TTuzOZjmTMKDhzzut3S7lQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 07:38:32 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TTuzOZjmTMKDhzzut3S7lQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 07:38:32 INFO - Fetch https://queue.taskcluster.net/v1/task/TTuzOZjmTMKDhzzut3S7lQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 07:38:33 INFO - Http code: 200 07:38:33 INFO - via: 1.1 d897b81191cbfd68a1b6fc44f98c52b0.cloudfront.net (CloudFront) 07:38:33 INFO - x-amz-cf-id: 1Y1LtvRWBLe5XSbuYm0dwvDL9Mt3F-rECTnundkMPM9Xk9CbUa05kg== 07:38:33 INFO - x-amz-version-id: cWgBhNi7Aw1lkGkt0vdLB1ya_Ox_T5O5 07:38:33 INFO - Expected file size: 14409006 07:38:33 INFO - Obtained file size: 14409006 07:38:33 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')]} 07:38:33 INFO - trying https://queue.taskcluster.net/v1/task/TTuzOZjmTMKDhzzut3S7lQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 07:38:33 INFO - Downloading https://queue.taskcluster.net/v1/task/TTuzOZjmTMKDhzzut3S7lQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 07:38:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TTuzOZjmTMKDhzzut3S7lQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 07:38:34 INFO - Downloaded 55901050 bytes. 07:38:34 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/TTuzOZjmTMKDhzzut3S7lQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 07:38:34 INFO - mkdir: /builds/slave/test/properties 07:38:34 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:38:34 INFO - Writing to file /builds/slave/test/properties/build_url 07:38:34 INFO - Contents: 07:38:34 INFO - build_url:https://queue.taskcluster.net/v1/task/TTuzOZjmTMKDhzzut3S7lQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 07:38:35 INFO - Running post-action listener: _resource_record_post_action 07:38:35 INFO - Running post-action listener: set_extra_try_arguments 07:38:35 INFO - [mozharness: 2016-10-11 14:38:35.693119Z] Finished download-and-extract step (success) 07:38:35 INFO - [mozharness: 2016-10-11 14:38:35.693387Z] Running populate-webroot step. 07:38:35 INFO - Running pre-action listener: _resource_record_pre_action 07:38:35 INFO - Running main action method: populate_webroot 07:38:35 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:38:35 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:38:35 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:38:35 INFO - '--tppagecycles', 07:38:35 INFO - '7'], 07:38:35 INFO - 'tests': ['tsvgm']}}, 07:38:35 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:38:35 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:38:35 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:38:35 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:38:35 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:38:35 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:38:35 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:38:35 INFO - 'talos_options': ['--disable-e10s'], 07:38:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:38:35 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:38:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:38:35 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:38:35 INFO - 'talos_options': ['--disable-e10s'], 07:38:35 INFO - 'tests': ['damp', 'tps']}, 07:38:35 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:38:35 INFO - 'tests': ['damp', 'tps']}, 07:38:35 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:38:35 INFO - 'tests': ['dromaeo_dom']}, 07:38:35 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:38:35 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:38:35 INFO - 'tests': ['basic_compositor_video']}, 07:38:35 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:38:35 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:38:35 INFO - 'tests': ['a11yr', 07:38:35 INFO - 'ts_paint', 07:38:35 INFO - 'tpaint', 07:38:35 INFO - 'sessionrestore', 07:38:35 INFO - 'sessionrestore_no_auto_restore', 07:38:35 INFO - 'tabpaint']}, 07:38:35 INFO - 'other-e10s': {'tests': ['a11yr', 07:38:35 INFO - 'ts_paint', 07:38:35 INFO - 'tpaint', 07:38:35 INFO - 'sessionrestore', 07:38:35 INFO - 'sessionrestore_no_auto_restore', 07:38:35 INFO - 'tabpaint']}, 07:38:35 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:38:35 INFO - 'ts_paint', 07:38:35 INFO - 'tpaint', 07:38:35 INFO - 'sessionrestore', 07:38:35 INFO - 'sessionrestore_no_auto_restore', 07:38:35 INFO - 'tabpaint']}, 07:38:35 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:38:35 INFO - 'ts_paint', 07:38:35 INFO - 'tpaint', 07:38:35 INFO - 'sessionrestore', 07:38:35 INFO - 'sessionrestore_no_auto_restore', 07:38:35 INFO - 'tabpaint']}, 07:38:35 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:38:35 INFO - 'tests': ['a11yr', 07:38:35 INFO - 'ts_paint', 07:38:35 INFO - 'tpaint', 07:38:35 INFO - 'sessionrestore', 07:38:35 INFO - 'sessionrestore_no_auto_restore', 07:38:35 INFO - 'tabpaint']}, 07:38:35 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:38:35 INFO - 'tests': ['a11yr', 07:38:35 INFO - 'ts_paint', 07:38:35 INFO - 'tpaint', 07:38:35 INFO - 'sessionrestore', 07:38:35 INFO - 'sessionrestore_no_auto_restore', 07:38:35 INFO - 'tabpaint']}, 07:38:35 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:38:35 INFO - 'tests': ['tsvgx', 07:38:35 INFO - 'tsvgr_opacity', 07:38:35 INFO - 'tart', 07:38:35 INFO - 'tscrollx', 07:38:35 INFO - 'cart']}, 07:38:35 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:38:35 INFO - 'tsvgr_opacity', 07:38:35 INFO - 'tart', 07:38:35 INFO - 'tscrollx', 07:38:35 INFO - 'cart']}, 07:38:35 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:38:35 INFO - 'talos_options': ['--disable-e10s'], 07:38:35 INFO - 'tests': ['tp5o']}, 07:38:35 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:38:35 INFO - 'tests': ['tp5o']}, 07:38:35 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:38:35 INFO - 'talos_options': ['--disable-e10s', 07:38:35 INFO - '--xperf_path', 07:38:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:38:35 INFO - 'tests': ['tp5n']}, 07:38:35 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:38:35 INFO - 'talos_options': ['--xperf_path', 07:38:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:38:35 INFO - 'tests': ['tp5n']}}, 07:38:35 INFO - 'talos.zip': {'path': '', 07:38:35 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:38:35 INFO - Running post-action listener: _resource_record_post_action 07:38:35 INFO - [mozharness: 2016-10-11 14:38:35.709291Z] Finished populate-webroot step (success) 07:38:35 INFO - [mozharness: 2016-10-11 14:38:35.709381Z] Running create-virtualenv step. 07:38:35 INFO - Running pre-action listener: _resource_record_pre_action 07:38:35 INFO - Running main action method: create_virtualenv 07:38:35 INFO - Creating virtualenv /builds/slave/test/build/venv 07:38:35 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 07:38:35 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:38:35 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:38:35 INFO - Using real prefix '/usr' 07:38:35 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:38:36 INFO - Installing distribute.............................................................................................................................................................................................done. 07:38:38 INFO - Installing pip.................done. 07:38:38 INFO - Return code: 0 07:38:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 07:38:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 07:38:38 INFO - Reading from file tmpfile_stdout 07:38:38 INFO - Output received: 07:38:38 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) 07:38:38 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:38:38 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')]} 07:38:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:38:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:38 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')]} 07:38:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:38:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:38 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 0x7fc96acf5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x117eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x117bf60>, '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 0x117cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x117d1d0>, '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': 'db0483c52d987ecb441a263b000001ad-1476196698.153023-1915257621', '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 07:38:38 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 07:38:38 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 07:38:38 INFO - Using env: {'DISPLAY': ':0', 07:38:38 INFO - 'HOME': '/home/cltbld', 07:38:38 INFO - 'LANG': 'en_US.UTF-8', 07:38:38 INFO - 'LANGUAGE': 'en_US:en', 07:38:38 INFO - 'LOGNAME': 'cltbld', 07:38:38 INFO - 'MAIL': '/var/mail/cltbld', 07:38:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:38:38 INFO - 'MOZ_NO_REMOTE': '1', 07:38:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:38:38 INFO - 'NO_EM_RESTART': '1', 07:38:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:38:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:38:38 INFO - 'PWD': '/builds/slave/test', 07:38:38 INFO - 'SHELL': '/bin/bash', 07:38:38 INFO - 'SHLVL': '1', 07:38:38 INFO - 'TERM': 'linux', 07:38:38 INFO - 'TMOUT': '86400', 07:38:38 INFO - 'USER': 'cltbld', 07:38:38 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1476196698.153023-1915257621', 07:38:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:38:38 INFO - '_': '/tools/buildbot/bin/python'} 07:38:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:38:38 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 07:38:38 INFO - Cleaning up... 07:38:38 INFO - Return code: 0 07:38:38 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:38:38 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')]} 07:38:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:38:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:38 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')]} 07:38:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:38:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:38 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 0x7fc96acf5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x117eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x117bf60>, '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 0x117cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x117d1d0>, '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': 'db0483c52d987ecb441a263b000001ad-1476196698.153023-1915257621', '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 07:38:38 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 07:38:38 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 07:38:38 INFO - Using env: {'DISPLAY': ':0', 07:38:38 INFO - 'HOME': '/home/cltbld', 07:38:38 INFO - 'LANG': 'en_US.UTF-8', 07:38:38 INFO - 'LANGUAGE': 'en_US:en', 07:38:38 INFO - 'LOGNAME': 'cltbld', 07:38:38 INFO - 'MAIL': '/var/mail/cltbld', 07:38:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:38:38 INFO - 'MOZ_NO_REMOTE': '1', 07:38:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:38:38 INFO - 'NO_EM_RESTART': '1', 07:38:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:38:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:38:38 INFO - 'PWD': '/builds/slave/test', 07:38:38 INFO - 'SHELL': '/bin/bash', 07:38:38 INFO - 'SHLVL': '1', 07:38:38 INFO - 'TERM': 'linux', 07:38:38 INFO - 'TMOUT': '86400', 07:38:38 INFO - 'USER': 'cltbld', 07:38:38 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1476196698.153023-1915257621', 07:38:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:38:38 INFO - '_': '/tools/buildbot/bin/python'} 07:38:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:38:38 INFO - Downloading/unpacking psutil>=3.1.1 07:38:38 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 07:38:38 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 07:38:38 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 07:38:38 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 07:38:38 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 07:38:38 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 07:38:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:38:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:38:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:38:40 INFO - Installing collected packages: psutil 07:38:40 INFO - Running setup.py install for psutil 07:38:41 INFO - building 'psutil._psutil_linux' extension 07:38:41 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 07:38:41 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 07:38:41 INFO - building 'psutil._psutil_posix' extension 07:38:41 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 07:38:41 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 07:38:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:38:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:38:41 INFO - Successfully installed psutil 07:38:41 INFO - Cleaning up... 07:38:41 INFO - Return code: 0 07:38:41 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:38: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')]} 07:38:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:38:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38: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')]} 07:38:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:38:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc96acf5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x117eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x117bf60>, '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 0x117cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x117d1d0>, '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': 'db0483c52d987ecb441a263b000001ad-1476196698.153023-1915257621', '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 07:38: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 07:38: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 mozsystemmonitor==0.3 07:38:41 INFO - Using env: {'DISPLAY': ':0', 07:38:41 INFO - 'HOME': '/home/cltbld', 07:38:41 INFO - 'LANG': 'en_US.UTF-8', 07:38:41 INFO - 'LANGUAGE': 'en_US:en', 07:38:41 INFO - 'LOGNAME': 'cltbld', 07:38:41 INFO - 'MAIL': '/var/mail/cltbld', 07:38:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:38:41 INFO - 'MOZ_NO_REMOTE': '1', 07:38:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:38:41 INFO - 'NO_EM_RESTART': '1', 07:38:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:38:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:38:41 INFO - 'PWD': '/builds/slave/test', 07:38:41 INFO - 'SHELL': '/bin/bash', 07:38:41 INFO - 'SHLVL': '1', 07:38:41 INFO - 'TERM': 'linux', 07:38:41 INFO - 'TMOUT': '86400', 07:38:41 INFO - 'USER': 'cltbld', 07:38:41 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1476196698.153023-1915257621', 07:38:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:38:41 INFO - '_': '/tools/buildbot/bin/python'} 07:38:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:38:41 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:38:41 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 07:38:41 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 07:38:41 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 07:38:41 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 07:38:41 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 07:38:41 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 07:38:43 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:38:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:38:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:38:43 INFO - Installing collected packages: mozsystemmonitor 07:38:43 INFO - Running setup.py install for mozsystemmonitor 07:38:43 INFO - Successfully installed mozsystemmonitor 07:38:43 INFO - Cleaning up... 07:38:43 INFO - Return code: 0 07:38:43 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:38:43 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')]} 07:38:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:38:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:43 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')]} 07:38:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:38:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:43 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 0x7fc96acf5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x117eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x117bf60>, '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 0x117cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x117d1d0>, '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': 'db0483c52d987ecb441a263b000001ad-1476196698.153023-1915257621', '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 07:38:43 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 07:38:43 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 07:38:43 INFO - Using env: {'DISPLAY': ':0', 07:38:43 INFO - 'HOME': '/home/cltbld', 07:38:43 INFO - 'LANG': 'en_US.UTF-8', 07:38:43 INFO - 'LANGUAGE': 'en_US:en', 07:38:43 INFO - 'LOGNAME': 'cltbld', 07:38:43 INFO - 'MAIL': '/var/mail/cltbld', 07:38:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:38:43 INFO - 'MOZ_NO_REMOTE': '1', 07:38:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:38:43 INFO - 'NO_EM_RESTART': '1', 07:38:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:38:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:38:43 INFO - 'PWD': '/builds/slave/test', 07:38:43 INFO - 'SHELL': '/bin/bash', 07:38:43 INFO - 'SHLVL': '1', 07:38:43 INFO - 'TERM': 'linux', 07:38:43 INFO - 'TMOUT': '86400', 07:38:43 INFO - 'USER': 'cltbld', 07:38:43 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1476196698.153023-1915257621', 07:38:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:38:43 INFO - '_': '/tools/buildbot/bin/python'} 07:38:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:38:44 INFO - Downloading/unpacking jsonschema==2.5.1 07:38:44 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 07:38:44 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 07:38:44 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 07:38:44 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 07:38:44 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 07:38:44 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 07:38:45 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:38:45 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:38:45 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 07:38:45 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 07:38:45 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 07:38:45 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 07:38:45 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 07:38:45 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 07:38:46 INFO - Downloading functools32-3.2.3-2.tar.gz 07:38:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:38:46 INFO - warning: no files found matching '*.txt' 07:38:46 INFO - no previously-included directories found matching 'build' 07:38:46 INFO - no previously-included directories found matching 'dist' 07:38:46 INFO - no previously-included directories found matching '.git*' 07:38:46 INFO - Installing collected packages: jsonschema, functools32 07:38:46 INFO - Running setup.py install for functools32 07:38:46 INFO - warning: no files found matching '*.txt' 07:38:46 INFO - no previously-included directories found matching 'build' 07:38:46 INFO - no previously-included directories found matching 'dist' 07:38:46 INFO - no previously-included directories found matching '.git*' 07:38:46 INFO - Successfully installed jsonschema functools32 07:38:46 INFO - Cleaning up... 07:38:46 INFO - Return code: 0 07:38:46 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:38:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:38:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:38:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:38:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:38:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fc96acf5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x117eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x117bf60>, '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 0x117cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x117d1d0>, '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': 'db0483c52d987ecb441a263b000001ad-1476196698.153023-1915257621', '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 07:38:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 07:38:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 07:38:46 INFO - Using env: {'DISPLAY': ':0', 07:38:46 INFO - 'HOME': '/home/cltbld', 07:38:46 INFO - 'LANG': 'en_US.UTF-8', 07:38:46 INFO - 'LANGUAGE': 'en_US:en', 07:38:46 INFO - 'LOGNAME': 'cltbld', 07:38:46 INFO - 'MAIL': '/var/mail/cltbld', 07:38:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:38:46 INFO - 'MOZ_NO_REMOTE': '1', 07:38:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:38:46 INFO - 'NO_EM_RESTART': '1', 07:38:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:38:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:38:46 INFO - 'PWD': '/builds/slave/test', 07:38:46 INFO - 'SHELL': '/bin/bash', 07:38:46 INFO - 'SHLVL': '1', 07:38:46 INFO - 'TERM': 'linux', 07:38:46 INFO - 'TMOUT': '86400', 07:38:46 INFO - 'USER': 'cltbld', 07:38:46 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1476196698.153023-1915257621', 07:38:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:38:46 INFO - '_': '/tools/buildbot/bin/python'} 07:38:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:38:46 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:38:46 INFO - Cleaning up... 07:38:46 INFO - Return code: 0 07:38:46 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:38:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:38:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:38:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:38:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:38:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fc96acf5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x117eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x117bf60>, '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 0x117cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x117d1d0>, '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': 'db0483c52d987ecb441a263b000001ad-1476196698.153023-1915257621', '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 07:38:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:38:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:38:46 INFO - Using env: {'DISPLAY': ':0', 07:38:46 INFO - 'HOME': '/home/cltbld', 07:38:46 INFO - 'LANG': 'en_US.UTF-8', 07:38:46 INFO - 'LANGUAGE': 'en_US:en', 07:38:46 INFO - 'LOGNAME': 'cltbld', 07:38:46 INFO - 'MAIL': '/var/mail/cltbld', 07:38:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:38:46 INFO - 'MOZ_NO_REMOTE': '1', 07:38:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:38:46 INFO - 'NO_EM_RESTART': '1', 07:38:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:38:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:38:46 INFO - 'PWD': '/builds/slave/test', 07:38:46 INFO - 'SHELL': '/bin/bash', 07:38:46 INFO - 'SHLVL': '1', 07:38:46 INFO - 'TERM': 'linux', 07:38:46 INFO - 'TMOUT': '86400', 07:38:46 INFO - 'USER': 'cltbld', 07:38:46 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1476196698.153023-1915257621', 07:38:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:38:46 INFO - '_': '/tools/buildbot/bin/python'} 07:38:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:38:46 INFO - Downloading/unpacking blobuploader==1.2.4 07:38:46 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 07:38:46 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 07:38:46 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 07:38:46 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 07:38:46 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 07:38:46 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 07:38:48 INFO - Downloading blobuploader-1.2.4.tar.gz 07:38:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:38:48 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:38:48 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 07:38:48 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 07:38:48 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 07:38:48 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 07:38:48 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 07:38:48 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 07:38:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:38:49 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:38:49 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 07:38:49 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 07:38:49 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 07:38:49 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 07:38:49 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 07:38:49 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 07:38:49 INFO - Downloading docopt-0.6.1.tar.gz 07:38:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:38:49 INFO - Installing collected packages: blobuploader, requests, docopt 07:38:49 INFO - Running setup.py install for blobuploader 07:38:49 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:38:49 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:38:49 INFO - Running setup.py install for requests 07:38:50 INFO - Running setup.py install for docopt 07:38:50 INFO - Successfully installed blobuploader requests docopt 07:38:50 INFO - Cleaning up... 07:38:50 INFO - Return code: 0 07:38:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:38:50 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')]} 07:38:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:38:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:50 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')]} 07:38:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:38:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:50 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 0x7fc96acf5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x117eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x117bf60>, '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 0x117cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x117d1d0>, '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': 'db0483c52d987ecb441a263b000001ad-1476196698.153023-1915257621', '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 07:38:50 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 07:38:50 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 07:38:50 INFO - Using env: {'DISPLAY': ':0', 07:38:50 INFO - 'HOME': '/home/cltbld', 07:38:50 INFO - 'LANG': 'en_US.UTF-8', 07:38:50 INFO - 'LANGUAGE': 'en_US:en', 07:38:50 INFO - 'LOGNAME': 'cltbld', 07:38:50 INFO - 'MAIL': '/var/mail/cltbld', 07:38:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:38:50 INFO - 'MOZ_NO_REMOTE': '1', 07:38:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:38:50 INFO - 'NO_EM_RESTART': '1', 07:38:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:38:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:38:50 INFO - 'PWD': '/builds/slave/test', 07:38:50 INFO - 'SHELL': '/bin/bash', 07:38:50 INFO - 'SHLVL': '1', 07:38:50 INFO - 'TERM': 'linux', 07:38:50 INFO - 'TMOUT': '86400', 07:38:50 INFO - 'USER': 'cltbld', 07:38:50 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1476196698.153023-1915257621', 07:38:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:38:50 INFO - '_': '/tools/buildbot/bin/python'} 07:38:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:38:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:38:50 INFO - Running setup.py (path:/tmp/pip-d1VSmc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:38:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:38:50 INFO - Running setup.py (path:/tmp/pip-QilvgR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:38:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:38:50 INFO - Running setup.py (path:/tmp/pip-kD8_6T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:38:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:38:50 INFO - Running setup.py (path:/tmp/pip-XfHfAM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:38:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:38:50 INFO - Running setup.py (path:/tmp/pip-I3Skng-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:38:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:38:50 INFO - Running setup.py (path:/tmp/pip-r4I3rK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:38:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:38:50 INFO - Running setup.py (path:/tmp/pip-OBRvLK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:38:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:38:50 INFO - Running setup.py (path:/tmp/pip-9JC956-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:38:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:38:50 INFO - Running setup.py (path:/tmp/pip-_VgOwO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:38:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:38:51 INFO - Running setup.py (path:/tmp/pip-3eoZnJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:38:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:38:51 INFO - Running setup.py (path:/tmp/pip-tLPLxn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:38:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:38:51 INFO - Running setup.py (path:/tmp/pip-ZAEjhe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:38:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:38:51 INFO - Running setup.py (path:/tmp/pip-jMwcqT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:38:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:38:51 INFO - Running setup.py (path:/tmp/pip-0o_Xkr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:38:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:38:51 INFO - Running setup.py (path:/tmp/pip-BVZ7GM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:38:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:38:51 INFO - Running setup.py (path:/tmp/pip-laFtIM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:38:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:38:51 INFO - Running setup.py (path:/tmp/pip-wnnBfK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:38:51 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:38:51 INFO - Running setup.py install for manifestparser 07:38:51 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:38:51 INFO - Running setup.py install for mozcrash 07:38:51 INFO - Running setup.py install for mozdebug 07:38:51 INFO - Running setup.py install for mozdevice 07:38:52 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:38:52 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:38:52 INFO - Running setup.py install for mozfile 07:38:52 INFO - Running setup.py install for mozhttpd 07:38:52 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:38:52 INFO - Running setup.py install for mozinfo 07:38:52 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:38:52 INFO - Running setup.py install for mozInstall 07:38:52 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:38:52 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:38:52 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:38:52 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:38:52 INFO - Running setup.py install for mozleak 07:38:52 INFO - Running setup.py install for mozlog 07:38:52 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:38:52 INFO - Running setup.py install for moznetwork 07:38:52 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:38:52 INFO - Running setup.py install for mozprocess 07:38:52 INFO - Running setup.py install for mozprofile 07:38:52 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:38:52 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:38:52 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:38:52 INFO - Running setup.py install for mozrunner 07:38:53 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:38:53 INFO - Running setup.py install for mozscreenshot 07:38:53 INFO - Running setup.py install for moztest 07:38:53 INFO - Running setup.py install for mozversion 07:38:53 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:38:53 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:38:53 INFO - Cleaning up... 07:38:53 INFO - Return code: 0 07:38:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:38:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:38:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:38:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:38:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:38:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:53 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 0x7fc96acf5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x117eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x117bf60>, '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 0x117cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x117d1d0>, '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': 'db0483c52d987ecb441a263b000001ad-1476196698.153023-1915257621', '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 07:38:53 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 07:38:53 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 07:38:53 INFO - Using env: {'DISPLAY': ':0', 07:38:53 INFO - 'HOME': '/home/cltbld', 07:38:53 INFO - 'LANG': 'en_US.UTF-8', 07:38:53 INFO - 'LANGUAGE': 'en_US:en', 07:38:53 INFO - 'LOGNAME': 'cltbld', 07:38:53 INFO - 'MAIL': '/var/mail/cltbld', 07:38:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:38:53 INFO - 'MOZ_NO_REMOTE': '1', 07:38:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:38:53 INFO - 'NO_EM_RESTART': '1', 07:38:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:38:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:38:53 INFO - 'PWD': '/builds/slave/test', 07:38:53 INFO - 'SHELL': '/bin/bash', 07:38:53 INFO - 'SHLVL': '1', 07:38:53 INFO - 'TERM': 'linux', 07:38:53 INFO - 'TMOUT': '86400', 07:38:53 INFO - 'USER': 'cltbld', 07:38:53 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1476196698.153023-1915257621', 07:38:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:38:53 INFO - '_': '/tools/buildbot/bin/python'} 07:38:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:38:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:38:53 INFO - Running setup.py (path:/tmp/pip-hxcfuQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:38:53 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)) 07:38:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:38:53 INFO - Running setup.py (path:/tmp/pip-Khq1gA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:38:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:38:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:38:53 INFO - Running setup.py (path:/tmp/pip-7M5goC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:38:53 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)) 07:38:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:38:53 INFO - Running setup.py (path:/tmp/pip-vuiL7_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:38:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:38:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:38:53 INFO - Running setup.py (path:/tmp/pip-_7b2VI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:38:54 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)) 07:38:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:38:54 INFO - Running setup.py (path:/tmp/pip-9h1iST-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:38:54 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)) 07:38:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:38:54 INFO - Running setup.py (path:/tmp/pip-Qki8bM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:38:54 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)) 07:38:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:38:54 INFO - Running setup.py (path:/tmp/pip-Et8QUc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:38:54 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)) 07:38:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:38:54 INFO - Running setup.py (path:/tmp/pip-Z63LVZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:38:54 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)) 07:38:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:38:54 INFO - Running setup.py (path:/tmp/pip-JKTz8p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:38:54 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)) 07:38:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:38:54 INFO - Running setup.py (path:/tmp/pip-JSTlFv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:38:54 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)) 07:38:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:38:54 INFO - Running setup.py (path:/tmp/pip-hIIUzN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:38:54 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)) 07:38:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:38:54 INFO - Running setup.py (path:/tmp/pip-BEratE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:38:54 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)) 07:38:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:38:54 INFO - Running setup.py (path:/tmp/pip-zLz8CQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:38:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 07:38:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:38:54 INFO - Running setup.py (path:/tmp/pip-ymDEsr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:38:54 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)) 07:38:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:38:54 INFO - Running setup.py (path:/tmp/pip-_KsNSd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:38:54 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)) 07:38:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:38:54 INFO - Running setup.py (path:/tmp/pip-3JDW9h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:38:54 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)) 07:38:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:38:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:38:54 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)) 07:38:54 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:38:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:38:54 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:38:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:38:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:38:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:38:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:38:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:38:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:38:56 INFO - Downloading blessings-1.6.tar.gz 07:38:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:38:56 INFO - Installing collected packages: blessings 07:38:56 INFO - Running setup.py install for blessings 07:38:57 INFO - Successfully installed blessings 07:38:57 INFO - Cleaning up... 07:38:57 INFO - Return code: 0 07:38:57 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:38:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:38:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:38:57 INFO - Reading from file tmpfile_stdout 07:38:57 INFO - Current package versions: 07:38:57 INFO - argparse == 1.2.1 07:38:57 INFO - blessings == 1.6 07:38:57 INFO - blobuploader == 1.2.4 07:38:57 INFO - docopt == 0.6.1 07:38:57 INFO - functools32 == 3.2.3-2 07:38:57 INFO - jsonschema == 2.5.1 07:38:57 INFO - manifestparser == 1.1 07:38:57 INFO - mozInstall == 1.12 07:38:57 INFO - mozcrash == 0.17 07:38:57 INFO - mozdebug == 0.1 07:38:57 INFO - mozdevice == 0.48 07:38:57 INFO - mozfile == 1.2 07:38:57 INFO - mozhttpd == 0.7 07:38:57 INFO - mozinfo == 0.9 07:38:57 INFO - mozleak == 0.1 07:38:57 INFO - mozlog == 3.4 07:38:57 INFO - moznetwork == 0.27 07:38:57 INFO - mozprocess == 0.23 07:38:57 INFO - mozprofile == 0.28 07:38:57 INFO - mozrunner == 6.12 07:38:57 INFO - mozscreenshot == 0.1 07:38:57 INFO - mozsystemmonitor == 0.3 07:38:57 INFO - moztest == 0.7 07:38:57 INFO - mozversion == 1.4 07:38:57 INFO - psutil == 3.1.1 07:38:57 INFO - requests == 1.2.3 07:38:57 INFO - wsgiref == 0.1.2 07:38:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:38:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:38:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:38:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:38:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:38:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:57 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 0x7fc96acf5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x117eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x117bf60>, '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 0x117cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x117d1d0>, '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': 'db0483c52d987ecb441a263b000001ad-1476196698.153023-1915257621', '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 07:38:57 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 07:38:57 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 07:38:57 INFO - Using env: {'DISPLAY': ':0', 07:38:57 INFO - 'HOME': '/home/cltbld', 07:38:57 INFO - 'LANG': 'en_US.UTF-8', 07:38:57 INFO - 'LANGUAGE': 'en_US:en', 07:38:57 INFO - 'LOGNAME': 'cltbld', 07:38:57 INFO - 'MAIL': '/var/mail/cltbld', 07:38:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:38:57 INFO - 'MOZ_NO_REMOTE': '1', 07:38:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:38:57 INFO - 'NO_EM_RESTART': '1', 07:38:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:38:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:38:57 INFO - 'PWD': '/builds/slave/test', 07:38:57 INFO - 'SHELL': '/bin/bash', 07:38:57 INFO - 'SHLVL': '1', 07:38:57 INFO - 'TERM': 'linux', 07:38:57 INFO - 'TMOUT': '86400', 07:38:57 INFO - 'USER': 'cltbld', 07:38:57 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1476196698.153023-1915257621', 07:38:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:38:57 INFO - '_': '/tools/buildbot/bin/python'} 07:38:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:38:57 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)) 07:38:57 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)) 07:38:57 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)) 07:38:57 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)) 07:38:57 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)) 07:38:57 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)) 07:38:57 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)) 07:38:57 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)) 07:38:57 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)) 07:38:57 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)) 07:38:57 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)) 07:38:57 INFO - Cleaning up... 07:38:57 INFO - Return code: 0 07:38:57 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:38:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:38:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:38:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:38:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:38:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:57 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 0x7fc96acf5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x117eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x117bf60>, '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 0x117cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x117d1d0>, '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': 'db0483c52d987ecb441a263b000001ad-1476196698.153023-1915257621', '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 07:38:57 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 07:38:57 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 07:38:57 INFO - Using env: {'DISPLAY': ':0', 07:38:57 INFO - 'HOME': '/home/cltbld', 07:38:57 INFO - 'LANG': 'en_US.UTF-8', 07:38:57 INFO - 'LANGUAGE': 'en_US:en', 07:38:57 INFO - 'LOGNAME': 'cltbld', 07:38:57 INFO - 'MAIL': '/var/mail/cltbld', 07:38:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:38:57 INFO - 'MOZ_NO_REMOTE': '1', 07:38:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:38:57 INFO - 'NO_EM_RESTART': '1', 07:38:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:38:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:38:57 INFO - 'PWD': '/builds/slave/test', 07:38:57 INFO - 'SHELL': '/bin/bash', 07:38:57 INFO - 'SHLVL': '1', 07:38:57 INFO - 'TERM': 'linux', 07:38:57 INFO - 'TMOUT': '86400', 07:38:57 INFO - 'USER': 'cltbld', 07:38:57 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1476196698.153023-1915257621', 07:38:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:38:57 INFO - '_': '/tools/buildbot/bin/python'} 07:38:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:38:57 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:38:57 INFO - Cleaning up... 07:38:57 INFO - Return code: 0 07:38:57 INFO - Running post-action listener: _resource_record_post_action 07:38:57 INFO - Running post-action listener: _start_resource_monitoring 07:38:57 INFO - Starting resource monitoring. 07:38:57 INFO - [mozharness: 2016-10-11 14:38:57.793437Z] Finished create-virtualenv step (success) 07:38:57 INFO - [mozharness: 2016-10-11 14:38:57.793904Z] Running install step. 07:38:57 INFO - Running pre-action listener: _resource_record_pre_action 07:38:57 INFO - Running main action method: install 07:38:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:38:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:38:58 INFO - Reading from file tmpfile_stdout 07:38:58 INFO - Detecting whether we're running mozinstall >=1.0... 07:38:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:38:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:38:58 INFO - Reading from file tmpfile_stdout 07:38:58 INFO - Output received: 07:38:58 INFO - Usage: mozinstall [options] installer 07:38:58 INFO - Options: 07:38:58 INFO - -h, --help show this help message and exit 07:38:58 INFO - -d DEST, --destination=DEST 07:38:58 INFO - Directory to install application into. [default: 07:38:58 INFO - "/builds/slave/test"] 07:38:58 INFO - --app=APP Application being installed. [default: firefox] 07:38:58 INFO - mkdir: /builds/slave/test/build/application 07:38:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 07:38:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 07:39:14 INFO - Reading from file tmpfile_stdout 07:39:14 INFO - Output received: 07:39:14 INFO - /builds/slave/test/build/application/firefox/firefox 07:39:14 INFO - Running post-action listener: _resource_record_post_action 07:39:14 INFO - [mozharness: 2016-10-11 14:39:14.275417Z] Finished install step (success) 07:39:14 INFO - [mozharness: 2016-10-11 14:39:14.275659Z] Running run-tests step. 07:39:14 INFO - Running pre-action listener: _resource_record_pre_action 07:39:14 INFO - Running main action method: run_tests 07:39:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:39:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:39:14 INFO - Python 2.7.3 07:39:14 INFO - Return code: 0 07:39:14 INFO - grabbing minidump binary from tooltool 07:39:14 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')]} 07:39:14 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 0x117bf60>, '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 0x117cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x117d1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:39:14 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 07:39:14 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 07:39:14 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 07:39:14 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:39:14 INFO - Return code: 0 07:39:14 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:39:14 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:39:14 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:39:14 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:39:14 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:39:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/TTuzOZjmTMKDhzzut3S7lQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-031', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 07:39:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/TTuzOZjmTMKDhzzut3S7lQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-031 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 07:39:14 INFO - Using env: {'DISPLAY': ':0', 07:39:14 INFO - 'HOME': '/home/cltbld', 07:39:14 INFO - 'LANG': 'en_US.UTF-8', 07:39:14 INFO - 'LANGUAGE': 'en_US:en', 07:39:14 INFO - 'LOGNAME': 'cltbld', 07:39:14 INFO - 'MAIL': '/var/mail/cltbld', 07:39:14 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:39:14 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:39:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:39:14 INFO - 'MOZ_NO_REMOTE': '1', 07:39:14 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:39:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:39:14 INFO - 'NO_EM_RESTART': '1', 07:39:14 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:39:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:39:14 INFO - 'PWD': '/builds/slave/test', 07:39:14 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:39:14 INFO - 'SHELL': '/bin/bash', 07:39:14 INFO - 'SHLVL': '1', 07:39:14 INFO - 'TERM': 'linux', 07:39:14 INFO - 'TMOUT': '86400', 07:39:14 INFO - 'USER': 'cltbld', 07:39:14 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1476196698.153023-1915257621', 07:39:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:39:14 INFO - '_': '/tools/buildbot/bin/python'} 07:39:14 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/TTuzOZjmTMKDhzzut3S7lQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-031', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 07:39:14 INFO - mozversion application_buildid: 20161011054447 07:39:14 INFO - mozversion application_changeset: 51dc2ac80cf14d15b60cd92d843f12c77b4b53b3 07:39:14 INFO - mozversion application_display_name: Nightly 07:39:14 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:39:14 INFO - mozversion application_name: Firefox 07:39:14 INFO - mozversion application_remotingname: firefox 07:39:14 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 07:39:14 INFO - mozversion application_vendor: Mozilla 07:39:14 INFO - mozversion application_version: 52.0a1 07:39:14 INFO - mozversion platform_buildid: 20161011054447 07:39:14 INFO - mozversion platform_changeset: 51dc2ac80cf14d15b60cd92d843f12c77b4b53b3 07:39:14 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 07:39:14 INFO - mozversion platform_version: 52.0a1 07:39:14 INFO - using testdate: 1476196754 07:39:14 INFO - actual date: 1476196754 07:39:14 INFO - starting webserver on 'localhost:43675' 07:39:14 INFO - SUITE-START | Running 2 tests 07:39:14 INFO - TEST-START | dromaeo_css 07:39:14 INFO - operating with platform_type : linux_ 07:39:14 INFO - Initialising browser for dromaeo_css test... 07:39:14 INFO - TEST-INFO | started process 15947 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8a4KYx/profile http://localhost:43675/getInfo.html) 07:39:19 INFO - PROCESS | 15947 | __metrics Screen width/height:1600/1200 07:39:19 INFO - PROCESS | 15947 | colorDepth:24 07:39:19 INFO - PROCESS | 15947 | Browser inner width/height: 1024/697 07:39:19 INFO - PROCESS | 15947 | __metrics 07:39:19 INFO - PROCESS | 15947 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 07:39:19 INFO - PROCESS | 15947 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:39:20 INFO - PROCESS | 15947 | console.error: PushService: 07:39:20 INFO - PROCESS | 15947 | stateChangeProcessEnqueue: Error transitioning state 07:39:20 INFO - PROCESS | 15947 | UnknownError 07:39:21 INFO - TEST-INFO | 15947: exit 0 07:39:21 INFO - Browser initialized. 07:39:21 INFO - Running cycle 1/1 for dromaeo_css test... 07:39:21 INFO - TEST-INFO | started process 16028 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8a4KYx/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:39:33 INFO - PROCESS | 16028 | RSS: Main: 175099904 07:39:33 INFO - PROCESS | 16028 | 07:40:24 INFO - PROCESS | 16028 | 1476196824088 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] 07:42:38 INFO - PROCESS | 16028 | Cycle 1(1): loaded http://localhost:43675/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43675/tests/dromaeo/cssquery-ext.html) 07:42:39 INFO - PROCESS | 16028 | RSS: Main: 287559680 07:42:39 INFO - PROCESS | 16028 | 07:45:42 INFO - PROCESS | 16028 | Cycle 1(1): loaded http://localhost:43675/tests/dromaeo/cssquery-ext.html (next: http://localhost:43675/tests/dromaeo/cssquery-jquery.html) 07:45:43 INFO - PROCESS | 16028 | RSS: Main: 279093248 07:45:43 INFO - PROCESS | 16028 | 07:48:45 INFO - PROCESS | 16028 | Cycle 1(1): loaded http://localhost:43675/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43675/tests/dromaeo/cssquery-mootools.html) 07:48:45 INFO - PROCESS | 16028 | RSS: Main: 218705920 07:48:45 INFO - PROCESS | 16028 | 07:51:48 INFO - PROCESS | 16028 | Cycle 1(1): loaded http://localhost:43675/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43675/tests/dromaeo/cssquery-prototype.html) 07:51:48 INFO - PROCESS | 16028 | RSS: Main: 218132480 07:51:48 INFO - PROCESS | 16028 | 07:54:52 INFO - PROCESS | 16028 | Cycle 1(1): loaded http://localhost:43675/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43675/tests/dromaeo/cssquery-yui.html) 07:54:52 INFO - PROCESS | 16028 | RSS: Main: 217354240 07:54:52 INFO - PROCESS | 16028 | 07:57:55 INFO - PROCESS | 16028 | Cycle 1(1): loaded http://localhost:43675/tests/dromaeo/cssquery-yui.html (next: http://localhost:43675/tests/dromaeo/cssquery-dojo.html) 07:57:56 INFO - PROCESS | 16028 | RSS: Main: 302309376 07:57:56 INFO - PROCESS | 16028 | 07:57:56 INFO - PROCESS | 16028 | __start_tp_report 07:57:56 INFO - PROCESS | 16028 | _x_x_mozilla_page_load 07:57:56 INFO - PROCESS | 16028 | _x_x_mozilla_page_load_details 07:57:56 INFO - PROCESS | 16028 | |i|pagename|runs| 07:57:56 INFO - PROCESS | 16028 | |0;dojo.html;2503.3241024923273;2531.5822889223277;2535.5309267785456;2562.92311230663;2576.09836557205;4484.103179364124;4544.681872268942;4615.746133962635;4633.142868569313;4647.233206520928;4573;4606.1478626454045;4657.534246575341;4671.439427268724;4716.056788642268;4160.958390416087;4172.603602657758;4211.968067823387;4227.87316380509;4229.027323715547;3853.84584616615;4236.533981262059;4271.231178387889;4309.892252693677;4361.34579813029;4157.771322577288;4259.552746961586;4260.7656578888145;4327.7619730914785;4365.323374876899;4194.0563373240775;4208.389783481378;4251.319788833803;4253.744775313491;4268.9786551067355;4220.345846393814;4224.619784219435;4226.5139508956245;4276.187524370391;4286.957130428687;4601.723896566216;4617.792199351004;4638.605718513931;4640.327152562893;4682.836100736492;4756.120117778188;4798.136335459616;4802.639802014863;4832.275158726184;4949.628777841676;4917.901641967176;4955.702657840505;4959.752012399365;4998.6750861193905;5018.096742586333;4631.9305210421535;4631.980964187874;4632.791524381343;4638.5593368629925;4687.6249900007915;4952.579030782424;5012.8496145115705;5042.512458824655;5046.470120637354;5111.131107711698;4786.946871688223;4793.065352256276;4808.855734327975;4848.8302909398;4883.218685010382;4881.975590122027;4944.258361245842;4944.90110197794;4947.356843610308;4955.256711493233;4859.65982381237;4862.635302352338;4871.415430148405;4922.606191504671;4929.901401971941;4748.548887855717;4780.545848144421;4797.592204662573;4824.879378015507;4880.1215781159735;4128.545859955402;4154.4183814265425;4164.604362585549;4184.456020717287;4245.61789438952;3651.7626354286886;3653.6529029742132;3696.9445458318146;3701.3152566775234;3703.666669999659;4222.0500387412585;4232.195882782323;4233.428487154257;4233.661307095425;4289.806958686867;4778.235482322812;4823.3729615149805;4829.95170048302;4839.685420447659;4872.6832755870755;4233.682473814476;4241.597048280409;4242;4278.208531421635;4282.678799090081;4407.2507673695545;4410.07388448423;4415.889602759892;4457.64338852891;4466.731996080245;4471.843485478123;4557.908841823211;4562.703424277412;4589.105124500824;4646.465656449552;4807.423109226916;4849.442314133778;4856.757162141808;4887.90224195507;4888.315635810918;4551.590356867898;4559.247724125482;4574.062317224894;4575.7483338416705;4580.541945805393;4783.689060211075;4785.377900872864;4794.640401969936;4797.736124513185;4819.084373968934;4948.925766113583;4952.306677065286;4991.276264941635;5043.672161309503;5050.570701490415;4828;4874.025194961093;4882.194437917704;4883.096627123993;4941.876453088702;4730.030343779586;4785.49752276006;4864.635152363516;4875.791233727412;4939.827106051271;4757.5718185363485;4786.880327991688;4801.4958429364415;4808.374911261513;4850.95149048505;4893.143699852582;4893.461719210955;4897.853064408074;4901.828436004723;4965.776540055634;4650.883727906829;4697.177993850994;4786.473487916257;4791.784369703441;4853.563179313879 07:57:56 INFO - PROCESS | 16028 | |1;ext.html;534.7219445888138;534.7326336831584;547.7726743401487;549.0090386851736;552.3868505958385;26868.4626307474;27981.720182798166;37527.99999999996;39122.80438597803;39322.803385983105;38978.41532377017;39328;39348.21303573927;39424.60575394245;39561.60438395615;7084.114485689289;7567.999999999986;7748.6900523978975;7756.844863102735;7758.262965018343;7199.280071992811;9647.469389183592;9910.454924979123;9922.503874806267;10268;10180;10224.130948869355;10225.642102526414;10253.641122560712;10257.794844103113;10004.449755263458;10074.9496252519;10100.595976160981;10102.898971010269;10125.89874101257;9933.50332483373;10000.499975001294;10004.649837255662;10006.849897251546;10010.249231307609;37773.62226377756;38006;38046.429303560195;38086.619133808585;38127.428088578694;2989.4021195760715;3022.637283525991;3057.1592811976884;3137.0588823352905;3222.017284728157;27412.725872741215;28510.714892851014;28682.426351473063;28775.71224287751;28988;3156.352947645727;3221.7100460958627;3254.625718042432;3264.722498587623;3281.0812972367776;243775;244039;244166;244755;245656;31300.53049204264;50934.49065509297;51295;51327;51327.48672513227;31850.044498665076;33892.49161262583;33993.83003084969;34034.14914627154;34038.829805850815;12698.619041428772;12725.745485090247;12737.490500379881;12806.61580152597;12854.228746275254;8359.791005224917;8622.525761083076;10285.074343309137;10630.521626526825;10633.308834925705;7755.961220193975;7869;7879.803004924923;7979.561124138112;7996.400269979658;3110.346827166275;3137.4038932602734;3139.8901038463546;3186.267158553546;3190.2343437574814;794.7854079398645;806.2582424169777;880.8062226310202;945.5036106044245;1022.2282176956351;26040;26944.59583106255;27222.183334499998;27462.45075098487;27506;904.3353135445442;961;971.7570607348163;994.1599348550463;1006.3810756384771;13629.865131019722;14369.928150359181;14498.565043048726;14532.418703251962;14655.853441465662;354662;358708;359078;359404;360480;48604.27093593599;49135.50864491381;49143.754281228365;49151;49184.26223606649;1025.2157099818644;1071.4642678660825;1126.4874482110783;1160.5937921727327;1169.3393232823428;26001.219963401127;28183.344660776693;28987;29173;29482.11553653394;40555.391669124394;41234.38148427836;41251;41254;41254.587454125074;289072;293867;294301;294335;294727;24333.026678932645;24601.384965376008;25524.23427297184;25577.616335755352;26960.460790784466;39126;39272;39362;39830.402543962446;39991.80004100077;34690.82654586711;34780.65219347774;34921.952341429795;35280.29439411146;35637.64362356343;34414.311713765084;34647.30705385929;34803;35033.64966350304;35180.648193517736;34272.143196420286;34272.65727342694;34435.31129377449;34532.48201277033;36010.63989360178;30086.398272034876;32839;32859;32914.5439728825;32966.67033329732;24628;24713.752862471145;25210.62184067277;25415.237542873743;25519.87240063788 07:57:56 INFO - PROCESS | 16028 | |2;jquery.html;329.80541480526483;343.44705024909894;347.65582073747;354.7179991906434;375.51558489548484;12102.035001424652;13092.541761038365;15601.765973510392;16448.177591120457;17282.654346913056;17156;17248;17297.91351043243;17428;17464.388746393877;3876;4992.375953005874;5215.869603259911;5236.607254455912;5236.8690782730355;5059;5171.560417364529;5191.792328306863;5201.063808514466;5201.349831271091;4942.901141977159;5112.923306150392;5177.042247184283;5181.093308670967;5184.1705327147665;5106.059697315034;5122.33409656746;5146.768395422215;5153.510416510426;5154.433012368637;4420.469543654782;4590.311453282001;4590.586847183769;4594.0122873582;4602.102589994919;20673.069711862852;20718.274860379814;20817.375478735663;20855.37433876986;21176.788232117637;1801.4775715042622;1887.9622407551772;2015.4860510569858;2220.922267720622;2337.9245547048376;12480.50077996879;12638.873611263862;12856.421461034275;12899.548515801996;13810.65473363164;1695.846824159571;1727.637196188802;1745.9912700436544;1753.1321995612127;1771.8936863788085;67178.66410667964;67678.66160669165;67817.66091169562;67927.32072679308;68761.65619171872;9122;9266.119718626855;9335.626574937063;9526.90473095274;9716;13132.474701012043;13136.671583210305;13141.211527308393;13142.60572182817;13155.73688526224;6400.295967443578;6569.310222426672;6723.394894459522;6832.940894161413;6957.156353566208;6378.521610879203;6405.519586030973;6461.19235095613;6567;6637.734490620321;5815.9709201453725;5867;5894.911576326359;5937.70311484424;5999.850003749942;1628.804543454793;1679.41220572801;1709.487103913046;1722.879398442122;1739.1304347826087;819.700809204648;838.1911455445525;839.8446287436843;840.6763396092426;845.0746432656232;16473.752893706605;17111.74332385015;17577.296908123786;18072.09639518019;18082.186301616195;799.7880561651167;805.6898094233645;826.5990994367847;846.0481957797477;846.1538461538462;7681.961590192125;9688.273379496566;10172.847407288897;10182.538813149185;10252;354099;387153;387914;390259;396869;64888.675556621914;81487;82149.17850821535;82360.58819705863;83323;878.2359347367703;903.4082675847462;933.8505839065717;934.4626839567276;938.7653086728318;15450.227488625298;15453.304601293194;15999.280032398803;16400.26198821032;16442.17789110516;35131.824340878135;35281.47077793784;35533.46699799453;35602.10994725153;36086.27827443384;48299.75850120727;48386.51613483961;48585;49829.50170498249;51187.488125118274;7072.752453664097;7213.855722885408;7231.385332246818;7472.14070381913;7676.117246516722;9058.954705226432;10390.22073344487;10534.315269507457;10555.894441055798;10733.463326833471;9262.44425334482;9414.15272625467;9581.712548623553;9774.364666296668;9820.116189542976;9259.583318750807;9334.673286434941;9341.2994025447;9509.952450237704;9698.660546881107;9377.718668439958;9399.483028433502;9452.952735236555;9679.70960871175;9908.950455247677;6385.29761726219;6608.7356505739235;6699.933000669931;6992.650367481708;7247.13034435871;9429.811403772022;9598.232141428809;9765.414075155513;9983.850242246226;10344.637937672145 07:57:56 INFO - PROCESS | 16028 | |3;mootools.html;1230.4708975140686;1341.8188544546485;1378.2350795308603;1398.9300534973256;1636.3536403120775;6469.450096741777;7288.979542864004;7489.026426564553;7508.399328053756;7676.616169191546;7541;7605.657745401456;7606.08726952765;7611;7620;2082.781307962665;2096.360610013945;2097;2107.820835229;2108.11459187141;2047.3653167518116;2052.189385192848;2052.3535086447796;2075.035108674466;2077.937661870139;2008.2669825513656;2010.346637342862;2018.0515157875775;2039.8470114741378;2053.4455696961813;2007.6185524750251;2019.636465436221;2020.1313435222849;2023.342413715541;2024.7772744998038;1952.6680464320957;1959.6080783843147;1996.2114964588907;1997.7103320018516;1997.7502812148482;7378.889316660255;7498.6625601848045;7518.473706840523;7619.809504762426;7622.085349758009;4340.457442819647;4461.843835465743;4463;4463.263561512346;4469.240229161018;2729.6042073899175;2870.5120129577813;2914.810537315068;2930.692277310873;2937.911862644124;881.6473410635733;887.7114937645291;891.7681402835309;892.5537231384308;908.6138391183721;10215.284930054899;10310.484475776182;10331.948340258326;10358.792824143551;10371.688849334532;3612.205314830733;3737.663610275034;3876.2053778975805;3897.590752970954;3927.4108883667677;8145.674173033012;8171.305439037748;8173.182681731898;8180.795480112925;8185.140560241089;4364.214441400515;4366.825326986885;4373.51891291964;4374.19077470669;4378.343248512685;3510.684038436553;3639.3813051781262;3909.237698648736;4069.4709687740406;4093.038136038029;3304.884329048472;3331.5002749587757;3433.6738009889023;3470.583529976419;3519.665631764978;1052.4211683574003;1059.3855563772993;1068.220199254533;1068.695421804782;1071.3946620159586;716.1799739298474;749.7975546602387;763.1338430880879;768.7347864986571;785.4776573578621;4639.257718764981;4680.274557443602;4871.464138944713;5199.532042116228;5287.550558202519;834.8163404051099;872.3283072034498;874.173905659146;882.5543100734217;898.5552151684827;3451.1027132945114;3451.240727040047;3484.651534846495;3500.842462089212;3606.6213047630145;8815.338849586307;9081.59132839024;9226.26189904806;9299.814003720023;9342.2526197904;9235.76910577241;9238.907610923805;9241.722748317561;9247.95376023129;9251.861222081674;6541.443977261986;6725.293844146392;6768.83077923046;7035.33164349386;7178.353948144692;5034.043531728959;5157.742112894265;5268.894622107613;5293.364796224478;5307.787688492417;8302.709405171032;8476.110008449024;8499.95750021246;8575;8635.6977505787;8272.420930534805;8732.60703268367;8732.65069397217;8753;8835.028146903707;5631.971840140937;6330.556861019684;6492.123563318892;6492.318306577741;6500.349965003462;6194.81415557534;6891.069705589681;6976.19773726028;7074;7078.362947334765;6174.38256174379;6247.875042499034;6351;6465.515086368447;6491.318411566906;6262.123302737529;6384.170057892445;6398.680065996588;6399.904001439889;6418.326075761977;5816.563757718272;5903.4391732787035;5906.70466476683;5914.556408269311;5929.169916211647;4023.5775243599;4025.436438898498;4155.522114956819;4182.456280683492;4276.059266961263;4025.577314381948;4061.268971585143;4115.9588404115575;4126;4253.936190957076 07:57:56 INFO - PROCESS | 16028 | |4;prototype.html;292.6093664957282;294.99115026549197;297.34583915386156;299.1399725788359;302.77745856795264;4768.427788665356;4836.830710925118;4846.369971903657;4855.660103792736;4866.318715379845;4763.4522029966565;4776.211925032374;4783.210770222909;4789.257665061921;4800.8319708810195;3547.964520354802;3662.52387189665;3672.669459748622;3806.486124373209;3807.0672685192167;3751;3764.661180493755;3771.0760863588457;3771.7548359356692;3780.2250538639514;3749.43758436234;3756.530433695788;3757.1358587524887;3758.135628805376;3761.8683346082894;3571.714262858965;3609.224016836393;3684.618268149444;3757.2008853404254;3778.301014312361;3328.267781088157;3330.150811543041;3331.583552055993;3334.733221342311;3355.1444381682513;4643.535646435364;4671.649626278043;4682.6253899687945;4683.648726345537;4693.88265293367;4213.377849527923;4294.184105020067;4301.5698430157045;4323.632491238249;4335.154644844225;5012.147934851084;5014.222795466709;5028.346314979066;5037.596992240612;5041.697498150123;3659.396199627058;3668.633136686337;3671.4125739881492;3674.8346324415465;3685.4840322354894;5238.276096429873;5273.789048438058;5281.853744810343;5306.867328316785;5307.203919412119;3570.839312230904;3714.4242642390473;3735.6451137141926;3745.587985321667;3749.681277091423;3786.981065094712;3788.109794198361;3799.810009499514;3802.8478860845257;3832.9041773955873;4283.935740963888;4301.139772045603;4307.6615622892505;4317.870463886088;4324.8486302979245;4779.498152693986;5034.395872495324;5053.8736531587;5059.316992206079;5079.085764562415;1280.4750052478626;1286.6718986658343;1290.387066143593;1291.6447976806267;1303.270168705528;803.8512875118122;814.5642081486376;825.9710910118117;831.7108481853104;832.5421018439833;4030.9395359069636;4031;4044.645043910323;4329.675274354373;4442.556169245008;5109.003744269831;5228.758169934665;5230.738463076831;5238.057149713089;5240.633155679142;4501.639868810487;4507.256302710081;4513.390692256503;4515.909681806345;4517.932231016537;2696.7168447313143;2747.7085769688615;2760.3927136030043;2770.8476033818333;2782.499150152951;4897.534734200245;4909.926351104737;4920.507949205123;4922.458529561745;4926.926096108561;5281.419043905167;5301.575873930154;5335.413104558495;5337.572994160458;5380.757865896044;4714.198586240347;4959.454460009396;4965.131102057126;4976.552110310017;5006.69959802413;5301.496357845998;5312.5218730314455;5314.760835762478;5325.707086110301;5326.9200961984825;5216.37403511581;5228.921566176587;5230.790768369375;5233.371995360429;5240.187770895517;4734.715917044989;4936.679115857458;4962.5533701967;4972.538593396292;5017.147084995487;3675;3690.4648825919553;3693.5937046924278;3702.500162478031;3713.350163721284;5242.764075616683;5247.370315562157;5247.4227834937365;5264.473552644705;5299.735013249399;4915.3855768029;5078.162103252922;5101.974490127525;5130.923036154535;5140.2803607495725;5128.282040514406;5130.769115389742;5135.204043373283;5135.794568217229;5146.305248791515;4977.950220497749;5024.221245706921;5069.619778516552;5072.264521644414;5084.186530155157;4887.633427493023;5109.437961824122;5154;5158.303629010185;5186.807034382038;4777.259524773665;4835.775543250144;4902.264660300983;4992.80028798844;5015.949840501548 07:57:56 INFO - PROCESS | 16028 | |5;yui.html;606.8573885136993;634.0710858592162;659.3571268013687;665.3047565294268;668.6589839182019;13044.478220871166;14412.063215890987;14414.27928603571;14435.206063666494;14444.855551444469;13547.187168769857;13655.726885462309;13673.521426750065;13704.725905481884;13714.314284285796;602.0758136260819;617.2038070888549;737.3327138939269;742.7920182348951;750.6471958179646;761.5544906229862;763.2596381509926;764.5756605084204;764.75910088322;765.3456294867891;788.1566723605744;788.3062904643905;794.5510786405691;794.7774623105539;795.5664163031162;635.8346829824233;650.453618960071;767.97312094077;785.9567723775218;786.0881377601954;575.5798267264878;590.3388205210192;590.4626789621467;590.6633219065135;590.7282649981014;12340.876591234062;12382.938085309606;12383.318917459535;12396.13227074105;12399.690007749878;12356;12568.874311256863;12629.43167557462;12821.038422118378;13042.347882605833;11728.589499367481;11744.530218791238;11870.88129118715;12130.818037729352;12176.634700958897;4075.4701888754566;4104.4664193654635;4108.116754897682;4297.656187505024;4308.569143085666;64595.67702161506;64800;65164;65274;65922;9402.670906518239;9468.14786669203;10061.144802691706;10186.083252507162;10267;17773.555661108574;18060.27758889656;18070.5482362942;18084.63830723378;18102.45692629223;6109.14471973924;6201.782937597162;6322.462590679752;6410.935890641033;6527.3472652734345;3535.5934067582557;3537.9469307960403;3575.785452872784;3601.3517566837695;3667.7799332040163;2751.9862400687866;2839.772818174541;2845.146456063173;2847.0604700448803;2849.586809912551;473.1412486337287;475.3416518122356;480.46428232520486;485.05414441838553;491.9434265059492;485.2454433356095;513.2147813844823;525.1282870435059;526.9288646032813;548.150366931255;7359.153697324876;7462.70149194037;7481.102267727908;7510.699572017167;7537.359324457482;511.74668539073394;524.9160134378558;532.1034057612935;536.4822945857188;564.8023191882808;3552.7690700104927;3608.296382205497;3691.501647277637;3693.6469272850654;3803.505544279226;95817;96504;98487;98652.5067374673;98745;49625.75187124041;52942.735286324096;81526.18473815304;83464.58267708623;86750.56624716963;78356;78735.60632196802;78782.21217787864;79052.60473697595;79540;6801.965990170018;7130.291314243653;7140.7857764267155;7244.927550724426;7260.128784545888;31069.378612428078;39240.76542507238;39263.803680981415;39596.40605390979;39627.405588916765;37907.81046094752;38139.42790858084;50007;58519.4148058514;60628.69685651544;10580.15358771281;10611.787764244518;10750.73123171927;10886.78226435451;11095.778084438427;11793.05655547537;12187.268763874195;12470;13241.470341186245;13330.00324683426;11653.212705870796;11888.643340699447;11918.165728398928;12253.203541769757;12542.498300067895;11888.405579720806;12144.939275303566;12209.755804884031;12416.068794840243;12449.377531123226;11666.88333116658;11784.351860647746;11985.28088314704;12149;12174.269543827399;9955.900440995498;10470.21473389514;10488;10520.421376824348;10816.783664326513;9381.437113773196;9521.238300936047;9929.751756206153;10672.679819605424;10809.405482698527 07:57:56 INFO - PROCESS | 16028 | __end_tp_report 07:57:56 INFO - PROCESS | 16028 | __start_cc_report 07:57:56 INFO - PROCESS | 16028 | _x_x_mozilla_cycle_collect,1291 07:57:56 INFO - PROCESS | 16028 | __end_cc_report 07:57:56 INFO - PROCESS | 16028 | __startTimestamp1476197876021__endTimestamp 07:57:56 INFO - PROCESS | 16028 | 07:57:56 INFO - PROCESS | 16028 | ------- Summary: start ------- 07:57:56 INFO - PROCESS | 16028 | Number of tests: 6 07:57:56 INFO - PROCESS | 16028 | 07:57:56 INFO - PROCESS | 16028 | [#0] dojo.html Cycles:165 Average:4548.19 Median:4671.44 stddev:478.06 (10.2%) stddev-sans-first:451.81 07:57:56 INFO - PROCESS | 16028 | Values: 2503.3 2531.6 2535.5 2562.9 2576.1 4484.1 4544.7 4615.7 4633.1 4647.2 4573.0 4606.1 4657.5 4671.4 4716.1 4161.0 4172.6 4212.0 4227.9 4229.0 3853.8 4236.5 4271.2 4309.9 4361.3 4157.8 4259.6 4260.8 4327.8 4365.3 4194.1 4208.4 4251.3 4253.7 4269.0 4220.3 4224.6 4226.5 4276.2 4287.0 4601.7 4617.8 4638.6 4640.3 4682.8 4756.1 4798.1 4802.6 4832.3 4949.6 4917.9 4955.7 4959.8 4998.7 5018.1 4631.9 4632.0 4632.8 4638.6 4687.6 4952.6 5012.8 5042.5 5046.5 5111.1 4786.9 4793.1 4808.9 4848.8 4883.2 4882.0 4944.3 4944.9 4947.4 4955.3 4859.7 4862.6 4871.4 4922.6 4929.9 4748.5 4780.5 4797.6 4824.9 4880.1 4128.5 4154.4 4164.6 4184.5 4245.6 3651.8 3653.7 3696.9 3701.3 3703.7 4222.1 4232.2 4233.4 4233.7 4289.8 4778.2 4823.4 4830.0 4839.7 4872.7 4233.7 4241.6 4242.0 4278.2 4282.7 4407.3 4410.1 4415.9 4457.6 4466.7 4471.8 4557.9 4562.7 4589.1 4646.5 4807.4 4849.4 4856.8 4887.9 4888.3 4551.6 4559.2 4574.1 4575.7 4580.5 4783.7 4785.4 4794.6 4797.7 4819.1 4948.9 4952.3 4991.3 5043.7 5050.6 4828.0 4874.0 4882.2 4883.1 4941.9 4730.0 4785.5 4864.6 4875.8 4939.8 4757.6 4786.9 4801.5 4808.4 4851.0 4893.1 4893.5 4897.9 4901.8 4965.8 4650.9 4697.2 4786.5 4791.8 4853.6 07:57:56 INFO - PROCESS | 16028 | 07:57:56 INFO - PROCESS | 16028 | [#1] ext.html Cycles:180 Average:44289.61 Median:32849.00 stddev:79499.20 (242.0%) stddev-sans-first:79654.34 07:57:56 INFO - PROCESS | 16028 | Values: 534.7 534.7 547.8 549.0 552.4 26868.5 27981.7 37528.0 39122.8 39322.8 38978.4 39328.0 39348.2 39424.6 39561.6 7084.1 7568.0 7748.7 7756.8 7758.3 7199.3 9647.5 9910.5 9922.5 10268.0 10180.0 10224.1 10225.6 10253.6 10257.8 10004.4 10074.9 10100.6 10102.9 10125.9 9933.5 10000.5 10004.6 10006.8 10010.2 37773.6 38006.0 38046.4 38086.6 38127.4 2989.4 3022.6 3057.2 3137.1 3222.0 27412.7 28510.7 28682.4 28775.7 28988.0 3156.4 3221.7 3254.6 3264.7 3281.1 243775.0 244039.0 244166.0 244755.0 245656.0 31300.5 50934.5 51295.0 51327.0 51327.5 31850.0 33892.5 33993.8 34034.1 34038.8 12698.6 12725.7 12737.5 12806.6 12854.2 8359.8 8622.5 10285.1 10630.5 10633.3 7756.0 7869.0 7879.8 7979.6 7996.4 3110.3 3137.4 3139.9 3186.3 3190.2 794.8 806.3 880.8 945.5 1022.2 26040.0 26944.6 27222.2 27462.5 27506.0 904.3 961.0 971.8 994.2 1006.4 13629.9 14369.9 14498.6 14532.4 14655.9 354662.0 358708.0 359078.0 359404.0 360480.0 48604.3 49135.5 49143.8 49151.0 49184.3 1025.2 1071.5 1126.5 1160.6 1169.3 26001.2 28183.3 28987.0 29173.0 29482.1 40555.4 41234.4 41251.0 41254.0 41254.6 289072.0 293867.0 294301.0 294335.0 294727.0 24333.0 24601.4 25524.2 25577.6 26960.5 39126.0 39272.0 39362.0 39830.4 39991.8 34690.8 34780.7 34922.0 35280.3 35637.6 34414.3 34647.3 34803.0 35033.6 35180.6 34272.1 34272.7 34435.3 34532.5 36010.6 30086.4 32839.0 32859.0 32914.5 32966.7 24628.0 24713.8 25210.6 25415.2 25519.9 07:57:56 INFO - PROCESS | 16028 | 07:57:56 INFO - PROCESS | 16028 | [#2] jquery.html Cycles:180 Average:23929.77 Median:5150.14 stddev:63407.41 (1231.2%) stddev-sans-first:63560.52 07:57:56 INFO - PROCESS | 16028 | Values: 329.8 343.4 347.7 354.7 375.5 12102.0 13092.5 15601.8 16448.2 17282.7 17156.0 17248.0 17297.9 17428.0 17464.4 3876.0 4992.4 5215.9 5236.6 5236.9 5059.0 5171.6 5191.8 5201.1 5201.3 4942.9 5112.9 5177.0 5181.1 5184.2 5106.1 5122.3 5146.8 5153.5 5154.4 4420.5 4590.3 4590.6 4594.0 4602.1 20673.1 20718.3 20817.4 20855.4 21176.8 1801.5 1888.0 2015.5 2220.9 2337.9 12480.5 12638.9 12856.4 12899.5 13810.7 1695.8 1727.6 1746.0 1753.1 1771.9 67178.7 67678.7 67817.7 67927.3 68761.7 9122.0 9266.1 9335.6 9526.9 9716.0 13132.5 13136.7 13141.2 13142.6 13155.7 6400.3 6569.3 6723.4 6832.9 6957.2 6378.5 6405.5 6461.2 6567.0 6637.7 5816.0 5867.0 5894.9 5937.7 5999.9 1628.8 1679.4 1709.5 1722.9 1739.1 819.7 838.2 839.8 840.7 845.1 16473.8 17111.7 17577.3 18072.1 18082.2 799.8 805.7 826.6 846.0 846.2 7682.0 9688.3 10172.8 10182.5 10252.0 354099.0 387153.0 387914.0 390259.0 396869.0 64888.7 81487.0 82149.2 82360.6 83323.0 878.2 903.4 933.9 934.5 938.8 15450.2 15453.3 15999.3 16400.3 16442.2 35131.8 35281.5 35533.5 35602.1 36086.3 48299.8 48386.5 48585.0 49829.5 51187.5 7072.8 7213.9 7231.4 7472.1 7676.1 9059.0 10390.2 10534.3 10555.9 10733.5 9262.4 9414.2 9581.7 9774.4 9820.1 9259.6 9334.7 9341.3 9510.0 9698.7 9377.7 9399.5 9453.0 9679.7 9909.0 6385.3 6608.7 6699.9 6992.7 7247.1 9429.8 9598.2 9765.4 9983.9 10344.6 07:57:56 INFO - PROCESS | 16028 | 07:57:56 INFO - PROCESS | 16028 | [#3] mootools.html Cycles:180 Average:4857.57 Median:5234.21 stddev:2742.46 (52.4%) stddev-sans-first:2736.61 07:57:56 INFO - PROCESS | 16028 | Values: 1230.5 1341.8 1378.2 1398.9 1636.4 6469.5 7289.0 7489.0 7508.4 7676.6 7541.0 7605.7 7606.1 7611.0 7620.0 2082.8 2096.4 2097.0 2107.8 2108.1 2047.4 2052.2 2052.4 2075.0 2077.9 2008.3 2010.3 2018.1 2039.8 2053.4 2007.6 2019.6 2020.1 2023.3 2024.8 1952.7 1959.6 1996.2 1997.7 1997.8 7378.9 7498.7 7518.5 7619.8 7622.1 4340.5 4461.8 4463.0 4463.3 4469.2 2729.6 2870.5 2914.8 2930.7 2937.9 881.6 887.7 891.8 892.6 908.6 10215.3 10310.5 10331.9 10358.8 10371.7 3612.2 3737.7 3876.2 3897.6 3927.4 8145.7 8171.3 8173.2 8180.8 8185.1 4364.2 4366.8 4373.5 4374.2 4378.3 3510.7 3639.4 3909.2 4069.5 4093.0 3304.9 3331.5 3433.7 3470.6 3519.7 1052.4 1059.4 1068.2 1068.7 1071.4 716.2 749.8 763.1 768.7 785.5 4639.3 4680.3 4871.5 5199.5 5287.6 834.8 872.3 874.2 882.6 898.6 3451.1 3451.2 3484.7 3500.8 3606.6 8815.3 9081.6 9226.3 9299.8 9342.3 9235.8 9238.9 9241.7 9248.0 9251.9 6541.4 6725.3 6768.8 7035.3 7178.4 5034.0 5157.7 5268.9 5293.4 5307.8 8302.7 8476.1 8500.0 8575.0 8635.7 8272.4 8732.6 8732.7 8753.0 8835.0 5632.0 6330.6 6492.1 6492.3 6500.3 6194.8 6891.1 6976.2 7074.0 7078.4 6174.4 6247.9 6351.0 6465.5 6491.3 6262.1 6384.2 6398.7 6399.9 6418.3 5816.6 5903.4 5906.7 5914.6 5929.2 4023.6 4025.4 4155.5 4182.5 4276.1 4025.6 4061.3 4116.0 4126.0 4253.9 07:57:56 INFO - PROCESS | 16028 | 07:57:56 INFO - PROCESS | 16028 | [#4] prototype.html Cycles:180 Average:4209.15 Median:4778.38 stddev:1233.14 (25.8%) stddev-sans-first:1201.05 07:57:56 INFO - PROCESS | 16028 | Values: 292.6 295.0 297.3 299.1 302.8 4768.4 4836.8 4846.4 4855.7 4866.3 4763.5 4776.2 4783.2 4789.3 4800.8 3548.0 3662.5 3672.7 3806.5 3807.1 3751.0 3764.7 3771.1 3771.8 3780.2 3749.4 3756.5 3757.1 3758.1 3761.9 3571.7 3609.2 3684.6 3757.2 3778.3 3328.3 3330.2 3331.6 3334.7 3355.1 4643.5 4671.6 4682.6 4683.6 4693.9 4213.4 4294.2 4301.6 4323.6 4335.2 5012.1 5014.2 5028.3 5037.6 5041.7 3659.4 3668.6 3671.4 3674.8 3685.5 5238.3 5273.8 5281.9 5306.9 5307.2 3570.8 3714.4 3735.6 3745.6 3749.7 3787.0 3788.1 3799.8 3802.8 3832.9 4283.9 4301.1 4307.7 4317.9 4324.8 4779.5 5034.4 5053.9 5059.3 5079.1 1280.5 1286.7 1290.4 1291.6 1303.3 803.9 814.6 826.0 831.7 832.5 4030.9 4031.0 4044.6 4329.7 4442.6 5109.0 5228.8 5230.7 5238.1 5240.6 4501.6 4507.3 4513.4 4515.9 4517.9 2696.7 2747.7 2760.4 2770.8 2782.5 4897.5 4909.9 4920.5 4922.5 4926.9 5281.4 5301.6 5335.4 5337.6 5380.8 4714.2 4959.5 4965.1 4976.6 5006.7 5301.5 5312.5 5314.8 5325.7 5326.9 5216.4 5228.9 5230.8 5233.4 5240.2 4734.7 4936.7 4962.6 4972.5 5017.1 3675.0 3690.5 3693.6 3702.5 3713.4 5242.8 5247.4 5247.4 5264.5 5299.7 4915.4 5078.2 5102.0 5130.9 5140.3 5128.3 5130.8 5135.2 5135.8 5146.3 4978.0 5024.2 5069.6 5072.3 5084.2 4887.6 5109.4 5154.0 5158.3 5186.8 4777.3 4835.8 4902.3 4992.8 5015.9 07:57:56 INFO - PROCESS | 16028 | 07:57:56 INFO - PROCESS | 16028 | [#5] yui.html Cycles:180 Average:17029.83 Median:2390.86 stddev:24318.86 (1017.2%) stddev-sans-first:24355.81 07:57:56 INFO - PROCESS | 16028 | Values: 606.9 634.1 659.4 665.3 668.7 13044.5 14412.1 14414.3 14435.2 14444.9 13547.2 13655.7 13673.5 13704.7 13714.3 602.1 617.2 737.3 742.8 750.6 761.6 763.3 764.6 764.8 765.3 788.2 788.3 794.6 794.8 795.6 635.8 650.5 768.0 786.0 786.1 575.6 590.3 590.5 590.7 590.7 12340.9 12382.9 12383.3 12396.1 12399.7 12356.0 12568.9 12629.4 12821.0 13042.3 11728.6 11744.5 11870.9 12130.8 12176.6 4075.5 4104.5 4108.1 4297.7 4308.6 64595.7 64800.0 65164.0 65274.0 65922.0 9402.7 9468.1 10061.1 10186.1 10267.0 17773.6 18060.3 18070.5 18084.6 18102.5 6109.1 6201.8 6322.5 6410.9 6527.3 3535.6 3537.9 3575.8 3601.4 3667.8 2752.0 2839.8 2845.1 2847.1 2849.6 473.1 475.3 480.5 485.1 491.9 485.2 513.2 525.1 526.9 548.2 7359.2 7462.7 7481.1 7510.7 7537.4 511.7 524.9 532.1 536.5 564.8 3552.8 3608.3 3691.5 3693.6 3803.5 95817.0 96504.0 98487.0 98652.5 98745.0 49625.8 52942.7 81526.2 83464.6 86750.6 78356.0 78735.6 78782.2 79052.6 79540.0 6802.0 7130.3 7140.8 7244.9 7260.1 31069.4 39240.8 39263.8 39596.4 39627.4 37907.8 38139.4 50007.0 58519.4 60628.7 10580.2 10611.8 10750.7 10886.8 11095.8 11793.1 12187.3 12470.0 13241.5 13330.0 11653.2 11888.6 11918.2 12253.2 12542.5 11888.4 12144.9 12209.8 12416.1 12449.4 11666.9 11784.4 11985.3 12149.0 12174.3 9955.9 10470.2 10488.0 10520.4 10816.8 9381.4 9521.2 9929.8 10672.7 10809.4 07:57:56 INFO - PROCESS | 16028 | -------- Summary: end -------- 07:57:56 INFO - PROCESS | 16028 | 07:57:57 INFO - TEST-INFO | 16028: exit 0 07:57:57 INFO - TEST-OK | dromaeo_css | took 1122525ms 07:57:57 INFO - TEST-START | kraken 07:57:57 INFO - operating with platform_type : linux_ 07:57:57 INFO - Initialising browser for kraken test... 07:57:57 INFO - TEST-INFO | started process 16336 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvE6Aua/profile http://localhost:43675/getInfo.html) 07:58:01 INFO - PROCESS | 16336 | __metrics Screen width/height:1600/1200 07:58:01 INFO - PROCESS | 16336 | colorDepth:24 07:58:01 INFO - PROCESS | 16336 | Browser inner width/height: 1024/697 07:58:01 INFO - PROCESS | 16336 | __metrics 07:58:02 INFO - PROCESS | 16336 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 07:58:02 INFO - PROCESS | 16336 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:58:02 INFO - PROCESS | 16336 | console.error: PushService: 07:58:02 INFO - PROCESS | 16336 | stateChangeProcessEnqueue: Error transitioning state 07:58:02 INFO - PROCESS | 16336 | UnknownError 07:58:03 INFO - TEST-INFO | 16336: exit 0 07:58:03 INFO - Browser initialized. 07:58:03 INFO - Running cycle 1/1 for kraken test... 07:58:03 INFO - TEST-INFO | started process 16419 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvE6Aua/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:58:15 INFO - PROCESS | 16419 | RSS: Main: 174960640 07:58:15 INFO - PROCESS | 16419 | 07:58:18 INFO - PROCESS | 16419 | Cycle 1(1): loaded http://localhost:43675/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43675/tests/kraken/driver.html?testName=audio-beat-detection) 07:58:19 INFO - PROCESS | 16419 | RSS: Main: 242323456 07:58:19 INFO - PROCESS | 16419 | 07:58:22 INFO - PROCESS | 16419 | Cycle 1(1): loaded http://localhost:43675/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43675/tests/kraken/driver.html?testName=audio-dft) 07:58:22 INFO - PROCESS | 16419 | RSS: Main: 217931776 07:58:22 INFO - PROCESS | 16419 | 07:58:26 INFO - PROCESS | 16419 | Cycle 1(1): loaded http://localhost:43675/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43675/tests/kraken/driver.html?testName=audio-fft) 07:58:26 INFO - PROCESS | 16419 | RSS: Main: 300945408 07:58:26 INFO - PROCESS | 16419 | 07:58:28 INFO - PROCESS | 16419 | Cycle 1(1): loaded http://localhost:43675/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43675/tests/kraken/driver.html?testName=audio-oscillator) 07:58:29 INFO - PROCESS | 16419 | RSS: Main: 211574784 07:58:29 INFO - PROCESS | 16419 | 07:58:31 INFO - PROCESS | 16419 | Cycle 1(1): loaded http://localhost:43675/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43675/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:58:32 INFO - PROCESS | 16419 | RSS: Main: 214278144 07:58:32 INFO - PROCESS | 16419 | 07:58:35 INFO - PROCESS | 16419 | Cycle 1(1): loaded http://localhost:43675/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43675/tests/kraken/driver.html?testName=imaging-darkroom) 07:58:36 INFO - PROCESS | 16419 | RSS: Main: 250245120 07:58:36 INFO - PROCESS | 16419 | 07:58:39 INFO - PROCESS | 16419 | Cycle 1(1): loaded http://localhost:43675/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43675/tests/kraken/driver.html?testName=imaging-desaturate) 07:58:40 INFO - PROCESS | 16419 | RSS: Main: 244240384 07:58:40 INFO - PROCESS | 16419 | 07:58:43 INFO - PROCESS | 16419 | Cycle 1(1): loaded http://localhost:43675/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43675/tests/kraken/driver.html?testName=json-parse-financial) 07:58:43 INFO - PROCESS | 16419 | RSS: Main: 246931456 07:58:43 INFO - PROCESS | 16419 | 07:58:45 INFO - PROCESS | 16419 | Cycle 1(1): loaded http://localhost:43675/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43675/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:58:46 INFO - PROCESS | 16419 | RSS: Main: 210427904 07:58:46 INFO - PROCESS | 16419 | 07:58:48 INFO - PROCESS | 16419 | Cycle 1(1): loaded http://localhost:43675/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43675/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:58:48 INFO - PROCESS | 16419 | RSS: Main: 217264128 07:58:48 INFO - PROCESS | 16419 | 07:58:50 INFO - PROCESS | 16419 | Cycle 1(1): loaded http://localhost:43675/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43675/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:58:51 INFO - PROCESS | 16419 | RSS: Main: 226893824 07:58:51 INFO - PROCESS | 16419 | 07:58:54 INFO - PROCESS | 16419 | Cycle 1(1): loaded http://localhost:43675/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43675/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:58:55 INFO - PROCESS | 16419 | RSS: Main: 235216896 07:58:55 INFO - PROCESS | 16419 | 07:58:58 INFO - PROCESS | 16419 | Cycle 1(1): loaded http://localhost:43675/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43675/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:58:58 INFO - PROCESS | 16419 | RSS: Main: 232521728 07:58:58 INFO - PROCESS | 16419 | 07:59:00 INFO - PROCESS | 16419 | Cycle 1(1): loaded http://localhost:43675/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43675/tests/kraken/driver.html?testName=ai-astar) 07:59:00 INFO - PROCESS | 16419 | RSS: Main: 283684864 07:59:00 INFO - PROCESS | 16419 | 07:59:00 INFO - PROCESS | 16419 | __start_tp_report 07:59:00 INFO - PROCESS | 16419 | _x_x_mozilla_page_load 07:59:00 INFO - PROCESS | 16419 | _x_x_mozilla_page_load_details 07:59:00 INFO - PROCESS | 16419 | |i|pagename|runs| 07:59:00 INFO - PROCESS | 16419 | |0;ai-astar;111;115;117;114;115;115;115;117;114;114 07:59:00 INFO - PROCESS | 16419 | |1;audio-beat-detection;153;126;125;164;128;132;127;127;169;127 07:59:00 INFO - PROCESS | 16419 | |2;audio-dft;161;161;162;161;161;160;161;161;163;162 07:59:00 INFO - PROCESS | 16419 | |3;audio-fft;76;77;76;111;78;76;77;77;111;76 07:59:00 INFO - PROCESS | 16419 | |4;audio-oscillator;84;82;127;84;84;83;119;83;83;116 07:59:00 INFO - PROCESS | 16419 | |5;imaging-gaussian-blur;117;118;118;118;117;117;119;117;117;118 07:59:00 INFO - PROCESS | 16419 | |6;imaging-darkroom;147;146;146;147;147;146;146;146;146;146 07:59:00 INFO - PROCESS | 16419 | |7;imaging-desaturate;95;95;97;96;95;94;95;95;95;95 07:59:00 INFO - PROCESS | 16419 | |8;json-parse-financial;65;65;65;63;64;65;65;65;71;65 07:59:00 INFO - PROCESS | 16419 | |9;json-stringify-tinderbox;65;65;65;65;65;65;65;65;66;65 07:59:00 INFO - PROCESS | 16419 | |10;stanford-crypto-aes;83;82;85;86;83;84;84;84;83;85 07:59:00 INFO - PROCESS | 16419 | |11;stanford-crypto-ccm;141;138;140;138;148;139;139;137;185;139 07:59:00 INFO - PROCESS | 16419 | |12;stanford-crypto-pbkdf2;177;178;179;180;181;178;184;179;180;176 07:59:00 INFO - PROCESS | 16419 | |13;stanford-crypto-sha256-iterative;73;70;77;70;69;71;70;70;69;67 07:59:00 INFO - PROCESS | 16419 | __end_tp_report 07:59:00 INFO - PROCESS | 16419 | __start_cc_report 07:59:00 INFO - PROCESS | 16419 | _x_x_mozilla_cycle_collect,2010 07:59:00 INFO - PROCESS | 16419 | __end_cc_report 07:59:00 INFO - PROCESS | 16419 | __startTimestamp1476197940813__endTimestamp 07:59:00 INFO - PROCESS | 16419 | 07:59:00 INFO - PROCESS | 16419 | ------- Summary: start ------- 07:59:00 INFO - PROCESS | 16419 | Number of tests: 14 07:59:00 INFO - PROCESS | 16419 | 07:59:00 INFO - PROCESS | 16419 | [#0] ai-astar Cycles:10 Average:114.70 Median:115.00 stddev:1.70 (1.5%) stddev-sans-first:1.17 07:59:00 INFO - PROCESS | 16419 | Values: 111.0 115.0 117.0 114.0 115.0 115.0 115.0 117.0 114.0 114.0 07:59:00 INFO - PROCESS | 16419 | 07:59:00 INFO - PROCESS | 16419 | [#1] audio-beat-detection Cycles:10 Average:137.80 Median:130.00 stddev:17.24 (13.3%) stddev-sans-first:17.38 07:59:00 INFO - PROCESS | 16419 | Values: 153.0 126.0 125.0 164.0 128.0 132.0 127.0 127.0 169.0 127.0 07:59:00 INFO - PROCESS | 16419 | 07:59:00 INFO - PROCESS | 16419 | [#2] audio-dft Cycles:10 Average:161.30 Median:161.00 stddev:0.82 (0.5%) stddev-sans-first:0.87 07:59:00 INFO - PROCESS | 16419 | Values: 161.0 161.0 162.0 161.0 161.0 160.0 161.0 161.0 163.0 162.0 07:59:00 INFO - PROCESS | 16419 | 07:59:00 INFO - PROCESS | 16419 | [#3] audio-fft Cycles:10 Average:83.50 Median:76.50 stddev:14.51 (19.0%) stddev-sans-first:15.13 07:59:00 INFO - PROCESS | 16419 | Values: 76.0 77.0 76.0 111.0 78.0 76.0 77.0 77.0 111.0 76.0 07:59:00 INFO - PROCESS | 16419 | 07:59:00 INFO - PROCESS | 16419 | [#4] audio-oscillator Cycles:10 Average:94.50 Median:83.00 stddev:18.27 (22.0%) stddev-sans-first:18.97 07:59:00 INFO - PROCESS | 16419 | Values: 84.0 82.0 127.0 84.0 84.0 83.0 119.0 83.0 83.0 116.0 07:59:00 INFO - PROCESS | 16419 | 07:59:00 INFO - PROCESS | 16419 | [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:118.00 stddev:0.70 (0.6%) stddev-sans-first:0.71 07:59:00 INFO - PROCESS | 16419 | Values: 117.0 118.0 118.0 118.0 117.0 117.0 119.0 117.0 117.0 118.0 07:59:00 INFO - PROCESS | 16419 | 07:59:00 INFO - PROCESS | 16419 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.00 stddev:0.48 (0.3%) stddev-sans-first:0.44 07:59:00 INFO - PROCESS | 16419 | Values: 147.0 146.0 146.0 147.0 147.0 146.0 146.0 146.0 146.0 146.0 07:59:00 INFO - PROCESS | 16419 | 07:59:00 INFO - PROCESS | 16419 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.79 (0.8%) stddev-sans-first:0.83 07:59:00 INFO - PROCESS | 16419 | Values: 95.0 95.0 97.0 96.0 95.0 94.0 95.0 95.0 95.0 95.0 07:59:00 INFO - PROCESS | 16419 | 07:59:00 INFO - PROCESS | 16419 | [#8] json-parse-financial Cycles:10 Average:65.30 Median:65.00 stddev:2.11 (3.2%) stddev-sans-first:2.24 07:59:00 INFO - PROCESS | 16419 | Values: 65.0 65.0 65.0 63.0 64.0 65.0 65.0 65.0 71.0 65.0 07:59:00 INFO - PROCESS | 16419 | 07:59:00 INFO - PROCESS | 16419 | [#9] json-stringify-tinderbox Cycles:10 Average:65.10 Median:65.00 stddev:0.32 (0.5%) stddev-sans-first:0.33 07:59:00 INFO - PROCESS | 16419 | Values: 65.0 65.0 65.0 65.0 65.0 65.0 65.0 65.0 66.0 65.0 07:59:00 INFO - PROCESS | 16419 | 07:59:00 INFO - PROCESS | 16419 | [#10] stanford-crypto-aes Cycles:10 Average:83.90 Median:84.00 stddev:1.20 (1.4%) stddev-sans-first:1.22 07:59:00 INFO - PROCESS | 16419 | Values: 83.0 82.0 85.0 86.0 83.0 84.0 84.0 84.0 83.0 85.0 07:59:00 INFO - PROCESS | 16419 | 07:59:00 INFO - PROCESS | 16419 | [#11] stanford-crypto-ccm Cycles:10 Average:144.40 Median:139.50 stddev:14.59 (10.5%) stddev-sans-first:15.43 07:59:00 INFO - PROCESS | 16419 | Values: 141.0 138.0 140.0 138.0 148.0 139.0 139.0 137.0 185.0 139.0 07:59:00 INFO - PROCESS | 16419 | 07:59:00 INFO - PROCESS | 16419 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:179.20 Median:179.50 stddev:2.25 (1.3%) stddev-sans-first:2.24 07:59:00 INFO - PROCESS | 16419 | Values: 177.0 178.0 179.0 180.0 181.0 178.0 184.0 179.0 180.0 176.0 07:59:00 INFO - PROCESS | 16419 | 07:59:00 INFO - PROCESS | 16419 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.60 Median:70.00 stddev:2.72 (3.9%) stddev-sans-first:2.74 07:59:00 INFO - PROCESS | 16419 | Values: 73.0 70.0 77.0 70.0 69.0 71.0 70.0 70.0 69.0 67.0 07:59:00 INFO - PROCESS | 16419 | -------- Summary: end -------- 07:59:00 INFO - PROCESS | 16419 | 07:59:02 INFO - TEST-INFO | 16419: exit 0 07:59:02 INFO - TEST-OK | kraken | took 65042ms 07:59:02 INFO - SUITE-END | took 1187s 07:59:02 INFO - Completed test suite (00:19:47) 07:59:02 INFO - javascript benchmark 07:59:02 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2503.3241024923273, 2531.5822889223277, 2535.5309267785456, 2562.92311230663, 2576.09836557205, 4484.103179364124, 4544.681872268942, 4615.746133962635, 4633.142868569313, 4647.233206520928, 4573.0, 4606.1478626454045, 4657.534246575341, 4671.439427268724, 4716.056788642268, 4160.958390416087, 4172.603602657758, 4211.968067823387, 4227.87316380509, 4229.027323715547, 3853.84584616615, 4236.533981262059, 4271.231178387889, 4309.892252693677, 4361.34579813029, 4157.771322577288, 4259.552746961586, 4260.7656578888145, 4327.7619730914785, 4365.323374876899, 4194.0563373240775, 4208.389783481378, 4251.319788833803, 4253.744775313491, 4268.9786551067355, 4220.345846393814, 4224.619784219435, 4226.5139508956245, 4276.187524370391, 4286.957130428687, 4601.723896566216, 4617.792199351004, 4638.605718513931, 4640.327152562893, 4682.836100736492, 4756.120117778188, 4798.136335459616, 4802.639802014863, 4832.275158726184, 4949.628777841676, 4917.901641967176, 4955.702657840505, 4959.752012399365, 4998.6750861193905, 5018.096742586333, 4631.9305210421535, 4631.980964187874, 4632.791524381343, 4638.5593368629925, 4687.6249900007915, 4952.579030782424, 5012.8496145115705, 5042.512458824655, 5046.470120637354, 5111.131107711698, 4786.946871688223, 4793.065352256276, 4808.855734327975, 4848.8302909398, 4883.218685010382, 4881.975590122027, 4944.258361245842, 4944.90110197794, 4947.356843610308, 4955.256711493233, 4859.65982381237, 4862.635302352338, 4871.415430148405, 4922.606191504671, 4929.901401971941, 4748.548887855717, 4780.545848144421, 4797.592204662573, 4824.879378015507, 4880.1215781159735, 4128.545859955402, 4154.4183814265425, 4164.604362585549, 4184.456020717287, 4245.61789438952, 3651.7626354286886, 3653.6529029742132, 3696.9445458318146, 3701.3152566775234, 3703.666669999659, 4222.0500387412585, 4232.195882782323, 4233.428487154257, 4233.661307095425, 4289.806958686867, 4778.235482322812, 4823.3729615149805, 4829.95170048302, 4839.685420447659, 4872.6832755870755, 4233.682473814476, 4241.597048280409, 4242.0, 4278.208531421635, 4282.678799090081, 4407.2507673695545, 4410.07388448423, 4415.889602759892, 4457.64338852891, 4466.731996080245, 4471.843485478123, 4557.908841823211, 4562.703424277412, 4589.105124500824, 4646.465656449552, 4807.423109226916, 4849.442314133778, 4856.757162141808, 4887.90224195507, 4888.315635810918, 4551.590356867898, 4559.247724125482, 4574.062317224894, 4575.7483338416705, 4580.541945805393, 4783.689060211075, 4785.377900872864, 4794.640401969936, 4797.736124513185, 4819.084373968934, 4948.925766113583, 4952.306677065286, 4991.276264941635, 5043.672161309503, 5050.570701490415, 4828.0, 4874.025194961093, 4882.194437917704, 4883.096627123993, 4941.876453088702, 4730.030343779586, 4785.49752276006, 4864.635152363516, 4875.791233727412, 4939.827106051271, 4757.5718185363485, 4786.880327991688, 4801.4958429364415, 4808.374911261513, 4850.95149048505, 4893.143699852582, 4893.461719210955, 4897.853064408074, 4901.828436004723, 4965.776540055634, 4650.883727906829, 4697.177993850994, 4786.473487916257, 4791.784369703441, 4853.563179313879], "value": 4517.4231879128265, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [534.7219445888138, 534.7326336831584, 547.7726743401487, 549.0090386851736, 552.3868505958385, 26868.4626307474, 27981.720182798166, 37527.99999999996, 39122.80438597803, 39322.803385983105, 38978.41532377017, 39328.0, 39348.21303573927, 39424.60575394245, 39561.60438395615, 7084.114485689289, 7567.999999999986, 7748.6900523978975, 7756.844863102735, 7758.262965018343, 7199.280071992811, 9647.469389183592, 9910.454924979123, 9922.503874806267, 10268.0, 10180.0, 10224.130948869355, 10225.642102526414, 10253.641122560712, 10257.794844103113, 10004.449755263458, 10074.9496252519, 10100.595976160981, 10102.898971010269, 10125.89874101257, 9933.50332483373, 10000.499975001294, 10004.649837255662, 10006.849897251546, 10010.249231307609, 37773.62226377756, 38006.0, 38046.429303560195, 38086.619133808585, 38127.428088578694, 2989.4021195760715, 3022.637283525991, 3057.1592811976884, 3137.0588823352905, 3222.017284728157, 27412.725872741215, 28510.714892851014, 28682.426351473063, 28775.71224287751, 28988.0, 3156.352947645727, 3221.7100460958627, 3254.625718042432, 3264.722498587623, 3281.0812972367776, 243775.0, 244039.0, 244166.0, 244755.0, 245656.0, 31300.53049204264, 50934.49065509297, 51295.0, 51327.0, 51327.48672513227, 31850.044498665076, 33892.49161262583, 33993.83003084969, 34034.14914627154, 34038.829805850815, 12698.619041428772, 12725.745485090247, 12737.490500379881, 12806.61580152597, 12854.228746275254, 8359.791005224917, 8622.525761083076, 10285.074343309137, 10630.521626526825, 10633.308834925705, 7755.961220193975, 7869.0, 7879.803004924923, 7979.561124138112, 7996.400269979658, 3110.346827166275, 3137.4038932602734, 3139.8901038463546, 3186.267158553546, 3190.2343437574814, 794.7854079398645, 806.2582424169777, 880.8062226310202, 945.5036106044245, 1022.2282176956351, 26040.0, 26944.59583106255, 27222.183334499998, 27462.45075098487, 27506.0, 904.3353135445442, 961.0, 971.7570607348163, 994.1599348550463, 1006.3810756384771, 13629.865131019722, 14369.928150359181, 14498.565043048726, 14532.418703251962, 14655.853441465662, 354662.0, 358708.0, 359078.0, 359404.0, 360480.0, 48604.27093593599, 49135.50864491381, 49143.754281228365, 49151.0, 49184.26223606649, 1025.2157099818644, 1071.4642678660825, 1126.4874482110783, 1160.5937921727327, 1169.3393232823428, 26001.219963401127, 28183.344660776693, 28987.0, 29173.0, 29482.11553653394, 40555.391669124394, 41234.38148427836, 41251.0, 41254.0, 41254.587454125074, 289072.0, 293867.0, 294301.0, 294335.0, 294727.0, 24333.026678932645, 24601.384965376008, 25524.23427297184, 25577.616335755352, 26960.460790784466, 39126.0, 39272.0, 39362.0, 39830.402543962446, 39991.80004100077, 34690.82654586711, 34780.65219347774, 34921.952341429795, 35280.29439411146, 35637.64362356343, 34414.311713765084, 34647.30705385929, 34803.0, 35033.64966350304, 35180.648193517736, 34272.143196420286, 34272.65727342694, 34435.31129377449, 34532.48201277033, 36010.63989360178, 30086.398272034876, 32839.0, 32859.0, 32914.5439728825, 32966.67033329732, 24628.0, 24713.752862471145, 25210.62184067277, 25415.237542873743, 25519.87240063788], "value": 16393.69521985435, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [329.80541480526483, 343.44705024909894, 347.65582073747, 354.7179991906434, 375.51558489548484, 12102.035001424652, 13092.541761038365, 15601.765973510392, 16448.177591120457, 17282.654346913056, 17156.0, 17248.0, 17297.91351043243, 17428.0, 17464.388746393877, 3876.0, 4992.375953005874, 5215.869603259911, 5236.607254455912, 5236.8690782730355, 5059.0, 5171.560417364529, 5191.792328306863, 5201.063808514466, 5201.349831271091, 4942.901141977159, 5112.923306150392, 5177.042247184283, 5181.093308670967, 5184.1705327147665, 5106.059697315034, 5122.33409656746, 5146.768395422215, 5153.510416510426, 5154.433012368637, 4420.469543654782, 4590.311453282001, 4590.586847183769, 4594.0122873582, 4602.102589994919, 20673.069711862852, 20718.274860379814, 20817.375478735663, 20855.37433876986, 21176.788232117637, 1801.4775715042622, 1887.9622407551772, 2015.4860510569858, 2220.922267720622, 2337.9245547048376, 12480.50077996879, 12638.873611263862, 12856.421461034275, 12899.548515801996, 13810.65473363164, 1695.846824159571, 1727.637196188802, 1745.9912700436544, 1753.1321995612127, 1771.8936863788085, 67178.66410667964, 67678.66160669165, 67817.66091169562, 67927.32072679308, 68761.65619171872, 9122.0, 9266.119718626855, 9335.626574937063, 9526.90473095274, 9716.0, 13132.474701012043, 13136.671583210305, 13141.211527308393, 13142.60572182817, 13155.73688526224, 6400.295967443578, 6569.310222426672, 6723.394894459522, 6832.940894161413, 6957.156353566208, 6378.521610879203, 6405.519586030973, 6461.19235095613, 6567.0, 6637.734490620321, 5815.9709201453725, 5867.0, 5894.911576326359, 5937.70311484424, 5999.850003749942, 1628.804543454793, 1679.41220572801, 1709.487103913046, 1722.879398442122, 1739.1304347826087, 819.700809204648, 838.1911455445525, 839.8446287436843, 840.6763396092426, 845.0746432656232, 16473.752893706605, 17111.74332385015, 17577.296908123786, 18072.09639518019, 18082.186301616195, 799.7880561651167, 805.6898094233645, 826.5990994367847, 846.0481957797477, 846.1538461538462, 7681.961590192125, 9688.273379496566, 10172.847407288897, 10182.538813149185, 10252.0, 354099.0, 387153.0, 387914.0, 390259.0, 396869.0, 64888.675556621914, 81487.0, 82149.17850821535, 82360.58819705863, 83323.0, 878.2359347367703, 903.4082675847462, 933.8505839065717, 934.4626839567276, 938.7653086728318, 15450.227488625298, 15453.304601293194, 15999.280032398803, 16400.26198821032, 16442.17789110516, 35131.824340878135, 35281.47077793784, 35533.46699799453, 35602.10994725153, 36086.27827443384, 48299.75850120727, 48386.51613483961, 48585.0, 49829.50170498249, 51187.488125118274, 7072.752453664097, 7213.855722885408, 7231.385332246818, 7472.14070381913, 7676.117246516722, 9058.954705226432, 10390.22073344487, 10534.315269507457, 10555.894441055798, 10733.463326833471, 9262.44425334482, 9414.15272625467, 9581.712548623553, 9774.364666296668, 9820.116189542976, 9259.583318750807, 9334.673286434941, 9341.2994025447, 9509.952450237704, 9698.660546881107, 9377.718668439958, 9399.483028433502, 9452.952735236555, 9679.70960871175, 9908.950455247677, 6385.29761726219, 6608.7356505739235, 6699.933000669931, 6992.650367481708, 7247.13034435871, 9429.811403772022, 9598.232141428809, 9765.414075155513, 9983.850242246226, 10344.637937672145], "value": 8032.96605500787, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1230.4708975140686, 1341.8188544546485, 1378.2350795308603, 1398.9300534973256, 1636.3536403120775, 6469.450096741777, 7288.979542864004, 7489.026426564553, 7508.399328053756, 7676.616169191546, 7541.0, 7605.657745401456, 7606.08726952765, 7611.0, 7620.0, 2082.781307962665, 2096.360610013945, 2097.0, 2107.820835229, 2108.11459187141, 2047.3653167518116, 2052.189385192848, 2052.3535086447796, 2075.035108674466, 2077.937661870139, 2008.2669825513656, 2010.346637342862, 2018.0515157875775, 2039.8470114741378, 2053.4455696961813, 2007.6185524750251, 2019.636465436221, 2020.1313435222849, 2023.342413715541, 2024.7772744998038, 1952.6680464320957, 1959.6080783843147, 1996.2114964588907, 1997.7103320018516, 1997.7502812148482, 7378.889316660255, 7498.6625601848045, 7518.473706840523, 7619.809504762426, 7622.085349758009, 4340.457442819647, 4461.843835465743, 4463.0, 4463.263561512346, 4469.240229161018, 2729.6042073899175, 2870.5120129577813, 2914.810537315068, 2930.692277310873, 2937.911862644124, 881.6473410635733, 887.7114937645291, 891.7681402835309, 892.5537231384308, 908.6138391183721, 10215.284930054899, 10310.484475776182, 10331.948340258326, 10358.792824143551, 10371.688849334532, 3612.205314830733, 3737.663610275034, 3876.2053778975805, 3897.590752970954, 3927.4108883667677, 8145.674173033012, 8171.305439037748, 8173.182681731898, 8180.795480112925, 8185.140560241089, 4364.214441400515, 4366.825326986885, 4373.51891291964, 4374.19077470669, 4378.343248512685, 3510.684038436553, 3639.3813051781262, 3909.237698648736, 4069.4709687740406, 4093.038136038029, 3304.884329048472, 3331.5002749587757, 3433.6738009889023, 3470.583529976419, 3519.665631764978, 1052.4211683574003, 1059.3855563772993, 1068.220199254533, 1068.695421804782, 1071.3946620159586, 716.1799739298474, 749.7975546602387, 763.1338430880879, 768.7347864986571, 785.4776573578621, 4639.257718764981, 4680.274557443602, 4871.464138944713, 5199.532042116228, 5287.550558202519, 834.8163404051099, 872.3283072034498, 874.173905659146, 882.5543100734217, 898.5552151684827, 3451.1027132945114, 3451.240727040047, 3484.651534846495, 3500.842462089212, 3606.6213047630145, 8815.338849586307, 9081.59132839024, 9226.26189904806, 9299.814003720023, 9342.2526197904, 9235.76910577241, 9238.907610923805, 9241.722748317561, 9247.95376023129, 9251.861222081674, 6541.443977261986, 6725.293844146392, 6768.83077923046, 7035.33164349386, 7178.353948144692, 5034.043531728959, 5157.742112894265, 5268.894622107613, 5293.364796224478, 5307.787688492417, 8302.709405171032, 8476.110008449024, 8499.95750021246, 8575.0, 8635.6977505787, 8272.420930534805, 8732.60703268367, 8732.65069397217, 8753.0, 8835.028146903707, 5631.971840140937, 6330.556861019684, 6492.123563318892, 6492.318306577741, 6500.349965003462, 6194.81415557534, 6891.069705589681, 6976.19773726028, 7074.0, 7078.362947334765, 6174.38256174379, 6247.875042499034, 6351.0, 6465.515086368447, 6491.318411566906, 6262.123302737529, 6384.170057892445, 6398.680065996588, 6399.904001439889, 6418.326075761977, 5816.563757718272, 5903.4391732787035, 5906.70466476683, 5914.556408269311, 5929.169916211647, 4023.5775243599, 4025.436438898498, 4155.522114956819, 4182.456280683492, 4276.059266961263, 4025.577314381948, 4061.268971585143, 4115.9588404115575, 4126.0, 4253.936190957076], "value": 3906.933902070767, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [292.6093664957282, 294.99115026549197, 297.34583915386156, 299.1399725788359, 302.77745856795264, 4768.427788665356, 4836.830710925118, 4846.369971903657, 4855.660103792736, 4866.318715379845, 4763.4522029966565, 4776.211925032374, 4783.210770222909, 4789.257665061921, 4800.8319708810195, 3547.964520354802, 3662.52387189665, 3672.669459748622, 3806.486124373209, 3807.0672685192167, 3751.0, 3764.661180493755, 3771.0760863588457, 3771.7548359356692, 3780.2250538639514, 3749.43758436234, 3756.530433695788, 3757.1358587524887, 3758.135628805376, 3761.8683346082894, 3571.714262858965, 3609.224016836393, 3684.618268149444, 3757.2008853404254, 3778.301014312361, 3328.267781088157, 3330.150811543041, 3331.583552055993, 3334.733221342311, 3355.1444381682513, 4643.535646435364, 4671.649626278043, 4682.6253899687945, 4683.648726345537, 4693.88265293367, 4213.377849527923, 4294.184105020067, 4301.5698430157045, 4323.632491238249, 4335.154644844225, 5012.147934851084, 5014.222795466709, 5028.346314979066, 5037.596992240612, 5041.697498150123, 3659.396199627058, 3668.633136686337, 3671.4125739881492, 3674.8346324415465, 3685.4840322354894, 5238.276096429873, 5273.789048438058, 5281.853744810343, 5306.867328316785, 5307.203919412119, 3570.839312230904, 3714.4242642390473, 3735.6451137141926, 3745.587985321667, 3749.681277091423, 3786.981065094712, 3788.109794198361, 3799.810009499514, 3802.8478860845257, 3832.9041773955873, 4283.935740963888, 4301.139772045603, 4307.6615622892505, 4317.870463886088, 4324.8486302979245, 4779.498152693986, 5034.395872495324, 5053.8736531587, 5059.316992206079, 5079.085764562415, 1280.4750052478626, 1286.6718986658343, 1290.387066143593, 1291.6447976806267, 1303.270168705528, 803.8512875118122, 814.5642081486376, 825.9710910118117, 831.7108481853104, 832.5421018439833, 4030.9395359069636, 4031.0, 4044.645043910323, 4329.675274354373, 4442.556169245008, 5109.003744269831, 5228.758169934665, 5230.738463076831, 5238.057149713089, 5240.633155679142, 4501.639868810487, 4507.256302710081, 4513.390692256503, 4515.909681806345, 4517.932231016537, 2696.7168447313143, 2747.7085769688615, 2760.3927136030043, 2770.8476033818333, 2782.499150152951, 4897.534734200245, 4909.926351104737, 4920.507949205123, 4922.458529561745, 4926.926096108561, 5281.419043905167, 5301.575873930154, 5335.413104558495, 5337.572994160458, 5380.757865896044, 4714.198586240347, 4959.454460009396, 4965.131102057126, 4976.552110310017, 5006.69959802413, 5301.496357845998, 5312.5218730314455, 5314.760835762478, 5325.707086110301, 5326.9200961984825, 5216.37403511581, 5228.921566176587, 5230.790768369375, 5233.371995360429, 5240.187770895517, 4734.715917044989, 4936.679115857458, 4962.5533701967, 4972.538593396292, 5017.147084995487, 3675.0, 3690.4648825919553, 3693.5937046924278, 3702.500162478031, 3713.350163721284, 5242.764075616683, 5247.370315562157, 5247.4227834937365, 5264.473552644705, 5299.735013249399, 4915.3855768029, 5078.162103252922, 5101.974490127525, 5130.923036154535, 5140.2803607495725, 5128.282040514406, 5130.769115389742, 5135.204043373283, 5135.794568217229, 5146.305248791515, 4977.950220497749, 5024.221245706921, 5069.619778516552, 5072.264521644414, 5084.186530155157, 4887.633427493023, 5109.437961824122, 5154.0, 5158.303629010185, 5186.807034382038, 4777.259524773665, 4835.775543250144, 4902.264660300983, 4992.80028798844, 5015.949840501548], "value": 3813.9963139051756, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [606.8573885136993, 634.0710858592162, 659.3571268013687, 665.3047565294268, 668.6589839182019, 13044.478220871166, 14412.063215890987, 14414.27928603571, 14435.206063666494, 14444.855551444469, 13547.187168769857, 13655.726885462309, 13673.521426750065, 13704.725905481884, 13714.314284285796, 602.0758136260819, 617.2038070888549, 737.3327138939269, 742.7920182348951, 750.6471958179646, 761.5544906229862, 763.2596381509926, 764.5756605084204, 764.75910088322, 765.3456294867891, 788.1566723605744, 788.3062904643905, 794.5510786405691, 794.7774623105539, 795.5664163031162, 635.8346829824233, 650.453618960071, 767.97312094077, 785.9567723775218, 786.0881377601954, 575.5798267264878, 590.3388205210192, 590.4626789621467, 590.6633219065135, 590.7282649981014, 12340.876591234062, 12382.938085309606, 12383.318917459535, 12396.13227074105, 12399.690007749878, 12356.0, 12568.874311256863, 12629.43167557462, 12821.038422118378, 13042.347882605833, 11728.589499367481, 11744.530218791238, 11870.88129118715, 12130.818037729352, 12176.634700958897, 4075.4701888754566, 4104.4664193654635, 4108.116754897682, 4297.656187505024, 4308.569143085666, 64595.67702161506, 64800.0, 65164.0, 65274.0, 65922.0, 9402.670906518239, 9468.14786669203, 10061.144802691706, 10186.083252507162, 10267.0, 17773.555661108574, 18060.27758889656, 18070.5482362942, 18084.63830723378, 18102.45692629223, 6109.14471973924, 6201.782937597162, 6322.462590679752, 6410.935890641033, 6527.3472652734345, 3535.5934067582557, 3537.9469307960403, 3575.785452872784, 3601.3517566837695, 3667.7799332040163, 2751.9862400687866, 2839.772818174541, 2845.146456063173, 2847.0604700448803, 2849.586809912551, 473.1412486337287, 475.3416518122356, 480.46428232520486, 485.05414441838553, 491.9434265059492, 485.2454433356095, 513.2147813844823, 525.1282870435059, 526.9288646032813, 548.150366931255, 7359.153697324876, 7462.70149194037, 7481.102267727908, 7510.699572017167, 7537.359324457482, 511.74668539073394, 524.9160134378558, 532.1034057612935, 536.4822945857188, 564.8023191882808, 3552.7690700104927, 3608.296382205497, 3691.501647277637, 3693.6469272850654, 3803.505544279226, 95817.0, 96504.0, 98487.0, 98652.5067374673, 98745.0, 49625.75187124041, 52942.735286324096, 81526.18473815304, 83464.58267708623, 86750.56624716963, 78356.0, 78735.60632196802, 78782.21217787864, 79052.60473697595, 79540.0, 6801.965990170018, 7130.291314243653, 7140.7857764267155, 7244.927550724426, 7260.128784545888, 31069.378612428078, 39240.76542507238, 39263.803680981415, 39596.40605390979, 39627.405588916765, 37907.81046094752, 38139.42790858084, 50007.0, 58519.4148058514, 60628.69685651544, 10580.15358771281, 10611.787764244518, 10750.73123171927, 10886.78226435451, 11095.778084438427, 11793.05655547537, 12187.268763874195, 12470.0, 13241.470341186245, 13330.00324683426, 11653.212705870796, 11888.643340699447, 11918.165728398928, 12253.203541769757, 12542.498300067895, 11888.405579720806, 12144.939275303566, 12209.755804884031, 12416.068794840243, 12449.377531123226, 11666.88333116658, 11784.351860647746, 11985.28088314704, 12149.0, 12174.269543827399, 9955.900440995498, 10470.21473389514, 10488.0, 10520.421376824348, 10816.783664326513, 9381.437113773196, 9521.238300936047, 9929.751756206153, 10672.679819605424, 10809.405482698527], "value": 6365.338536391811, "unit": "score"}], "name": "dromaeo_css", "value": 6193.2949940496665, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 115.0, 117.0, 114.0, 115.0, 115.0, 115.0, 117.0, 114.0, 114.0], "value": 114.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 126.0, 125.0, 164.0, 128.0, 132.0, 127.0, 127.0, 169.0, 127.0], "value": 137.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 162.0, 161.0, 161.0, 160.0, 161.0, 161.0, 163.0, 162.0], "value": 161.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 76.0, 111.0, 78.0, 76.0, 77.0, 77.0, 111.0, 76.0], "value": 83.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 82.0, 127.0, 84.0, 84.0, 83.0, 119.0, 83.0, 83.0, 116.0], "value": 94.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 118.0, 118.0, 117.0, 117.0, 119.0, 117.0, 117.0, 118.0], "value": 117.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 146.0, 147.0, 147.0, 146.0, 146.0, 146.0, 146.0, 146.0], "value": 146.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 97.0, 96.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 63.0, 64.0, 65.0, 65.0, 65.0, 71.0, 65.0], "value": 65.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 65.0, 65.0, 65.0, 65.0, 65.0, 66.0, 65.0], "value": 65.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 85.0, 86.0, 83.0, 84.0, 84.0, 84.0, 83.0, 85.0], "value": 83.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 138.0, 140.0, 138.0, 148.0, 139.0, 139.0, 137.0, 185.0, 139.0], "value": 144.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [177.0, 178.0, 179.0, 180.0, 181.0, 178.0, 184.0, 179.0, 180.0, 176.0], "value": 179.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 70.0, 77.0, 70.0, 69.0, 71.0, 70.0, 70.0, 69.0, 67.0], "value": 70.6, "unit": "score"}], "name": "kraken", "value": 1559.4, "alertThreshold": 2.0}]} 07:59:02 INFO - Return code: 0 07:59:02 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:59:02 INFO - # TBPL SUCCESS # 07:59:02 INFO - Running post-action listener: _resource_record_post_action 07:59:02 INFO - [mozharness: 2016-10-11 14:59:02.597336Z] Finished run-tests step (success) 07:59:02 INFO - Running post-run listener: _resource_record_post_run 07:59:02 INFO - Total resource usage - Wall time: 1204s; CPU: 13.0%; Read bytes: 4096; Write bytes: 391766016; Read time: 8; Write time: 282204 07:59:02 INFO - TinderboxPrint: CPU usage
13.0% 07:59:02 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 07:59:02 INFO - TinderboxPrint: I/O write bytes / time
391,766,016 / 282,204 07:59:02 INFO - TinderboxPrint: CPU idle
8,354.7 (87.0%) 07:59:02 INFO - TinderboxPrint: CPU user
1,203.1 (12.5%) 07:59:02 INFO - TinderboxPrint: Swap in / out
0 / 0 07:59:02 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 99246080; Read time: 0; Write time: 61056 07:59:02 INFO - run-tests - Wall time: 1188s; CPU: 13.0%; Read bytes: 0; Write bytes: 292519936; Read time: 0; Write time: 221148 07:59:03 INFO - Running post-run listener: _upload_blobber_files 07:59:03 INFO - Blob upload gear active. 07:59:03 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:59:03 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 07:59:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Autoland-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:59:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Autoland-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:59:03 INFO - (blobuploader) - INFO - Open directory for files ... 07:59:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:59:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:59:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:59:06 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:59:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:59:06 INFO - (blobuploader) - INFO - Done attempting. 07:59:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:59:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:59:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:59:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:59:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:59:07 INFO - (blobuploader) - INFO - Done attempting. 07:59:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:59:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:59:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:59:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:59:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:59:09 INFO - (blobuploader) - INFO - Done attempting. 07:59:09 INFO - (blobuploader) - INFO - Iteration through files over. 07:59:09 INFO - Return code: 0 07:59:09 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:59:09 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:59:09 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/fc6bcc93e15d778d1aaa31fd2f0d1dbd10079c138082f02fecd507c5266ea61ba1c9d4e293cc6e0b929241464d2e3e051abe036885d6d1f233595ee38888bbb3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/bd2df69bb5cb7cfe87b9e4835d7df5ca425f8dd676e737169355cb311a1bbc2c86fd30f6339c450f8839127a68ae07953ae9c1ce3c0a98faff54291c00696316", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/d99a303188eed73582d585b45735a73a1ee4278ba49be999d1e8feca146a6e679b3082ed245691ea0c56507aa4c43a4487f81ad2dc67486973fc8fe9d4630ff3"} 07:59:09 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:59:09 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:59:09 INFO - Contents: 07:59:09 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/fc6bcc93e15d778d1aaa31fd2f0d1dbd10079c138082f02fecd507c5266ea61ba1c9d4e293cc6e0b929241464d2e3e051abe036885d6d1f233595ee38888bbb3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/bd2df69bb5cb7cfe87b9e4835d7df5ca425f8dd676e737169355cb311a1bbc2c86fd30f6339c450f8839127a68ae07953ae9c1ce3c0a98faff54291c00696316", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/d99a303188eed73582d585b45735a73a1ee4278ba49be999d1e8feca146a6e679b3082ed245691ea0c56507aa4c43a4487f81ad2dc67486973fc8fe9d4630ff3"} 07:59:09 INFO - Running post-run listener: copy_logs_to_upload_dir 07:59:09 INFO - Copying logs to upload dir... 07:59:09 INFO - mkdir: /builds/slave/test/build/upload/logs 07:59:09 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.559726 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-10-11 07:59:08.330143) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-11 07:59:08.334324) ========= 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=db0483c52d987ecb441a263b000001ad-1476196698.153023-1915257621 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/fc6bcc93e15d778d1aaa31fd2f0d1dbd10079c138082f02fecd507c5266ea61ba1c9d4e293cc6e0b929241464d2e3e051abe036885d6d1f233595ee38888bbb3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/bd2df69bb5cb7cfe87b9e4835d7df5ca425f8dd676e737169355cb311a1bbc2c86fd30f6339c450f8839127a68ae07953ae9c1ce3c0a98faff54291c00696316", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/d99a303188eed73582d585b45735a73a1ee4278ba49be999d1e8feca146a6e679b3082ed245691ea0c56507aa4c43a4487f81ad2dc67486973fc8fe9d4630ff3"} build_url:https://queue.taskcluster.net/v1/task/TTuzOZjmTMKDhzzut3S7lQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011195 build_url: 'https://queue.taskcluster.net/v1/task/TTuzOZjmTMKDhzzut3S7lQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/fc6bcc93e15d778d1aaa31fd2f0d1dbd10079c138082f02fecd507c5266ea61ba1c9d4e293cc6e0b929241464d2e3e051abe036885d6d1f233595ee38888bbb3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/bd2df69bb5cb7cfe87b9e4835d7df5ca425f8dd676e737169355cb311a1bbc2c86fd30f6339c450f8839127a68ae07953ae9c1ce3c0a98faff54291c00696316", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/d99a303188eed73582d585b45735a73a1ee4278ba49be999d1e8feca146a6e679b3082ed245691ea0c56507aa4c43a4487f81ad2dc67486973fc8fe9d4630ff3"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-11 07:59:08.360129) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-11 07:59:08.360465) ========= 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=db0483c52d987ecb441a263b000001ad-1476196698.153023-1915257621 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004485 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-11 07:59:08.445646) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-11 07:59:08.445973) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-11 07:59:08.446273) ========= ========= Total master_lag: 0.41 =========