builder: autoland_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-016 starttime: 1475177943.79 results: success (0) buildid: 20160929093019 builduid: 6c2bdf1702bd45df882f45a5da334c40 revision: f21ffbf119bd6d7084309123be42f97743f1f7e5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-29 12:39:03.791002) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-29 12:39:03.791459) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-29 12:39:03.791751) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-29 12:39:03.806705) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-29 12:39:03.807111) ========= 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=00204705a9daa57ed339a427000001b9-1475177941.865958-565175556 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-29 12:39:03-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.5M=0s 2016-09-29 12:39:04 (46.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.123941 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-29 12:39:03.945078) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-29 12:39:03.945407) ========= 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=00204705a9daa57ed339a427000001b9-1475177941.865958-565175556 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016423 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-29 12:39:03.995679) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-29 12:39:03.996039) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev f21ffbf119bd6d7084309123be42f97743f1f7e5 --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 f21ffbf119bd6d7084309123be42f97743f1f7e5 --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=00204705a9daa57ed339a427000001b9-1475177941.865958-565175556 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-29 12:39:04,146 truncating revision to first 12 chars 2016-09-29 12:39:04,146 Setting DEBUG logging. 2016-09-29 12:39:04,146 attempt 1/10 2016-09-29 12:39:04,146 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/f21ffbf119bd?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-29 12:39:04,438 unpacking tar archive at: autoland-f21ffbf119bd/testing/mozharness/ program finished with exit code 0 elapsedTime=0.649281 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-29 12:39:04.659376) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-29 12:39:04.659904) ========= script_repo_revision: f21ffbf119bd6d7084309123be42f97743f1f7e5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-29 12:39:04.660546) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-29 12:39:04.660988) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-29 12:39:04.671694) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-09-29 12:39:04.672065) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Autoland', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=00204705a9daa57ed339a427000001b9-1475177941.865958-565175556 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:39:04 INFO - MultiFileLogger online at 20160929 12:39:04 in /builds/slave/test 12:39:04 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 12:39:04 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:39:04 INFO - {'append_to_log': False, 12:39:04 INFO - 'base_work_dir': '/builds/slave/test', 12:39:04 INFO - 'blob_upload_branch': 'Autoland', 12:39:04 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:39:04 INFO - 'branch': 'Autoland', 12:39:04 INFO - 'buildbot_json_path': 'buildprops.json', 12:39:04 INFO - 'config_files': ('talos/linux_config.py',), 12:39:04 INFO - 'default_actions': ('clobber', 12:39:04 INFO - 'read-buildbot-config', 12:39:04 INFO - 'download-and-extract', 12:39:04 INFO - 'populate-webroot', 12:39:04 INFO - 'create-virtualenv', 12:39:04 INFO - 'install', 12:39:04 INFO - 'run-tests'), 12:39:04 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:39:04 INFO - 'download_minidump_stackwalk': True, 12:39:04 INFO - 'download_symbols': 'ondemand', 12:39:04 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:39:04 INFO - 'tooltool.py': '/tools/tooltool.py', 12:39:04 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:39:04 INFO - '/tools/misc-python/virtualenv.py')}, 12:39:04 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:39:04 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:39:04 INFO - 'installer_path': 'installer.exe', 12:39:04 INFO - 'log_level': 'info', 12:39:04 INFO - 'log_name': 'talos', 12:39:04 INFO - 'log_to_console': True, 12:39:04 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:39:04 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:39:04 INFO - 'opt_config_files': (), 12:39:04 INFO - 'pip_index': False, 12:39:04 INFO - 'sps_profile': False, 12:39:04 INFO - 'sps_profile_interval': 0, 12:39:04 INFO - 'suite': 'dromaeojs-e10s', 12:39:04 INFO - 'system_bits': '32', 12:39:04 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:39:04 INFO - 'title': 'talos-linux64-ix-016', 12:39:04 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:39:04 INFO - 'use_talos_json': True, 12:39:04 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:39:04 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:39:04 INFO - 'work_dir': 'build'} 12:39:04 INFO - [mozharness: 2016-09-29 19:39:04.920249Z] Running clobber step. 12:39:04 INFO - Running pre-action listener: _resource_record_pre_action 12:39:04 INFO - Running main action method: clobber 12:39:04 INFO - rmtree: /builds/slave/test/build 12:39:04 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:39:05 INFO - Running post-action listener: _resource_record_post_action 12:39:05 INFO - [mozharness: 2016-09-29 19:39:05.389595Z] Finished clobber step (success) 12:39:05 INFO - [mozharness: 2016-09-29 19:39:05.389695Z] Running read-buildbot-config step. 12:39:05 INFO - Running pre-action listener: _resource_record_pre_action 12:39:05 INFO - Running main action method: read_buildbot_config 12:39:05 INFO - Using buildbot properties: 12:39:05 INFO - { 12:39:05 INFO - "project": "", 12:39:05 INFO - "product": "firefox", 12:39:05 INFO - "script_repo_revision": "production", 12:39:05 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs-e10s", 12:39:05 INFO - "repository": "", 12:39:05 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland pgo talos dromaeojs-e10s", 12:39:05 INFO - "buildid": "20160929093019", 12:39:05 INFO - "pgo_build": "True", 12:39:05 INFO - "basedir": "/builds/slave/test", 12:39:05 INFO - "buildnumber": 299, 12:39:05 INFO - "slavename": "talos-linux64-ix-016", 12:39:05 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 12:39:05 INFO - "platform": "ubuntu64_hw", 12:39:05 INFO - "scheduler": "tests-autoland-linux64-pgo-talos", 12:39:05 INFO - "branch": "autoland", 12:39:05 INFO - "repo_path": "integration/autoland", 12:39:05 INFO - "revision": "f21ffbf119bd6d7084309123be42f97743f1f7e5", 12:39:05 INFO - "stage_platform": "linux64-pgo", 12:39:05 INFO - "builduid": "6c2bdf1702bd45df882f45a5da334c40", 12:39:05 INFO - "slavebuilddir": "test" 12:39:05 INFO - } 12:39:05 INFO - Found installer url https://queue.taskcluster.net/v1/task/bV7VLb_MT62eaQdxqlI60g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 12:39:05 INFO - Running post-action listener: _resource_record_post_action 12:39:05 INFO - [mozharness: 2016-09-29 19:39:05.392121Z] Finished read-buildbot-config step (success) 12:39:05 INFO - [mozharness: 2016-09-29 19:39:05.392210Z] Running download-and-extract step. 12:39:05 INFO - Running pre-action listener: _resource_record_pre_action 12:39:05 INFO - Running main action method: download_and_extract 12:39:05 INFO - mkdir: /builds/slave/test/build/tests 12:39:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:39:05 INFO - trying https://queue.taskcluster.net/v1/task/bV7VLb_MT62eaQdxqlI60g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 12:39:05 INFO - Downloading https://queue.taskcluster.net/v1/task/bV7VLb_MT62eaQdxqlI60g/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 12:39:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bV7VLb_MT62eaQdxqlI60g/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 12:39:05 INFO - Downloaded 1361 bytes. 12:39:05 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 12:39:05 INFO - Using the following test package requirements: 12:39:05 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 12:39:05 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:39:05 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 12:39:05 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:39:05 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 12:39:05 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:39:05 INFO - u'jsshell-linux-x86_64.zip'], 12:39:05 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:39:05 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 12:39:05 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 12:39:05 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:39:05 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 12:39:05 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:39:05 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 12:39:05 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:39:05 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 12:39:05 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 12:39:05 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 12:39:05 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:39:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bV7VLb_MT62eaQdxqlI60g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 12:39:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bV7VLb_MT62eaQdxqlI60g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:39:05 INFO - Fetch https://queue.taskcluster.net/v1/task/bV7VLb_MT62eaQdxqlI60g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 12:39:06 INFO - Http code: 200 12:39:06 INFO - Content-Encoding: None 12:39:06 INFO - Content-Type: application/zip 12:39:06 INFO - via: 1.1 c0740de9f16cf32ffedfd2f9806b8483.cloudfront.net (CloudFront) 12:39:06 INFO - x-amz-cf-id: nKQHKMHBRmSLyiSlUKUNpZZYV21soCuF3qgiuDjAgmIighqreUACIQ== 12:39:06 INFO - x-amz-version-id: mYxwdnwBjAC.bGLQemXK21FbAbZRWp6W 12:39:06 INFO - x-cache: Hit from cloudfront 12:39:06 INFO - Expected file size: 21988666 12:39:06 INFO - Obtained file size: 21988666 12:39:10 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 12:39:10 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bV7VLb_MT62eaQdxqlI60g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 12:39:10 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bV7VLb_MT62eaQdxqlI60g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:39:10 INFO - Fetch https://queue.taskcluster.net/v1/task/bV7VLb_MT62eaQdxqlI60g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 12:39:11 INFO - Http code: 200 12:39:11 INFO - Content-Encoding: None 12:39:11 INFO - Content-Type: application/zip 12:39:11 INFO - via: 1.1 d8f42fc9558e3e49ebfdf8834baeb756.cloudfront.net (CloudFront) 12:39:11 INFO - x-amz-cf-id: dsraBVQXTovGmtxbsPRdWX53Rmml3MwUyAw4miA3D1GbIgMW4JZXvA== 12:39:11 INFO - x-amz-version-id: mYxwdnwBjAC.bGLQemXK21FbAbZRWp6W 12:39:11 INFO - x-cache: Hit from cloudfront 12:39:11 INFO - Expected file size: 21988666 12:39:11 INFO - Obtained file size: 21988666 12:39:16 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bV7VLb_MT62eaQdxqlI60g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 12:39:16 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bV7VLb_MT62eaQdxqlI60g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 12:39:16 INFO - Fetch https://queue.taskcluster.net/v1/task/bV7VLb_MT62eaQdxqlI60g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 12:39:16 INFO - Http code: 200 12:39:16 INFO - Content-Encoding: None 12:39:16 INFO - Content-Type: application/zip 12:39:16 INFO - via: 1.1 24b0e5a3429d07ef12381da50e07f70f.cloudfront.net (CloudFront) 12:39:16 INFO - x-amz-cf-id: nwAzWvjth4O0zfrIye3Jziehn_yKblrQxqz41WG9PvNwgLnn_Ekcpw== 12:39:16 INFO - x-amz-version-id: pNsSW5b0G32A0.E7SuTH4pbuC3rVnU5C 12:39:16 INFO - x-cache: Hit from cloudfront 12:39:16 INFO - Expected file size: 14414067 12:39:16 INFO - Obtained file size: 14414067 12:39:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:39:17 INFO - trying https://queue.taskcluster.net/v1/task/bV7VLb_MT62eaQdxqlI60g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 12:39:17 INFO - Downloading https://queue.taskcluster.net/v1/task/bV7VLb_MT62eaQdxqlI60g/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 12:39:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bV7VLb_MT62eaQdxqlI60g/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 12:39:18 INFO - Downloaded 59748949 bytes. 12:39:18 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bV7VLb_MT62eaQdxqlI60g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 12:39:18 INFO - mkdir: /builds/slave/test/properties 12:39:18 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:39:18 INFO - Writing to file /builds/slave/test/properties/build_url 12:39:18 INFO - Contents: 12:39:18 INFO - build_url:https://queue.taskcluster.net/v1/task/bV7VLb_MT62eaQdxqlI60g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 12:39:19 INFO - Running post-action listener: _resource_record_post_action 12:39:19 INFO - Running post-action listener: set_extra_try_arguments 12:39:19 INFO - [mozharness: 2016-09-29 19:39:19.153662Z] Finished download-and-extract step (success) 12:39:19 INFO - [mozharness: 2016-09-29 19:39:19.153889Z] Running populate-webroot step. 12:39:19 INFO - Running pre-action listener: _resource_record_pre_action 12:39:19 INFO - Running main action method: populate_webroot 12:39:19 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:39:19 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:39:19 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:39:19 INFO - '--tppagecycles', 12:39:19 INFO - '7'], 12:39:19 INFO - 'tests': ['tsvgm']}}, 12:39:19 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:39:19 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:39:19 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:39:19 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:39:19 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:39:19 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:39:19 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:39:19 INFO - 'talos_options': ['--disable-e10s'], 12:39:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:39:19 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:39:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:39:19 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:39:19 INFO - 'talos_options': ['--disable-e10s'], 12:39:19 INFO - 'tests': ['damp', 'tps']}, 12:39:19 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:39:19 INFO - 'tests': ['damp', 'tps']}, 12:39:19 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:39:19 INFO - 'tests': ['dromaeo_dom']}, 12:39:19 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:39:19 INFO - 'g4': {'talos_options': ['--disable-e10s'], 12:39:19 INFO - 'tests': ['basic_compositor_video']}, 12:39:19 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 12:39:19 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:39:19 INFO - 'tests': ['a11yr', 12:39:19 INFO - 'ts_paint', 12:39:19 INFO - 'tpaint', 12:39:19 INFO - 'sessionrestore', 12:39:19 INFO - 'sessionrestore_no_auto_restore', 12:39:19 INFO - 'tabpaint']}, 12:39:19 INFO - 'other-e10s': {'tests': ['a11yr', 12:39:19 INFO - 'ts_paint', 12:39:19 INFO - 'tpaint', 12:39:19 INFO - 'sessionrestore', 12:39:19 INFO - 'sessionrestore_no_auto_restore', 12:39:19 INFO - 'tabpaint']}, 12:39:19 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:39:19 INFO - 'ts_paint', 12:39:19 INFO - 'tpaint', 12:39:19 INFO - 'sessionrestore', 12:39:19 INFO - 'sessionrestore_no_auto_restore', 12:39:19 INFO - 'tabpaint']}, 12:39:19 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:39:19 INFO - 'ts_paint', 12:39:19 INFO - 'tpaint', 12:39:19 INFO - 'sessionrestore', 12:39:19 INFO - 'sessionrestore_no_auto_restore', 12:39:19 INFO - 'tabpaint']}, 12:39:19 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:39:19 INFO - 'tests': ['a11yr', 12:39:19 INFO - 'ts_paint', 12:39:19 INFO - 'tpaint', 12:39:19 INFO - 'sessionrestore', 12:39:19 INFO - 'sessionrestore_no_auto_restore', 12:39:19 INFO - 'tabpaint']}, 12:39:19 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:39:19 INFO - 'tests': ['a11yr', 12:39:19 INFO - 'ts_paint', 12:39:19 INFO - 'tpaint', 12:39:19 INFO - 'sessionrestore', 12:39:19 INFO - 'sessionrestore_no_auto_restore', 12:39:19 INFO - 'tabpaint']}, 12:39:19 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:39:19 INFO - 'tests': ['tsvgx', 12:39:19 INFO - 'tsvgr_opacity', 12:39:19 INFO - 'tart', 12:39:19 INFO - 'tscrollx', 12:39:19 INFO - 'cart']}, 12:39:19 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:39:19 INFO - 'tsvgr_opacity', 12:39:19 INFO - 'tart', 12:39:19 INFO - 'tscrollx', 12:39:19 INFO - 'cart']}, 12:39:19 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:39:19 INFO - 'talos_options': ['--disable-e10s'], 12:39:19 INFO - 'tests': ['tp5o']}, 12:39:19 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:39:19 INFO - 'tests': ['tp5o']}, 12:39:19 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:39:19 INFO - 'talos_options': ['--disable-e10s', 12:39:19 INFO - '--xperf_path', 12:39:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:39:19 INFO - 'tests': ['tp5n']}, 12:39:19 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:39:19 INFO - 'talos_options': ['--xperf_path', 12:39:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:39:19 INFO - 'tests': ['tp5n']}}, 12:39:19 INFO - 'talos.zip': {'path': '', 12:39:19 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:39:19 INFO - Running post-action listener: _resource_record_post_action 12:39:19 INFO - [mozharness: 2016-09-29 19:39:19.171898Z] Finished populate-webroot step (success) 12:39:19 INFO - [mozharness: 2016-09-29 19:39:19.171986Z] Running create-virtualenv step. 12:39:19 INFO - Running pre-action listener: _resource_record_pre_action 12:39:19 INFO - Running main action method: create_virtualenv 12:39:19 INFO - Creating virtualenv /builds/slave/test/build/venv 12:39:19 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 12:39:19 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:39:19 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:39:19 INFO - Using real prefix '/usr' 12:39:19 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:39:19 INFO - Installing distribute.............................................................................................................................................................................................done. 12:39:21 INFO - Installing pip.................done. 12:39:21 INFO - Return code: 0 12:39:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 12:39:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 12:39:21 INFO - Reading from file tmpfile_stdout 12:39:21 INFO - Output received: 12:39:21 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) 12:39:21 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:39:21 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')]} 12:39:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:39:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:39:21 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')]} 12:39:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:39:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:39:21 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 0x7f3e84451f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21668a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2233790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2230930>, '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 0x2231830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2231cc0>, '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': '00204705a9daa57ed339a427000001b9-1475177941.865958-565175556', '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 12:39:21 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 12:39:21 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 12:39:21 INFO - Using env: {'DISPLAY': ':0', 12:39:21 INFO - 'HOME': '/home/cltbld', 12:39:21 INFO - 'LANG': 'en_US.UTF-8', 12:39:21 INFO - 'LANGUAGE': 'en_US:en', 12:39:21 INFO - 'LOGNAME': 'cltbld', 12:39:21 INFO - 'MAIL': '/var/mail/cltbld', 12:39:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:39:21 INFO - 'MOZ_NO_REMOTE': '1', 12:39:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:39:21 INFO - 'NO_EM_RESTART': '1', 12:39:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:39:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:39:21 INFO - 'PWD': '/builds/slave/test', 12:39:21 INFO - 'SHELL': '/bin/bash', 12:39:21 INFO - 'SHLVL': '1', 12:39:21 INFO - 'TERM': 'linux', 12:39:21 INFO - 'TMOUT': '86400', 12:39:21 INFO - 'USER': 'cltbld', 12:39:21 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1475177941.865958-565175556', 12:39:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:39:21 INFO - '_': '/tools/buildbot/bin/python'} 12:39:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:39:22 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 12:39:22 INFO - Cleaning up... 12:39:22 INFO - Return code: 0 12:39:22 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:39: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')]} 12:39:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:39:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:39: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')]} 12:39:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:39:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:39:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3e84451f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21668a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2233790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2230930>, '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 0x2231830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2231cc0>, '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': '00204705a9daa57ed339a427000001b9-1475177941.865958-565175556', '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 12:39:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 12:39:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 12:39:22 INFO - Using env: {'DISPLAY': ':0', 12:39:22 INFO - 'HOME': '/home/cltbld', 12:39:22 INFO - 'LANG': 'en_US.UTF-8', 12:39:22 INFO - 'LANGUAGE': 'en_US:en', 12:39:22 INFO - 'LOGNAME': 'cltbld', 12:39:22 INFO - 'MAIL': '/var/mail/cltbld', 12:39:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:39:22 INFO - 'MOZ_NO_REMOTE': '1', 12:39:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:39:22 INFO - 'NO_EM_RESTART': '1', 12:39:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:39:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:39:22 INFO - 'PWD': '/builds/slave/test', 12:39:22 INFO - 'SHELL': '/bin/bash', 12:39:22 INFO - 'SHLVL': '1', 12:39:22 INFO - 'TERM': 'linux', 12:39:22 INFO - 'TMOUT': '86400', 12:39:22 INFO - 'USER': 'cltbld', 12:39:22 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1475177941.865958-565175556', 12:39:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:39:22 INFO - '_': '/tools/buildbot/bin/python'} 12:39:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:39:22 INFO - Downloading/unpacking psutil>=3.1.1 12:39:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:39:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:39:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:39:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:39:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:39:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:39:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:39:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:39:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:39:24 INFO - Installing collected packages: psutil 12:39:24 INFO - Running setup.py install for psutil 12:39:24 INFO - building 'psutil._psutil_linux' extension 12:39:24 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 12:39:24 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 12:39:24 INFO - building 'psutil._psutil_posix' extension 12:39:24 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 12:39:24 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 12:39:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:39:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:39:24 INFO - Successfully installed psutil 12:39:24 INFO - Cleaning up... 12:39:24 INFO - Return code: 0 12:39:24 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:39:24 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')]} 12:39:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:39:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:39:24 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')]} 12:39:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:39:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:39:24 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 0x7f3e84451f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21668a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2233790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2230930>, '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 0x2231830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2231cc0>, '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': '00204705a9daa57ed339a427000001b9-1475177941.865958-565175556', '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 12:39:24 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 12:39:24 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 12:39:24 INFO - Using env: {'DISPLAY': ':0', 12:39:24 INFO - 'HOME': '/home/cltbld', 12:39:24 INFO - 'LANG': 'en_US.UTF-8', 12:39:24 INFO - 'LANGUAGE': 'en_US:en', 12:39:24 INFO - 'LOGNAME': 'cltbld', 12:39:24 INFO - 'MAIL': '/var/mail/cltbld', 12:39:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:39:24 INFO - 'MOZ_NO_REMOTE': '1', 12:39:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:39:24 INFO - 'NO_EM_RESTART': '1', 12:39:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:39:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:39:24 INFO - 'PWD': '/builds/slave/test', 12:39:24 INFO - 'SHELL': '/bin/bash', 12:39:24 INFO - 'SHLVL': '1', 12:39:24 INFO - 'TERM': 'linux', 12:39:24 INFO - 'TMOUT': '86400', 12:39:24 INFO - 'USER': 'cltbld', 12:39:24 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1475177941.865958-565175556', 12:39:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:39:24 INFO - '_': '/tools/buildbot/bin/python'} 12:39:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:39:25 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:39:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:39:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:39:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:39:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:39:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:39:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:39:27 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:39:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:39:27 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:39:27 INFO - Installing collected packages: mozsystemmonitor 12:39:27 INFO - Running setup.py install for mozsystemmonitor 12:39:27 INFO - Successfully installed mozsystemmonitor 12:39:27 INFO - Cleaning up... 12:39:27 INFO - Return code: 0 12:39:27 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 12:39:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:39:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:39:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:39:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:39:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:39:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:39:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3e84451f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21668a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2233790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2230930>, '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 0x2231830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2231cc0>, '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': '00204705a9daa57ed339a427000001b9-1475177941.865958-565175556', '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 12:39:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 12:39:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 12:39:27 INFO - Using env: {'DISPLAY': ':0', 12:39:27 INFO - 'HOME': '/home/cltbld', 12:39:27 INFO - 'LANG': 'en_US.UTF-8', 12:39:27 INFO - 'LANGUAGE': 'en_US:en', 12:39:27 INFO - 'LOGNAME': 'cltbld', 12:39:27 INFO - 'MAIL': '/var/mail/cltbld', 12:39:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:39:27 INFO - 'MOZ_NO_REMOTE': '1', 12:39:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:39:27 INFO - 'NO_EM_RESTART': '1', 12:39:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:39:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:39:27 INFO - 'PWD': '/builds/slave/test', 12:39:27 INFO - 'SHELL': '/bin/bash', 12:39:27 INFO - 'SHLVL': '1', 12:39:27 INFO - 'TERM': 'linux', 12:39:27 INFO - 'TMOUT': '86400', 12:39:27 INFO - 'USER': 'cltbld', 12:39:27 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1475177941.865958-565175556', 12:39:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:39:27 INFO - '_': '/tools/buildbot/bin/python'} 12:39:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:39:27 INFO - Downloading/unpacking jsonschema==2.5.1 12:39:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:39:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:39:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:39:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:39:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:39:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:39:29 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:39:29 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12:39:29 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 12:39:29 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 12:39:29 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 12:39:29 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 12:39:29 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 12:39:29 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 12:39:29 INFO - Downloading functools32-3.2.3-2.tar.gz 12:39:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:39:29 INFO - warning: no files found matching '*.txt' 12:39:29 INFO - no previously-included directories found matching 'build' 12:39:29 INFO - no previously-included directories found matching 'dist' 12:39:29 INFO - no previously-included directories found matching '.git*' 12:39:29 INFO - Installing collected packages: jsonschema, functools32 12:39:29 INFO - Running setup.py install for functools32 12:39:29 INFO - warning: no files found matching '*.txt' 12:39:29 INFO - no previously-included directories found matching 'build' 12:39:29 INFO - no previously-included directories found matching 'dist' 12:39:29 INFO - no previously-included directories found matching '.git*' 12:39:29 INFO - Successfully installed jsonschema functools32 12:39:29 INFO - Cleaning up... 12:39:29 INFO - Return code: 0 12:39:29 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 12:39:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:39:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:39:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:39:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:39:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:39:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:39:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f3e84451f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21668a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2233790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2230930>, '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 0x2231830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2231cc0>, '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': '00204705a9daa57ed339a427000001b9-1475177941.865958-565175556', '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 12:39:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 12:39:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 12:39:29 INFO - Using env: {'DISPLAY': ':0', 12:39:29 INFO - 'HOME': '/home/cltbld', 12:39:29 INFO - 'LANG': 'en_US.UTF-8', 12:39:29 INFO - 'LANGUAGE': 'en_US:en', 12:39:29 INFO - 'LOGNAME': 'cltbld', 12:39:29 INFO - 'MAIL': '/var/mail/cltbld', 12:39:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:39:29 INFO - 'MOZ_NO_REMOTE': '1', 12:39:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:39:29 INFO - 'NO_EM_RESTART': '1', 12:39:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:39:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:39:29 INFO - 'PWD': '/builds/slave/test', 12:39:29 INFO - 'SHELL': '/bin/bash', 12:39:29 INFO - 'SHLVL': '1', 12:39:29 INFO - 'TERM': 'linux', 12:39:29 INFO - 'TMOUT': '86400', 12:39:29 INFO - 'USER': 'cltbld', 12:39:29 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1475177941.865958-565175556', 12:39:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:39:29 INFO - '_': '/tools/buildbot/bin/python'} 12:39:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:39:30 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 12:39:30 INFO - Cleaning up... 12:39:30 INFO - Return code: 0 12:39:30 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:39:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:39:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:39:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:39:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:39:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:39:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:39:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3e84451f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21668a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2233790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2230930>, '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 0x2231830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2231cc0>, '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': '00204705a9daa57ed339a427000001b9-1475177941.865958-565175556', '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 12:39:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 12:39:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 12:39:30 INFO - Using env: {'DISPLAY': ':0', 12:39:30 INFO - 'HOME': '/home/cltbld', 12:39:30 INFO - 'LANG': 'en_US.UTF-8', 12:39:30 INFO - 'LANGUAGE': 'en_US:en', 12:39:30 INFO - 'LOGNAME': 'cltbld', 12:39:30 INFO - 'MAIL': '/var/mail/cltbld', 12:39:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:39:30 INFO - 'MOZ_NO_REMOTE': '1', 12:39:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:39:30 INFO - 'NO_EM_RESTART': '1', 12:39:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:39:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:39:30 INFO - 'PWD': '/builds/slave/test', 12:39:30 INFO - 'SHELL': '/bin/bash', 12:39:30 INFO - 'SHLVL': '1', 12:39:30 INFO - 'TERM': 'linux', 12:39:30 INFO - 'TMOUT': '86400', 12:39:30 INFO - 'USER': 'cltbld', 12:39:30 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1475177941.865958-565175556', 12:39:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:39:30 INFO - '_': '/tools/buildbot/bin/python'} 12:39:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:39:30 INFO - Downloading/unpacking blobuploader==1.2.4 12:39:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:39:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:39:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:39:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:39:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:39:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:39:32 INFO - Downloading blobuploader-1.2.4.tar.gz 12:39:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:39:32 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:39:32 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 12:39:32 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 12:39:32 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 12:39:32 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 12:39:32 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 12:39:32 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 12:39:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:39:32 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:39:32 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 12:39:32 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 12:39:32 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 12:39:32 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 12:39:32 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 12:39:32 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 12:39:32 INFO - Downloading docopt-0.6.1.tar.gz 12:39:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:39:32 INFO - Installing collected packages: blobuploader, requests, docopt 12:39:32 INFO - Running setup.py install for blobuploader 12:39:32 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:39:33 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:39:33 INFO - Running setup.py install for requests 12:39:33 INFO - Running setup.py install for docopt 12:39:33 INFO - Successfully installed blobuploader requests docopt 12:39:33 INFO - Cleaning up... 12:39:33 INFO - Return code: 0 12:39:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:39: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')]} 12:39:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:39:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:39: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')]} 12:39:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:39:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:39:33 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 0x7f3e84451f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21668a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2233790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2230930>, '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 0x2231830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2231cc0>, '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': '00204705a9daa57ed339a427000001b9-1475177941.865958-565175556', '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 12:39:33 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 12:39:33 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 12:39:33 INFO - Using env: {'DISPLAY': ':0', 12:39:33 INFO - 'HOME': '/home/cltbld', 12:39:33 INFO - 'LANG': 'en_US.UTF-8', 12:39:33 INFO - 'LANGUAGE': 'en_US:en', 12:39:33 INFO - 'LOGNAME': 'cltbld', 12:39:33 INFO - 'MAIL': '/var/mail/cltbld', 12:39:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:39:33 INFO - 'MOZ_NO_REMOTE': '1', 12:39:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:39:33 INFO - 'NO_EM_RESTART': '1', 12:39:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:39:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:39:33 INFO - 'PWD': '/builds/slave/test', 12:39:33 INFO - 'SHELL': '/bin/bash', 12:39:33 INFO - 'SHLVL': '1', 12:39:33 INFO - 'TERM': 'linux', 12:39:33 INFO - 'TMOUT': '86400', 12:39:33 INFO - 'USER': 'cltbld', 12:39:33 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1475177941.865958-565175556', 12:39:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:39:33 INFO - '_': '/tools/buildbot/bin/python'} 12:39:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:39:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:39:33 INFO - Running setup.py (path:/tmp/pip-zbYkfH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:39:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:39:33 INFO - Running setup.py (path:/tmp/pip-xItuec-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:39:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:39:33 INFO - Running setup.py (path:/tmp/pip-9Ep5gY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:39:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:39:33 INFO - Running setup.py (path:/tmp/pip-rNYr6R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:39:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:39:34 INFO - Running setup.py (path:/tmp/pip-NQNz58-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:39:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:39:34 INFO - Running setup.py (path:/tmp/pip-E2YKrs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:39:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:39:34 INFO - Running setup.py (path:/tmp/pip-3Y1XN9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:39:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:39:34 INFO - Running setup.py (path:/tmp/pip-ctcN1i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:39:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:39:34 INFO - Running setup.py (path:/tmp/pip-GHAAWw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:39:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:39:34 INFO - Running setup.py (path:/tmp/pip-oxyepu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:39:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:39:34 INFO - Running setup.py (path:/tmp/pip-M9t4sw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:39:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:39:34 INFO - Running setup.py (path:/tmp/pip-mwTpyA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:39:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:39:34 INFO - Running setup.py (path:/tmp/pip-El4shP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:39:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:39:34 INFO - Running setup.py (path:/tmp/pip-5DJ6Y4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:39:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:39:34 INFO - Running setup.py (path:/tmp/pip-aOhfMm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:39:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:39:34 INFO - Running setup.py (path:/tmp/pip-vytSsl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:39:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:39:34 INFO - Running setup.py (path:/tmp/pip-GOcJC4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:39:34 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:39:34 INFO - Running setup.py install for manifestparser 12:39:35 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:39:35 INFO - Running setup.py install for mozcrash 12:39:35 INFO - Running setup.py install for mozdebug 12:39:35 INFO - Running setup.py install for mozdevice 12:39:35 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:39:35 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:39:35 INFO - Running setup.py install for mozfile 12:39:35 INFO - Running setup.py install for mozhttpd 12:39:35 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:39:35 INFO - Running setup.py install for mozinfo 12:39:35 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:39:35 INFO - Running setup.py install for mozInstall 12:39:35 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:39:35 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:39:35 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:39:35 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:39:35 INFO - Running setup.py install for mozleak 12:39:35 INFO - Running setup.py install for mozlog 12:39:35 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:39:36 INFO - Running setup.py install for moznetwork 12:39:36 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:39:36 INFO - Running setup.py install for mozprocess 12:39:36 INFO - Running setup.py install for mozprofile 12:39:36 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:39:36 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:39:36 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:39:36 INFO - Running setup.py install for mozrunner 12:39:36 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:39:36 INFO - Running setup.py install for mozscreenshot 12:39:36 INFO - Running setup.py install for moztest 12:39:36 INFO - Running setup.py install for mozversion 12:39:36 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:39:36 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:39:36 INFO - Cleaning up... 12:39:36 INFO - Return code: 0 12:39:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:39:36 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')]} 12:39:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:39:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:39:36 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')]} 12:39:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:39:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:39:36 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 0x7f3e84451f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21668a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2233790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2230930>, '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 0x2231830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2231cc0>, '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': '00204705a9daa57ed339a427000001b9-1475177941.865958-565175556', '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 12:39:36 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 12:39:36 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 12:39:36 INFO - Using env: {'DISPLAY': ':0', 12:39:36 INFO - 'HOME': '/home/cltbld', 12:39:36 INFO - 'LANG': 'en_US.UTF-8', 12:39:36 INFO - 'LANGUAGE': 'en_US:en', 12:39:36 INFO - 'LOGNAME': 'cltbld', 12:39:36 INFO - 'MAIL': '/var/mail/cltbld', 12:39:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:39:36 INFO - 'MOZ_NO_REMOTE': '1', 12:39:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:39:36 INFO - 'NO_EM_RESTART': '1', 12:39:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:39:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:39:36 INFO - 'PWD': '/builds/slave/test', 12:39:36 INFO - 'SHELL': '/bin/bash', 12:39:36 INFO - 'SHLVL': '1', 12:39:36 INFO - 'TERM': 'linux', 12:39:36 INFO - 'TMOUT': '86400', 12:39:36 INFO - 'USER': 'cltbld', 12:39:36 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1475177941.865958-565175556', 12:39:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:39:36 INFO - '_': '/tools/buildbot/bin/python'} 12:39:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:39:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:39:37 INFO - Running setup.py (path:/tmp/pip-Nd03iv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:39:37 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)) 12:39:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:39:37 INFO - Running setup.py (path:/tmp/pip-z8JVkm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:39:37 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)) 12:39:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:39:37 INFO - Running setup.py (path:/tmp/pip-benV5L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:39:37 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)) 12:39:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:39:37 INFO - Running setup.py (path:/tmp/pip-UNkr1j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:39:37 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)) 12:39:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:39:37 INFO - Running setup.py (path:/tmp/pip-zLtrMi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:39:37 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)) 12:39:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:39:37 INFO - Running setup.py (path:/tmp/pip-yghkrw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:39:37 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)) 12:39:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:39:37 INFO - Running setup.py (path:/tmp/pip-YD7Rhd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:39:37 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)) 12:39:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:39:37 INFO - Running setup.py (path:/tmp/pip-pyug9z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:39:37 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)) 12:39:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:39:37 INFO - Running setup.py (path:/tmp/pip-bcWPf2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:39:37 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)) 12:39:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:39:37 INFO - Running setup.py (path:/tmp/pip-wBP2Me-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:39:37 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)) 12:39:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:39:37 INFO - Running setup.py (path:/tmp/pip-GA0xww-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:39:37 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)) 12:39:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:39:37 INFO - Running setup.py (path:/tmp/pip-_4pMsu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:39:37 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)) 12:39:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:39:37 INFO - Running setup.py (path:/tmp/pip-puEN2a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:39:37 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)) 12:39:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:39:37 INFO - Running setup.py (path:/tmp/pip-CphuA8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:39:38 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)) 12:39:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:39:38 INFO - Running setup.py (path:/tmp/pip-Bsl7iN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:39:38 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)) 12:39:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:39:38 INFO - Running setup.py (path:/tmp/pip-j9JQEp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:39:38 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)) 12:39:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:39:38 INFO - Running setup.py (path:/tmp/pip-aAzaO_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:39:38 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)) 12:39:38 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)) 12:39:38 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)) 12:39:38 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)) 12:39:38 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)) 12:39:38 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)) 12:39:38 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:39: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 12:39: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 12:39: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 12:39: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 12:39: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 12:39: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 12:39:40 INFO - Downloading blessings-1.6.tar.gz 12:39:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:39:40 INFO - Installing collected packages: blessings 12:39:40 INFO - Running setup.py install for blessings 12:39:40 INFO - Successfully installed blessings 12:39:40 INFO - Cleaning up... 12:39:40 INFO - Return code: 0 12:39:40 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:39:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:39:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:39:40 INFO - Reading from file tmpfile_stdout 12:39:40 INFO - Current package versions: 12:39:40 INFO - argparse == 1.2.1 12:39:40 INFO - blessings == 1.6 12:39:40 INFO - blobuploader == 1.2.4 12:39:40 INFO - docopt == 0.6.1 12:39:40 INFO - functools32 == 3.2.3-2 12:39:40 INFO - jsonschema == 2.5.1 12:39:40 INFO - manifestparser == 1.1 12:39:40 INFO - mozInstall == 1.12 12:39:40 INFO - mozcrash == 0.17 12:39:40 INFO - mozdebug == 0.1 12:39:40 INFO - mozdevice == 0.48 12:39:40 INFO - mozfile == 1.2 12:39:40 INFO - mozhttpd == 0.7 12:39:40 INFO - mozinfo == 0.9 12:39:40 INFO - mozleak == 0.1 12:39:40 INFO - mozlog == 3.4 12:39:40 INFO - moznetwork == 0.27 12:39:40 INFO - mozprocess == 0.23 12:39:40 INFO - mozprofile == 0.28 12:39:40 INFO - mozrunner == 6.12 12:39:40 INFO - mozscreenshot == 0.1 12:39:40 INFO - mozsystemmonitor == 0.3 12:39:40 INFO - moztest == 0.7 12:39:40 INFO - mozversion == 1.4 12:39:40 INFO - psutil == 3.1.1 12:39:40 INFO - requests == 1.2.3 12:39:40 INFO - wsgiref == 0.1.2 12:39:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:39:40 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')]} 12:39:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:39:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:39:40 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')]} 12:39:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:39:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:39:40 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 0x7f3e84451f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21668a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2233790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2230930>, '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 0x2231830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2231cc0>, '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': '00204705a9daa57ed339a427000001b9-1475177941.865958-565175556', '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 12:39:40 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 12:39:40 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 12:39:40 INFO - Using env: {'DISPLAY': ':0', 12:39:40 INFO - 'HOME': '/home/cltbld', 12:39:40 INFO - 'LANG': 'en_US.UTF-8', 12:39:40 INFO - 'LANGUAGE': 'en_US:en', 12:39:40 INFO - 'LOGNAME': 'cltbld', 12:39:40 INFO - 'MAIL': '/var/mail/cltbld', 12:39:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:39:40 INFO - 'MOZ_NO_REMOTE': '1', 12:39:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:39:40 INFO - 'NO_EM_RESTART': '1', 12:39:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:39:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:39:40 INFO - 'PWD': '/builds/slave/test', 12:39:40 INFO - 'SHELL': '/bin/bash', 12:39:40 INFO - 'SHLVL': '1', 12:39:40 INFO - 'TERM': 'linux', 12:39:40 INFO - 'TMOUT': '86400', 12:39:40 INFO - 'USER': 'cltbld', 12:39:40 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1475177941.865958-565175556', 12:39:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:39:40 INFO - '_': '/tools/buildbot/bin/python'} 12:39:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:39:40 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)) 12:39:40 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)) 12:39:40 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)) 12:39:40 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)) 12:39:40 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)) 12:39:40 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)) 12:39:40 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)) 12:39:40 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)) 12:39:40 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)) 12:39:40 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)) 12:39:40 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)) 12:39:40 INFO - Cleaning up... 12:39:40 INFO - Return code: 0 12:39:40 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:39:40 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')]} 12:39:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:39:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:39:40 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')]} 12:39:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:39:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:39:40 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 0x7f3e84451f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21668a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2233790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2230930>, '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 0x2231830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2231cc0>, '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': '00204705a9daa57ed339a427000001b9-1475177941.865958-565175556', '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 12:39:40 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 12:39:40 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 12:39:40 INFO - Using env: {'DISPLAY': ':0', 12:39:40 INFO - 'HOME': '/home/cltbld', 12:39:40 INFO - 'LANG': 'en_US.UTF-8', 12:39:40 INFO - 'LANGUAGE': 'en_US:en', 12:39:40 INFO - 'LOGNAME': 'cltbld', 12:39:40 INFO - 'MAIL': '/var/mail/cltbld', 12:39:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:39:40 INFO - 'MOZ_NO_REMOTE': '1', 12:39:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:39:40 INFO - 'NO_EM_RESTART': '1', 12:39:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:39:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:39:40 INFO - 'PWD': '/builds/slave/test', 12:39:40 INFO - 'SHELL': '/bin/bash', 12:39:40 INFO - 'SHLVL': '1', 12:39:40 INFO - 'TERM': 'linux', 12:39:40 INFO - 'TMOUT': '86400', 12:39:40 INFO - 'USER': 'cltbld', 12:39:40 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1475177941.865958-565175556', 12:39:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:39:40 INFO - '_': '/tools/buildbot/bin/python'} 12:39:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:39:41 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 12:39:41 INFO - Cleaning up... 12:39:41 INFO - Return code: 0 12:39:41 INFO - Running post-action listener: _resource_record_post_action 12:39:41 INFO - Running post-action listener: _start_resource_monitoring 12:39:41 INFO - Starting resource monitoring. 12:39:41 INFO - [mozharness: 2016-09-29 19:39:41.102563Z] Finished create-virtualenv step (success) 12:39:41 INFO - [mozharness: 2016-09-29 19:39:41.103025Z] Running install step. 12:39:41 INFO - Running pre-action listener: _resource_record_pre_action 12:39:41 INFO - Running main action method: install 12:39:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:39:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:39:41 INFO - Reading from file tmpfile_stdout 12:39:41 INFO - Detecting whether we're running mozinstall >=1.0... 12:39:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:39:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:39:41 INFO - Reading from file tmpfile_stdout 12:39:41 INFO - Output received: 12:39:41 INFO - Usage: mozinstall [options] installer 12:39:41 INFO - Options: 12:39:41 INFO - -h, --help show this help message and exit 12:39:41 INFO - -d DEST, --destination=DEST 12:39:41 INFO - Directory to install application into. [default: 12:39:41 INFO - "/builds/slave/test"] 12:39:41 INFO - --app=APP Application being installed. [default: firefox] 12:39:41 INFO - mkdir: /builds/slave/test/build/application 12:39:41 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'] 12:39:41 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 12:39:58 INFO - Reading from file tmpfile_stdout 12:39:58 INFO - Output received: 12:39:58 INFO - /builds/slave/test/build/application/firefox/firefox 12:39:58 INFO - Running post-action listener: _resource_record_post_action 12:39:58 INFO - [mozharness: 2016-09-29 19:39:58.439902Z] Finished install step (success) 12:39:58 INFO - [mozharness: 2016-09-29 19:39:58.440147Z] Running run-tests step. 12:39:58 INFO - Running pre-action listener: _resource_record_pre_action 12:39:58 INFO - Running main action method: run_tests 12:39:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:39:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:39:58 INFO - Python 2.7.3 12:39:58 INFO - Return code: 0 12:39:58 INFO - grabbing minidump binary from tooltool 12:39:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:39:58 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2230930>, '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 0x2231830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2231cc0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:39:58 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 12:39:58 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 12:39:58 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 12:39:58 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:39:58 INFO - Return code: 0 12:39:58 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:39:58 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:39:58 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:39:58 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:39:58 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:39:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bV7VLb_MT62eaQdxqlI60g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-016', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 12:39:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/bV7VLb_MT62eaQdxqlI60g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-016 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 12:39:58 INFO - Using env: {'DISPLAY': ':0', 12:39:58 INFO - 'HOME': '/home/cltbld', 12:39:58 INFO - 'LANG': 'en_US.UTF-8', 12:39:58 INFO - 'LANGUAGE': 'en_US:en', 12:39:58 INFO - 'LOGNAME': 'cltbld', 12:39:58 INFO - 'MAIL': '/var/mail/cltbld', 12:39:58 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:39:58 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:39:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:39:58 INFO - 'MOZ_NO_REMOTE': '1', 12:39:58 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:39:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:39:58 INFO - 'NO_EM_RESTART': '1', 12:39:58 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:39:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:39:58 INFO - 'PWD': '/builds/slave/test', 12:39:58 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:39:58 INFO - 'SHELL': '/bin/bash', 12:39:58 INFO - 'SHLVL': '1', 12:39:58 INFO - 'TERM': 'linux', 12:39:58 INFO - 'TMOUT': '86400', 12:39:58 INFO - 'USER': 'cltbld', 12:39:58 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1475177941.865958-565175556', 12:39:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:39:58 INFO - '_': '/tools/buildbot/bin/python'} 12:39:58 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bV7VLb_MT62eaQdxqlI60g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-016', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 12:39:58 INFO - mozversion application_buildid: 20160929093019 12:39:58 INFO - mozversion application_changeset: f21ffbf119bd6d7084309123be42f97743f1f7e5 12:39:58 INFO - mozversion application_display_name: Nightly 12:39:58 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:39:58 INFO - mozversion application_name: Firefox 12:39:58 INFO - mozversion application_remotingname: firefox 12:39:58 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 12:39:58 INFO - mozversion application_vendor: Mozilla 12:39:58 INFO - mozversion application_version: 52.0a1 12:39:58 INFO - mozversion platform_buildid: 20160929093019 12:39:58 INFO - mozversion platform_changeset: f21ffbf119bd6d7084309123be42f97743f1f7e5 12:39:58 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 12:39:58 INFO - mozversion platform_version: 52.0a1 12:39:58 INFO - using testdate: 1475177998 12:39:58 INFO - actual date: 1475177998 12:39:58 INFO - starting webserver on 'localhost:46280' 12:39:58 INFO - SUITE-START | Running 2 tests 12:39:58 INFO - TEST-START | dromaeo_css 12:39:58 INFO - operating with platform_type : linux_ 12:39:58 INFO - Initialising browser for dromaeo_css test... 12:39:58 INFO - TEST-INFO | started process 16783 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRNskDm/profile http://localhost:46280/getInfo.html) 12:40:03 INFO - PROCESS | 16783 | __metrics Screen width/height:1600/1200 12:40:03 INFO - PROCESS | 16783 | colorDepth:24 12:40:03 INFO - PROCESS | 16783 | Browser inner width/height: 1024/697 12:40:03 INFO - PROCESS | 16783 | __metrics 12:40:03 ERROR - PROCESS | 16783 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3076: TypeError: this.tabs is undefined 12:40:04 INFO - TEST-INFO | 16783: exit 0 12:40:04 INFO - Browser initialized. 12:40:04 INFO - Running cycle 1/1 for dromaeo_css test... 12:40:04 INFO - TEST-INFO | started process 16906 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRNskDm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:40:16 INFO - PROCESS | 16906 | RSS: Main: 186040320 12:40:16 INFO - PROCESS | 16906 | 12:41:06 INFO - PROCESS | 16906 | 1475178066637 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] 12:43:16 INFO - PROCESS | 16906 | Cycle 1(1): loaded http://localhost:46280/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46280/tests/dromaeo/cssquery-ext.html) 12:43:17 INFO - PROCESS | 16906 | RSS: Main: 201232384 12:43:17 INFO - PROCESS | 16906 | 12:46:19 INFO - PROCESS | 16906 | Cycle 1(1): loaded http://localhost:46280/tests/dromaeo/cssquery-ext.html (next: http://localhost:46280/tests/dromaeo/cssquery-jquery.html) 12:46:20 INFO - PROCESS | 16906 | RSS: Main: 197500928 12:46:20 INFO - PROCESS | 16906 | 12:49:22 INFO - PROCESS | 16906 | Cycle 1(1): loaded http://localhost:46280/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46280/tests/dromaeo/cssquery-mootools.html) 12:49:22 INFO - PROCESS | 16906 | RSS: Main: 199667712 12:49:22 INFO - PROCESS | 16906 | 12:52:24 INFO - PROCESS | 16906 | Cycle 1(1): loaded http://localhost:46280/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46280/tests/dromaeo/cssquery-prototype.html) 12:52:25 INFO - PROCESS | 16906 | RSS: Main: 196464640 12:52:25 INFO - PROCESS | 16906 | 12:55:27 INFO - PROCESS | 16906 | Cycle 1(1): loaded http://localhost:46280/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46280/tests/dromaeo/cssquery-yui.html) 12:55:28 INFO - PROCESS | 16906 | RSS: Main: 199753728 12:55:28 INFO - PROCESS | 16906 | 12:58:31 INFO - PROCESS | 16906 | Cycle 1(1): loaded http://localhost:46280/tests/dromaeo/cssquery-yui.html (next: http://localhost:46280/tests/dromaeo/cssquery-dojo.html) 12:58:31 INFO - PROCESS | 16906 | RSS: Main: 200335360 12:58:31 INFO - PROCESS | 16906 | 12:58:31 INFO - PROCESS | 16906 | __start_tp_report 12:58:31 INFO - PROCESS | 16906 | _x_x_mozilla_page_load 12:58:31 INFO - PROCESS | 16906 | _x_x_mozilla_page_load_details 12:58:31 INFO - PROCESS | 16906 | |i|pagename|runs| 12:58:31 INFO - PROCESS | 16906 | |0;dojo.html;3057.2051266670665;3058.969410305898;3060.8928687495913;3088.49039908415;3092.2887735820755;5281.339832520935;5396;5436.945630543698;5466.972665136674;5537.307836520435;5298.284731561238;5406.378266499354;5483.698396588186;5508.118701007839;5512.283403157594;4872.951270487303;4873.829415970442;4902.754862256891;4951;5013.924791128136;4946.530079642428;5006.799728010875;5011.84964451067;5011.974940125294;5062.468440813716;4851.393575803025;4950.2822090796635;4967.801287948514;5005.274235235888;5010.398752149747;4856.878578035577;4922.852314430573;4927.359443272388;4959.876003099951;5029.823956161516;4890.902181956377;4925.605951523869;4941.950580494221;4947.703137811743;5013.548780609726;5373.086575282172;5417.160340147283;5418.972905135489;5422.701751403672;5427.104527752916;5671.829845104653;5702.486776190121;5744.741486633112;5777.740001699934;5788.363280039192;5794.739236734357;5816.098504731774;5819.127130930395;5819.73811178498;5844.503217226541;5483.670979741229;5486.094794358926;5486.396496385434;5489.176623506466;5500.119980803052;5886.05823068307;5931.466168044811;5953.434423729739;5960.433758792908;6005.789797357072;5712.600117991784;5713.143028545668;5716.942830571641;5716.971415142898;5730.426957304319;5695.231143795535;5730.169125476866;5814.418558144152;5818.44724751148;5818.650880947157;5765.913511297334;5774.0761478163295;5801.390853960358;5806.303243610793;5850.502707269845;5799.739011744482;5803.622764520293;5809.331926828469;5813.157092221689;5813.6221145625395;4393.956060439418;4439.200943830142;4458.197524445566;4459.799309031101;4514.548545145525;3945.171513982096;3954.6440820326306;3998.4801975742967;4018.477597912311;4078.938815917764;5587.832365029056;5602.38373778884;5607.887842243133;5615.0454422748235;5617.494425501643;5860.150278209721;5866.090755932837;5873.970630146822;5876.529877609781;5901.734421951022;5359.062164121263;5451.345838499326;5460.372057213472;5491.423400542885;5554.1946417769195;5065.341505604321;5084.339035925306;5101.387833459934;5101.540861322499;5123.615728820353;5991.730372133265;6008.579399442085;6021.217241758543;6030.698465076816;6047.5464340173785;5537.390887002346;5560.221568980265;5850.678212698343;5864.149698293638;5873.647581145145;5926.140709597171;5953.255843019622;5958.880822383441;6045.848853778515;6079.422454866957;5628.634138780966;5647.971760141173;5700.543956483554;5701.087825947829;5704.543636508986;5655.264815573949;5821.126830975388;5823.505002074871;5851.385604511635;5873.148393483007;5519.779208831602;5634.802781902614;5643.858903527444;5663.801766938137;5745.87955348703;5663.9716801415725;5679.6876171810945;5679.801206957736;5681.715914204191;5682.573806964411;5443.836684899459;5483.670979741229;5602.691851948019;5603.663780173202;5618.943810561842;5741.971290143522;5746.454086861741;5751.252337196138;5752.395998420106;5813.418658134153;5567.526760225264;5593.4126916674795;5606.943930560642;5611.5230205433;5614.5789065821045 12:58:31 INFO - PROCESS | 16906 | |1;ext.html;554.8937859837204;579.7478097027794;593.5222146172332;594.5600255810701;612.4855121697773;42092.15815683684;42743.572564274386;42934.570654293486;47552;47621.28568071473;44181;44331;44742.32886506697;44833;44934.32598511025;8824.117588241188;9006.774830629221;9023.864642030374;9028.954855225715;9067;8862.601182946783;8923.41997770143;8934.955325223398;8959.731208063737;8960.417572857776;8978.191962723353;9003.09969003101;9021;9024.14270644291;9036.954815225914;8797.780055498632;8854.3359248056;8865.911340886638;8909.420887642314;8956.373053886231;8763.649454021832;8844.204021638083;8898.73303800887;8917.375783695144;8925.776855578597;42363.36454953147;42532;42848.57151428508;42881.78559107184;42932.78533607343;3322.667733226658;3441.1913200397885;3597.37046016946;3920.823562939646;3962.2075584883137;31062.378752424826;31636.525452118236;31686;32055;33776.49335259973;4286.097771944978;4366.366876802877;4383.7150585212175;4547.79534920926;4565.292379681155;340935;346681;347198;348438;350568.99999999744;55604.72197639067;55616;55792.72103639537;55872.44127558672;56003;36081.819590901876;36301.273974520365;36399.63600364015;38830.22339553193;38996.22007559833;16515;16606.584835379213;16786.66426671484;16786.832131678526;16799.748003779954;12499.812502812465;12635.620931372074;12667.93666031664;12670.683232919066;12684.619461416172;18385.63228735418;18463.353782617545;18585.163667634988;18621;18810.153543090593;7066.57600543969;7164.534305270141;7270.309320614533;7469.663865126083;7516.549007059594;830;898.070497035565;927.248928368024;932.4218984229685;1119.138263537072;31718.2070448236;31782.205444864063;32064.35871282608;32687.346253074804;32727.50908736371;1084.2464487181492;1085.9945700271448;1160.4371879638368;1161.3902701082;1173.559915031863;16653.583660408345;16905.23926423314;16963.915180424017;17234.741478877826;17427.302907883797;530161;542139;542199;545452;545904;55909.44090559124;56613.43386566164;56751.43248567544;56868.43131568714;56905;1195.9521619135137;1220.5850010996126;1289.9677508062373;1303.3483258370813;1303.7001489657432;29589.408211836075;31690.683093168773;31753;31966.52050219202;32176.517352240204;49907;50463.49536504735;50495.24257136072;50508.49491505038;50511;419152;421049;421534;422046;422207;27396.17811465659;27615.171544853685;27851.860740696167;27859.582106268015;27897.16308510748;47144;47519;47683.28475072946;48087;48223.27665085097;39601.40597890977;39769.2046159081;40352;41024.1795164101;41721.79139104285;38604;39912;40610.59389406068;41827.163456730086;42026.57973420226;34814;35260.294794104484;38715.22569548649;39544.40683389809;40520.594794051685;33929.321413572085;36184.27631447409;36309;36738.81630591937;37048;28568.57147142753;28708.282292942007;28802.711972880843;28918.37306031025;29067 12:58:31 INFO - PROCESS | 16906 | |2;jquery.html;396.6113209055128;396.736170446653;398.4123417958511;402.6617641181408;408.25900989703683;16352.018878867277;16778;18689.906550467247;19453.31913383032;19527.902360488177;11428.71428214295;11688.707782305426;11947.940260298708;11979.640610781691;18109;4996.700197988123;5214.8696282592855;5218.295530103444;5225.320708307915;5235.031519168947;4976.925346119811;5114.923276150861;5129.53834154926;5148.691078535281;5150.922736158961;5109.795608175668;5146.5110814472755;5151.613628977823;5152.381714194302;5158.509941555565;4942.184539550988;5044.39467263927;5091.770870310808;5147.073526765181;5156.20078887773;4963.503649635008;4968.205087186069;4977.104121258172;4977.377827771528;5001.124803159432;12892.742145157139;13400.463981440731;13507.932460337635;13848.376823042987;13950.162990220619;2087.7285952826037;2151.741790985076;2220.100859152046;2262.637977923541;2794.6646402431634;9393.812123757487;9930.255230857641;10153.28926975112;12320.260784352968;14492.34784434703;1828.8902665840092;1865.3003638523905;1898.8291053805224;1903.9048047597703;1976.188225460595;82788.17211827864;84417.57791211005;85086.57456712677;85376;85606;10912.29070110456;11084.279521831055;11099.667009989713;11152.330860148417;11503.942480287546;15979.440719574759;15997.760033599505;16018.599535011717;16026.599335016717;16056;7684.538927664358;7926.445148839641;7998.880016799752;8074.717384891501;8314.62584183701;7311.4516411268305;7335.596542190231;7409.703611855573;7510.9484672145945;7597.506162099557;4791.305260737243;4803.087413391514;4839.491853355417;4860.854174374775;4949.208126699711;1895.5640202753443;1929.4983304340692;1993.2425678242175;1997.4507010572208;2080.219917530926;825.8513467575895;918.4626993208914;976.3019441099648;1005.5776573839005;1009.6970908727352;19080.14139363732;19162.13770380336;19294.13176407065;19349.226030958886;19622.8037719621;946.7538440005649;960.0927123868017;960.9135177834029;973.634886917406;975.2303458178807;10593.89406105929;10910.127189824794;10928.125749939985;10941.671749847517;10969.396683182502;457938;460787;461071;462270;474361.5638436198;85965.14034859571;87060.5646971761;89103.55448222718;90187.54906225427;101977;1009.4801177393648;1051.106559424483;1053.9209559283083;1066.8719753629614;1078.013617539942;16656.916715416344;17365.565860853076;18145.546361341072;18186.727199091758;18193;32640.83679581682;40992;41491.79254103831;42569.14861702687;43851;59804;60857.69571152116;61907.38092619016;62230;62795.05807412984;8297;8331.958340208503;8528.488290702579;8583.356248281529;8596.699115530926;11362.772744545227;13191;13252;13297.933510332387;13817.309134543433;10404.895951040393;10820.080293175168;11084.445777711244;11134.587048275582;11910.047196224108;11477.368744718786;11765.705857353292;11892.76214475723;12109.75780484403;12469.937650311691;12082.879171208175;12115.091368147248;12115.939420302842;12225.510979560719;12432.254064756144;8137.186281371815;8359.366799458394;8460.788480288042;8480.74557763268;8486.278666313432;8311.376646751396;12017.09871759604;12097.879021210027;12144.878551214375;12314 12:58:31 INFO - PROCESS | 16906 | |3;mootools.html;1447.34869308811;1506.1038681984219;1606.9517914462563;1750.9387171449002;1773.9290428382874;7808.180141085175;8069.757907262777;8376.706815261467;9064.138906803852;9072.546372681365;8331.875021874677;8598.828023439528;8614.87077693835;8863.46819190849;8867.866981995276;2346.4133966508375;2395.2694428199393;2396.0775101585928;2396.4727759892794;2402.8798560072014;2332.4285550040263;2332.521833024226;2390.9599324293986;2392.031227352916;2398.5322862041908;2286.805621522164;2291.46150654596;2306.423394151462;2318.5015221727326;2324.69778928739;2320.883955802203;2355.9175428859994;2358.13927916311;2366.6213405855065;2370.8221883358815;2287.4052746286084;2300.0799680127916;2301.6777651128855;2302.6200676888293;2312.491251924574;8556.871646925301;8803.295736341077;8809.779755506099;8816.8677469838;8826.514541700204;5047.293378926953;5047.369078865142;5202.219667049935;5215.061288967984;5222.294990176316;3203.3913556424436;3263.1352691536763;3346.748993825473;3350.6816852398983;3488.4418493041244;1070.637460004925;1110.972225694356;1121.7307846116955;1131.6548452721916;1144.370596172102;12583.433745481476;12652.62042138728;12710.300933448656;12731.872681273162;12769.17000394962;4628.583427491474;4691.976540117277;4870.9269360959615;4877.341558889575;4898.461169271377;10236.385816851012;10244.692659220234;10336.224783141295;10339.121174700234;10364.637237696645;5284.7886084556185;5301.310829592128;5302.628815982845;5325.946740532622;5332.493413125747;4316.395704601358;4427.358033085185;4754.191787396151;4874.366332376769;4931.654784165074;4017.216642754693;4105.920559580315;4134.503859536815;4274.636655884285;4286.87139385819;1286.8584455709865;1300.876416740408;1301.212766276408;1308.5420102964076;1323.1201251168059;813.5444151275304;917.3349321741684;943.6366998705411;951.743029382063;993.0913214408735;5865.296164460292;5951.672658003765;6022.939770602238;6032.939670603326;6187.81436556904;410.138708711709;417.66586730615387;434.7478462491747;438.0472472372577;443.82247101159794;4075.3886916962692;4160;4165.8333666653;4191.455110835572;4205.747655140702;10596.841047384296;10851.403172825412;10856.131509479223;10964.616238431616;10967.396793176293;10878.836817447745;10885.510152043176;10909.618163364403;10936.343819370863;10946.835797463045;7816.452848300678;7843.137254901956;7916.920830791619;7938.761837144895;7967.9203207967175;5767.106098554731;5809.767609295581;5836.445537673914;5899.233099697012;6041.969790151021;9760.951195244263;9905.752356191153;9933.155681766842;9978.501074946369;10083.193344532274;10231.59073637076;10240.436775977094;10283.897161028593;10294.124999375137;10326.845097323396;7090.220075791762;7292.963535182503;7349.77950661481;7890.171531989058;7981;8268.83462330762;8460.915390846012;8503.957480212559;8578.4424012439;8588.441751286146;7669.348105411103;7688.807779805549;7845.450818442654;7955.204479551999;8000.039995200613;7349;7440.962795185989;7524.360429363565;7593.088829340514;7595.3164215220895;7003.4747393944635;7139.286071392819;7142.607156606437;7145.321194486515;7165.605891676008;5144.897102058013;5230.320058392384;5240.554552863049;5253.921191182212;5512.173174023928;5206.297149884868;5256.921146182887;5272.578193744568;5341.439148889311;5555.250041244381 12:58:31 INFO - PROCESS | 16906 | |4;prototype.html;327.77711156413636;329.19183404741375;340.6014962493881;342.15999720685704;345.314550617025;5398.8920221595545;5553.72231388431;5564.554835613151;5677.659340439576;5680.7443665035125;5291.735413229342;5429.185622156669;5452.318460192476;5467.316585426822;5476.4249753775775;4265.786710664462;4270.615644591986;4272.444582204309;4276.203994322392;4276.23027854986;4185.393117997904;4240.469941257343;4260.360945858115;4280.443542339492;4283.357496375537;4212.810423530948;4230.323148296273;4243.6605071594195;4243.893902652428;4244.299690551071;4237.580410562466;4245.5375881988375;4274.29474136767;4275.572442755731;4301;3651.2697460508007;3811.6188381161937;3812.046988252937;3818.618138186187;3821.522309711286;5321.175217841241;5321.201819727072;5360.865978350534;5360.946390536123;5365.812196573141;4846.5638092571835;4875.317455556225;4891.461939186686;4895.510448955076;4906.632002599784;5548.223248745179;5708.286464191976;5715.599908006441;5728.541716662657;5815.476607105381;4133.689973252018;4145.113973142213;4154.857414211086;4166.354290055441;4170.457840480748;5953.523718102541;6059.484943779784;6071.757129714806;6074.301455332649;6077.209962704865;4102.466679331667;4222.324428091552;4227;4229.957700422957;4232.682548808852;4222.4933008038615;4233.983843877509;4259.936100958488;4266.850660226939;4267.871963841089;4892.412910450768;4899.755012249373;4907.263910413467;4912.631552633567;4918.754062296871;5626.240457538262;5782.421757824184;5787.884242315215;5846.269216347957;5855;1418.6027912184604;1419.9290035498184;1447.949321773733;1451.7386870363225;1453.5058080252766;868.6959564152622;895.3061377432542;907.732218995398;911.886014248219;914.1087439746194;4880.341153944243;4927.556519913153;4948.960718249136;4964.35463389757;4967.5162418790605;5131.076406246837;5152.510511501401;5183.922241166386;5204.76578553966;5204.9219261711105;4815.723852775018;4828.130936431406;4934.309196712463;4936.654434189644;4939.950600494021;2800.635917330734;2805.340744924941;2805.8636252317438;2813.423248234148;2822.50606143924;5372.838814835562;5405.378381486179;5409.594280428983;5446.019716451076;5446.700431476307;5025.6482046256415;5255.921161182585;5306;5331.600129990266;5335.759890804923;5320.467953204648;5329.227262046981;5367.490088441592;5376.978374108907;5384.515393614515;5196.402413722471;5216.765245564035;5222.451642577626;5227;5295.313647421982;5206.921896171636;5510;5904.881902362014;5917.378675239038;5952.226210592596;6271.498280137669;6286.811395658137;6293.811185664437;6311.747530098744;6316.431521163117;4013.337799263206;4200.432941552851;4223.577642235752;4232.534421213602;4234.322508398642;5827.125931110368;5879.764809407576;5895.351511333664;5926.555508336805;5946.613470124428;5746.885062298647;5796.652200867961;5802.94197058024;5813.738381772915;5828.154917537018;5800.912986305125;5800.941990580209;5807.186993820784;5811.4479124483105;5812.9709351452975;5656.5757568181725;5704.686242256716;5720.513756330759;5764.36591974874;5769.9711501442225;5860.446981549978;5888.558358123072;5910.556708246984;5917.733701983507;5961.463468287875;5720.227769251098;5773.91339129905;5788.739506722123;5820.82537523875;5826.533877289891 12:58:31 INFO - PROCESS | 16906 | |5;yui.html;737.9520331178473;747.8093086263002;753.5328096580121;775.577310365851;865.5888452984831;14428.783568246472;15467.22663866805;15490.845091549081;15512;15536.990095643776;13381.39783709733;13393.330333483336;13437.462501499927;13448.462061517528;13466.865331346684;767.5011242692239;784.6704384158667;805.6173317674117;814.1858141858141;816.5345752920838;795.6857041468617;797.8125140591957;797.8444203380343;798.2496453333877;799.1169757418056;851.6040041380757;852.6759831264111;854.2952064546743;855.6876739989921;856.3192262151605;846.4328899637196;849.2611428057598;849.6771226933756;852.0074113657581;853.0573716043745;621.9906701399483;622.4087117238596;622.7042154976396;622.7820262907991;624.2290770897937;14463.349149288308;14558.417663293561;14581.19803410812;14630.41478340865;14638.560843174722;13725.588232353046;13928.51250206238;14172.787408188886;14197.432102715879;14344.42622295107;12062.517499300018;12086.576969806014;12093;12153.878461215452;12444.688882777913;3734.9439758403646;3801.7434620174345;3813.1420430402936;3819.9236015279816;3965.405189221611;82340.58829705813;82446.17553824445;82730;83064.58467707623;84471.57764211201;11006.889931100746;11059.72350691239;11084.501197445972;11098.44507774608;11396.715082122848;20558;20567.280145194847;20633.587328253652;20642.27752028672;20686.689699654216;7750.534967901944;8070.717524886718;8227.42408031432;8365.707200247962;8406.957965210135;4646.535346465326;4931.3096166536;4948.703077815343;5019.021290848323;5162.535371816554;3482.2861313430685;3570.8928732137556;3582.8208589570418;3609.260101679202;3628.9455658165148;538.4104405675779;549.9835004949858;559.4852735483365;565.5447364871236;570.6034306157264;705.8976448414951;725.753243897067;757.7234309477001;760.634895250283;762.8436170585016;8551.957240213884;8586.87119693205;9143.405678630868;9190.356675032683;9218.44689318643;620.1906512001791;703.6094967293099;706.2654838967417;731.8217669552017;750.5871770526189;4410.42664453619;4625.190591646448;4718.673444542119;4769.284607308931;4802.351682522884;109493.90506094997;114681.4265928665;119598.4020079894;124557.37721311336;128723.35638321748;89475;105340.47329763455;105892;106362.46818765857;107246;57144.714276429186;58070;59088;90577;91624;8557.743267701979;8693.69572065;8905.777355565904;8915.032939516625;8940.73177804667;50688.23967640415;51331;52604.47395525996;53428;53839.46160538345;71098;77993.61003194947;80213.59893200497;81672;83380.16619833966;10990.725231869268;11272.380019099028;11358.204925655125;11608.419579020847;11638.941805290919;11578.652640420802;12444.502219911103;13048.804267935799;13230.735385292433;13375.264360460269;12385.19496232742;12967.805482917953;13109.737805244033;13323.800142998056;13370.465181392636;12593.93703031479;12854.357282136043;12964.416601252778;13006.609801705965;13595.11631743973;11894.643160705193;12111.212771169845;12151.210171339188;12235.632931012084;12582.496700131893;9782.461964592016;10027.699169024942;10436.217283703905;10459.424731639832;10628.734281642712;9613;10076.84884726715;10842.457877106272;11019.779604408028;11185.217034807485 12:58:31 INFO - PROCESS | 16906 | __end_tp_report 12:58:31 INFO - PROCESS | 16906 | __start_cc_report 12:58:31 INFO - PROCESS | 16906 | _x_x_mozilla_cycle_collect,298 12:58:31 INFO - PROCESS | 16906 | __end_cc_report 12:58:31 INFO - PROCESS | 16906 | __startTimestamp1475179111330__endTimestamp 12:58:31 INFO - PROCESS | 16906 | 12:58:31 INFO - PROCESS | 16906 | ------- Summary: start ------- 12:58:31 INFO - PROCESS | 16906 | Number of tests: 6 12:58:31 INFO - PROCESS | 16906 | 12:58:31 INFO - PROCESS | 16906 | [#0] dojo.html Cycles:165 Average:5399.00 Median:5607.89 stddev:612.81 (10.9%) stddev-sans-first:586.51 12:58:31 INFO - PROCESS | 16906 | Values: 3057.2 3059.0 3060.9 3088.5 3092.3 5281.3 5396.0 5436.9 5467.0 5537.3 5298.3 5406.4 5483.7 5508.1 5512.3 4873.0 4873.8 4902.8 4951.0 5013.9 4946.5 5006.8 5011.8 5012.0 5062.5 4851.4 4950.3 4967.8 5005.3 5010.4 4856.9 4922.9 4927.4 4959.9 5029.8 4890.9 4925.6 4942.0 4947.7 5013.5 5373.1 5417.2 5419.0 5422.7 5427.1 5671.8 5702.5 5744.7 5777.7 5788.4 5794.7 5816.1 5819.1 5819.7 5844.5 5483.7 5486.1 5486.4 5489.2 5500.1 5886.1 5931.5 5953.4 5960.4 6005.8 5712.6 5713.1 5716.9 5717.0 5730.4 5695.2 5730.2 5814.4 5818.4 5818.7 5765.9 5774.1 5801.4 5806.3 5850.5 5799.7 5803.6 5809.3 5813.2 5813.6 4394.0 4439.2 4458.2 4459.8 4514.5 3945.2 3954.6 3998.5 4018.5 4078.9 5587.8 5602.4 5607.9 5615.0 5617.5 5860.2 5866.1 5874.0 5876.5 5901.7 5359.1 5451.3 5460.4 5491.4 5554.2 5065.3 5084.3 5101.4 5101.5 5123.6 5991.7 6008.6 6021.2 6030.7 6047.5 5537.4 5560.2 5850.7 5864.1 5873.6 5926.1 5953.3 5958.9 6045.8 6079.4 5628.6 5648.0 5700.5 5701.1 5704.5 5655.3 5821.1 5823.5 5851.4 5873.1 5519.8 5634.8 5643.9 5663.8 5745.9 5664.0 5679.7 5679.8 5681.7 5682.6 5443.8 5483.7 5602.7 5603.7 5618.9 5742.0 5746.5 5751.3 5752.4 5813.4 5567.5 5593.4 5606.9 5611.5 5614.6 12:58:31 INFO - PROCESS | 16906 | 12:58:31 INFO - PROCESS | 16906 | [#1] ext.html Cycles:180 Average:59024.67 Median:230589.29 stddev:117672.42 (51.0%) stddev-sans-first:117920.64 12:58:31 INFO - PROCESS | 16906 | Values: 554.9 579.7 593.5 594.6 612.5 42092.2 42743.6 42934.6 47552.0 47621.3 44181.0 44331.0 44742.3 44833.0 44934.3 8824.1 9006.8 9023.9 9029.0 9067.0 8862.6 8923.4 8935.0 8959.7 8960.4 8978.2 9003.1 9021.0 9024.1 9037.0 8797.8 8854.3 8865.9 8909.4 8956.4 8763.6 8844.2 8898.7 8917.4 8925.8 42363.4 42532.0 42848.6 42881.8 42932.8 3322.7 3441.2 3597.4 3920.8 3962.2 31062.4 31636.5 31686.0 32055.0 33776.5 4286.1 4366.4 4383.7 4547.8 4565.3 340935.0 346681.0 347198.0 348438.0 350569.0 55604.7 55616.0 55792.7 55872.4 56003.0 36081.8 36301.3 36399.6 38830.2 38996.2 16515.0 16606.6 16786.7 16786.8 16799.7 12499.8 12635.6 12667.9 12670.7 12684.6 18385.6 18463.4 18585.2 18621.0 18810.2 7066.6 7164.5 7270.3 7469.7 7516.5 830.0 898.1 927.2 932.4 1119.1 31718.2 31782.2 32064.4 32687.3 32727.5 1084.2 1086.0 1160.4 1161.4 1173.6 16653.6 16905.2 16963.9 17234.7 17427.3 530161.0 542139.0 542199.0 545452.0 545904.0 55909.4 56613.4 56751.4 56868.4 56905.0 1196.0 1220.6 1290.0 1303.3 1303.7 29589.4 31690.7 31753.0 31966.5 32176.5 49907.0 50463.5 50495.2 50508.5 50511.0 419152.0 421049.0 421534.0 422046.0 422207.0 27396.2 27615.2 27851.9 27859.6 27897.2 47144.0 47519.0 47683.3 48087.0 48223.3 39601.4 39769.2 40352.0 41024.2 41721.8 38604.0 39912.0 40610.6 41827.2 42026.6 34814.0 35260.3 38715.2 39544.4 40520.6 33929.3 36184.3 36309.0 36738.8 37048.0 28568.6 28708.3 28802.7 28918.4 29067.0 12:58:31 INFO - PROCESS | 16906 | 12:58:31 INFO - PROCESS | 16906 | [#2] jquery.html Cycles:180 Average:27871.26 Median:16518.72 stddev:76723.41 (464.5%) stddev-sans-first:76910.90 12:58:31 INFO - PROCESS | 16906 | Values: 396.6 396.7 398.4 402.7 408.3 16352.0 16778.0 18689.9 19453.3 19527.9 11428.7 11688.7 11947.9 11979.6 18109.0 4996.7 5214.9 5218.3 5225.3 5235.0 4976.9 5114.9 5129.5 5148.7 5150.9 5109.8 5146.5 5151.6 5152.4 5158.5 4942.2 5044.4 5091.8 5147.1 5156.2 4963.5 4968.2 4977.1 4977.4 5001.1 12892.7 13400.5 13507.9 13848.4 13950.2 2087.7 2151.7 2220.1 2262.6 2794.7 9393.8 9930.3 10153.3 12320.3 14492.3 1828.9 1865.3 1898.8 1903.9 1976.2 82788.2 84417.6 85086.6 85376.0 85606.0 10912.3 11084.3 11099.7 11152.3 11503.9 15979.4 15997.8 16018.6 16026.6 16056.0 7684.5 7926.4 7998.9 8074.7 8314.6 7311.5 7335.6 7409.7 7510.9 7597.5 4791.3 4803.1 4839.5 4860.9 4949.2 1895.6 1929.5 1993.2 1997.5 2080.2 825.9 918.5 976.3 1005.6 1009.7 19080.1 19162.1 19294.1 19349.2 19622.8 946.8 960.1 960.9 973.6 975.2 10593.9 10910.1 10928.1 10941.7 10969.4 457938.0 460787.0 461071.0 462270.0 474361.6 85965.1 87060.6 89103.6 90187.5 101977.0 1009.5 1051.1 1053.9 1066.9 1078.0 16656.9 17365.6 18145.5 18186.7 18193.0 32640.8 40992.0 41491.8 42569.1 43851.0 59804.0 60857.7 61907.4 62230.0 62795.1 8297.0 8332.0 8528.5 8583.4 8596.7 11362.8 13191.0 13252.0 13297.9 13817.3 10404.9 10820.1 11084.4 11134.6 11910.0 11477.4 11765.7 11892.8 12109.8 12469.9 12082.9 12115.1 12115.9 12225.5 12432.3 8137.2 8359.4 8460.8 8480.7 8486.3 8311.4 12017.1 12097.9 12144.9 12314.0 12:58:31 INFO - PROCESS | 16906 | 12:58:31 INFO - PROCESS | 16906 | [#3] mootools.html Cycles:180 Average:5787.87 Median:4812.56 stddev:3307.21 (68.7%) stddev-sans-first:3300.41 12:58:31 INFO - PROCESS | 16906 | Values: 1447.3 1506.1 1607.0 1750.9 1773.9 7808.2 8069.8 8376.7 9064.1 9072.5 8331.9 8598.8 8614.9 8863.5 8867.9 2346.4 2395.3 2396.1 2396.5 2402.9 2332.4 2332.5 2391.0 2392.0 2398.5 2286.8 2291.5 2306.4 2318.5 2324.7 2320.9 2355.9 2358.1 2366.6 2370.8 2287.4 2300.1 2301.7 2302.6 2312.5 8556.9 8803.3 8809.8 8816.9 8826.5 5047.3 5047.4 5202.2 5215.1 5222.3 3203.4 3263.1 3346.7 3350.7 3488.4 1070.6 1111.0 1121.7 1131.7 1144.4 12583.4 12652.6 12710.3 12731.9 12769.2 4628.6 4692.0 4870.9 4877.3 4898.5 10236.4 10244.7 10336.2 10339.1 10364.6 5284.8 5301.3 5302.6 5325.9 5332.5 4316.4 4427.4 4754.2 4874.4 4931.7 4017.2 4105.9 4134.5 4274.6 4286.9 1286.9 1300.9 1301.2 1308.5 1323.1 813.5 917.3 943.6 951.7 993.1 5865.3 5951.7 6022.9 6032.9 6187.8 410.1 417.7 434.7 438.0 443.8 4075.4 4160.0 4165.8 4191.5 4205.7 10596.8 10851.4 10856.1 10964.6 10967.4 10878.8 10885.5 10909.6 10936.3 10946.8 7816.5 7843.1 7916.9 7938.8 7967.9 5767.1 5809.8 5836.4 5899.2 6042.0 9761.0 9905.8 9933.2 9978.5 10083.2 10231.6 10240.4 10283.9 10294.1 10326.8 7090.2 7293.0 7349.8 7890.2 7981.0 8268.8 8460.9 8504.0 8578.4 8588.4 7669.3 7688.8 7845.5 7955.2 8000.0 7349.0 7441.0 7524.4 7593.1 7595.3 7003.5 7139.3 7142.6 7145.3 7165.6 5144.9 5230.3 5240.6 5253.9 5512.2 5206.3 5256.9 5272.6 5341.4 5555.3 12:58:31 INFO - PROCESS | 16906 | 12:58:31 INFO - PROCESS | 16906 | [#4] prototype.html Cycles:180 Average:4719.80 Median:5241.46 stddev:1390.24 (26.5%) stddev-sans-first:1354.50 12:58:31 INFO - PROCESS | 16906 | Values: 327.8 329.2 340.6 342.2 345.3 5398.9 5553.7 5564.6 5677.7 5680.7 5291.7 5429.2 5452.3 5467.3 5476.4 4265.8 4270.6 4272.4 4276.2 4276.2 4185.4 4240.5 4260.4 4280.4 4283.4 4212.8 4230.3 4243.7 4243.9 4244.3 4237.6 4245.5 4274.3 4275.6 4301.0 3651.3 3811.6 3812.0 3818.6 3821.5 5321.2 5321.2 5360.9 5360.9 5365.8 4846.6 4875.3 4891.5 4895.5 4906.6 5548.2 5708.3 5715.6 5728.5 5815.5 4133.7 4145.1 4154.9 4166.4 4170.5 5953.5 6059.5 6071.8 6074.3 6077.2 4102.5 4222.3 4227.0 4230.0 4232.7 4222.5 4234.0 4259.9 4266.9 4267.9 4892.4 4899.8 4907.3 4912.6 4918.8 5626.2 5782.4 5787.9 5846.3 5855.0 1418.6 1419.9 1447.9 1451.7 1453.5 868.7 895.3 907.7 911.9 914.1 4880.3 4927.6 4949.0 4964.4 4967.5 5131.1 5152.5 5183.9 5204.8 5204.9 4815.7 4828.1 4934.3 4936.7 4940.0 2800.6 2805.3 2805.9 2813.4 2822.5 5372.8 5405.4 5409.6 5446.0 5446.7 5025.6 5255.9 5306.0 5331.6 5335.8 5320.5 5329.2 5367.5 5377.0 5384.5 5196.4 5216.8 5222.5 5227.0 5295.3 5206.9 5510.0 5904.9 5917.4 5952.2 6271.5 6286.8 6293.8 6311.7 6316.4 4013.3 4200.4 4223.6 4232.5 4234.3 5827.1 5879.8 5895.4 5926.6 5946.6 5746.9 5796.7 5802.9 5813.7 5828.2 5800.9 5800.9 5807.2 5811.4 5813.0 5656.6 5704.7 5720.5 5764.4 5770.0 5860.4 5888.6 5910.6 5917.7 5961.5 5720.2 5773.9 5788.7 5820.8 5826.5 12:58:31 INFO - PROCESS | 16906 | 12:58:31 INFO - PROCESS | 16906 | [#5] yui.html Cycles:180 Average:20607.72 Median:4743.98 stddev:30674.88 (646.6%) stddev-sans-first:30724.65 12:58:31 INFO - PROCESS | 16906 | Values: 738.0 747.8 753.5 775.6 865.6 14428.8 15467.2 15490.8 15512.0 15537.0 13381.4 13393.3 13437.5 13448.5 13466.9 767.5 784.7 805.6 814.2 816.5 795.7 797.8 797.8 798.2 799.1 851.6 852.7 854.3 855.7 856.3 846.4 849.3 849.7 852.0 853.1 622.0 622.4 622.7 622.8 624.2 14463.3 14558.4 14581.2 14630.4 14638.6 13725.6 13928.5 14172.8 14197.4 14344.4 12062.5 12086.6 12093.0 12153.9 12444.7 3734.9 3801.7 3813.1 3819.9 3965.4 82340.6 82446.2 82730.0 83064.6 84471.6 11006.9 11059.7 11084.5 11098.4 11396.7 20558.0 20567.3 20633.6 20642.3 20686.7 7750.5 8070.7 8227.4 8365.7 8407.0 4646.5 4931.3 4948.7 5019.0 5162.5 3482.3 3570.9 3582.8 3609.3 3628.9 538.4 550.0 559.5 565.5 570.6 705.9 725.8 757.7 760.6 762.8 8552.0 8586.9 9143.4 9190.4 9218.4 620.2 703.6 706.3 731.8 750.6 4410.4 4625.2 4718.7 4769.3 4802.4 109493.9 114681.4 119598.4 124557.4 128723.4 89475.0 105340.5 105892.0 106362.5 107246.0 57144.7 58070.0 59088.0 90577.0 91624.0 8557.7 8693.7 8905.8 8915.0 8940.7 50688.2 51331.0 52604.5 53428.0 53839.5 71098.0 77993.6 80213.6 81672.0 83380.2 10990.7 11272.4 11358.2 11608.4 11638.9 11578.7 12444.5 13048.8 13230.7 13375.3 12385.2 12967.8 13109.7 13323.8 13370.5 12593.9 12854.4 12964.4 13006.6 13595.1 11894.6 12111.2 12151.2 12235.6 12582.5 9782.5 10027.7 10436.2 10459.4 10628.7 9613.0 10076.8 10842.5 11019.8 11185.2 12:58:31 INFO - PROCESS | 16906 | -------- Summary: end -------- 12:58:31 INFO - PROCESS | 16906 | 12:58:32 INFO - TEST-INFO | 16906: exit 0 12:58:32 INFO - TEST-OK | dromaeo_css | took 1113665ms 12:58:32 INFO - TEST-START | kraken 12:58:32 INFO - operating with platform_type : linux_ 12:58:32 INFO - Initialising browser for kraken test... 12:58:32 INFO - TEST-INFO | started process 17261 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdKNwwb/profile http://localhost:46280/getInfo.html) 12:58:36 INFO - PROCESS | 17261 | __metrics Screen width/height:1600/1200 12:58:36 INFO - PROCESS | 17261 | colorDepth:24 12:58:36 INFO - PROCESS | 17261 | Browser inner width/height: 1024/697 12:58:36 INFO - PROCESS | 17261 | __metrics 12:58:37 ERROR - PROCESS | 17261 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3076: TypeError: this.tabs is undefined 12:58:38 INFO - TEST-INFO | 17261: exit 0 12:58:38 INFO - Browser initialized. 12:58:38 INFO - Running cycle 1/1 for kraken test... 12:58:38 INFO - TEST-INFO | started process 17385 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdKNwwb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:58:50 INFO - PROCESS | 17385 | RSS: Main: 185217024 12:58:50 INFO - PROCESS | 17385 | 12:58:53 INFO - PROCESS | 17385 | Cycle 1(1): loaded http://localhost:46280/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46280/tests/kraken/driver.html?testName=audio-beat-detection) 12:58:54 INFO - PROCESS | 17385 | RSS: Main: 198799360 12:58:54 INFO - PROCESS | 17385 | 12:58:56 INFO - PROCESS | 17385 | Cycle 1(1): loaded http://localhost:46280/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46280/tests/kraken/driver.html?testName=audio-dft) 12:58:57 INFO - PROCESS | 17385 | RSS: Main: 196308992 12:58:57 INFO - PROCESS | 17385 | 12:59:00 INFO - PROCESS | 17385 | Cycle 1(1): loaded http://localhost:46280/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46280/tests/kraken/driver.html?testName=audio-fft) 12:59:00 INFO - PROCESS | 17385 | RSS: Main: 192634880 12:59:00 INFO - PROCESS | 17385 | 12:59:03 INFO - PROCESS | 17385 | Cycle 1(1): loaded http://localhost:46280/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46280/tests/kraken/driver.html?testName=audio-oscillator) 12:59:03 INFO - PROCESS | 17385 | RSS: Main: 193617920 12:59:03 INFO - PROCESS | 17385 | 12:59:05 INFO - PROCESS | 17385 | Cycle 1(1): loaded http://localhost:46280/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46280/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:59:06 INFO - PROCESS | 17385 | RSS: Main: 193650688 12:59:06 INFO - PROCESS | 17385 | 12:59:09 INFO - PROCESS | 17385 | Cycle 1(1): loaded http://localhost:46280/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46280/tests/kraken/driver.html?testName=imaging-darkroom) 12:59:10 INFO - PROCESS | 17385 | RSS: Main: 194465792 12:59:10 INFO - PROCESS | 17385 | 12:59:13 INFO - PROCESS | 17385 | Cycle 1(1): loaded http://localhost:46280/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46280/tests/kraken/driver.html?testName=imaging-desaturate) 12:59:14 INFO - PROCESS | 17385 | RSS: Main: 194146304 12:59:14 INFO - PROCESS | 17385 | 12:59:16 INFO - PROCESS | 17385 | Cycle 1(1): loaded http://localhost:46280/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46280/tests/kraken/driver.html?testName=json-parse-financial) 12:59:17 INFO - PROCESS | 17385 | RSS: Main: 194281472 12:59:17 INFO - PROCESS | 17385 | 12:59:19 INFO - PROCESS | 17385 | Cycle 1(1): loaded http://localhost:46280/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46280/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:59:19 INFO - PROCESS | 17385 | RSS: Main: 194048000 12:59:19 INFO - PROCESS | 17385 | 12:59:21 INFO - PROCESS | 17385 | Cycle 1(1): loaded http://localhost:46280/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46280/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:59:22 INFO - PROCESS | 17385 | RSS: Main: 194150400 12:59:22 INFO - PROCESS | 17385 | 12:59:24 INFO - PROCESS | 17385 | Cycle 1(1): loaded http://localhost:46280/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46280/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:59:24 INFO - PROCESS | 17385 | RSS: Main: 194347008 12:59:24 INFO - PROCESS | 17385 | 12:59:27 INFO - PROCESS | 17385 | Cycle 1(1): loaded http://localhost:46280/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46280/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:59:28 INFO - PROCESS | 17385 | RSS: Main: 194510848 12:59:28 INFO - PROCESS | 17385 | 12:59:31 INFO - PROCESS | 17385 | Cycle 1(1): loaded http://localhost:46280/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46280/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:59:31 INFO - PROCESS | 17385 | RSS: Main: 194928640 12:59:31 INFO - PROCESS | 17385 | 12:59:33 INFO - PROCESS | 17385 | Cycle 1(1): loaded http://localhost:46280/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46280/tests/kraken/driver.html?testName=ai-astar) 12:59:33 INFO - PROCESS | 17385 | RSS: Main: 196313088 12:59:33 INFO - PROCESS | 17385 | 12:59:33 INFO - PROCESS | 17385 | __start_tp_report 12:59:33 INFO - PROCESS | 17385 | _x_x_mozilla_page_load 12:59:33 INFO - PROCESS | 17385 | _x_x_mozilla_page_load_details 12:59:33 INFO - PROCESS | 17385 | |i|pagename|runs| 12:59:33 INFO - PROCESS | 17385 | |0;ai-astar;103;112;111;112;113;111;111;111;111;113 12:59:33 INFO - PROCESS | 17385 | |1;audio-beat-detection;160;123;121;164;124;121;121;122;158;120 12:59:33 INFO - PROCESS | 17385 | |2;audio-dft;171;164;162;167;173;164;161;161;163;164 12:59:33 INFO - PROCESS | 17385 | |3;audio-fft;75;75;77;118;76;77;78;78;101;77 12:59:33 INFO - PROCESS | 17385 | |4;audio-oscillator;83;85;110;82;84;83;99;82;82;117 12:59:33 INFO - PROCESS | 17385 | |5;imaging-gaussian-blur;118;117;118;117;117;117;117;117;118;120 12:59:33 INFO - PROCESS | 17385 | |6;imaging-darkroom;147;150;147;149;147;147;147;147;147;147 12:59:33 INFO - PROCESS | 17385 | |7;imaging-desaturate;96;96;96;96;95;96;96;95;95;95 12:59:33 INFO - PROCESS | 17385 | |8;json-parse-financial;53;54;51;51;55;54;54;53;53;54 12:59:33 INFO - PROCESS | 17385 | |9;json-stringify-tinderbox;60;70;61;61;61;61;60;60;59;60 12:59:33 INFO - PROCESS | 17385 | |10;stanford-crypto-aes;79;79;79;81;81;85;79;79;87;83 12:59:33 INFO - PROCESS | 17385 | |11;stanford-crypto-ccm;135;136;140;131;124;135;126;144;177;150 12:59:33 INFO - PROCESS | 17385 | |12;stanford-crypto-pbkdf2;164;163;167;164;161;162;163;165;171;161 12:59:33 INFO - PROCESS | 17385 | |13;stanford-crypto-sha256-iterative;68;67;66;65;63;65;65;71;64;63 12:59:33 INFO - PROCESS | 17385 | __end_tp_report 12:59:33 INFO - PROCESS | 17385 | __start_cc_report 12:59:33 INFO - PROCESS | 17385 | _x_x_mozilla_cycle_collect,769 12:59:33 INFO - PROCESS | 17385 | __end_cc_report 12:59:33 INFO - PROCESS | 17385 | __startTimestamp1475179173688__endTimestamp 12:59:33 INFO - PROCESS | 17385 | 12:59:33 INFO - PROCESS | 17385 | ------- Summary: start ------- 12:59:33 INFO - PROCESS | 17385 | Number of tests: 14 12:59:33 INFO - PROCESS | 17385 | 12:59:33 INFO - PROCESS | 17385 | [#0] ai-astar Cycles:10 Average:110.80 Median:111.50 stddev:2.86 (2.6%) stddev-sans-first:0.87 12:59:33 INFO - PROCESS | 17385 | Values: 103.0 112.0 111.0 112.0 113.0 111.0 111.0 111.0 111.0 113.0 12:59:33 INFO - PROCESS | 17385 | 12:59:33 INFO - PROCESS | 17385 | [#1] audio-beat-detection Cycles:10 Average:133.40 Median:123.50 stddev:18.90 (15.3%) stddev-sans-first:17.43 12:59:33 INFO - PROCESS | 17385 | Values: 160.0 123.0 121.0 164.0 124.0 121.0 121.0 122.0 158.0 120.0 12:59:33 INFO - PROCESS | 17385 | 12:59:33 INFO - PROCESS | 17385 | [#2] audio-dft Cycles:10 Average:165.00 Median:164.00 stddev:4.11 (2.5%) stddev-sans-first:3.74 12:59:33 INFO - PROCESS | 17385 | Values: 171.0 164.0 162.0 167.0 173.0 164.0 161.0 161.0 163.0 164.0 12:59:33 INFO - PROCESS | 17385 | 12:59:33 INFO - PROCESS | 17385 | [#3] audio-fft Cycles:10 Average:83.20 Median:77.00 stddev:14.47 (18.8%) stddev-sans-first:15.04 12:59:33 INFO - PROCESS | 17385 | Values: 75.0 75.0 77.0 118.0 76.0 77.0 78.0 78.0 101.0 77.0 12:59:33 INFO - PROCESS | 17385 | 12:59:33 INFO - PROCESS | 17385 | [#4] audio-oscillator Cycles:10 Average:90.70 Median:83.00 stddev:13.15 (15.8%) stddev-sans-first:13.65 12:59:33 INFO - PROCESS | 17385 | Values: 83.0 85.0 110.0 82.0 84.0 83.0 99.0 82.0 82.0 117.0 12:59:33 INFO - PROCESS | 17385 | 12:59:33 INFO - PROCESS | 17385 | [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:117.50 stddev:0.97 (0.8%) stddev-sans-first:1.01 12:59:33 INFO - PROCESS | 17385 | Values: 118.0 117.0 118.0 117.0 117.0 117.0 117.0 117.0 118.0 120.0 12:59:33 INFO - PROCESS | 17385 | 12:59:33 INFO - PROCESS | 17385 | [#6] imaging-darkroom Cycles:10 Average:147.50 Median:147.00 stddev:1.08 (0.7%) stddev-sans-first:1.13 12:59:33 INFO - PROCESS | 17385 | Values: 147.0 150.0 147.0 149.0 147.0 147.0 147.0 147.0 147.0 147.0 12:59:33 INFO - PROCESS | 17385 | 12:59:33 INFO - PROCESS | 17385 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 12:59:33 INFO - PROCESS | 17385 | Values: 96.0 96.0 96.0 96.0 95.0 96.0 96.0 95.0 95.0 95.0 12:59:33 INFO - PROCESS | 17385 | 12:59:33 INFO - PROCESS | 17385 | [#8] json-parse-financial Cycles:10 Average:53.20 Median:54.00 stddev:1.32 (2.4%) stddev-sans-first:1.39 12:59:33 INFO - PROCESS | 17385 | Values: 53.0 54.0 51.0 51.0 55.0 54.0 54.0 53.0 53.0 54.0 12:59:33 INFO - PROCESS | 17385 | 12:59:33 INFO - PROCESS | 17385 | [#9] json-stringify-tinderbox Cycles:10 Average:61.30 Median:61.00 stddev:3.13 (5.1%) stddev-sans-first:3.28 12:59:33 INFO - PROCESS | 17385 | Values: 60.0 70.0 61.0 61.0 61.0 61.0 60.0 60.0 59.0 60.0 12:59:33 INFO - PROCESS | 17385 | 12:59:33 INFO - PROCESS | 17385 | [#10] stanford-crypto-aes Cycles:10 Average:81.20 Median:81.00 stddev:2.90 (3.6%) stddev-sans-first:2.96 12:59:33 INFO - PROCESS | 17385 | Values: 79.0 79.0 79.0 81.0 81.0 85.0 79.0 79.0 87.0 83.0 12:59:33 INFO - PROCESS | 17385 | 12:59:33 INFO - PROCESS | 17385 | [#11] stanford-crypto-ccm Cycles:10 Average:139.80 Median:138.00 stddev:15.22 (11.0%) stddev-sans-first:16.04 12:59:33 INFO - PROCESS | 17385 | Values: 135.0 136.0 140.0 131.0 124.0 135.0 126.0 144.0 177.0 150.0 12:59:33 INFO - PROCESS | 17385 | 12:59:33 INFO - PROCESS | 17385 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.10 Median:164.00 stddev:3.03 (1.9%) stddev-sans-first:3.22 12:59:33 INFO - PROCESS | 17385 | Values: 164.0 163.0 167.0 164.0 161.0 162.0 163.0 165.0 171.0 161.0 12:59:33 INFO - PROCESS | 17385 | 12:59:33 INFO - PROCESS | 17385 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.70 Median:65.50 stddev:2.45 (3.7%) stddev-sans-first:2.46 12:59:33 INFO - PROCESS | 17385 | Values: 68.0 67.0 66.0 65.0 63.0 65.0 65.0 71.0 64.0 63.0 12:59:33 INFO - PROCESS | 17385 | -------- Summary: end -------- 12:59:33 INFO - PROCESS | 17385 | 12:59:33 INFO - PROCESS | 17385 | 12:59:33 INFO - PROCESS | 17385 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 12:59:33 INFO - PROCESS | 17385 | 12:59:33 INFO - PROCESS | 17385 | 12:59:33 INFO - PROCESS | 17385 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 12:59:33 INFO - PROCESS | 17385 | 12:59:33 INFO - PROCESS | 17385 | 12:59:33 INFO - PROCESS | 17385 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 12:59:33 INFO - PROCESS | 17385 | 12:59:33 INFO - PROCESS | 17385 | 12:59:33 INFO - PROCESS | 17385 | ###!!! [Parent][MessageChannel] Error: (msgtype=0x2000B,name=PAPZ::Msg_Destroy) Channel error: cannot send/recv 12:59:33 INFO - PROCESS | 17385 | 12:59:33 INFO - PROCESS | 17385 | 12:59:33 INFO - PROCESS | 17385 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 12:59:33 INFO - PROCESS | 17385 | 12:59:34 INFO - TEST-INFO | 17385: exit 0 12:59:34 INFO - TEST-OK | kraken | took 62406ms 12:59:34 INFO - SUITE-END | took 1176s 12:59:34 INFO - Completed test suite (00:19:36) 12:59:34 INFO - javascript benchmark 12:59:34 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7146.909537309979, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3057.2051266670665, 3058.969410305898, 3060.8928687495913, 3088.49039908415, 3092.2887735820755, 5281.339832520935, 5396.0, 5436.945630543698, 5466.972665136674, 5537.307836520435, 5298.284731561238, 5406.378266499354, 5483.698396588186, 5508.118701007839, 5512.283403157594, 4872.951270487303, 4873.829415970442, 4902.754862256891, 4951.0, 5013.924791128136, 4946.530079642428, 5006.799728010875, 5011.84964451067, 5011.974940125294, 5062.468440813716, 4851.393575803025, 4950.2822090796635, 4967.801287948514, 5005.274235235888, 5010.398752149747, 4856.878578035577, 4922.852314430573, 4927.359443272388, 4959.876003099951, 5029.823956161516, 4890.902181956377, 4925.605951523869, 4941.950580494221, 4947.703137811743, 5013.548780609726, 5373.086575282172, 5417.160340147283, 5418.972905135489, 5422.701751403672, 5427.104527752916, 5671.829845104653, 5702.486776190121, 5744.741486633112, 5777.740001699934, 5788.363280039192, 5794.739236734357, 5816.098504731774, 5819.127130930395, 5819.73811178498, 5844.503217226541, 5483.670979741229, 5486.094794358926, 5486.396496385434, 5489.176623506466, 5500.119980803052, 5886.05823068307, 5931.466168044811, 5953.434423729739, 5960.433758792908, 6005.789797357072, 5712.600117991784, 5713.143028545668, 5716.942830571641, 5716.971415142898, 5730.426957304319, 5695.231143795535, 5730.169125476866, 5814.418558144152, 5818.44724751148, 5818.650880947157, 5765.913511297334, 5774.0761478163295, 5801.390853960358, 5806.303243610793, 5850.502707269845, 5799.739011744482, 5803.622764520293, 5809.331926828469, 5813.157092221689, 5813.6221145625395, 4393.956060439418, 4439.200943830142, 4458.197524445566, 4459.799309031101, 4514.548545145525, 3945.171513982096, 3954.6440820326306, 3998.4801975742967, 4018.477597912311, 4078.938815917764, 5587.832365029056, 5602.38373778884, 5607.887842243133, 5615.0454422748235, 5617.494425501643, 5860.150278209721, 5866.090755932837, 5873.970630146822, 5876.529877609781, 5901.734421951022, 5359.062164121263, 5451.345838499326, 5460.372057213472, 5491.423400542885, 5554.1946417769195, 5065.341505604321, 5084.339035925306, 5101.387833459934, 5101.540861322499, 5123.615728820353, 5991.730372133265, 6008.579399442085, 6021.217241758543, 6030.698465076816, 6047.5464340173785, 5537.390887002346, 5560.221568980265, 5850.678212698343, 5864.149698293638, 5873.647581145145, 5926.140709597171, 5953.255843019622, 5958.880822383441, 6045.848853778515, 6079.422454866957, 5628.634138780966, 5647.971760141173, 5700.543956483554, 5701.087825947829, 5704.543636508986, 5655.264815573949, 5821.126830975388, 5823.505002074871, 5851.385604511635, 5873.148393483007, 5519.779208831602, 5634.802781902614, 5643.858903527444, 5663.801766938137, 5745.87955348703, 5663.9716801415725, 5679.6876171810945, 5679.801206957736, 5681.715914204191, 5682.573806964411, 5443.836684899459, 5483.670979741229, 5602.691851948019, 5603.663780173202, 5618.943810561842, 5741.971290143522, 5746.454086861741, 5751.252337196138, 5752.395998420106, 5813.418658134153, 5567.526760225264, 5593.4126916674795, 5606.943930560642, 5611.5230205433, 5614.5789065821045], "value": 5357.0246863309685, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [554.8937859837204, 579.7478097027794, 593.5222146172332, 594.5600255810701, 612.4855121697773, 42092.15815683684, 42743.572564274386, 42934.570654293486, 47552.0, 47621.28568071473, 44181.0, 44331.0, 44742.32886506697, 44833.0, 44934.32598511025, 8824.117588241188, 9006.774830629221, 9023.864642030374, 9028.954855225715, 9067.0, 8862.601182946783, 8923.41997770143, 8934.955325223398, 8959.731208063737, 8960.417572857776, 8978.191962723353, 9003.09969003101, 9021.0, 9024.14270644291, 9036.954815225914, 8797.780055498632, 8854.3359248056, 8865.911340886638, 8909.420887642314, 8956.373053886231, 8763.649454021832, 8844.204021638083, 8898.73303800887, 8917.375783695144, 8925.776855578597, 42363.36454953147, 42532.0, 42848.57151428508, 42881.78559107184, 42932.78533607343, 3322.667733226658, 3441.1913200397885, 3597.37046016946, 3920.823562939646, 3962.2075584883137, 31062.378752424826, 31636.525452118236, 31686.0, 32055.0, 33776.49335259973, 4286.097771944978, 4366.366876802877, 4383.7150585212175, 4547.79534920926, 4565.292379681155, 340935.0, 346681.0, 347198.0, 348438.0, 350568.99999999744, 55604.72197639067, 55616.0, 55792.72103639537, 55872.44127558672, 56003.0, 36081.819590901876, 36301.273974520365, 36399.63600364015, 38830.22339553193, 38996.22007559833, 16515.0, 16606.584835379213, 16786.66426671484, 16786.832131678526, 16799.748003779954, 12499.812502812465, 12635.620931372074, 12667.93666031664, 12670.683232919066, 12684.619461416172, 18385.63228735418, 18463.353782617545, 18585.163667634988, 18621.0, 18810.153543090593, 7066.57600543969, 7164.534305270141, 7270.309320614533, 7469.663865126083, 7516.549007059594, 830.0, 898.070497035565, 927.248928368024, 932.4218984229685, 1119.138263537072, 31718.2070448236, 31782.205444864063, 32064.35871282608, 32687.346253074804, 32727.50908736371, 1084.2464487181492, 1085.9945700271448, 1160.4371879638368, 1161.3902701082, 1173.559915031863, 16653.583660408345, 16905.23926423314, 16963.915180424017, 17234.741478877826, 17427.302907883797, 530161.0, 542139.0, 542199.0, 545452.0, 545904.0, 55909.44090559124, 56613.43386566164, 56751.43248567544, 56868.43131568714, 56905.0, 1195.9521619135137, 1220.5850010996126, 1289.9677508062373, 1303.3483258370813, 1303.7001489657432, 29589.408211836075, 31690.683093168773, 31753.0, 31966.52050219202, 32176.517352240204, 49907.0, 50463.49536504735, 50495.24257136072, 50508.49491505038, 50511.0, 419152.0, 421049.0, 421534.0, 422046.0, 422207.0, 27396.17811465659, 27615.171544853685, 27851.860740696167, 27859.582106268015, 27897.16308510748, 47144.0, 47519.0, 47683.28475072946, 48087.0, 48223.27665085097, 39601.40597890977, 39769.2046159081, 40352.0, 41024.1795164101, 41721.79139104285, 38604.0, 39912.0, 40610.59389406068, 41827.163456730086, 42026.57973420226, 34814.0, 35260.294794104484, 38715.22569548649, 39544.40683389809, 40520.594794051685, 33929.321413572085, 36184.27631447409, 36309.0, 36738.81630591937, 37048.0, 28568.57147142753, 28708.282292942007, 28802.711972880843, 28918.37306031025, 29067.0], "value": 19691.79290288586, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [396.6113209055128, 396.736170446653, 398.4123417958511, 402.6617641181408, 408.25900989703683, 16352.018878867277, 16778.0, 18689.906550467247, 19453.31913383032, 19527.902360488177, 11428.71428214295, 11688.707782305426, 11947.940260298708, 11979.640610781691, 18109.0, 4996.700197988123, 5214.8696282592855, 5218.295530103444, 5225.320708307915, 5235.031519168947, 4976.925346119811, 5114.923276150861, 5129.53834154926, 5148.691078535281, 5150.922736158961, 5109.795608175668, 5146.5110814472755, 5151.613628977823, 5152.381714194302, 5158.509941555565, 4942.184539550988, 5044.39467263927, 5091.770870310808, 5147.073526765181, 5156.20078887773, 4963.503649635008, 4968.205087186069, 4977.104121258172, 4977.377827771528, 5001.124803159432, 12892.742145157139, 13400.463981440731, 13507.932460337635, 13848.376823042987, 13950.162990220619, 2087.7285952826037, 2151.741790985076, 2220.100859152046, 2262.637977923541, 2794.6646402431634, 9393.812123757487, 9930.255230857641, 10153.28926975112, 12320.260784352968, 14492.34784434703, 1828.8902665840092, 1865.3003638523905, 1898.8291053805224, 1903.9048047597703, 1976.188225460595, 82788.17211827864, 84417.57791211005, 85086.57456712677, 85376.0, 85606.0, 10912.29070110456, 11084.279521831055, 11099.667009989713, 11152.330860148417, 11503.942480287546, 15979.440719574759, 15997.760033599505, 16018.599535011717, 16026.599335016717, 16056.0, 7684.538927664358, 7926.445148839641, 7998.880016799752, 8074.717384891501, 8314.62584183701, 7311.4516411268305, 7335.596542190231, 7409.703611855573, 7510.9484672145945, 7597.506162099557, 4791.305260737243, 4803.087413391514, 4839.491853355417, 4860.854174374775, 4949.208126699711, 1895.5640202753443, 1929.4983304340692, 1993.2425678242175, 1997.4507010572208, 2080.219917530926, 825.8513467575895, 918.4626993208914, 976.3019441099648, 1005.5776573839005, 1009.6970908727352, 19080.14139363732, 19162.13770380336, 19294.13176407065, 19349.226030958886, 19622.8037719621, 946.7538440005649, 960.0927123868017, 960.9135177834029, 973.634886917406, 975.2303458178807, 10593.89406105929, 10910.127189824794, 10928.125749939985, 10941.671749847517, 10969.396683182502, 457938.0, 460787.0, 461071.0, 462270.0, 474361.5638436198, 85965.14034859571, 87060.5646971761, 89103.55448222718, 90187.54906225427, 101977.0, 1009.4801177393648, 1051.106559424483, 1053.9209559283083, 1066.8719753629614, 1078.013617539942, 16656.916715416344, 17365.565860853076, 18145.546361341072, 18186.727199091758, 18193.0, 32640.83679581682, 40992.0, 41491.79254103831, 42569.14861702687, 43851.0, 59804.0, 60857.69571152116, 61907.38092619016, 62230.0, 62795.05807412984, 8297.0, 8331.958340208503, 8528.488290702579, 8583.356248281529, 8596.699115530926, 11362.772744545227, 13191.0, 13252.0, 13297.933510332387, 13817.309134543433, 10404.895951040393, 10820.080293175168, 11084.445777711244, 11134.587048275582, 11910.047196224108, 11477.368744718786, 11765.705857353292, 11892.76214475723, 12109.75780484403, 12469.937650311691, 12082.879171208175, 12115.091368147248, 12115.939420302842, 12225.510979560719, 12432.254064756144, 8137.186281371815, 8359.366799458394, 8460.788480288042, 8480.74557763268, 8486.278666313432, 8311.376646751396, 12017.09871759604, 12097.879021210027, 12144.878551214375, 12314.0], "value": 8839.99473742996, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1447.34869308811, 1506.1038681984219, 1606.9517914462563, 1750.9387171449002, 1773.9290428382874, 7808.180141085175, 8069.757907262777, 8376.706815261467, 9064.138906803852, 9072.546372681365, 8331.875021874677, 8598.828023439528, 8614.87077693835, 8863.46819190849, 8867.866981995276, 2346.4133966508375, 2395.2694428199393, 2396.0775101585928, 2396.4727759892794, 2402.8798560072014, 2332.4285550040263, 2332.521833024226, 2390.9599324293986, 2392.031227352916, 2398.5322862041908, 2286.805621522164, 2291.46150654596, 2306.423394151462, 2318.5015221727326, 2324.69778928739, 2320.883955802203, 2355.9175428859994, 2358.13927916311, 2366.6213405855065, 2370.8221883358815, 2287.4052746286084, 2300.0799680127916, 2301.6777651128855, 2302.6200676888293, 2312.491251924574, 8556.871646925301, 8803.295736341077, 8809.779755506099, 8816.8677469838, 8826.514541700204, 5047.293378926953, 5047.369078865142, 5202.219667049935, 5215.061288967984, 5222.294990176316, 3203.3913556424436, 3263.1352691536763, 3346.748993825473, 3350.6816852398983, 3488.4418493041244, 1070.637460004925, 1110.972225694356, 1121.7307846116955, 1131.6548452721916, 1144.370596172102, 12583.433745481476, 12652.62042138728, 12710.300933448656, 12731.872681273162, 12769.17000394962, 4628.583427491474, 4691.976540117277, 4870.9269360959615, 4877.341558889575, 4898.461169271377, 10236.385816851012, 10244.692659220234, 10336.224783141295, 10339.121174700234, 10364.637237696645, 5284.7886084556185, 5301.310829592128, 5302.628815982845, 5325.946740532622, 5332.493413125747, 4316.395704601358, 4427.358033085185, 4754.191787396151, 4874.366332376769, 4931.654784165074, 4017.216642754693, 4105.920559580315, 4134.503859536815, 4274.636655884285, 4286.87139385819, 1286.8584455709865, 1300.876416740408, 1301.212766276408, 1308.5420102964076, 1323.1201251168059, 813.5444151275304, 917.3349321741684, 943.6366998705411, 951.743029382063, 993.0913214408735, 5865.296164460292, 5951.672658003765, 6022.939770602238, 6032.939670603326, 6187.81436556904, 410.138708711709, 417.66586730615387, 434.7478462491747, 438.0472472372577, 443.82247101159794, 4075.3886916962692, 4160.0, 4165.8333666653, 4191.455110835572, 4205.747655140702, 10596.841047384296, 10851.403172825412, 10856.131509479223, 10964.616238431616, 10967.396793176293, 10878.836817447745, 10885.510152043176, 10909.618163364403, 10936.343819370863, 10946.835797463045, 7816.452848300678, 7843.137254901956, 7916.920830791619, 7938.761837144895, 7967.9203207967175, 5767.106098554731, 5809.767609295581, 5836.445537673914, 5899.233099697012, 6041.969790151021, 9760.951195244263, 9905.752356191153, 9933.155681766842, 9978.501074946369, 10083.193344532274, 10231.59073637076, 10240.436775977094, 10283.897161028593, 10294.124999375137, 10326.845097323396, 7090.220075791762, 7292.963535182503, 7349.77950661481, 7890.171531989058, 7981.0, 8268.83462330762, 8460.915390846012, 8503.957480212559, 8578.4424012439, 8588.441751286146, 7669.348105411103, 7688.807779805549, 7845.450818442654, 7955.204479551999, 8000.039995200613, 7349.0, 7440.962795185989, 7524.360429363565, 7593.088829340514, 7595.3164215220895, 7003.4747393944635, 7139.286071392819, 7142.607156606437, 7145.321194486515, 7165.605891676008, 5144.897102058013, 5230.320058392384, 5240.554552863049, 5253.921191182212, 5512.173174023928, 5206.297149884868, 5256.921146182887, 5272.578193744568, 5341.439148889311, 5555.250041244381], "value": 4551.603765060293, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [327.77711156413636, 329.19183404741375, 340.6014962493881, 342.15999720685704, 345.314550617025, 5398.8920221595545, 5553.72231388431, 5564.554835613151, 5677.659340439576, 5680.7443665035125, 5291.735413229342, 5429.185622156669, 5452.318460192476, 5467.316585426822, 5476.4249753775775, 4265.786710664462, 4270.615644591986, 4272.444582204309, 4276.203994322392, 4276.23027854986, 4185.393117997904, 4240.469941257343, 4260.360945858115, 4280.443542339492, 4283.357496375537, 4212.810423530948, 4230.323148296273, 4243.6605071594195, 4243.893902652428, 4244.299690551071, 4237.580410562466, 4245.5375881988375, 4274.29474136767, 4275.572442755731, 4301.0, 3651.2697460508007, 3811.6188381161937, 3812.046988252937, 3818.618138186187, 3821.522309711286, 5321.175217841241, 5321.201819727072, 5360.865978350534, 5360.946390536123, 5365.812196573141, 4846.5638092571835, 4875.317455556225, 4891.461939186686, 4895.510448955076, 4906.632002599784, 5548.223248745179, 5708.286464191976, 5715.599908006441, 5728.541716662657, 5815.476607105381, 4133.689973252018, 4145.113973142213, 4154.857414211086, 4166.354290055441, 4170.457840480748, 5953.523718102541, 6059.484943779784, 6071.757129714806, 6074.301455332649, 6077.209962704865, 4102.466679331667, 4222.324428091552, 4227.0, 4229.957700422957, 4232.682548808852, 4222.4933008038615, 4233.983843877509, 4259.936100958488, 4266.850660226939, 4267.871963841089, 4892.412910450768, 4899.755012249373, 4907.263910413467, 4912.631552633567, 4918.754062296871, 5626.240457538262, 5782.421757824184, 5787.884242315215, 5846.269216347957, 5855.0, 1418.6027912184604, 1419.9290035498184, 1447.949321773733, 1451.7386870363225, 1453.5058080252766, 868.6959564152622, 895.3061377432542, 907.732218995398, 911.886014248219, 914.1087439746194, 4880.341153944243, 4927.556519913153, 4948.960718249136, 4964.35463389757, 4967.5162418790605, 5131.076406246837, 5152.510511501401, 5183.922241166386, 5204.76578553966, 5204.9219261711105, 4815.723852775018, 4828.130936431406, 4934.309196712463, 4936.654434189644, 4939.950600494021, 2800.635917330734, 2805.340744924941, 2805.8636252317438, 2813.423248234148, 2822.50606143924, 5372.838814835562, 5405.378381486179, 5409.594280428983, 5446.019716451076, 5446.700431476307, 5025.6482046256415, 5255.921161182585, 5306.0, 5331.600129990266, 5335.759890804923, 5320.467953204648, 5329.227262046981, 5367.490088441592, 5376.978374108907, 5384.515393614515, 5196.402413722471, 5216.765245564035, 5222.451642577626, 5227.0, 5295.313647421982, 5206.921896171636, 5510.0, 5904.881902362014, 5917.378675239038, 5952.226210592596, 6271.498280137669, 6286.811395658137, 6293.811185664437, 6311.747530098744, 6316.431521163117, 4013.337799263206, 4200.432941552851, 4223.577642235752, 4232.534421213602, 4234.322508398642, 5827.125931110368, 5879.764809407576, 5895.351511333664, 5926.555508336805, 5946.613470124428, 5746.885062298647, 5796.652200867961, 5802.94197058024, 5813.738381772915, 5828.154917537018, 5800.912986305125, 5800.941990580209, 5807.186993820784, 5811.4479124483105, 5812.9709351452975, 5656.5757568181725, 5704.686242256716, 5720.513756330759, 5764.36591974874, 5769.9711501442225, 5860.446981549978, 5888.558358123072, 5910.556708246984, 5917.733701983507, 5961.463468287875, 5720.227769251098, 5773.91339129905, 5788.739506722123, 5820.82537523875, 5826.533877289891], "value": 4272.560134674894, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [737.9520331178473, 747.8093086263002, 753.5328096580121, 775.577310365851, 865.5888452984831, 14428.783568246472, 15467.22663866805, 15490.845091549081, 15512.0, 15536.990095643776, 13381.39783709733, 13393.330333483336, 13437.462501499927, 13448.462061517528, 13466.865331346684, 767.5011242692239, 784.6704384158667, 805.6173317674117, 814.1858141858141, 816.5345752920838, 795.6857041468617, 797.8125140591957, 797.8444203380343, 798.2496453333877, 799.1169757418056, 851.6040041380757, 852.6759831264111, 854.2952064546743, 855.6876739989921, 856.3192262151605, 846.4328899637196, 849.2611428057598, 849.6771226933756, 852.0074113657581, 853.0573716043745, 621.9906701399483, 622.4087117238596, 622.7042154976396, 622.7820262907991, 624.2290770897937, 14463.349149288308, 14558.417663293561, 14581.19803410812, 14630.41478340865, 14638.560843174722, 13725.588232353046, 13928.51250206238, 14172.787408188886, 14197.432102715879, 14344.42622295107, 12062.517499300018, 12086.576969806014, 12093.0, 12153.878461215452, 12444.688882777913, 3734.9439758403646, 3801.7434620174345, 3813.1420430402936, 3819.9236015279816, 3965.405189221611, 82340.58829705813, 82446.17553824445, 82730.0, 83064.58467707623, 84471.57764211201, 11006.889931100746, 11059.72350691239, 11084.501197445972, 11098.44507774608, 11396.715082122848, 20558.0, 20567.280145194847, 20633.587328253652, 20642.27752028672, 20686.689699654216, 7750.534967901944, 8070.717524886718, 8227.42408031432, 8365.707200247962, 8406.957965210135, 4646.535346465326, 4931.3096166536, 4948.703077815343, 5019.021290848323, 5162.535371816554, 3482.2861313430685, 3570.8928732137556, 3582.8208589570418, 3609.260101679202, 3628.9455658165148, 538.4104405675779, 549.9835004949858, 559.4852735483365, 565.5447364871236, 570.6034306157264, 705.8976448414951, 725.753243897067, 757.7234309477001, 760.634895250283, 762.8436170585016, 8551.957240213884, 8586.87119693205, 9143.405678630868, 9190.356675032683, 9218.44689318643, 620.1906512001791, 703.6094967293099, 706.2654838967417, 731.8217669552017, 750.5871770526189, 4410.42664453619, 4625.190591646448, 4718.673444542119, 4769.284607308931, 4802.351682522884, 109493.90506094997, 114681.4265928665, 119598.4020079894, 124557.37721311336, 128723.35638321748, 89475.0, 105340.47329763455, 105892.0, 106362.46818765857, 107246.0, 57144.714276429186, 58070.0, 59088.0, 90577.0, 91624.0, 8557.743267701979, 8693.69572065, 8905.777355565904, 8915.032939516625, 8940.73177804667, 50688.23967640415, 51331.0, 52604.47395525996, 53428.0, 53839.46160538345, 71098.0, 77993.61003194947, 80213.59893200497, 81672.0, 83380.16619833966, 10990.725231869268, 11272.380019099028, 11358.204925655125, 11608.419579020847, 11638.941805290919, 11578.652640420802, 12444.502219911103, 13048.804267935799, 13230.735385292433, 13375.264360460269, 12385.19496232742, 12967.805482917953, 13109.737805244033, 13323.800142998056, 13370.465181392636, 12593.93703031479, 12854.357282136043, 12964.416601252778, 13006.609801705965, 13595.11631743973, 11894.643160705193, 12111.212771169845, 12151.210171339188, 12235.632931012084, 12582.496700131893, 9782.461964592016, 10027.699169024942, 10436.217283703905, 10459.424731639832, 10628.734281642712, 9613.0, 10076.84884726715, 10842.457877106272, 11019.779604408028, 11185.217034807485], "value": 7347.715873974615, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1509.1000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 112.0, 111.0, 112.0, 113.0, 111.0, 111.0, 111.0, 111.0, 113.0], "value": 110.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 123.0, 121.0, 164.0, 124.0, 121.0, 121.0, 122.0, 158.0, 120.0], "value": 133.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 164.0, 162.0, 167.0, 173.0, 164.0, 161.0, 161.0, 163.0, 164.0], "value": 165.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 77.0, 118.0, 76.0, 77.0, 78.0, 78.0, 101.0, 77.0], "value": 83.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 85.0, 110.0, 82.0, 84.0, 83.0, 99.0, 82.0, 82.0, 117.0], "value": 90.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 120.0], "value": 117.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 150.0, 147.0, 149.0, 147.0, 147.0, 147.0, 147.0, 147.0, 147.0], "value": 147.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 96.0, 95.0, 96.0, 96.0, 95.0, 95.0, 95.0], "value": 95.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 54.0, 51.0, 51.0, 55.0, 54.0, 54.0, 53.0, 53.0, 54.0], "value": 53.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 70.0, 61.0, 61.0, 61.0, 61.0, 60.0, 60.0, 59.0, 60.0], "value": 61.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 79.0, 81.0, 81.0, 85.0, 79.0, 79.0, 87.0, 83.0], "value": 81.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 136.0, 140.0, 131.0, 124.0, 135.0, 126.0, 144.0, 177.0, 150.0], "value": 139.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 163.0, 167.0, 164.0, 161.0, 162.0, 163.0, 165.0, 171.0, 161.0], "value": 164.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 66.0, 65.0, 63.0, 65.0, 65.0, 71.0, 64.0, 63.0], "value": 65.7, "unit": "score"}]}]} 12:59:34 INFO - Return code: 0 12:59:34 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:59:34 ERROR - # TBPL SUCCESS # 12:59:34 INFO - Running post-action listener: _resource_record_post_action 12:59:34 INFO - [mozharness: 2016-09-29 19:59:34.993439Z] Finished run-tests step (success) 12:59:34 INFO - Running post-run listener: _resource_record_post_run 12:59:35 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 4096; Write bytes: 400125952; Read time: 16; Write time: 226920 12:59:35 INFO - TinderboxPrint: CPU usage
13.4% 12:59:35 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 12:59:35 INFO - TinderboxPrint: I/O write bytes / time
400,125,952 / 226,920 12:59:35 INFO - TinderboxPrint: CPU idle
8,236.3 (86.6%) 12:59:35 INFO - TinderboxPrint: CPU user
1,216.6 (12.8%) 12:59:35 INFO - TinderboxPrint: Swap in / out
0 / 0 12:59:35 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 111775744; Read time: 0; Write time: 78996 12:59:35 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 0; Write bytes: 288350208; Read time: 0; Write time: 147924 12:59:35 INFO - Running post-run listener: _upload_blobber_files 12:59:35 INFO - Blob upload gear active. 12:59:35 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:59:35 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 12:59:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Autoland', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 12:59:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Autoland -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 12:59:36 INFO - (blobuploader) - INFO - Open directory for files ... 12:59:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 12:59:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:59:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:59:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 12:59:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:59:36 INFO - (blobuploader) - INFO - Done attempting. 12:59:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 12:59:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:59:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:59:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 12:59:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:59:37 INFO - (blobuploader) - INFO - Done attempting. 12:59:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:59:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:59:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:59:41 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:59:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:59:41 INFO - (blobuploader) - INFO - Done attempting. 12:59:41 INFO - (blobuploader) - INFO - Iteration through files over. 12:59:41 INFO - Return code: 0 12:59:41 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:59:41 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:59:41 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/42c15a46cd0737c5150511dcb31a4ab1daf8af78b74c5ca6ba2d801e8639a7530eda90af72163d896cbaa009183f1df43fb0d0f23461c770152999e94e1a246a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/44f1bef4689c35aac58c971a32e3ad1504612b79815891a0839e547bb5f3fca5a6e7b38d63c324e07ccfe3981a7ca2dd82ef28283cfc48316ec17d5532f6a6c9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/77227e7c1af3d390648ec8fff7e6af9bf833688467cfd32b6bd66e2867a17b8e141c495f5baac136219b2f98fcf805631b1232672433259d875d7a9c5a278d25"} 12:59:41 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:59:41 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:59:41 INFO - Contents: 12:59:41 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/42c15a46cd0737c5150511dcb31a4ab1daf8af78b74c5ca6ba2d801e8639a7530eda90af72163d896cbaa009183f1df43fb0d0f23461c770152999e94e1a246a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/44f1bef4689c35aac58c971a32e3ad1504612b79815891a0839e547bb5f3fca5a6e7b38d63c324e07ccfe3981a7ca2dd82ef28283cfc48316ec17d5532f6a6c9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/77227e7c1af3d390648ec8fff7e6af9bf833688467cfd32b6bd66e2867a17b8e141c495f5baac136219b2f98fcf805631b1232672433259d875d7a9c5a278d25"} 12:59:41 INFO - Running post-run listener: copy_logs_to_upload_dir 12:59:41 INFO - Copying logs to upload dir... 12:59:41 INFO - mkdir: /builds/slave/test/build/upload/logs 12:59:41 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.730868 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-09-29 12:59:41.424028) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-29 12:59:41.429091) ========= 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=00204705a9daa57ed339a427000001b9-1475177941.865958-565175556 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/42c15a46cd0737c5150511dcb31a4ab1daf8af78b74c5ca6ba2d801e8639a7530eda90af72163d896cbaa009183f1df43fb0d0f23461c770152999e94e1a246a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/44f1bef4689c35aac58c971a32e3ad1504612b79815891a0839e547bb5f3fca5a6e7b38d63c324e07ccfe3981a7ca2dd82ef28283cfc48316ec17d5532f6a6c9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/77227e7c1af3d390648ec8fff7e6af9bf833688467cfd32b6bd66e2867a17b8e141c495f5baac136219b2f98fcf805631b1232672433259d875d7a9c5a278d25"} build_url:https://queue.taskcluster.net/v1/task/bV7VLb_MT62eaQdxqlI60g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011499 build_url: 'https://queue.taskcluster.net/v1/task/bV7VLb_MT62eaQdxqlI60g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/42c15a46cd0737c5150511dcb31a4ab1daf8af78b74c5ca6ba2d801e8639a7530eda90af72163d896cbaa009183f1df43fb0d0f23461c770152999e94e1a246a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/44f1bef4689c35aac58c971a32e3ad1504612b79815891a0839e547bb5f3fca5a6e7b38d63c324e07ccfe3981a7ca2dd82ef28283cfc48316ec17d5532f6a6c9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/77227e7c1af3d390648ec8fff7e6af9bf833688467cfd32b6bd66e2867a17b8e141c495f5baac136219b2f98fcf805631b1232672433259d875d7a9c5a278d25"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-29 12:59:41.455141) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-29 12:59:41.455480) ========= 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=00204705a9daa57ed339a427000001b9-1475177941.865958-565175556 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004387 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-29 12:59:41.539699) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-29 12:59:41.540024) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-29 12:59:41.540343) ========= ========= Total master_lag: 0.18 =========