builder: autoland_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-021 starttime: 1468492196.0 results: success (0) buildid: 20160714020544 builduid: 200501155004462089108747c9c6ff97 revision: cb1812acfcd1ed05706e0bd9405668d11516cfd4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-14 03:29:56.000845) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-14 03:29:56.001289) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-14 03:29:56.001585) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-14 03:29:56.023386) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-14 03:29:56.023850) ========= 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=df17445c3590ff7897617a0e00000225-1468492193.762447-1086351707 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-14 03:29:56-- 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% 16.6M=0.001s 2016-07-14 03:29:56 (16.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.087936 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-14 03:29:56.126621) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-14 03:29:56.127023) ========= 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=df17445c3590ff7897617a0e00000225-1468492193.762447-1086351707 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017743 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-14 03:29:56.177483) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-14 03:29:56.177980) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev cb1812acfcd1ed05706e0bd9405668d11516cfd4 --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 cb1812acfcd1ed05706e0bd9405668d11516cfd4 --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=df17445c3590ff7897617a0e00000225-1468492193.762447-1086351707 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-14 03:29:56,761 truncating revision to first 12 chars 2016-07-14 03:29:56,761 Setting DEBUG logging. 2016-07-14 03:29:56,761 attempt 1/10 2016-07-14 03:29:56,761 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/cb1812acfcd1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-14 03:29:57,086 unpacking tar archive at: autoland-cb1812acfcd1/testing/mozharness/ program finished with exit code 0 elapsedTime=0.664835 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-14 03:29:56.858733) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-14 03:29:56.859041) ========= script_repo_revision: cb1812acfcd1ed05706e0bd9405668d11516cfd4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-14 03:29:56.859485) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-14 03:29:56.859798) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-14 03:29:56.871616) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2016-07-14 03:29:56.872098) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Autoland-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=df17445c3590ff7897617a0e00000225-1468492193.762447-1086351707 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:29:57 INFO - MultiFileLogger online at 20160714 03:29:57 in /builds/slave/test 03:29:57 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO 03:29:57 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:29:57 INFO - {'append_to_log': False, 03:29:57 INFO - 'base_work_dir': '/builds/slave/test', 03:29:57 INFO - 'blob_upload_branch': 'Autoland-Non-PGO', 03:29:57 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:29:57 INFO - 'branch': 'Autoland-Non-PGO', 03:29:57 INFO - 'buildbot_json_path': 'buildprops.json', 03:29:57 INFO - 'config_files': ('talos/linux_config.py',), 03:29:57 INFO - 'default_actions': ('clobber', 03:29:57 INFO - 'read-buildbot-config', 03:29:57 INFO - 'download-and-extract', 03:29:57 INFO - 'populate-webroot', 03:29:57 INFO - 'create-virtualenv', 03:29:57 INFO - 'install', 03:29:57 INFO - 'run-tests'), 03:29:57 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:29:57 INFO - 'download_minidump_stackwalk': True, 03:29:57 INFO - 'download_symbols': 'ondemand', 03:29:57 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:29:57 INFO - 'tooltool.py': '/tools/tooltool.py', 03:29:57 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:29:57 INFO - '/tools/misc-python/virtualenv.py')}, 03:29:57 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:29:57 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:29:57 INFO - 'installer_path': 'installer.exe', 03:29:57 INFO - 'log_level': 'info', 03:29:57 INFO - 'log_name': 'talos', 03:29:57 INFO - 'log_to_console': True, 03:29:57 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:29:57 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:29:57 INFO - 'opt_config_files': (), 03:29:57 INFO - 'pip_index': False, 03:29:57 INFO - 'sps_profile': False, 03:29:57 INFO - 'sps_profile_interval': 0, 03:29:57 INFO - 'suite': 'dromaeojs', 03:29:57 INFO - 'system_bits': '32', 03:29:57 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:29:57 INFO - 'title': 'talos-linux64-ix-021', 03:29:57 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:29:57 INFO - 'use_talos_json': True, 03:29:57 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:29:57 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:29:57 INFO - 'work_dir': 'build'} 03:29:57 INFO - ##### 03:29:57 INFO - ##### Running clobber step. 03:29:57 INFO - ##### 03:29:57 INFO - Running pre-action listener: _resource_record_pre_action 03:29:57 INFO - Running main action method: clobber 03:29:57 INFO - rmtree: /builds/slave/test/build 03:29:57 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:29:58 INFO - Running post-action listener: _resource_record_post_action 03:29:58 INFO - ##### 03:29:58 INFO - ##### Finished clobber step (success) 03:29:58 INFO - ##### 03:29:58 INFO - ##### 03:29:58 INFO - ##### Running read-buildbot-config step. 03:29:58 INFO - ##### 03:29:58 INFO - Running pre-action listener: _resource_record_pre_action 03:29:58 INFO - Running main action method: read_buildbot_config 03:29:58 INFO - Using buildbot properties: 03:29:58 INFO - { 03:29:58 INFO - "project": "", 03:29:58 INFO - "product": "firefox", 03:29:58 INFO - "script_repo_revision": "production", 03:29:58 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs", 03:29:58 INFO - "repository": "", 03:29:58 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland talos dromaeojs", 03:29:58 INFO - "buildid": "20160714020544", 03:29:58 INFO - "pgo_build": "False", 03:29:58 INFO - "basedir": "/builds/slave/test", 03:29:58 INFO - "buildnumber": 42, 03:29:58 INFO - "slavename": "talos-linux64-ix-021", 03:29:58 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 03:29:58 INFO - "platform": "ubuntu64_hw", 03:29:58 INFO - "scheduler": "tests-autoland-linux64-talos", 03:29:58 INFO - "branch": "autoland", 03:29:58 INFO - "repo_path": "integration/autoland", 03:29:58 INFO - "revision": "cb1812acfcd1ed05706e0bd9405668d11516cfd4", 03:29:58 INFO - "stage_platform": "linux64", 03:29:58 INFO - "builduid": "200501155004462089108747c9c6ff97", 03:29:58 INFO - "slavebuilddir": "test" 03:29:58 INFO - } 03:29:58 INFO - Found installer url https://queue.taskcluster.net/v1/task/EpF1zUodTk-tAcL3Hg-05Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 03:29:58 INFO - Running post-action listener: _resource_record_post_action 03:29:58 INFO - ##### 03:29:58 INFO - ##### Finished read-buildbot-config step (success) 03:29:58 INFO - ##### 03:29:58 INFO - ##### 03:29:58 INFO - ##### Running download-and-extract step. 03:29:58 INFO - ##### 03:29:58 INFO - Running pre-action listener: _resource_record_pre_action 03:29:58 INFO - Running main action method: download_and_extract 03:29:58 INFO - mkdir: /builds/slave/test/build/tests 03:29: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:29:58 INFO - https://queue.taskcluster.net/v1/task/EpF1zUodTk-tAcL3Hg-05Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 03:29:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EpF1zUodTk-tAcL3Hg-05Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 03:29:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EpF1zUodTk-tAcL3Hg-05Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 03:29:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EpF1zUodTk-tAcL3Hg-05Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 03:29:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EpF1zUodTk-tAcL3Hg-05Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 03:30:01 INFO - Downloaded 1361 bytes. 03:30:01 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 03:30:01 INFO - Using the following test package requirements: 03:30:01 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 03:30:01 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:30:01 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 03:30:01 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:30:01 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 03:30:01 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:30:01 INFO - u'jsshell-linux-x86_64.zip'], 03:30:01 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:30:01 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 03:30:01 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 03:30:01 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:30:01 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 03:30:01 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:30:01 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 03:30:01 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:30:01 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 03:30:01 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:30:01 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 03:30:01 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:30:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:30:01 INFO - https://queue.taskcluster.net/v1/task/EpF1zUodTk-tAcL3Hg-05Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:30:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EpF1zUodTk-tAcL3Hg-05Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 03:30:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EpF1zUodTk-tAcL3Hg-05Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 03:30:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EpF1zUodTk-tAcL3Hg-05Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 03:30:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EpF1zUodTk-tAcL3Hg-05Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:30:05 INFO - Downloaded 22755958 bytes. 03:30:05 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:30:05 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:30:06 INFO - Return code: 0 03:30:06 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 03:30:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:30:06 INFO - https://queue.taskcluster.net/v1/task/EpF1zUodTk-tAcL3Hg-05Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:30:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EpF1zUodTk-tAcL3Hg-05Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 03:30:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EpF1zUodTk-tAcL3Hg-05Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 03:30:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EpF1zUodTk-tAcL3Hg-05Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 03:30:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EpF1zUodTk-tAcL3Hg-05Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:30:09 INFO - Downloaded 22755958 bytes. 03:30:09 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:30:09 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:30:11 INFO - Return code: 0 03:30:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:30:11 INFO - https://queue.taskcluster.net/v1/task/EpF1zUodTk-tAcL3Hg-05Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:30:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EpF1zUodTk-tAcL3Hg-05Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 03:30:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EpF1zUodTk-tAcL3Hg-05Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 03:30:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EpF1zUodTk-tAcL3Hg-05Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 03:30:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EpF1zUodTk-tAcL3Hg-05Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 03:30:13 INFO - Downloaded 14403317 bytes. 03:30:13 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:30:13 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 03:30:14 INFO - Return code: 0 03:30:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:30:14 INFO - https://queue.taskcluster.net/v1/task/EpF1zUodTk-tAcL3Hg-05Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:30:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EpF1zUodTk-tAcL3Hg-05Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 03:30:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EpF1zUodTk-tAcL3Hg-05Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 03:30:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EpF1zUodTk-tAcL3Hg-05Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 03:30:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/EpF1zUodTk-tAcL3Hg-05Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 03:30:15 INFO - Downloaded 57058107 bytes. 03:30:15 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/EpF1zUodTk-tAcL3Hg-05Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 03:30:15 INFO - mkdir: /builds/slave/test/properties 03:30:15 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:30:15 INFO - Writing to file /builds/slave/test/properties/build_url 03:30:15 INFO - Contents: 03:30:15 INFO - build_url:https://queue.taskcluster.net/v1/task/EpF1zUodTk-tAcL3Hg-05Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 03:30:16 INFO - Running post-action listener: _resource_record_post_action 03:30:16 INFO - Running post-action listener: set_extra_try_arguments 03:30:16 INFO - ##### 03:30:16 INFO - ##### Finished download-and-extract step (success) 03:30:16 INFO - ##### 03:30:16 INFO - ##### 03:30:16 INFO - ##### Running populate-webroot step. 03:30:16 INFO - ##### 03:30:16 INFO - Running pre-action listener: _resource_record_pre_action 03:30:16 INFO - Running main action method: populate_webroot 03:30:16 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:30:16 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:30:16 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:30:16 INFO - '--tppagecycles', 03:30:16 INFO - '7'], 03:30:16 INFO - 'tests': ['tsvgm']}}, 03:30:16 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:30:16 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:30:16 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:30:16 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:30:16 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:30:16 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:30:16 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:30:16 INFO - 'talos_options': ['--disable-e10s'], 03:30:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:30:16 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:30:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:30:16 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:30:16 INFO - 'talos_options': ['--disable-e10s'], 03:30:16 INFO - 'tests': ['damp', 'tps']}, 03:30:16 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:30:16 INFO - 'tests': ['damp', 'tps']}, 03:30:16 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:30:16 INFO - 'tests': ['dromaeo_dom']}, 03:30:16 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:30:16 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:30:16 INFO - 'tests': ['basic_compositor_video']}, 03:30:16 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:30:16 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:30:16 INFO - 'tests': ['a11yr', 03:30:16 INFO - 'ts_paint', 03:30:16 INFO - 'tpaint', 03:30:16 INFO - 'sessionrestore', 03:30:16 INFO - 'sessionrestore_no_auto_restore', 03:30:16 INFO - 'tabpaint']}, 03:30:16 INFO - 'other-e10s': {'tests': ['a11yr', 03:30:16 INFO - 'ts_paint', 03:30:16 INFO - 'tpaint', 03:30:16 INFO - 'sessionrestore', 03:30:16 INFO - 'sessionrestore_no_auto_restore', 03:30:16 INFO - 'tabpaint']}, 03:30:16 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:30:16 INFO - 'ts_paint', 03:30:16 INFO - 'tpaint', 03:30:16 INFO - 'sessionrestore', 03:30:16 INFO - 'sessionrestore_no_auto_restore', 03:30:16 INFO - 'tabpaint']}, 03:30:16 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:30:16 INFO - 'ts_paint', 03:30:16 INFO - 'tpaint', 03:30:16 INFO - 'sessionrestore', 03:30:16 INFO - 'sessionrestore_no_auto_restore', 03:30:16 INFO - 'tabpaint']}, 03:30:16 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:30:16 INFO - 'tests': ['a11yr', 03:30:16 INFO - 'ts_paint', 03:30:16 INFO - 'tpaint', 03:30:16 INFO - 'sessionrestore', 03:30:16 INFO - 'sessionrestore_no_auto_restore', 03:30:16 INFO - 'tabpaint']}, 03:30:16 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:30:16 INFO - 'tests': ['a11yr', 03:30:16 INFO - 'ts_paint', 03:30:16 INFO - 'tpaint', 03:30:16 INFO - 'sessionrestore', 03:30:16 INFO - 'sessionrestore_no_auto_restore', 03:30:16 INFO - 'tabpaint']}, 03:30:16 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:30:16 INFO - 'tests': ['tsvgx', 03:30:16 INFO - 'tsvgr_opacity', 03:30:16 INFO - 'tart', 03:30:16 INFO - 'tscrollx', 03:30:16 INFO - 'cart']}, 03:30:16 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:30:16 INFO - 'tsvgr_opacity', 03:30:16 INFO - 'tart', 03:30:16 INFO - 'tscrollx', 03:30:16 INFO - 'cart']}, 03:30:16 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:30:16 INFO - 'talos_options': ['--disable-e10s'], 03:30:16 INFO - 'tests': ['tp5o']}, 03:30:16 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:30:16 INFO - 'tests': ['tp5o']}, 03:30:16 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:30:16 INFO - 'talos_options': ['--disable-e10s', 03:30:16 INFO - '--xperf_path', 03:30:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:30:16 INFO - 'tests': ['tp5n']}, 03:30:16 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:30:16 INFO - 'talos_options': ['--xperf_path', 03:30:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:30:16 INFO - 'tests': ['tp5n']}}, 03:30:16 INFO - 'talos.zip': {'path': '', 03:30:16 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:30:16 INFO - Running post-action listener: _resource_record_post_action 03:30:16 INFO - ##### 03:30:16 INFO - ##### Finished populate-webroot step (success) 03:30:16 INFO - ##### 03:30:16 INFO - ##### 03:30:16 INFO - ##### Running create-virtualenv step. 03:30:16 INFO - ##### 03:30:16 INFO - Running pre-action listener: _resource_record_pre_action 03:30:16 INFO - Running main action method: create_virtualenv 03:30:16 INFO - Creating virtualenv /builds/slave/test/build/venv 03:30:16 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 03:30:16 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:30:16 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:30:16 INFO - Using real prefix '/usr' 03:30:16 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:30:16 INFO - Installing distribute.............................................................................................................................................................................................done. 03:30:18 INFO - Installing pip.................done. 03:30:18 INFO - Return code: 0 03:30:18 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:30:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:30:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:30:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:30:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:30:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x192f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a928a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bf0180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bee3b0>, '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 0x1bef2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bef740>, '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': 'df17445c3590ff7897617a0e00000225-1468492193.762447-1086351707', '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 03:30:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:30:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:30:18 INFO - Using env: {'DISPLAY': ':0', 03:30:18 INFO - 'HOME': '/home/cltbld', 03:30:18 INFO - 'LANG': 'en_US.UTF-8', 03:30:18 INFO - 'LANGUAGE': 'en_US:en', 03:30:18 INFO - 'LOGNAME': 'cltbld', 03:30:18 INFO - 'MAIL': '/var/mail/cltbld', 03:30:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:30:18 INFO - 'MOZ_NO_REMOTE': '1', 03:30:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:30:18 INFO - 'NO_EM_RESTART': '1', 03:30:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:30:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:30:18 INFO - 'PWD': '/builds/slave/test', 03:30:18 INFO - 'SHELL': '/bin/bash', 03:30:18 INFO - 'SHLVL': '1', 03:30:18 INFO - 'TERM': 'linux', 03:30:18 INFO - 'TMOUT': '86400', 03:30:18 INFO - 'USER': 'cltbld', 03:30:18 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1468492193.762447-1086351707', 03:30:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:30:18 INFO - '_': '/tools/buildbot/bin/python'} 03:30:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:30:19 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 03:30:19 INFO - Cleaning up... 03:30:19 INFO - Return code: 0 03:30:19 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:30:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:30:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:30:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:30:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:30:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x192f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a928a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bf0180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bee3b0>, '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 0x1bef2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bef740>, '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': 'df17445c3590ff7897617a0e00000225-1468492193.762447-1086351707', '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 03:30:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 03:30:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 03:30:19 INFO - Using env: {'DISPLAY': ':0', 03:30:19 INFO - 'HOME': '/home/cltbld', 03:30:19 INFO - 'LANG': 'en_US.UTF-8', 03:30:19 INFO - 'LANGUAGE': 'en_US:en', 03:30:19 INFO - 'LOGNAME': 'cltbld', 03:30:19 INFO - 'MAIL': '/var/mail/cltbld', 03:30:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:30:19 INFO - 'MOZ_NO_REMOTE': '1', 03:30:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:30:19 INFO - 'NO_EM_RESTART': '1', 03:30:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:30:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:30:19 INFO - 'PWD': '/builds/slave/test', 03:30:19 INFO - 'SHELL': '/bin/bash', 03:30:19 INFO - 'SHLVL': '1', 03:30:19 INFO - 'TERM': 'linux', 03:30:19 INFO - 'TMOUT': '86400', 03:30:19 INFO - 'USER': 'cltbld', 03:30:19 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1468492193.762447-1086351707', 03:30:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:30:19 INFO - '_': '/tools/buildbot/bin/python'} 03:30:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:30:19 INFO - Downloading/unpacking psutil>=3.1.1 03:30:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:30:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:30:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:30:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:30:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:30:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:30:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:30:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:30:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:30:21 INFO - Installing collected packages: psutil 03:30:21 INFO - Running setup.py install for psutil 03:30:21 INFO - building 'psutil._psutil_linux' extension 03:30:21 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 03:30:21 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 03:30:21 INFO - building 'psutil._psutil_posix' extension 03:30:21 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 03:30:21 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 03:30:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:30:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:30:21 INFO - Successfully installed psutil 03:30:21 INFO - Cleaning up... 03:30:21 INFO - Return code: 0 03:30:21 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:30: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:30:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:30:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:30:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:30:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x192f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a928a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bf0180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bee3b0>, '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 0x1bef2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bef740>, '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': 'df17445c3590ff7897617a0e00000225-1468492193.762447-1086351707', '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 03:30: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 03:30: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 mozsystemmonitor==0.3 03:30:21 INFO - Using env: {'DISPLAY': ':0', 03:30:21 INFO - 'HOME': '/home/cltbld', 03:30:21 INFO - 'LANG': 'en_US.UTF-8', 03:30:21 INFO - 'LANGUAGE': 'en_US:en', 03:30:21 INFO - 'LOGNAME': 'cltbld', 03:30:21 INFO - 'MAIL': '/var/mail/cltbld', 03:30:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:30:21 INFO - 'MOZ_NO_REMOTE': '1', 03:30:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:30:21 INFO - 'NO_EM_RESTART': '1', 03:30:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:30:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:30:21 INFO - 'PWD': '/builds/slave/test', 03:30:21 INFO - 'SHELL': '/bin/bash', 03:30:21 INFO - 'SHLVL': '1', 03:30:21 INFO - 'TERM': 'linux', 03:30:21 INFO - 'TMOUT': '86400', 03:30:21 INFO - 'USER': 'cltbld', 03:30:21 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1468492193.762447-1086351707', 03:30:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:30:21 INFO - '_': '/tools/buildbot/bin/python'} 03:30:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:30:22 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:30: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 03:30: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 03:30: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 03:30: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 03:30: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 03:30: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 03:30:23 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:30:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:30:23 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:30:23 INFO - Installing collected packages: mozsystemmonitor 03:30:23 INFO - Running setup.py install for mozsystemmonitor 03:30:24 INFO - Successfully installed mozsystemmonitor 03:30:24 INFO - Cleaning up... 03:30:24 INFO - Return code: 0 03:30:24 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:30: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:30:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:30:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:30:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:30:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30: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', '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 0x192f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a928a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bf0180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bee3b0>, '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 0x1bef2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bef740>, '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': 'df17445c3590ff7897617a0e00000225-1468492193.762447-1086351707', '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 03:30: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:30: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 jsonschema==2.5.1 03:30:24 INFO - Using env: {'DISPLAY': ':0', 03:30:24 INFO - 'HOME': '/home/cltbld', 03:30:24 INFO - 'LANG': 'en_US.UTF-8', 03:30:24 INFO - 'LANGUAGE': 'en_US:en', 03:30:24 INFO - 'LOGNAME': 'cltbld', 03:30:24 INFO - 'MAIL': '/var/mail/cltbld', 03:30:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:30:24 INFO - 'MOZ_NO_REMOTE': '1', 03:30:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:30:24 INFO - 'NO_EM_RESTART': '1', 03:30:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:30:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:30:24 INFO - 'PWD': '/builds/slave/test', 03:30:24 INFO - 'SHELL': '/bin/bash', 03:30:24 INFO - 'SHLVL': '1', 03:30:24 INFO - 'TERM': 'linux', 03:30:24 INFO - 'TMOUT': '86400', 03:30:24 INFO - 'USER': 'cltbld', 03:30:24 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1468492193.762447-1086351707', 03:30:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:30:24 INFO - '_': '/tools/buildbot/bin/python'} 03:30:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:30:24 INFO - Downloading/unpacking jsonschema==2.5.1 03:30:24 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 03:30:24 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 03:30:24 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 03:30:24 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 03:30:24 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 03:30:24 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 03:30:26 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:30:26 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:30:26 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 03:30:26 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 03:30:26 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 03:30:26 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 03:30:26 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 03:30:26 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 03:30:26 INFO - Downloading functools32-3.2.3-2.tar.gz 03:30:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:30:26 INFO - warning: no files found matching '*.txt' 03:30:26 INFO - no previously-included directories found matching 'build' 03:30:26 INFO - no previously-included directories found matching 'dist' 03:30:26 INFO - no previously-included directories found matching '.git*' 03:30:26 INFO - Installing collected packages: jsonschema, functools32 03:30:26 INFO - Running setup.py install for functools32 03:30:26 INFO - warning: no files found matching '*.txt' 03:30:26 INFO - no previously-included directories found matching 'build' 03:30:26 INFO - no previously-included directories found matching 'dist' 03:30:26 INFO - no previously-included directories found matching '.git*' 03:30:26 INFO - Successfully installed jsonschema functools32 03:30:26 INFO - Cleaning up... 03:30:26 INFO - Return code: 0 03:30:26 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:30:26 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:30:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:30:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30:26 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:30:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:30:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30:26 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 0x192f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a928a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bf0180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bee3b0>, '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 0x1bef2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bef740>, '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': 'df17445c3590ff7897617a0e00000225-1468492193.762447-1086351707', '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 03:30:26 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 03:30:26 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 03:30:26 INFO - Using env: {'DISPLAY': ':0', 03:30:26 INFO - 'HOME': '/home/cltbld', 03:30:26 INFO - 'LANG': 'en_US.UTF-8', 03:30:26 INFO - 'LANGUAGE': 'en_US:en', 03:30:26 INFO - 'LOGNAME': 'cltbld', 03:30:26 INFO - 'MAIL': '/var/mail/cltbld', 03:30:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:30:26 INFO - 'MOZ_NO_REMOTE': '1', 03:30:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:30:26 INFO - 'NO_EM_RESTART': '1', 03:30:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:30:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:30:26 INFO - 'PWD': '/builds/slave/test', 03:30:26 INFO - 'SHELL': '/bin/bash', 03:30:26 INFO - 'SHLVL': '1', 03:30:26 INFO - 'TERM': 'linux', 03:30:26 INFO - 'TMOUT': '86400', 03:30:26 INFO - 'USER': 'cltbld', 03:30:26 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1468492193.762447-1086351707', 03:30:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:30:26 INFO - '_': '/tools/buildbot/bin/python'} 03:30:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:30:26 INFO - Downloading/unpacking blobuploader==1.2.4 03:30:26 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 03:30:26 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 03:30:26 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 03:30:26 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 03:30:26 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 03:30:26 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 03:30:28 INFO - Downloading blobuploader-1.2.4.tar.gz 03:30:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:30:28 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:30:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:30:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:30:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:30:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:30:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:30:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:30:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:30:29 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:30: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 03:30: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 03:30: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 03:30: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 03:30: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 03:30: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 03:30:29 INFO - Downloading docopt-0.6.1.tar.gz 03:30:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:30:29 INFO - Installing collected packages: blobuploader, requests, docopt 03:30:29 INFO - Running setup.py install for blobuploader 03:30:29 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:30:29 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:30:29 INFO - Running setup.py install for requests 03:30:30 INFO - Running setup.py install for docopt 03:30:30 INFO - Successfully installed blobuploader requests docopt 03:30:30 INFO - Cleaning up... 03:30:30 INFO - Return code: 0 03:30:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:30: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:30:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:30:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:30:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:30:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30:30 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 0x192f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a928a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bf0180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bee3b0>, '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 0x1bef2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bef740>, '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': 'df17445c3590ff7897617a0e00000225-1468492193.762447-1086351707', '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 03:30:30 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 03:30:30 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 03:30:30 INFO - Using env: {'DISPLAY': ':0', 03:30:30 INFO - 'HOME': '/home/cltbld', 03:30:30 INFO - 'LANG': 'en_US.UTF-8', 03:30:30 INFO - 'LANGUAGE': 'en_US:en', 03:30:30 INFO - 'LOGNAME': 'cltbld', 03:30:30 INFO - 'MAIL': '/var/mail/cltbld', 03:30:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:30:30 INFO - 'MOZ_NO_REMOTE': '1', 03:30:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:30:30 INFO - 'NO_EM_RESTART': '1', 03:30:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:30:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:30:30 INFO - 'PWD': '/builds/slave/test', 03:30:30 INFO - 'SHELL': '/bin/bash', 03:30:30 INFO - 'SHLVL': '1', 03:30:30 INFO - 'TERM': 'linux', 03:30:30 INFO - 'TMOUT': '86400', 03:30:30 INFO - 'USER': 'cltbld', 03:30:30 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1468492193.762447-1086351707', 03:30:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:30:30 INFO - '_': '/tools/buildbot/bin/python'} 03:30:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:30:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:30:30 INFO - Running setup.py (path:/tmp/pip-7i2GQd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:30:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:30:30 INFO - Running setup.py (path:/tmp/pip-19ZTOn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:30:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:30:30 INFO - Running setup.py (path:/tmp/pip-7dxCuO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:30:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:30:30 INFO - Running setup.py (path:/tmp/pip-WDy_2K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:30:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:30:30 INFO - Running setup.py (path:/tmp/pip-pp0d_V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:30:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:30:30 INFO - Running setup.py (path:/tmp/pip-uREoAv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:30:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:30:30 INFO - Running setup.py (path:/tmp/pip-DQOEyO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:30:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:30:31 INFO - Running setup.py (path:/tmp/pip-vmHuly-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:30:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:30:31 INFO - Running setup.py (path:/tmp/pip-J3bf0Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:30:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:30:31 INFO - Running setup.py (path:/tmp/pip-z1Zn02-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:30:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:30:31 INFO - Running setup.py (path:/tmp/pip-lW0PGm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:30:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:30:31 INFO - Running setup.py (path:/tmp/pip-SzSKN3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:30:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:30:31 INFO - Running setup.py (path:/tmp/pip-1OFE6a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:30:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:30:31 INFO - Running setup.py (path:/tmp/pip-Ps6ken-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:30:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:30:31 INFO - Running setup.py (path:/tmp/pip-bnhZAp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:30:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:30:31 INFO - Running setup.py (path:/tmp/pip-ATJZsp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:30:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:30:31 INFO - Running setup.py (path:/tmp/pip-yn0ROY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:30:31 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:30:31 INFO - Running setup.py install for manifestparser 03:30:31 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:30:31 INFO - Running setup.py install for mozcrash 03:30:31 INFO - Running setup.py install for mozdebug 03:30:32 INFO - Running setup.py install for mozdevice 03:30:32 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:30:32 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:30:32 INFO - Running setup.py install for mozfile 03:30:32 INFO - Running setup.py install for mozhttpd 03:30:32 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:30:32 INFO - Running setup.py install for mozinfo 03:30:32 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:30:32 INFO - Running setup.py install for mozInstall 03:30:32 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:30:32 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:30:32 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:30:32 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:30:32 INFO - Running setup.py install for mozleak 03:30:32 INFO - Running setup.py install for mozlog 03:30:32 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:30:32 INFO - Running setup.py install for moznetwork 03:30:32 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:30:32 INFO - Running setup.py install for mozprocess 03:30:32 INFO - Running setup.py install for mozprofile 03:30:33 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:30:33 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:30:33 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:30:33 INFO - Running setup.py install for mozrunner 03:30:33 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:30:33 INFO - Running setup.py install for mozscreenshot 03:30:33 INFO - Running setup.py install for moztest 03:30:33 INFO - Running setup.py install for mozversion 03:30:33 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:30:33 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:30:33 INFO - Cleaning up... 03:30:33 INFO - Return code: 0 03:30:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:30: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:30:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:30:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:30:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:30:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30:33 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 0x192f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a928a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bf0180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bee3b0>, '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 0x1bef2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bef740>, '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': 'df17445c3590ff7897617a0e00000225-1468492193.762447-1086351707', '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 03:30:33 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 03:30:33 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 03:30:33 INFO - Using env: {'DISPLAY': ':0', 03:30:33 INFO - 'HOME': '/home/cltbld', 03:30:33 INFO - 'LANG': 'en_US.UTF-8', 03:30:33 INFO - 'LANGUAGE': 'en_US:en', 03:30:33 INFO - 'LOGNAME': 'cltbld', 03:30:33 INFO - 'MAIL': '/var/mail/cltbld', 03:30:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:30:33 INFO - 'MOZ_NO_REMOTE': '1', 03:30:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:30:33 INFO - 'NO_EM_RESTART': '1', 03:30:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:30:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:30:33 INFO - 'PWD': '/builds/slave/test', 03:30:33 INFO - 'SHELL': '/bin/bash', 03:30:33 INFO - 'SHLVL': '1', 03:30:33 INFO - 'TERM': 'linux', 03:30:33 INFO - 'TMOUT': '86400', 03:30:33 INFO - 'USER': 'cltbld', 03:30:33 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1468492193.762447-1086351707', 03:30:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:30:33 INFO - '_': '/tools/buildbot/bin/python'} 03:30:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:30:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:30:33 INFO - Running setup.py (path:/tmp/pip-8OBv2m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:30:33 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)) 03:30:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:30:33 INFO - Running setup.py (path:/tmp/pip-262yi6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:30:33 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)) 03:30:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:30:33 INFO - Running setup.py (path:/tmp/pip-HOOwWq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:30:33 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)) 03:30:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:30:33 INFO - Running setup.py (path:/tmp/pip-HaDVhJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:30:34 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)) 03:30:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:30:34 INFO - Running setup.py (path:/tmp/pip-0uKbHy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:30:34 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)) 03:30:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:30:34 INFO - Running setup.py (path:/tmp/pip-rRjNy4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:30:34 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)) 03:30:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:30:34 INFO - Running setup.py (path:/tmp/pip-IUddZZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:30:34 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)) 03:30:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:30:34 INFO - Running setup.py (path:/tmp/pip-fvAA00-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:30:34 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)) 03:30:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:30:34 INFO - Running setup.py (path:/tmp/pip-yL1uCZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:30:34 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)) 03:30:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:30:34 INFO - Running setup.py (path:/tmp/pip-zQFl7d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:30:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 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)) 03:30:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:30:34 INFO - Running setup.py (path:/tmp/pip-AGyxT_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:30:34 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)) 03:30:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:30:34 INFO - Running setup.py (path:/tmp/pip-1iZf1U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:30:34 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)) 03:30:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:30:34 INFO - Running setup.py (path:/tmp/pip-xYp0_A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:30:34 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)) 03:30:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:30:34 INFO - Running setup.py (path:/tmp/pip-yTSLSe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:30:34 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)) 03:30:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:30:34 INFO - Running setup.py (path:/tmp/pip-SYUCc3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:30:34 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)) 03:30:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:30:34 INFO - Running setup.py (path:/tmp/pip-pLWdMA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:30:34 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)) 03:30:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:30:34 INFO - Running setup.py (path:/tmp/pip-AFwJU2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:30:34 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)) 03:30:34 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)) 03:30:34 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)) 03:30:34 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)) 03:30:34 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)) 03:30:34 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)) 03:30:34 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:30:34 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 03:30:34 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 03:30:34 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 03:30:34 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 03:30:34 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 03:30:34 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 03:30:36 INFO - Downloading blessings-1.6.tar.gz 03:30:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:30:36 INFO - Installing collected packages: blessings 03:30:36 INFO - Running setup.py install for blessings 03:30:37 INFO - Successfully installed blessings 03:30:37 INFO - Cleaning up... 03:30:37 INFO - Return code: 0 03:30:37 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:30:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:30:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:30:37 INFO - Reading from file tmpfile_stdout 03:30:37 INFO - Current package versions: 03:30:37 INFO - argparse == 1.2.1 03:30:37 INFO - blessings == 1.6 03:30:37 INFO - blobuploader == 1.2.4 03:30:37 INFO - docopt == 0.6.1 03:30:37 INFO - functools32 == 3.2.3-2 03:30:37 INFO - jsonschema == 2.5.1 03:30:37 INFO - manifestparser == 1.1 03:30:37 INFO - mozInstall == 1.12 03:30:37 INFO - mozcrash == 0.17 03:30:37 INFO - mozdebug == 0.1 03:30:37 INFO - mozdevice == 0.48 03:30:37 INFO - mozfile == 1.2 03:30:37 INFO - mozhttpd == 0.7 03:30:37 INFO - mozinfo == 0.9 03:30:37 INFO - mozleak == 0.1 03:30:37 INFO - mozlog == 3.2 03:30:37 INFO - moznetwork == 0.27 03:30:37 INFO - mozprocess == 0.23 03:30:37 INFO - mozprofile == 0.28 03:30:37 INFO - mozrunner == 6.12 03:30:37 INFO - mozscreenshot == 0.1 03:30:37 INFO - mozsystemmonitor == 0.3 03:30:37 INFO - moztest == 0.7 03:30:37 INFO - mozversion == 1.4 03:30:37 INFO - psutil == 3.1.1 03:30:37 INFO - requests == 1.2.3 03:30:37 INFO - wsgiref == 0.1.2 03:30:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:30:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:30:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:30:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:30:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:30:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30:37 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 0x192f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a928a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bf0180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bee3b0>, '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 0x1bef2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bef740>, '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': 'df17445c3590ff7897617a0e00000225-1468492193.762447-1086351707', '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 03:30:37 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 03:30:37 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 03:30:37 INFO - Using env: {'DISPLAY': ':0', 03:30:37 INFO - 'HOME': '/home/cltbld', 03:30:37 INFO - 'LANG': 'en_US.UTF-8', 03:30:37 INFO - 'LANGUAGE': 'en_US:en', 03:30:37 INFO - 'LOGNAME': 'cltbld', 03:30:37 INFO - 'MAIL': '/var/mail/cltbld', 03:30:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:30:37 INFO - 'MOZ_NO_REMOTE': '1', 03:30:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:30:37 INFO - 'NO_EM_RESTART': '1', 03:30:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:30:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:30:37 INFO - 'PWD': '/builds/slave/test', 03:30:37 INFO - 'SHELL': '/bin/bash', 03:30:37 INFO - 'SHLVL': '1', 03:30:37 INFO - 'TERM': 'linux', 03:30:37 INFO - 'TMOUT': '86400', 03:30:37 INFO - 'USER': 'cltbld', 03:30:37 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1468492193.762447-1086351707', 03:30:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:30:37 INFO - '_': '/tools/buildbot/bin/python'} 03:30:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:30:37 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)) 03:30:37 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)) 03:30:37 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)) 03:30:37 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)) 03:30:37 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)) 03:30:37 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)) 03:30:37 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)) 03:30:37 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)) 03:30:37 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)) 03:30:37 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)) 03:30:37 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)) 03:30:37 INFO - Cleaning up... 03:30:37 INFO - Return code: 0 03:30:37 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:30:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:30:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:30:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:30:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:30:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30:37 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 0x192f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a928a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bf0180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bee3b0>, '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 0x1bef2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bef740>, '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': 'df17445c3590ff7897617a0e00000225-1468492193.762447-1086351707', '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 03:30:37 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 03:30:37 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 03:30:37 INFO - Using env: {'DISPLAY': ':0', 03:30:37 INFO - 'HOME': '/home/cltbld', 03:30:37 INFO - 'LANG': 'en_US.UTF-8', 03:30:37 INFO - 'LANGUAGE': 'en_US:en', 03:30:37 INFO - 'LOGNAME': 'cltbld', 03:30:37 INFO - 'MAIL': '/var/mail/cltbld', 03:30:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:30:37 INFO - 'MOZ_NO_REMOTE': '1', 03:30:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:30:37 INFO - 'NO_EM_RESTART': '1', 03:30:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:30:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:30:37 INFO - 'PWD': '/builds/slave/test', 03:30:37 INFO - 'SHELL': '/bin/bash', 03:30:37 INFO - 'SHLVL': '1', 03:30:37 INFO - 'TERM': 'linux', 03:30:37 INFO - 'TMOUT': '86400', 03:30:37 INFO - 'USER': 'cltbld', 03:30:37 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1468492193.762447-1086351707', 03:30:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:30:37 INFO - '_': '/tools/buildbot/bin/python'} 03:30:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:30:37 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:30:37 INFO - Cleaning up... 03:30:37 INFO - Return code: 0 03:30:37 INFO - Running post-action listener: _resource_record_post_action 03:30:37 INFO - Running post-action listener: _start_resource_monitoring 03:30:37 INFO - Starting resource monitoring. 03:30:37 INFO - ##### 03:30:37 INFO - ##### Finished create-virtualenv step (success) 03:30:37 INFO - ##### 03:30:37 INFO - ##### 03:30:37 INFO - ##### Running install step. 03:30:37 INFO - ##### 03:30:37 INFO - Running pre-action listener: _resource_record_pre_action 03:30:37 INFO - Running main action method: install 03:30:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:30:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:30:38 INFO - Reading from file tmpfile_stdout 03:30:38 INFO - Detecting whether we're running mozinstall >=1.0... 03:30:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:30:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:30:38 INFO - Reading from file tmpfile_stdout 03:30:38 INFO - Output received: 03:30:38 INFO - Usage: mozinstall [options] installer 03:30:38 INFO - Options: 03:30:38 INFO - -h, --help show this help message and exit 03:30:38 INFO - -d DEST, --destination=DEST 03:30:38 INFO - Directory to install application into. [default: 03:30:38 INFO - "/builds/slave/test"] 03:30:38 INFO - --app=APP Application being installed. [default: firefox] 03:30:38 INFO - mkdir: /builds/slave/test/build/application 03:30:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 03:30:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 03:30:55 INFO - Reading from file tmpfile_stdout 03:30:55 INFO - Output received: 03:30:55 INFO - /builds/slave/test/build/application/firefox/firefox 03:30:55 INFO - Running post-action listener: _resource_record_post_action 03:30:55 INFO - ##### 03:30:55 INFO - ##### Finished install step (success) 03:30:55 INFO - ##### 03:30:55 INFO - ##### 03:30:55 INFO - ##### Running run-tests step. 03:30:55 INFO - ##### 03:30:55 INFO - Running pre-action listener: _resource_record_pre_action 03:30:55 INFO - Running main action method: run_tests 03:30:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:30:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:30:55 INFO - Python 2.7.3 03:30:55 INFO - Return code: 0 03:30:55 INFO - grabbing minidump binary from tooltool 03:30:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:30:55 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 0x1bee3b0>, '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 0x1bef2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bef740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:30:55 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 03:30:55 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 03:30:55 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 03:30:55 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:30:55 INFO - Return code: 0 03:30:55 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:30:55 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:30:55 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:30:55 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:30:55 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:30:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EpF1zUodTk-tAcL3Hg-05Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 03:30:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/EpF1zUodTk-tAcL3Hg-05Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-021 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 03:30:55 INFO - Using env: {'DISPLAY': ':0', 03:30:55 INFO - 'HOME': '/home/cltbld', 03:30:55 INFO - 'LANG': 'en_US.UTF-8', 03:30:55 INFO - 'LANGUAGE': 'en_US:en', 03:30:55 INFO - 'LOGNAME': 'cltbld', 03:30:55 INFO - 'MAIL': '/var/mail/cltbld', 03:30:55 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:30:55 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:30:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:30:55 INFO - 'MOZ_NO_REMOTE': '1', 03:30:55 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:30:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:30:55 INFO - 'NO_EM_RESTART': '1', 03:30:55 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:30:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:30:55 INFO - 'PWD': '/builds/slave/test', 03:30:55 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:30:55 INFO - 'SHELL': '/bin/bash', 03:30:55 INFO - 'SHLVL': '1', 03:30:55 INFO - 'TERM': 'linux', 03:30:55 INFO - 'TMOUT': '86400', 03:30:55 INFO - 'USER': 'cltbld', 03:30:55 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1468492193.762447-1086351707', 03:30:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:30:55 INFO - '_': '/tools/buildbot/bin/python'} 03:30:55 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EpF1zUodTk-tAcL3Hg-05Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 03:30:55 INFO - mozversion application_buildid: 20160714020544 03:30:55 INFO - mozversion application_changeset: cb1812acfcd1ed05706e0bd9405668d11516cfd4 03:30:55 INFO - mozversion application_display_name: Nightly 03:30:55 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:30:55 INFO - mozversion application_name: Firefox 03:30:55 INFO - mozversion application_remotingname: firefox 03:30:55 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 03:30:55 INFO - mozversion application_vendor: Mozilla 03:30:55 INFO - mozversion application_version: 50.0a1 03:30:55 INFO - mozversion platform_buildid: 20160714020544 03:30:55 INFO - mozversion platform_changeset: cb1812acfcd1ed05706e0bd9405668d11516cfd4 03:30:55 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 03:30:55 INFO - mozversion platform_version: 50.0a1 03:30:55 INFO - using testdate: 1468492255 03:30:55 INFO - actual date: 1468492255 03:30:55 INFO - starting webserver on 'localhost:55536' 03:30:55 INFO - SUITE-START | Running 2 tests 03:30:55 INFO - TEST-START | dromaeo_css 03:30:55 INFO - operating with platform_type : linux_ 03:30:55 INFO - Initialising browser for dromaeo_css test... 03:30:55 INFO - TEST-INFO | started process 15959 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppQtKtE/profile http://localhost:55536/getInfo.html) 03:31:00 INFO - PROCESS | 15959 | __metrics Screen width/height:1600/1200 03:31:00 INFO - PROCESS | 15959 | colorDepth:24 03:31:00 INFO - PROCESS | 15959 | Browser inner width/height: 1024/697 03:31:00 INFO - PROCESS | 15959 | __metrics 03:31:02 INFO - PROCESS | 15959 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 03:31:02 INFO - PROCESS | 15959 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:31:03 INFO - TEST-INFO | 15959: exit 0 03:31:03 INFO - Browser initialized. 03:31:03 INFO - Running cycle 1/1 for dromaeo_css test... 03:31:03 INFO - TEST-INFO | started process 16041 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppQtKtE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:31:15 INFO - PROCESS | 16041 | RSS: Main: 159408128 03:31:15 INFO - PROCESS | 16041 | 03:32:06 INFO - PROCESS | 16041 | 1468492326362 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] 03:34:19 INFO - PROCESS | 16041 | Cycle 1(1): loaded http://localhost:55536/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55536/tests/dromaeo/cssquery-ext.html) 03:34:20 INFO - PROCESS | 16041 | RSS: Main: 268681216 03:34:20 INFO - PROCESS | 16041 | 03:37:23 INFO - PROCESS | 16041 | Cycle 1(1): loaded http://localhost:55536/tests/dromaeo/cssquery-ext.html (next: http://localhost:55536/tests/dromaeo/cssquery-jquery.html) 03:37:23 INFO - PROCESS | 16041 | RSS: Main: 238854144 03:37:23 INFO - PROCESS | 16041 | 03:40:26 INFO - PROCESS | 16041 | Cycle 1(1): loaded http://localhost:55536/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55536/tests/dromaeo/cssquery-mootools.html) 03:40:26 INFO - PROCESS | 16041 | RSS: Main: 240652288 03:40:26 INFO - PROCESS | 16041 | 03:43:28 INFO - PROCESS | 16041 | Cycle 1(1): loaded http://localhost:55536/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55536/tests/dromaeo/cssquery-prototype.html) 03:43:29 INFO - PROCESS | 16041 | RSS: Main: 234352640 03:43:29 INFO - PROCESS | 16041 | 03:46:32 INFO - PROCESS | 16041 | Cycle 1(1): loaded http://localhost:55536/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55536/tests/dromaeo/cssquery-yui.html) 03:46:33 INFO - PROCESS | 16041 | RSS: Main: 228384768 03:46:33 INFO - PROCESS | 16041 | 03:49:35 INFO - PROCESS | 16041 | Cycle 1(1): loaded http://localhost:55536/tests/dromaeo/cssquery-yui.html (next: http://localhost:55536/tests/dromaeo/cssquery-dojo.html) 03:49:36 INFO - PROCESS | 16041 | RSS: Main: 279285760 03:49:36 INFO - PROCESS | 16041 | 03:49:36 INFO - PROCESS | 16041 | __start_tp_report 03:49:36 INFO - PROCESS | 16041 | _x_x_mozilla_page_load 03:49:36 INFO - PROCESS | 16041 | _x_x_mozilla_page_load_details 03:49:36 INFO - PROCESS | 16041 | |i|pagename|runs| 03:49:36 INFO - PROCESS | 16041 | |0;dojo.html;2570.2674737699754;2594.5589249827526;2621.6591843060405;2630.9736902630966;2637.89448422063;4422.11557688462;4470.150671372437;4552.817887284509;4582.725036497808;4595.195840727876;4582.885427864305;4589.609883159936;4633.096546173498;4648.511906249837;4714.010057887839;4022.839086436539;4207.431996680455;4264.808083636244;4315.115401342718;4361.803718832644;4266.743995360288;4322.913541729164;4327.935080973788;4362.367456718774;4384.473863136428;4153.480814898137;4204.936925946114;4218.936715949232;4257.106007738379;4262.296721041024;4253.255680255943;4256.87229383119;4262.595053469915;4315.3742707307265;4352;4267.253230684618;4274.380214868826;4297.484301883794;4321.6326612238;4325.178216138924;4466.263066594008;4566.1780879441685;4628.976855115737;4698.647601429906;4699.577038066591;4987.576056035241;4999.650024498286;5006.023825354057;5006.5744411725045;5007.674501157449;4988.451270360258;5023.874403139951;5040.294358789773;5052.545270925634;5052.797888084472;4491.932621010687;4601.33280674307;4657.580817726353;4664.370310008173;4695.976520117378;5072.721000345016;5111.514406131411;5146.922796158061;5148.922766158511;5149.176131818891;4906.092372911023;4935.901281974412;4949.257611358253;4953.7275449849885;4953.801847926043;4760.214564596872;4901.313816065754;4961.925571116436;4964.60283177345;5021.774020169101;4911.9754401227765;4925.679830810986;4928.408590969107;4931.211006239057;4967.627427942919;4877.3903262092235;4893.09477746618;4896.6572339935865;4899.902001959941;4930.038642464685;4065.2276067547073;4105.794710264475;4111.958880411157;4139.855105071308;4235.788210589458;3649.3613617617343;3651.3610118229735;3652.3790955537625;3677.3013127506224;3725.832337544817;4252.170826688766;4263;4265.189613973397;4306.354046892991;4306.418633484503;4883.951160488421;4892.510748925079;4960.751962401865;4964.702117872939;5004.4995500450395;4254.085371645111;4259.467566554181;4280.59334363235;4314.978425107917;4318.848840290575;4260.211860805761;4265.53079161292;4271.807768650418;4277.8288868444915;4319.114581510783;4489.775511224491;4583.472900616339;4637.53624637547;4641.582257596765;4694.835680751157;4951.5048495150195;4967.900641987212;4974.303597496426;4977.377827771528;5013.498650134958;4631.814727411001;4655.743934083658;4659.254519276899;4683.297505374221;4717.693349932243;4746.264329029006;4823.589994850477;4830.661853670209;4869.561739443467;4905.583025442877;4958.082754690394;4964.453910069961;4974.37820272466;4978.1288274552535;5022.54797068251;4804.5195480451675;4813.807447702193;4815.759212039314;4818.903621927612;4861.416630004422;4630.72215667061;4797.928031079467;4822.565969062801;4833.709977401367;4866.732329721899;4719.905601888012;4748.0503899220985;4758.666893317573;4806.735629540409;4814.5907597853175;4692.366530518473;4835.564799168092;4840.782164802522;4843.733594652187;4895.510448955076;4738.668293219442;4782.593479554277;4790.592799611933;4791.856244312677;4805.038992201504 03:49:36 INFO - PROCESS | 16041 | |1;ext.html;552.9625672458715;576.4667682393786;582.5834528312258;590.8227531740482;600.9933361619287;26873.865630671844;27356;29817.25456863574;30075.699243007562;30230.54654180189;41537.58462415375;42496.57503424965;42680.78659606697;46391.53608463914;46784.76607616957;7939.285464308196;8082.353411727077;8090.150534193913;8097.919020809775;8098.109207987117;7904.565248911307;7986.880196797053;7987.480813747117;7991.32073773727;7992.240737129963;8001.23988221121;8031.4377993540475;8057.435979481439;8066.959665201666;8070.475419097769;7895.407844411663;7966.123726390092;7968.402369822286;7975.96012019942;7981.241782030698;7897.17079706634;7941.086775020889;7965.6017199139815;7965.64154613038;7968.282854543061;38458.42312365317;38631.42052869181;38703;38773.41839872404;38785.80607096946;3113.984430077835;3121.438141134595;3153;3255.0161554110587;3687.6865466435383;30476.085717428512;30555.847220763753;30977.845110774302;31145.377092458024;32109;2960.467115919134;2971.1829246957045;3008.127642983532;3033.8331391773445;3059.37282857016;247471;248506;248575;248766;248776;32515.18712032218;33428;54043.72978135084;54204;54409.45590544123;33954.49068263978;33969.830150849084;34084.488732668535;34109.48835767466;34264.14339641529;11956.880431195577;11960.282383057045;11966.102542309362;11970.58102966392;11977.101717371232;10595.894041059644;10632;10632.681019569425;10650.946745266225;10659.040686338267;7887.092984306763;7891.092524359658;7897.644605992629;7903.84192316162;7972.246105856702;3058.9541156882665;3059.541068839692;3072.400881828022;3078.7690923180853;3106.409782141386;852.6205838401976;899.8920129584492;944.4946953379908;949.1931857920712;998.3660375661507;28072.43855122927;28295.434091318057;28594;28856;29106.854465727534;764.3693952489108;920.2545937790411;921.7695576105973;940.9388389754644;956.583886009588;14311.928440357731;14817.925910370379;14819.40722371093;15060.623484412758;15119.924400378148;398485;403141;405125;405264;405638;48110;48781;48805;48840.511594883596;48907;1070.0797314309686;1135.3585224348217;1166.3177041430688;1206.3365149168098;1213.872543382932;28714;29886.85056574703;30043;30470.085897423112;30528;37952;38081.61918380781;38141.618583813804;38225;38265.80867095647;315803;316440;317001;318769;528351;25448.363790905376;26153.215403537924;26264;27398;27438.725612743616;42836.78581607072;43553.34669980016;43716.781416092716;44284.77857610691;44424.33363499615;37369.25261494701;37450.8127459361;37565.248695026494;38067;38667.22665546617;35892.8205358982;37393.58218729509;37411.812940935124;38141;38378;36286.09284767902;36450.27099457943;36958.8152059238;37050;37448.251034979694;33186.33627327488;33663.495047573815;33843.830780845936;34053;34565.65434345624;25281.62077568801;25609.743902560735;25758.484830302914;26346.34134146585;26392.472150557267 03:49:36 INFO - PROCESS | 16041 | |2;jquery.html;345.721694036301;364.1969457346551;365.0945654776155;366.8899330200939;377.3603741657891;13228;16513.58716032098;16851.41020064298;17771.55571110723;18661.16024778885;16720.331186752544;16786.916065419686;16854.662906741858;17143.828561714377;17163.74254386182;4422.933655995163;5035.219540971137;5239.371275446952;5250.264962905197;5254.973725131369;5167.612429067835;5202.557782588466;5210.895782084356;5220.373555173365;5227.3465816772905;5189.325387699594;5277.445868183843;5574.10814269717;5589.04986152353;5650.039493286151;5394.1908713692865;5557.110862262019;5561.332640083176;5574.052411090104;5576.609637325369;5375.462453754632;5384.6769193848495;5393.352797664305;5411.512963833274;5414.133738601844;12888.484460621565;13095.869041309561;14770;21557.461063473384;21586.244481443075;1820.4265656318216;1869.1309437815971;1904.9047547622702;1916.57835276239;1954.8631595788302;9526.952365238129;9880.35777674456;10027.298089133763;11533.077353811675;12670.429830657642;1716.682413753447;1719.3380548488797;1755.0785837435321;1845.427917345627;1858.1638262781803;67299;73034.26965730327;73039;73189.26810731877;74287.62856185739;9113.407628504126;9633.32566720337;10121.949390253149;10323.638672646572;10475.94762026185;13029.804552931713;13942.233177175352;13942.512012079529;14369.209693466959;14381.352839122264;7276.199618042011;7478.476506644592;7566.697332106764;7579.1284002340435;7623.123340815766;6193.566450348432;6529.347065293433;7085.681144348517;7224.711011559584;7307.561546307238;3672.5042119313553;3842.615738426191;3935.822887970048;3941.7240793144206;4003.179348233605;1794.1388133695898;1812.8216659171644;1849.694800357926;1900.1354383755358;1904.4578679848385;775.6974779835869;850.2305413600701;859.1880672764178;902.0798785239019;903.746950853762;16595.004299742053;16723.49829505117;17400.5649858752;17655.55861103457;17873.553161171076;805.7582725182422;827.6730691376872;856.961436735336;880.4541184465544;882.4264228251559;9519.428834269966;9599;9721.270904682176;9780.573653860642;10028.749281268027;362227;365015;369291;369870;370564;79587;82090;82999;83162.16837831665;83319.58340208381;898.9505577193187;899.5187574647663;919.1084647891535;921.953902304882;924.0343840686498;14981.925090374478;15323.61690957735;15337;15510.379584816481;15741.685166296838;38161.6183838158;38589;38657.42013869851;39206.41190382204;39258;48791.5120848787;51945.740271298404;52571;52581.211281831565;52667;5358.249845021622;6220.782272620437;7205.495615306878;7617.69529218825;8073.192680732115;11454.312741235219;12186.451609677762;12271.141020128505;12351.75296494083;12473.93763031179;10471.68584942453;10512.26414151002;10620.628278010232;10876.836847447137;10896.564137434414;10047.447390393598;10285.794284114425;10467.319624224401;10579.62971296001;10595.523201455799;7540.660670269741;10694.983976522219;10735.89264107349;10890.673279801618;10985.780284394426;7627.313541781266;7732.420068494773;7806.92193078062;7966.800829979065;8112.75661730149;8665.306775458075;9936.20510359184;9946.055124763136;10079.748006299902;10751.516181771683 03:49:36 INFO - PROCESS | 16041 | |3;mootools.html;1357.402742793171;1434.4835859090729;1496.5809573319475;1691.2896583434956;1718.1065845760204;7549.584772837492;8066.516009039462;8138.348932085434;8148.185181481849;8153.551554664498;6918.135233095863;7129.89305160423;7529.84940301195;7841.411894107936;7994.520328780262;2137.0490131891315;2160.924367647133;2166.4042388343255;2168.1977668262766;2170.283806343911;2059.9176032958662;2105.3368189020484;2118.4386137673528;2119.8410119241044;2121.16214095433;1802.0269054710507;1865.8880467171946;1867.9719804202948;1876.5496280892555;2084.3121769815925;2117.0579092303933;2135.231316725977;2135.7543882453406;2141.1863491873146;2144.281665642012;2074.9377518674464;2082.968755468654;2100.537881666031;2142.4001279641725;2145.4743587820926;6898.551594146415;7639.395726897358;7886.842263154762;8144.470609410369;8179.631916563769;4443;4565.977170114128;4587.082583483317;4588.24293991491;4590.242609969351;2663.946721065568;2735.0564055401055;2778.333200031998;2779.7915156363356;2781.1656503049207;808.0505406147753;817.3297895725508;831.339085427087;840.3865178419727;847.254416113822;10827.729306767395;10878.945605272002;10929.836052459219;10939.234253602252;10954.780904381867;3988.12261302513;4034.3948407739076;4198.139381426861;4202.054537728986;4209.621134097946;9240.21458176049;9242.72271831846;9262.073792620818;9271.768205794775;9318.207952324128;4586.88532786683;4587.472440669299;4595.954040459619;4598.379218805485;4601.67788254819;4091.4272001919753;4167.041580436517;4170.749755014709;4170.854020109282;4174.227767862955;3609.8917032488544;3621.8913432597064;3646.489491471143;3650.5619325681087;3741.420079887622;1132.3715337987496;1134.2910680824484;1143.845580846575;1146.140394703972;1147.1740346950182;687.5908834243617;821.7288294862681;824.2911096457042;835.6114406800746;855.4183155454226;5069.923951140736;5133.4609865964285;5146.536811686891;5166.250893620404;5240.816571419982;359.86505060602275;370.4110464361678;371.21673269401543;373.44543353120594;382.4225419616399;3518.208403109331;3533.5229743984746;3538.5186101149993;3586.085548185196;3599.676029157336;9594.232461403071;9973.30186886911;9998.15015723657;10003;10006.69979900604;9778.75553111178;9977.700668979796;9991.550380232762;9994.300398972002;9999.950000249952;7487.887681684779;7592.620368981528;7616.200298968529;7619.08570971487;7624.618769061524;5006.098902197639;5008.223725322581;5106.234064890296;5240.68555886648;5297.8145764898045;9078.636854526008;9125.908740912506;9248.722538323862;9269.768255793659;9288.767780805534;8958.596863141305;9254.4910029949;9351.672691455766;9374.203192728422;9440.386374885611;6560.737570497126;6772.762953296611;6927.896081558882;6932.410745086522;7054.964725176341;7707.34487568563;7721.073471183494;7761.61191940412;7768.572728499987;7796.337311328601;6023.247094113236;6033.456988871023;6933.965330173317;7049.400800931773;7229.060222171084;6774.796756097325;6778.7288508459105;6812.693428795816;6851.931480685329;6975.023496710363;6453.225612926479;6463.709133089116;6500.512461565496;6541.443977261795;6550;4270.145970805789;4414.580614841585;4479.417675702138;4511.571400716926;4546.068056048436;4612.884677882946;4641.3734145889875;4664.976675116603;4665.6967297125575;4737.194676904865 03:49:36 INFO - PROCESS | 16041 | |4;prototype.html;293.6432234834677;296.9361587258739;299.47890670233784;304.4838997898563;306.15348561228205;4801.303810947415;4824.83113091041;4827.324174615556;4837.443693975199;4843.903121937564;4739.691920025196;4759.547842954922;4766.928496072553;4767.594754445868;4773.546513081261;3818.5417749870053;3821.866234681787;3822.69418446525;3825.4261860720835;3845.5769865314933;3565.937608490795;3659.8837354606835;3819.2361527694434;3821.9044523886846;3836.0819590204896;3277.3609146216377;3432.541170002751;3647.963520364802;3669.4495825626104;3768.679662228714;3655.5430571178604;3668.816559172031;3715.2383761329133;3730.5709843367954;3735.9252814943547;3354.194993201638;3364.243045314809;3368.2253081791323;3377.4089534331392;3385.3737058643983;4468.8882777930485;4567.794449249792;4684.32077348786;4701.553352431513;4702.3181638662545;4302.870913872589;4303.849365272201;4308.870733877989;4315.741055536678;4319.524852266248;5028.974855125737;5031.899362012739;5038.042771873333;5039.798408063673;5043.571296439807;3523.6300188480095;3657.158853463718;3673.6142705015855;3676.8529258829612;3696.650722486273;5187.299714538564;5197.766100525448;5205.427402985669;5211.661242019257;5221.921671174898;3753.8873833784482;3762.360398732222;3765.6799172070682;3767;3780.8676696315497;3804.9619503804606;3805.1438426353848;3813.237352529505;3813.694904407641;3816.14136819219;4143.97928010358;4199.790010499524;4207.948012996751;4212.389203565466;4291.463567054118;4965.3048573199785;4968.428630707443;5002.474740152305;5010.423801262828;5024.422191447957;1317.7562151002096;1327.1307293722434;1328.4885319152004;1331.2826453874586;1334.4128583423262;809.4536188073027;858.9184027517376;858.9914100858912;871.2507243770352;872.6029656506274;3929.233799409145;3945.704072194597;3967.484227050523;4004.2391945530258;4007.5591684914634;4496.3705081288645;4542.955120322345;4555.794989225493;4557.612602928788;4565.744420284382;3979.4826672532386;3995.420664003703;4002.9570134164705;4008.2785098681934;4009.3785463252657;2280.669302951063;2436.768506991833;2442.2184900831917;2450.4486490539844;2451.669024681645;4298.656107511391;4303.311470164758;4307.406259683874;4309.569043095728;4322.7680111168165;4983.202687569971;5054.873628159326;5267.394249661262;5267.841964741064;5301.708406037628;4845.733484658378;4848.733319667382;4858;4866.975665121652;4870.659053866266;4885.975570122127;5158.742062896915;5165.690058596496;5169.043726910533;5170.121079416433;5034.748262586929;5047.687601223782;5058.519440653132;5087.974560127176;5091.923621145612;4818.10864989978;4830.1305764961235;4833.95166048335;4836.322914791862;4850.5149485052625;3721.7394782364972;3757.304898593769;3764.360058790067;3767.7550959187565;3778.282126395976;4902.558769710743;5115.667481613683;5147.459516750687;5151.459096794782;5170.586353091669;4949.851504454872;4966.1376983631135;4977.481868030285;4983.352164218773;4984.6261530384645;4979.427365852974;4994.076095922266;5009.574186194214;5031.471695472069;5036;4743.881402964816;4999.275105109811;5010.498950105106;5016.272640467185;5017;5054.220178901663;5092.668976516515;5099.286099945936;5099.56653684441;5107.846764597068;4783.425988881357;5000.199968005102;5008.724520151427;5009.423916249678;5024 03:49:36 INFO - PROCESS | 16041 | |5;yui.html;640.3500447046248;642.4507046475263;683.8290427393151;705.5308220033678;753.7512620835125;13334.199948003114;14058.367373468192;14083.718325633481;14094.929525352372;14876.553703388889;13578.117422367539;14265.072770269926;14288.142711437295;14348.856511434882;14352.354144063516;624.1449214576037;741.8145463634091;759.290063790355;781.4920301803816;786.382689588673;786.8583654942108;788.2432864450135;788.692409960116;789.8617741895174;789.9763007109796;818.3535007344191;818.6357071103362;818.8730746734236;819.5082950229875;819.6434550970317;640.190159448296;658.4403257231315;658.6476235214137;661.7121552124842;812.5287333346645;582.790195529609;599.9760009599654;600.6756351570147;603.7947097986662;605.1527860994598;12709.428075736614;12754.36228188587;12835.87164128356;12855.550055748005;13181.736365272642;11621.535138594447;11979.401029948554;12025.759484810254;12052.397380130958;12348.876511234863;10354.689359319158;10381.532831022621;10425.843612345821;10457.267991240617;10522.736931576695;3719.3119272934596;3731.440283957401;3765.0963768695588;3782.243551289753;3805.010697218743;65322.10202931508;65712;65848.67075664639;65903.67048164729;66137.3386266136;9671.371360861522;9841.852372214422;10062.849057264148;10071;10078.294519383573;17992.1003949802;18017.639647206983;18031.63936721258;18144.818551814576;18149.455516334532;6517.934820651828;6523.902141467882;6600.636964966973;6643.800685979429;6668.666566671647;3728.5339332583426;3740.9064773380883;3744.8689295874515;3753.662170404622;3773.3773927301686;2768.5570308750503;2860.856957152134;2868.756155726745;2870.3398218409884;2874.798764086494;472.4613940108279;477.5248627615475;479.8920242945379;483.6300230323805;485.4514398729413;439.3673110720552;471.4319245309462;493.69390977593406;516.3648712084157;545.585355130104;7487.588182650006;7496.400287976949;7641.2740789624895;7745.993020907359;7907.288344049063;440.3785675847805;475.3653872080811;506.2406390414378;527.1276038156857;529.2246858352455;3417.8120203388553;3503.5555885924136;3739.420389839525;3762.124423388605;3891.552471465761;84072;92180.53909730543;96121.5193924026;96150.51924740331;96442;82917;83442.58278708567;83682.16317836866;84105.63820601541;84856;46805.5319446808;70447;76631.23368766352;77277.6136119327;77346;6511.413972742286;6741.898871516833;6779.525433219627;6980.7207711693;6984;41820.372694410216;43074;43847;44484.11031779411;44638.10723785571;55226;55619;56407.43592564186;56452.43547564472;57057;10481.37111773296;10703.090237329914;11032.558697652004;11048.613298534512;11119.944400277947;11205.159613029218;11396.658100257006;12517.624471265877;13148;13465.498204533957;11059.668209953714;11267.661970140909;11941.223820451643;12268.815967760313;12310.569130080405;10379.584816607252;10561.313514621525;10771.13830893511;11149.163812714241;11418.771624567296;10079.69760907174;10208.132308753839;10236.539355729159;10281.948590257001;10495.895041049796;9324.720258392259;9715.319927605282;10287.691369258935;10317.432541210306;10388.480575971322;9867.16129129032;10068.39589624625;10126.898731012596;10238.129758970274;10309.432981186106 03:49:36 INFO - PROCESS | 16041 | __end_tp_report 03:49:36 INFO - PROCESS | 16041 | __start_cc_report 03:49:36 INFO - PROCESS | 16041 | _x_x_mozilla_cycle_collect,1017 03:49:36 INFO - PROCESS | 16041 | __end_cc_report 03:49:36 INFO - PROCESS | 16041 | __startTimestamp1468493376008__endTimestamp 03:49:36 INFO - PROCESS | 16041 | 03:49:36 INFO - PROCESS | 16041 | ------- Summary: start ------- 03:49:36 INFO - PROCESS | 16041 | Number of tests: 6 03:49:36 INFO - PROCESS | 16041 | 03:49:36 INFO - PROCESS | 16041 | [#0] dojo.html Cycles:165 Average:4571.89 Median:4695.98 stddev:482.86 (10.3%) stddev-sans-first:458.10 03:49:36 INFO - PROCESS | 16041 | Values: 2570.3 2594.6 2621.7 2631.0 2637.9 4422.1 4470.2 4552.8 4582.7 4595.2 4582.9 4589.6 4633.1 4648.5 4714.0 4022.8 4207.4 4264.8 4315.1 4361.8 4266.7 4322.9 4327.9 4362.4 4384.5 4153.5 4204.9 4218.9 4257.1 4262.3 4253.3 4256.9 4262.6 4315.4 4352.0 4267.3 4274.4 4297.5 4321.6 4325.2 4466.3 4566.2 4629.0 4698.6 4699.6 4987.6 4999.7 5006.0 5006.6 5007.7 4988.5 5023.9 5040.3 5052.5 5052.8 4491.9 4601.3 4657.6 4664.4 4696.0 5072.7 5111.5 5146.9 5148.9 5149.2 4906.1 4935.9 4949.3 4953.7 4953.8 4760.2 4901.3 4961.9 4964.6 5021.8 4912.0 4925.7 4928.4 4931.2 4967.6 4877.4 4893.1 4896.7 4899.9 4930.0 4065.2 4105.8 4112.0 4139.9 4235.8 3649.4 3651.4 3652.4 3677.3 3725.8 4252.2 4263.0 4265.2 4306.4 4306.4 4884.0 4892.5 4960.8 4964.7 5004.5 4254.1 4259.5 4280.6 4315.0 4318.8 4260.2 4265.5 4271.8 4277.8 4319.1 4489.8 4583.5 4637.5 4641.6 4694.8 4951.5 4967.9 4974.3 4977.4 5013.5 4631.8 4655.7 4659.3 4683.3 4717.7 4746.3 4823.6 4830.7 4869.6 4905.6 4958.1 4964.5 4974.4 4978.1 5022.5 4804.5 4813.8 4815.8 4818.9 4861.4 4630.7 4797.9 4822.6 4833.7 4866.7 4719.9 4748.1 4758.7 4806.7 4814.6 4692.4 4835.6 4840.8 4843.7 4895.5 4738.7 4782.6 4790.6 4791.9 4805.0 03:49:36 INFO - PROCESS | 16041 | 03:49:36 INFO - PROCESS | 16041 | [#1] ext.html Cycles:180 Average:47758.73 Median:37209.63 stddev:91895.10 (247.0%) stddev-sans-first:92084.54 03:49:36 INFO - PROCESS | 16041 | Values: 553.0 576.5 582.6 590.8 601.0 26873.9 27356.0 29817.3 30075.7 30230.5 41537.6 42496.6 42680.8 46391.5 46784.8 7939.3 8082.4 8090.2 8097.9 8098.1 7904.6 7986.9 7987.5 7991.3 7992.2 8001.2 8031.4 8057.4 8067.0 8070.5 7895.4 7966.1 7968.4 7976.0 7981.2 7897.2 7941.1 7965.6 7965.6 7968.3 38458.4 38631.4 38703.0 38773.4 38785.8 3114.0 3121.4 3153.0 3255.0 3687.7 30476.1 30555.8 30977.8 31145.4 32109.0 2960.5 2971.2 3008.1 3033.8 3059.4 247471.0 248506.0 248575.0 248766.0 248776.0 32515.2 33428.0 54043.7 54204.0 54409.5 33954.5 33969.8 34084.5 34109.5 34264.1 11956.9 11960.3 11966.1 11970.6 11977.1 10595.9 10632.0 10632.7 10650.9 10659.0 7887.1 7891.1 7897.6 7903.8 7972.2 3059.0 3059.5 3072.4 3078.8 3106.4 852.6 899.9 944.5 949.2 998.4 28072.4 28295.4 28594.0 28856.0 29106.9 764.4 920.3 921.8 940.9 956.6 14311.9 14817.9 14819.4 15060.6 15119.9 398485.0 403141.0 405125.0 405264.0 405638.0 48110.0 48781.0 48805.0 48840.5 48907.0 1070.1 1135.4 1166.3 1206.3 1213.9 28714.0 29886.9 30043.0 30470.1 30528.0 37952.0 38081.6 38141.6 38225.0 38265.8 315803.0 316440.0 317001.0 318769.0 528351.0 25448.4 26153.2 26264.0 27398.0 27438.7 42836.8 43553.3 43716.8 44284.8 44424.3 37369.3 37450.8 37565.2 38067.0 38667.2 35892.8 37393.6 37411.8 38141.0 38378.0 36286.1 36450.3 36958.8 37050.0 37448.3 33186.3 33663.5 33843.8 34053.0 34565.7 25281.6 25609.7 25758.5 26346.3 26392.5 03:49:36 INFO - PROCESS | 16041 | 03:49:36 INFO - PROCESS | 16041 | [#2] jquery.html Cycles:180 Average:23915.35 Median:3938.77 stddev:61046.63 (1549.9%) stddev-sans-first:61192.23 03:49:36 INFO - PROCESS | 16041 | Values: 345.7 364.2 365.1 366.9 377.4 13228.0 16513.6 16851.4 17771.6 18661.2 16720.3 16786.9 16854.7 17143.8 17163.7 4422.9 5035.2 5239.4 5250.3 5255.0 5167.6 5202.6 5210.9 5220.4 5227.3 5189.3 5277.4 5574.1 5589.0 5650.0 5394.2 5557.1 5561.3 5574.1 5576.6 5375.5 5384.7 5393.4 5411.5 5414.1 12888.5 13095.9 14770.0 21557.5 21586.2 1820.4 1869.1 1904.9 1916.6 1954.9 9527.0 9880.4 10027.3 11533.1 12670.4 1716.7 1719.3 1755.1 1845.4 1858.2 67299.0 73034.3 73039.0 73189.3 74287.6 9113.4 9633.3 10121.9 10323.6 10475.9 13029.8 13942.2 13942.5 14369.2 14381.4 7276.2 7478.5 7566.7 7579.1 7623.1 6193.6 6529.3 7085.7 7224.7 7307.6 3672.5 3842.6 3935.8 3941.7 4003.2 1794.1 1812.8 1849.7 1900.1 1904.5 775.7 850.2 859.2 902.1 903.7 16595.0 16723.5 17400.6 17655.6 17873.6 805.8 827.7 857.0 880.5 882.4 9519.4 9599.0 9721.3 9780.6 10028.7 362227.0 365015.0 369291.0 369870.0 370564.0 79587.0 82090.0 82999.0 83162.2 83319.6 899.0 899.5 919.1 922.0 924.0 14981.9 15323.6 15337.0 15510.4 15741.7 38161.6 38589.0 38657.4 39206.4 39258.0 48791.5 51945.7 52571.0 52581.2 52667.0 5358.2 6220.8 7205.5 7617.7 8073.2 11454.3 12186.5 12271.1 12351.8 12473.9 10471.7 10512.3 10620.6 10876.8 10896.6 10047.4 10285.8 10467.3 10579.6 10595.5 7540.7 10695.0 10735.9 10890.7 10985.8 7627.3 7732.4 7806.9 7966.8 8112.8 8665.3 9936.2 9946.1 10079.7 10751.5 03:49:36 INFO - PROCESS | 16041 | 03:49:36 INFO - PROCESS | 16041 | [#3] mootools.html Cycles:180 Average:5161.54 Median:4701.45 stddev:3006.88 (64.0%) stddev-sans-first:3001.73 03:49:36 INFO - PROCESS | 16041 | Values: 1357.4 1434.5 1496.6 1691.3 1718.1 7549.6 8066.5 8138.3 8148.2 8153.6 6918.1 7129.9 7529.8 7841.4 7994.5 2137.0 2160.9 2166.4 2168.2 2170.3 2059.9 2105.3 2118.4 2119.8 2121.2 1802.0 1865.9 1868.0 1876.5 2084.3 2117.1 2135.2 2135.8 2141.2 2144.3 2074.9 2083.0 2100.5 2142.4 2145.5 6898.6 7639.4 7886.8 8144.5 8179.6 4443.0 4566.0 4587.1 4588.2 4590.2 2663.9 2735.1 2778.3 2779.8 2781.2 808.1 817.3 831.3 840.4 847.3 10827.7 10878.9 10929.8 10939.2 10954.8 3988.1 4034.4 4198.1 4202.1 4209.6 9240.2 9242.7 9262.1 9271.8 9318.2 4586.9 4587.5 4596.0 4598.4 4601.7 4091.4 4167.0 4170.7 4170.9 4174.2 3609.9 3621.9 3646.5 3650.6 3741.4 1132.4 1134.3 1143.8 1146.1 1147.2 687.6 821.7 824.3 835.6 855.4 5069.9 5133.5 5146.5 5166.3 5240.8 359.9 370.4 371.2 373.4 382.4 3518.2 3533.5 3538.5 3586.1 3599.7 9594.2 9973.3 9998.2 10003.0 10006.7 9778.8 9977.7 9991.6 9994.3 10000.0 7487.9 7592.6 7616.2 7619.1 7624.6 5006.1 5008.2 5106.2 5240.7 5297.8 9078.6 9125.9 9248.7 9269.8 9288.8 8958.6 9254.5 9351.7 9374.2 9440.4 6560.7 6772.8 6927.9 6932.4 7055.0 7707.3 7721.1 7761.6 7768.6 7796.3 6023.2 6033.5 6934.0 7049.4 7229.1 6774.8 6778.7 6812.7 6851.9 6975.0 6453.2 6463.7 6500.5 6541.4 6550.0 4270.1 4414.6 4479.4 4511.6 4546.1 4612.9 4641.4 4665.0 4665.7 4737.2 03:49:36 INFO - PROCESS | 16041 | 03:49:36 INFO - PROCESS | 16041 | [#4] prototype.html Cycles:180 Average:4111.07 Median:4566.77 stddev:1194.36 (26.2%) stddev-sans-first:1162.83 03:49:36 INFO - PROCESS | 16041 | Values: 293.6 296.9 299.5 304.5 306.2 4801.3 4824.8 4827.3 4837.4 4843.9 4739.7 4759.5 4766.9 4767.6 4773.5 3818.5 3821.9 3822.7 3825.4 3845.6 3565.9 3659.9 3819.2 3821.9 3836.1 3277.4 3432.5 3648.0 3669.4 3768.7 3655.5 3668.8 3715.2 3730.6 3735.9 3354.2 3364.2 3368.2 3377.4 3385.4 4468.9 4567.8 4684.3 4701.6 4702.3 4302.9 4303.8 4308.9 4315.7 4319.5 5029.0 5031.9 5038.0 5039.8 5043.6 3523.6 3657.2 3673.6 3676.9 3696.7 5187.3 5197.8 5205.4 5211.7 5221.9 3753.9 3762.4 3765.7 3767.0 3780.9 3805.0 3805.1 3813.2 3813.7 3816.1 4144.0 4199.8 4207.9 4212.4 4291.5 4965.3 4968.4 5002.5 5010.4 5024.4 1317.8 1327.1 1328.5 1331.3 1334.4 809.5 858.9 859.0 871.3 872.6 3929.2 3945.7 3967.5 4004.2 4007.6 4496.4 4543.0 4555.8 4557.6 4565.7 3979.5 3995.4 4003.0 4008.3 4009.4 2280.7 2436.8 2442.2 2450.4 2451.7 4298.7 4303.3 4307.4 4309.6 4322.8 4983.2 5054.9 5267.4 5267.8 5301.7 4845.7 4848.7 4858.0 4867.0 4870.7 4886.0 5158.7 5165.7 5169.0 5170.1 5034.7 5047.7 5058.5 5088.0 5091.9 4818.1 4830.1 4834.0 4836.3 4850.5 3721.7 3757.3 3764.4 3767.8 3778.3 4902.6 5115.7 5147.5 5151.5 5170.6 4949.9 4966.1 4977.5 4983.4 4984.6 4979.4 4994.1 5009.6 5031.5 5036.0 4743.9 4999.3 5010.5 5016.3 5017.0 5054.2 5092.7 5099.3 5099.6 5107.8 4783.4 5000.2 5008.7 5009.4 5024.0 03:49:36 INFO - PROCESS | 16041 | 03:49:36 INFO - PROCESS | 16041 | [#5] yui.html Cycles:180 Average:17240.70 Median:44561.11 stddev:24592.33 (55.2%) stddev-sans-first:24629.72 03:49:36 INFO - PROCESS | 16041 | Values: 640.4 642.5 683.8 705.5 753.8 13334.2 14058.4 14083.7 14094.9 14876.6 13578.1 14265.1 14288.1 14348.9 14352.4 624.1 741.8 759.3 781.5 786.4 786.9 788.2 788.7 789.9 790.0 818.4 818.6 818.9 819.5 819.6 640.2 658.4 658.6 661.7 812.5 582.8 600.0 600.7 603.8 605.2 12709.4 12754.4 12835.9 12855.6 13181.7 11621.5 11979.4 12025.8 12052.4 12348.9 10354.7 10381.5 10425.8 10457.3 10522.7 3719.3 3731.4 3765.1 3782.2 3805.0 65322.1 65712.0 65848.7 65903.7 66137.3 9671.4 9841.9 10062.8 10071.0 10078.3 17992.1 18017.6 18031.6 18144.8 18149.5 6517.9 6523.9 6600.6 6643.8 6668.7 3728.5 3740.9 3744.9 3753.7 3773.4 2768.6 2860.9 2868.8 2870.3 2874.8 472.5 477.5 479.9 483.6 485.5 439.4 471.4 493.7 516.4 545.6 7487.6 7496.4 7641.3 7746.0 7907.3 440.4 475.4 506.2 527.1 529.2 3417.8 3503.6 3739.4 3762.1 3891.6 84072.0 92180.5 96121.5 96150.5 96442.0 82917.0 83442.6 83682.2 84105.6 84856.0 46805.5 70447.0 76631.2 77277.6 77346.0 6511.4 6741.9 6779.5 6980.7 6984.0 41820.4 43074.0 43847.0 44484.1 44638.1 55226.0 55619.0 56407.4 56452.4 57057.0 10481.4 10703.1 11032.6 11048.6 11119.9 11205.2 11396.7 12517.6 13148.0 13465.5 11059.7 11267.7 11941.2 12268.8 12310.6 10379.6 10561.3 10771.1 11149.2 11418.8 10079.7 10208.1 10236.5 10281.9 10495.9 9324.7 9715.3 10287.7 10317.4 10388.5 9867.2 10068.4 10126.9 10238.1 10309.4 03:49:36 INFO - PROCESS | 16041 | -------- Summary: end -------- 03:49:36 INFO - PROCESS | 16041 | 03:49:36 INFO - TEST-INFO | 16041: exit 0 03:49:36 INFO - TEST-OK | dromaeo_css | took 1121363ms 03:49:36 INFO - TEST-START | kraken 03:49:36 INFO - operating with platform_type : linux_ 03:49:36 INFO - Initialising browser for kraken test... 03:49:36 INFO - TEST-INFO | started process 16231 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDRJRHF/profile http://localhost:55536/getInfo.html) 03:49:42 INFO - PROCESS | 16231 | __metrics Screen width/height:1600/1200 03:49:42 INFO - PROCESS | 16231 | colorDepth:24 03:49:42 INFO - PROCESS | 16231 | Browser inner width/height: 1024/697 03:49:42 INFO - PROCESS | 16231 | __metrics 03:49:43 INFO - PROCESS | 16231 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 03:49:43 INFO - PROCESS | 16231 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:49:43 INFO - PROCESS | 16231 | console.error: PushService: 03:49:43 INFO - PROCESS | 16231 | stateChangeProcessEnqueue: Error transitioning state 03:49:43 INFO - PROCESS | 16231 | UnknownError 03:49:44 INFO - TEST-INFO | 16231: exit 0 03:49:44 INFO - Browser initialized. 03:49:44 INFO - Running cycle 1/1 for kraken test... 03:49:44 INFO - TEST-INFO | started process 16312 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDRJRHF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:49:56 INFO - PROCESS | 16312 | RSS: Main: 158720000 03:49:56 INFO - PROCESS | 16312 | 03:49:58 INFO - PROCESS | 16312 | Cycle 1(1): loaded http://localhost:55536/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55536/tests/kraken/driver.html?testName=audio-beat-detection) 03:49:59 INFO - PROCESS | 16312 | RSS: Main: 217231360 03:49:59 INFO - PROCESS | 16312 | 03:50:02 INFO - PROCESS | 16312 | Cycle 1(1): loaded http://localhost:55536/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55536/tests/kraken/driver.html?testName=audio-dft) 03:50:03 INFO - PROCESS | 16312 | RSS: Main: 205561856 03:50:03 INFO - PROCESS | 16312 | 03:50:06 INFO - PROCESS | 16312 | Cycle 1(1): loaded http://localhost:55536/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55536/tests/kraken/driver.html?testName=audio-fft) 03:50:07 INFO - PROCESS | 16312 | RSS: Main: 270864384 03:50:07 INFO - PROCESS | 16312 | 03:50:09 INFO - PROCESS | 16312 | Cycle 1(1): loaded http://localhost:55536/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55536/tests/kraken/driver.html?testName=audio-oscillator) 03:50:09 INFO - PROCESS | 16312 | RSS: Main: 182099968 03:50:09 INFO - PROCESS | 16312 | 03:50:12 INFO - PROCESS | 16312 | Cycle 1(1): loaded http://localhost:55536/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55536/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:50:12 INFO - PROCESS | 16312 | RSS: Main: 186560512 03:50:12 INFO - PROCESS | 16312 | 03:50:15 INFO - PROCESS | 16312 | Cycle 1(1): loaded http://localhost:55536/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55536/tests/kraken/driver.html?testName=imaging-darkroom) 03:50:16 INFO - PROCESS | 16312 | RSS: Main: 221790208 03:50:16 INFO - PROCESS | 16312 | 03:50:19 INFO - PROCESS | 16312 | Cycle 1(1): loaded http://localhost:55536/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55536/tests/kraken/driver.html?testName=imaging-desaturate) 03:50:20 INFO - PROCESS | 16312 | RSS: Main: 217694208 03:50:20 INFO - PROCESS | 16312 | 03:50:23 INFO - PROCESS | 16312 | Cycle 1(1): loaded http://localhost:55536/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55536/tests/kraken/driver.html?testName=json-parse-financial) 03:50:24 INFO - PROCESS | 16312 | RSS: Main: 220884992 03:50:24 INFO - PROCESS | 16312 | 03:50:25 INFO - PROCESS | 16312 | Cycle 1(1): loaded http://localhost:55536/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55536/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:50:26 INFO - PROCESS | 16312 | RSS: Main: 208015360 03:50:26 INFO - PROCESS | 16312 | 03:50:28 INFO - PROCESS | 16312 | Cycle 1(1): loaded http://localhost:55536/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55536/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:50:28 INFO - PROCESS | 16312 | RSS: Main: 213569536 03:50:28 INFO - PROCESS | 16312 | 03:50:30 INFO - PROCESS | 16312 | Cycle 1(1): loaded http://localhost:55536/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55536/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:50:31 INFO - PROCESS | 16312 | RSS: Main: 209805312 03:50:31 INFO - PROCESS | 16312 | 03:50:34 INFO - PROCESS | 16312 | Cycle 1(1): loaded http://localhost:55536/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55536/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:50:35 INFO - PROCESS | 16312 | RSS: Main: 225411072 03:50:35 INFO - PROCESS | 16312 | 03:50:37 INFO - PROCESS | 16312 | Cycle 1(1): loaded http://localhost:55536/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55536/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:50:38 INFO - PROCESS | 16312 | RSS: Main: 227295232 03:50:38 INFO - PROCESS | 16312 | 03:50:40 INFO - PROCESS | 16312 | Cycle 1(1): loaded http://localhost:55536/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55536/tests/kraken/driver.html?testName=ai-astar) 03:50:40 INFO - PROCESS | 16312 | RSS: Main: 268759040 03:50:40 INFO - PROCESS | 16312 | 03:50:40 INFO - PROCESS | 16312 | __start_tp_report 03:50:40 INFO - PROCESS | 16312 | _x_x_mozilla_page_load 03:50:40 INFO - PROCESS | 16312 | _x_x_mozilla_page_load_details 03:50:40 INFO - PROCESS | 16312 | |i|pagename|runs| 03:50:40 INFO - PROCESS | 16312 | |0;ai-astar;105;113;113;112;114;114;113;114;114;114 03:50:40 INFO - PROCESS | 16312 | |1;audio-beat-detection;152;122;124;179;127;123;147;122;161;121 03:50:40 INFO - PROCESS | 16312 | |2;audio-dft;162;162;161;162;161;162;162;162;165;163 03:50:40 INFO - PROCESS | 16312 | |3;audio-fft;76;75;76;121;77;78;76;76;117;75 03:50:40 INFO - PROCESS | 16312 | |4;audio-oscillator;85;85;114;85;85;85;127;85;85;126 03:50:40 INFO - PROCESS | 16312 | |5;imaging-gaussian-blur;117;117;118;117;117;117;117;116;117;117 03:50:40 INFO - PROCESS | 16312 | |6;imaging-darkroom;146;147;147;146;146;147;147;147;146;146 03:50:40 INFO - PROCESS | 16312 | |7;imaging-desaturate;94;95;94;95;95;95;95;95;95;94 03:50:40 INFO - PROCESS | 16312 | |8;json-parse-financial;64;64;66;64;64;65;66;66;66;65 03:50:40 INFO - PROCESS | 16312 | |9;json-stringify-tinderbox;65;67;65;65;67;65;65;65;65;67 03:50:40 INFO - PROCESS | 16312 | |10;stanford-crypto-aes;78;78;87;81;78;78;82;78;78;81 03:50:40 INFO - PROCESS | 16312 | |11;stanford-crypto-ccm;141;139;128;128;128;129;138;130;204;139 03:50:40 INFO - PROCESS | 16312 | |12;stanford-crypto-pbkdf2;163;163;165;163;165;164;172;166;165;165 03:50:40 INFO - PROCESS | 16312 | |13;stanford-crypto-sha256-iterative;67;66;66;66;66;65;66;65;66;65 03:50:40 INFO - PROCESS | 16312 | __end_tp_report 03:50:40 INFO - PROCESS | 16312 | __start_cc_report 03:50:40 INFO - PROCESS | 16312 | _x_x_mozilla_cycle_collect,1895 03:50:40 INFO - PROCESS | 16312 | __end_cc_report 03:50:40 INFO - PROCESS | 16312 | __startTimestamp1468493440517__endTimestamp 03:50:40 INFO - PROCESS | 16312 | 03:50:40 INFO - PROCESS | 16312 | ------- Summary: start ------- 03:50:40 INFO - PROCESS | 16312 | Number of tests: 14 03:50:40 INFO - PROCESS | 16312 | 03:50:40 INFO - PROCESS | 16312 | [#0] ai-astar Cycles:10 Average:112.60 Median:114.00 stddev:2.76 (2.4%) stddev-sans-first:0.73 03:50:40 INFO - PROCESS | 16312 | Values: 105.0 113.0 113.0 112.0 114.0 114.0 113.0 114.0 114.0 114.0 03:50:40 INFO - PROCESS | 16312 | 03:50:40 INFO - PROCESS | 16312 | [#1] audio-beat-detection Cycles:10 Average:137.80 Median:137.00 stddev:20.63 (15.1%) stddev-sans-first:21.23 03:50:40 INFO - PROCESS | 16312 | Values: 152.0 122.0 124.0 179.0 127.0 123.0 147.0 122.0 161.0 121.0 03:50:40 INFO - PROCESS | 16312 | 03:50:40 INFO - PROCESS | 16312 | [#2] audio-dft Cycles:10 Average:162.20 Median:162.00 stddev:1.14 (0.7%) stddev-sans-first:1.20 03:50:40 INFO - PROCESS | 16312 | Values: 162.0 162.0 161.0 162.0 161.0 162.0 162.0 162.0 165.0 163.0 03:50:40 INFO - PROCESS | 16312 | 03:50:40 INFO - PROCESS | 16312 | [#3] audio-fft Cycles:10 Average:84.70 Median:76.00 stddev:18.12 (23.8%) stddev-sans-first:18.95 03:50:40 INFO - PROCESS | 16312 | Values: 76.0 75.0 76.0 121.0 77.0 78.0 76.0 76.0 117.0 75.0 03:50:40 INFO - PROCESS | 16312 | 03:50:40 INFO - PROCESS | 16312 | [#4] audio-oscillator Cycles:10 Average:96.20 Median:85.00 stddev:18.35 (21.6%) stddev-sans-first:19.01 03:50:40 INFO - PROCESS | 16312 | Values: 85.0 85.0 114.0 85.0 85.0 85.0 127.0 85.0 85.0 126.0 03:50:40 INFO - PROCESS | 16312 | 03:50:40 INFO - PROCESS | 16312 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.47 (0.4%) stddev-sans-first:0.50 03:50:40 INFO - PROCESS | 16312 | Values: 117.0 117.0 118.0 117.0 117.0 117.0 117.0 116.0 117.0 117.0 03:50:40 INFO - PROCESS | 16312 | 03:50:40 INFO - PROCESS | 16312 | [#6] imaging-darkroom Cycles:10 Average:146.50 Median:147.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 03:50:40 INFO - PROCESS | 16312 | Values: 146.0 147.0 147.0 146.0 146.0 147.0 147.0 147.0 146.0 146.0 03:50:40 INFO - PROCESS | 16312 | 03:50:40 INFO - PROCESS | 16312 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 03:50:40 INFO - PROCESS | 16312 | Values: 94.0 95.0 94.0 95.0 95.0 95.0 95.0 95.0 95.0 94.0 03:50:40 INFO - PROCESS | 16312 | 03:50:40 INFO - PROCESS | 16312 | [#8] json-parse-financial Cycles:10 Average:65.00 Median:65.50 stddev:0.94 (1.4%) stddev-sans-first:0.93 03:50:40 INFO - PROCESS | 16312 | Values: 64.0 64.0 66.0 64.0 64.0 65.0 66.0 66.0 66.0 65.0 03:50:40 INFO - PROCESS | 16312 | 03:50:40 INFO - PROCESS | 16312 | [#9] json-stringify-tinderbox Cycles:10 Average:65.60 Median:65.00 stddev:0.97 (1.5%) stddev-sans-first:1.00 03:50:40 INFO - PROCESS | 16312 | Values: 65.0 67.0 65.0 65.0 67.0 65.0 65.0 65.0 65.0 67.0 03:50:40 INFO - PROCESS | 16312 | 03:50:40 INFO - PROCESS | 16312 | [#10] stanford-crypto-aes Cycles:10 Average:79.90 Median:79.50 stddev:2.96 (3.7%) stddev-sans-first:3.06 03:50:40 INFO - PROCESS | 16312 | Values: 78.0 78.0 87.0 81.0 78.0 78.0 82.0 78.0 78.0 81.0 03:50:40 INFO - PROCESS | 16312 | 03:50:40 INFO - PROCESS | 16312 | [#11] stanford-crypto-ccm Cycles:10 Average:140.40 Median:138.50 stddev:22.98 (16.6%) stddev-sans-first:24.38 03:50:40 INFO - PROCESS | 16312 | Values: 141.0 139.0 128.0 128.0 128.0 129.0 138.0 130.0 204.0 139.0 03:50:40 INFO - PROCESS | 16312 | 03:50:40 INFO - PROCESS | 16312 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.10 Median:165.00 stddev:2.64 (1.6%) stddev-sans-first:2.69 03:50:40 INFO - PROCESS | 16312 | Values: 163.0 163.0 165.0 163.0 165.0 164.0 172.0 166.0 165.0 165.0 03:50:40 INFO - PROCESS | 16312 | 03:50:40 INFO - PROCESS | 16312 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.80 Median:66.00 stddev:0.63 (1.0%) stddev-sans-first:0.50 03:50:40 INFO - PROCESS | 16312 | Values: 67.0 66.0 66.0 66.0 66.0 65.0 66.0 65.0 66.0 65.0 03:50:40 INFO - PROCESS | 16312 | -------- Summary: end -------- 03:50:40 INFO - PROCESS | 16312 | 03:50:41 INFO - TEST-INFO | 16312: exit 0 03:50:41 INFO - TEST-OK | kraken | took 64978ms 03:50:41 INFO - SUITE-END | took 1186s 03:50:42 INFO - Completed test suite (00:19:46) 03:50:42 INFO - javascript benchmark 03:50:42 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2570.2674737699754, 2594.5589249827526, 2621.6591843060405, 2630.9736902630966, 2637.89448422063, 4422.11557688462, 4470.150671372437, 4552.817887284509, 4582.725036497808, 4595.195840727876, 4582.885427864305, 4589.609883159936, 4633.096546173498, 4648.511906249837, 4714.010057887839, 4022.839086436539, 4207.431996680455, 4264.808083636244, 4315.115401342718, 4361.803718832644, 4266.743995360288, 4322.913541729164, 4327.935080973788, 4362.367456718774, 4384.473863136428, 4153.480814898137, 4204.936925946114, 4218.936715949232, 4257.106007738379, 4262.296721041024, 4253.255680255943, 4256.87229383119, 4262.595053469915, 4315.3742707307265, 4352.0, 4267.253230684618, 4274.380214868826, 4297.484301883794, 4321.6326612238, 4325.178216138924, 4466.263066594008, 4566.1780879441685, 4628.976855115737, 4698.647601429906, 4699.577038066591, 4987.576056035241, 4999.650024498286, 5006.023825354057, 5006.5744411725045, 5007.674501157449, 4988.451270360258, 5023.874403139951, 5040.294358789773, 5052.545270925634, 5052.797888084472, 4491.932621010687, 4601.33280674307, 4657.580817726353, 4664.370310008173, 4695.976520117378, 5072.721000345016, 5111.514406131411, 5146.922796158061, 5148.922766158511, 5149.176131818891, 4906.092372911023, 4935.901281974412, 4949.257611358253, 4953.7275449849885, 4953.801847926043, 4760.214564596872, 4901.313816065754, 4961.925571116436, 4964.60283177345, 5021.774020169101, 4911.9754401227765, 4925.679830810986, 4928.408590969107, 4931.211006239057, 4967.627427942919, 4877.3903262092235, 4893.09477746618, 4896.6572339935865, 4899.902001959941, 4930.038642464685, 4065.2276067547073, 4105.794710264475, 4111.958880411157, 4139.855105071308, 4235.788210589458, 3649.3613617617343, 3651.3610118229735, 3652.3790955537625, 3677.3013127506224, 3725.832337544817, 4252.170826688766, 4263.0, 4265.189613973397, 4306.354046892991, 4306.418633484503, 4883.951160488421, 4892.510748925079, 4960.751962401865, 4964.702117872939, 5004.4995500450395, 4254.085371645111, 4259.467566554181, 4280.59334363235, 4314.978425107917, 4318.848840290575, 4260.211860805761, 4265.53079161292, 4271.807768650418, 4277.8288868444915, 4319.114581510783, 4489.775511224491, 4583.472900616339, 4637.53624637547, 4641.582257596765, 4694.835680751157, 4951.5048495150195, 4967.900641987212, 4974.303597496426, 4977.377827771528, 5013.498650134958, 4631.814727411001, 4655.743934083658, 4659.254519276899, 4683.297505374221, 4717.693349932243, 4746.264329029006, 4823.589994850477, 4830.661853670209, 4869.561739443467, 4905.583025442877, 4958.082754690394, 4964.453910069961, 4974.37820272466, 4978.1288274552535, 5022.54797068251, 4804.5195480451675, 4813.807447702193, 4815.759212039314, 4818.903621927612, 4861.416630004422, 4630.72215667061, 4797.928031079467, 4822.565969062801, 4833.709977401367, 4866.732329721899, 4719.905601888012, 4748.0503899220985, 4758.666893317573, 4806.735629540409, 4814.5907597853175, 4692.366530518473, 4835.564799168092, 4840.782164802522, 4843.733594652187, 4895.510448955076, 4738.668293219442, 4782.593479554277, 4790.592799611933, 4791.856244312677, 4805.038992201504], "value": 4541.269421627327, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [552.9625672458715, 576.4667682393786, 582.5834528312258, 590.8227531740482, 600.9933361619287, 26873.865630671844, 27356.0, 29817.25456863574, 30075.699243007562, 30230.54654180189, 41537.58462415375, 42496.57503424965, 42680.78659606697, 46391.53608463914, 46784.76607616957, 7939.285464308196, 8082.353411727077, 8090.150534193913, 8097.919020809775, 8098.109207987117, 7904.565248911307, 7986.880196797053, 7987.480813747117, 7991.32073773727, 7992.240737129963, 8001.23988221121, 8031.4377993540475, 8057.435979481439, 8066.959665201666, 8070.475419097769, 7895.407844411663, 7966.123726390092, 7968.402369822286, 7975.96012019942, 7981.241782030698, 7897.17079706634, 7941.086775020889, 7965.6017199139815, 7965.64154613038, 7968.282854543061, 38458.42312365317, 38631.42052869181, 38703.0, 38773.41839872404, 38785.80607096946, 3113.984430077835, 3121.438141134595, 3153.0, 3255.0161554110587, 3687.6865466435383, 30476.085717428512, 30555.847220763753, 30977.845110774302, 31145.377092458024, 32109.0, 2960.467115919134, 2971.1829246957045, 3008.127642983532, 3033.8331391773445, 3059.37282857016, 247471.0, 248506.0, 248575.0, 248766.0, 248776.0, 32515.18712032218, 33428.0, 54043.72978135084, 54204.0, 54409.45590544123, 33954.49068263978, 33969.830150849084, 34084.488732668535, 34109.48835767466, 34264.14339641529, 11956.880431195577, 11960.282383057045, 11966.102542309362, 11970.58102966392, 11977.101717371232, 10595.894041059644, 10632.0, 10632.681019569425, 10650.946745266225, 10659.040686338267, 7887.092984306763, 7891.092524359658, 7897.644605992629, 7903.84192316162, 7972.246105856702, 3058.9541156882665, 3059.541068839692, 3072.400881828022, 3078.7690923180853, 3106.409782141386, 852.6205838401976, 899.8920129584492, 944.4946953379908, 949.1931857920712, 998.3660375661507, 28072.43855122927, 28295.434091318057, 28594.0, 28856.0, 29106.854465727534, 764.3693952489108, 920.2545937790411, 921.7695576105973, 940.9388389754644, 956.583886009588, 14311.928440357731, 14817.925910370379, 14819.40722371093, 15060.623484412758, 15119.924400378148, 398485.0, 403141.0, 405125.0, 405264.0, 405638.0, 48110.0, 48781.0, 48805.0, 48840.511594883596, 48907.0, 1070.0797314309686, 1135.3585224348217, 1166.3177041430688, 1206.3365149168098, 1213.872543382932, 28714.0, 29886.85056574703, 30043.0, 30470.085897423112, 30528.0, 37952.0, 38081.61918380781, 38141.618583813804, 38225.0, 38265.80867095647, 315803.0, 316440.0, 317001.0, 318769.0, 528351.0, 25448.363790905376, 26153.215403537924, 26264.0, 27398.0, 27438.725612743616, 42836.78581607072, 43553.34669980016, 43716.781416092716, 44284.77857610691, 44424.33363499615, 37369.25261494701, 37450.8127459361, 37565.248695026494, 38067.0, 38667.22665546617, 35892.8205358982, 37393.58218729509, 37411.812940935124, 38141.0, 38378.0, 36286.09284767902, 36450.27099457943, 36958.8152059238, 37050.0, 37448.251034979694, 33186.33627327488, 33663.495047573815, 33843.830780845936, 34053.0, 34565.65434345624, 25281.62077568801, 25609.743902560735, 25758.484830302914, 26346.34134146585, 26392.472150557267], "value": 16447.264326138167, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [345.721694036301, 364.1969457346551, 365.0945654776155, 366.8899330200939, 377.3603741657891, 13228.0, 16513.58716032098, 16851.41020064298, 17771.55571110723, 18661.16024778885, 16720.331186752544, 16786.916065419686, 16854.662906741858, 17143.828561714377, 17163.74254386182, 4422.933655995163, 5035.219540971137, 5239.371275446952, 5250.264962905197, 5254.973725131369, 5167.612429067835, 5202.557782588466, 5210.895782084356, 5220.373555173365, 5227.3465816772905, 5189.325387699594, 5277.445868183843, 5574.10814269717, 5589.04986152353, 5650.039493286151, 5394.1908713692865, 5557.110862262019, 5561.332640083176, 5574.052411090104, 5576.609637325369, 5375.462453754632, 5384.6769193848495, 5393.352797664305, 5411.512963833274, 5414.133738601844, 12888.484460621565, 13095.869041309561, 14770.0, 21557.461063473384, 21586.244481443075, 1820.4265656318216, 1869.1309437815971, 1904.9047547622702, 1916.57835276239, 1954.8631595788302, 9526.952365238129, 9880.35777674456, 10027.298089133763, 11533.077353811675, 12670.429830657642, 1716.682413753447, 1719.3380548488797, 1755.0785837435321, 1845.427917345627, 1858.1638262781803, 67299.0, 73034.26965730327, 73039.0, 73189.26810731877, 74287.62856185739, 9113.407628504126, 9633.32566720337, 10121.949390253149, 10323.638672646572, 10475.94762026185, 13029.804552931713, 13942.233177175352, 13942.512012079529, 14369.209693466959, 14381.352839122264, 7276.199618042011, 7478.476506644592, 7566.697332106764, 7579.1284002340435, 7623.123340815766, 6193.566450348432, 6529.347065293433, 7085.681144348517, 7224.711011559584, 7307.561546307238, 3672.5042119313553, 3842.615738426191, 3935.822887970048, 3941.7240793144206, 4003.179348233605, 1794.1388133695898, 1812.8216659171644, 1849.694800357926, 1900.1354383755358, 1904.4578679848385, 775.6974779835869, 850.2305413600701, 859.1880672764178, 902.0798785239019, 903.746950853762, 16595.004299742053, 16723.49829505117, 17400.5649858752, 17655.55861103457, 17873.553161171076, 805.7582725182422, 827.6730691376872, 856.961436735336, 880.4541184465544, 882.4264228251559, 9519.428834269966, 9599.0, 9721.270904682176, 9780.573653860642, 10028.749281268027, 362227.0, 365015.0, 369291.0, 369870.0, 370564.0, 79587.0, 82090.0, 82999.0, 83162.16837831665, 83319.58340208381, 898.9505577193187, 899.5187574647663, 919.1084647891535, 921.953902304882, 924.0343840686498, 14981.925090374478, 15323.61690957735, 15337.0, 15510.379584816481, 15741.685166296838, 38161.6183838158, 38589.0, 38657.42013869851, 39206.41190382204, 39258.0, 48791.5120848787, 51945.740271298404, 52571.0, 52581.211281831565, 52667.0, 5358.249845021622, 6220.782272620437, 7205.495615306878, 7617.69529218825, 8073.192680732115, 11454.312741235219, 12186.451609677762, 12271.141020128505, 12351.75296494083, 12473.93763031179, 10471.68584942453, 10512.26414151002, 10620.628278010232, 10876.836847447137, 10896.564137434414, 10047.447390393598, 10285.794284114425, 10467.319624224401, 10579.62971296001, 10595.523201455799, 7540.660670269741, 10694.983976522219, 10735.89264107349, 10890.673279801618, 10985.780284394426, 7627.313541781266, 7732.420068494773, 7806.92193078062, 7966.800829979065, 8112.75661730149, 8665.306775458075, 9936.20510359184, 9946.055124763136, 10079.748006299902, 10751.516181771683], "value": 8189.370782378886, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1357.402742793171, 1434.4835859090729, 1496.5809573319475, 1691.2896583434956, 1718.1065845760204, 7549.584772837492, 8066.516009039462, 8138.348932085434, 8148.185181481849, 8153.551554664498, 6918.135233095863, 7129.89305160423, 7529.84940301195, 7841.411894107936, 7994.520328780262, 2137.0490131891315, 2160.924367647133, 2166.4042388343255, 2168.1977668262766, 2170.283806343911, 2059.9176032958662, 2105.3368189020484, 2118.4386137673528, 2119.8410119241044, 2121.16214095433, 1802.0269054710507, 1865.8880467171946, 1867.9719804202948, 1876.5496280892555, 2084.3121769815925, 2117.0579092303933, 2135.231316725977, 2135.7543882453406, 2141.1863491873146, 2144.281665642012, 2074.9377518674464, 2082.968755468654, 2100.537881666031, 2142.4001279641725, 2145.4743587820926, 6898.551594146415, 7639.395726897358, 7886.842263154762, 8144.470609410369, 8179.631916563769, 4443.0, 4565.977170114128, 4587.082583483317, 4588.24293991491, 4590.242609969351, 2663.946721065568, 2735.0564055401055, 2778.333200031998, 2779.7915156363356, 2781.1656503049207, 808.0505406147753, 817.3297895725508, 831.339085427087, 840.3865178419727, 847.254416113822, 10827.729306767395, 10878.945605272002, 10929.836052459219, 10939.234253602252, 10954.780904381867, 3988.12261302513, 4034.3948407739076, 4198.139381426861, 4202.054537728986, 4209.621134097946, 9240.21458176049, 9242.72271831846, 9262.073792620818, 9271.768205794775, 9318.207952324128, 4586.88532786683, 4587.472440669299, 4595.954040459619, 4598.379218805485, 4601.67788254819, 4091.4272001919753, 4167.041580436517, 4170.749755014709, 4170.854020109282, 4174.227767862955, 3609.8917032488544, 3621.8913432597064, 3646.489491471143, 3650.5619325681087, 3741.420079887622, 1132.3715337987496, 1134.2910680824484, 1143.845580846575, 1146.140394703972, 1147.1740346950182, 687.5908834243617, 821.7288294862681, 824.2911096457042, 835.6114406800746, 855.4183155454226, 5069.923951140736, 5133.4609865964285, 5146.536811686891, 5166.250893620404, 5240.816571419982, 359.86505060602275, 370.4110464361678, 371.21673269401543, 373.44543353120594, 382.4225419616399, 3518.208403109331, 3533.5229743984746, 3538.5186101149993, 3586.085548185196, 3599.676029157336, 9594.232461403071, 9973.30186886911, 9998.15015723657, 10003.0, 10006.69979900604, 9778.75553111178, 9977.700668979796, 9991.550380232762, 9994.300398972002, 9999.950000249952, 7487.887681684779, 7592.620368981528, 7616.200298968529, 7619.08570971487, 7624.618769061524, 5006.098902197639, 5008.223725322581, 5106.234064890296, 5240.68555886648, 5297.8145764898045, 9078.636854526008, 9125.908740912506, 9248.722538323862, 9269.768255793659, 9288.767780805534, 8958.596863141305, 9254.4910029949, 9351.672691455766, 9374.203192728422, 9440.386374885611, 6560.737570497126, 6772.762953296611, 6927.896081558882, 6932.410745086522, 7054.964725176341, 7707.34487568563, 7721.073471183494, 7761.61191940412, 7768.572728499987, 7796.337311328601, 6023.247094113236, 6033.456988871023, 6933.965330173317, 7049.400800931773, 7229.060222171084, 6774.796756097325, 6778.7288508459105, 6812.693428795816, 6851.931480685329, 6975.023496710363, 6453.225612926479, 6463.709133089116, 6500.512461565496, 6541.443977261795, 6550.0, 4270.145970805789, 4414.580614841585, 4479.417675702138, 4511.571400716926, 4546.068056048436, 4612.884677882946, 4641.3734145889875, 4664.976675116603, 4665.6967297125575, 4737.194676904865], "value": 4019.4717593965925, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [293.6432234834677, 296.9361587258739, 299.47890670233784, 304.4838997898563, 306.15348561228205, 4801.303810947415, 4824.83113091041, 4827.324174615556, 4837.443693975199, 4843.903121937564, 4739.691920025196, 4759.547842954922, 4766.928496072553, 4767.594754445868, 4773.546513081261, 3818.5417749870053, 3821.866234681787, 3822.69418446525, 3825.4261860720835, 3845.5769865314933, 3565.937608490795, 3659.8837354606835, 3819.2361527694434, 3821.9044523886846, 3836.0819590204896, 3277.3609146216377, 3432.541170002751, 3647.963520364802, 3669.4495825626104, 3768.679662228714, 3655.5430571178604, 3668.816559172031, 3715.2383761329133, 3730.5709843367954, 3735.9252814943547, 3354.194993201638, 3364.243045314809, 3368.2253081791323, 3377.4089534331392, 3385.3737058643983, 4468.8882777930485, 4567.794449249792, 4684.32077348786, 4701.553352431513, 4702.3181638662545, 4302.870913872589, 4303.849365272201, 4308.870733877989, 4315.741055536678, 4319.524852266248, 5028.974855125737, 5031.899362012739, 5038.042771873333, 5039.798408063673, 5043.571296439807, 3523.6300188480095, 3657.158853463718, 3673.6142705015855, 3676.8529258829612, 3696.650722486273, 5187.299714538564, 5197.766100525448, 5205.427402985669, 5211.661242019257, 5221.921671174898, 3753.8873833784482, 3762.360398732222, 3765.6799172070682, 3767.0, 3780.8676696315497, 3804.9619503804606, 3805.1438426353848, 3813.237352529505, 3813.694904407641, 3816.14136819219, 4143.97928010358, 4199.790010499524, 4207.948012996751, 4212.389203565466, 4291.463567054118, 4965.3048573199785, 4968.428630707443, 5002.474740152305, 5010.423801262828, 5024.422191447957, 1317.7562151002096, 1327.1307293722434, 1328.4885319152004, 1331.2826453874586, 1334.4128583423262, 809.4536188073027, 858.9184027517376, 858.9914100858912, 871.2507243770352, 872.6029656506274, 3929.233799409145, 3945.704072194597, 3967.484227050523, 4004.2391945530258, 4007.5591684914634, 4496.3705081288645, 4542.955120322345, 4555.794989225493, 4557.612602928788, 4565.744420284382, 3979.4826672532386, 3995.420664003703, 4002.9570134164705, 4008.2785098681934, 4009.3785463252657, 2280.669302951063, 2436.768506991833, 2442.2184900831917, 2450.4486490539844, 2451.669024681645, 4298.656107511391, 4303.311470164758, 4307.406259683874, 4309.569043095728, 4322.7680111168165, 4983.202687569971, 5054.873628159326, 5267.394249661262, 5267.841964741064, 5301.708406037628, 4845.733484658378, 4848.733319667382, 4858.0, 4866.975665121652, 4870.659053866266, 4885.975570122127, 5158.742062896915, 5165.690058596496, 5169.043726910533, 5170.121079416433, 5034.748262586929, 5047.687601223782, 5058.519440653132, 5087.974560127176, 5091.923621145612, 4818.10864989978, 4830.1305764961235, 4833.95166048335, 4836.322914791862, 4850.5149485052625, 3721.7394782364972, 3757.304898593769, 3764.360058790067, 3767.7550959187565, 3778.282126395976, 4902.558769710743, 5115.667481613683, 5147.459516750687, 5151.459096794782, 5170.586353091669, 4949.851504454872, 4966.1376983631135, 4977.481868030285, 4983.352164218773, 4984.6261530384645, 4979.427365852974, 4994.076095922266, 5009.574186194214, 5031.471695472069, 5036.0, 4743.881402964816, 4999.275105109811, 5010.498950105106, 5016.272640467185, 5017.0, 5054.220178901663, 5092.668976516515, 5099.286099945936, 5099.56653684441, 5107.846764597068, 4783.425988881357, 5000.199968005102, 5008.724520151427, 5009.423916249678, 5024.0], "value": 3736.057474410606, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [640.3500447046248, 642.4507046475263, 683.8290427393151, 705.5308220033678, 753.7512620835125, 13334.199948003114, 14058.367373468192, 14083.718325633481, 14094.929525352372, 14876.553703388889, 13578.117422367539, 14265.072770269926, 14288.142711437295, 14348.856511434882, 14352.354144063516, 624.1449214576037, 741.8145463634091, 759.290063790355, 781.4920301803816, 786.382689588673, 786.8583654942108, 788.2432864450135, 788.692409960116, 789.8617741895174, 789.9763007109796, 818.3535007344191, 818.6357071103362, 818.8730746734236, 819.5082950229875, 819.6434550970317, 640.190159448296, 658.4403257231315, 658.6476235214137, 661.7121552124842, 812.5287333346645, 582.790195529609, 599.9760009599654, 600.6756351570147, 603.7947097986662, 605.1527860994598, 12709.428075736614, 12754.36228188587, 12835.87164128356, 12855.550055748005, 13181.736365272642, 11621.535138594447, 11979.401029948554, 12025.759484810254, 12052.397380130958, 12348.876511234863, 10354.689359319158, 10381.532831022621, 10425.843612345821, 10457.267991240617, 10522.736931576695, 3719.3119272934596, 3731.440283957401, 3765.0963768695588, 3782.243551289753, 3805.010697218743, 65322.10202931508, 65712.0, 65848.67075664639, 65903.67048164729, 66137.3386266136, 9671.371360861522, 9841.852372214422, 10062.849057264148, 10071.0, 10078.294519383573, 17992.1003949802, 18017.639647206983, 18031.63936721258, 18144.818551814576, 18149.455516334532, 6517.934820651828, 6523.902141467882, 6600.636964966973, 6643.800685979429, 6668.666566671647, 3728.5339332583426, 3740.9064773380883, 3744.8689295874515, 3753.662170404622, 3773.3773927301686, 2768.5570308750503, 2860.856957152134, 2868.756155726745, 2870.3398218409884, 2874.798764086494, 472.4613940108279, 477.5248627615475, 479.8920242945379, 483.6300230323805, 485.4514398729413, 439.3673110720552, 471.4319245309462, 493.69390977593406, 516.3648712084157, 545.585355130104, 7487.588182650006, 7496.400287976949, 7641.2740789624895, 7745.993020907359, 7907.288344049063, 440.3785675847805, 475.3653872080811, 506.2406390414378, 527.1276038156857, 529.2246858352455, 3417.8120203388553, 3503.5555885924136, 3739.420389839525, 3762.124423388605, 3891.552471465761, 84072.0, 92180.53909730543, 96121.5193924026, 96150.51924740331, 96442.0, 82917.0, 83442.58278708567, 83682.16317836866, 84105.63820601541, 84856.0, 46805.5319446808, 70447.0, 76631.23368766352, 77277.6136119327, 77346.0, 6511.413972742286, 6741.898871516833, 6779.525433219627, 6980.7207711693, 6984.0, 41820.372694410216, 43074.0, 43847.0, 44484.11031779411, 44638.10723785571, 55226.0, 55619.0, 56407.43592564186, 56452.43547564472, 57057.0, 10481.37111773296, 10703.090237329914, 11032.558697652004, 11048.613298534512, 11119.944400277947, 11205.159613029218, 11396.658100257006, 12517.624471265877, 13148.0, 13465.498204533957, 11059.668209953714, 11267.661970140909, 11941.223820451643, 12268.815967760313, 12310.569130080405, 10379.584816607252, 10561.313514621525, 10771.13830893511, 11149.163812714241, 11418.771624567296, 10079.69760907174, 10208.132308753839, 10236.539355729159, 10281.948590257001, 10495.895041049796, 9324.720258392259, 9715.319927605282, 10287.691369258935, 10317.432541210306, 10388.480575971322, 9867.16129129032, 10068.39589624625, 10126.898731012596, 10238.129758970274, 10309.432981186106], "value": 6333.8480667845215, "unit": "score"}], "name": "dromaeo_css", "value": 6224.963750257443, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 113.0, 113.0, 112.0, 114.0, 114.0, 113.0, 114.0, 114.0, 114.0], "value": 112.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 122.0, 124.0, 179.0, 127.0, 123.0, 147.0, 122.0, 161.0, 121.0], "value": 137.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 161.0, 162.0, 161.0, 162.0, 162.0, 162.0, 165.0, 163.0], "value": 162.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 76.0, 121.0, 77.0, 78.0, 76.0, 76.0, 117.0, 75.0], "value": 84.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 114.0, 85.0, 85.0, 85.0, 127.0, 85.0, 85.0, 126.0], "value": 96.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 118.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 147.0, 146.0, 146.0, 147.0, 147.0, 147.0, 146.0, 146.0], "value": 146.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 66.0, 64.0, 64.0, 65.0, 66.0, 66.0, 66.0, 65.0], "value": 65.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 67.0, 65.0, 65.0, 67.0, 65.0, 65.0, 65.0, 65.0, 67.0], "value": 65.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 78.0, 87.0, 81.0, 78.0, 78.0, 82.0, 78.0, 78.0, 81.0], "value": 79.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 139.0, 128.0, 128.0, 128.0, 129.0, 138.0, 130.0, 204.0, 139.0], "value": 140.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 165.0, 163.0, 165.0, 164.0, 172.0, 166.0, 165.0, 165.0], "value": 165.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 66.0, 66.0, 66.0, 65.0, 66.0, 65.0, 66.0, 65.0], "value": 65.8, "unit": "score"}], "name": "kraken", "value": 1533.5, "alertThreshold": 2.0}]} 03:50:42 INFO - Return code: 0 03:50:42 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:50:42 INFO - # TBPL SUCCESS # 03:50:42 INFO - Running post-action listener: _resource_record_post_action 03:50:42 INFO - ##### 03:50:42 INFO - ##### Finished run-tests step (success) 03:50:42 INFO - ##### 03:50:42 INFO - Running post-run listener: _resource_record_post_run 03:50:42 INFO - Total resource usage - Wall time: 1204s; CPU: 13.0%; Read bytes: 8192; Write bytes: 544997376; Read time: 232; Write time: 1849736 03:50:42 INFO - TinderboxPrint: CPU usage
13.1% 03:50:42 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 232 03:50:42 INFO - TinderboxPrint: I/O write bytes / time
544,997,376 / 1,849,736 03:50:42 INFO - TinderboxPrint: CPU idle
8,346.9 (86.9%) 03:50:42 INFO - TinderboxPrint: CPU user
1,203.7 (12.5%) 03:50:42 INFO - TinderboxPrint: Swap in / out
0 / 0 03:50:42 INFO - install - Wall time: 17s; CPU: 20.0%; Read bytes: 0; Write bytes: 247402496; Read time: 0; Write time: 1200040 03:50:42 INFO - run-tests - Wall time: 1187s; CPU: 13.0%; Read bytes: 4096; Write bytes: 297594880; Read time: 224; Write time: 649696 03:50:42 INFO - Running post-run listener: _upload_blobber_files 03:50:42 INFO - Blob upload gear active. 03:50:42 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:50:42 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 03:50:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Autoland-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:50:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Autoland-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:50:43 INFO - (blobuploader) - INFO - Open directory for files ... 03:50:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:50:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:50:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:50:46 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:50:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:50:46 INFO - (blobuploader) - INFO - Done attempting. 03:50:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:50:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:50:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:50:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:50:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:50:47 INFO - (blobuploader) - INFO - Done attempting. 03:50:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:50:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:50:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:50:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:50:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:50:48 INFO - (blobuploader) - INFO - Done attempting. 03:50:48 INFO - (blobuploader) - INFO - Iteration through files over. 03:50:48 INFO - Return code: 0 03:50:48 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:50:48 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:50:48 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/203ae1ae6d9177f88fc072ca063fdd3987268133812002a44fc81664e70c7b7fed25a18757e1d52d598ff9731c6b287009b73d189e6c79cb059c3ede240b756e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/500e6a31f225d24679bf268353d542153f915f3d0747797d016f08d35cd9b4ddcf35c8aea6233004b0f8dc12d42237267acf599821718cd4fda897a6ae3bd307", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/cd7040d4336e90d649d7f32fd1ce326151ca32243050ad91e2d1e79f0bbf77f70a967e7866b4e009395240a243b72d71b4c922922ab37f3c9684d501f1320edd"} 03:50:48 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:50:48 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:50:48 INFO - Contents: 03:50:48 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/203ae1ae6d9177f88fc072ca063fdd3987268133812002a44fc81664e70c7b7fed25a18757e1d52d598ff9731c6b287009b73d189e6c79cb059c3ede240b756e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/500e6a31f225d24679bf268353d542153f915f3d0747797d016f08d35cd9b4ddcf35c8aea6233004b0f8dc12d42237267acf599821718cd4fda897a6ae3bd307", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/cd7040d4336e90d649d7f32fd1ce326151ca32243050ad91e2d1e79f0bbf77f70a967e7866b4e009395240a243b72d71b4c922922ab37f3c9684d501f1320edd"} 03:50:48 INFO - Running post-run listener: copy_logs_to_upload_dir 03:50:48 INFO - Copying logs to upload dir... 03:50:48 INFO - mkdir: /builds/slave/test/build/upload/logs 03:50:48 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1251.218242 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2016-07-14 03:50:48.107116) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-14 03:50:48.111117) ========= 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=df17445c3590ff7897617a0e00000225-1468492193.762447-1086351707 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/203ae1ae6d9177f88fc072ca063fdd3987268133812002a44fc81664e70c7b7fed25a18757e1d52d598ff9731c6b287009b73d189e6c79cb059c3ede240b756e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/500e6a31f225d24679bf268353d542153f915f3d0747797d016f08d35cd9b4ddcf35c8aea6233004b0f8dc12d42237267acf599821718cd4fda897a6ae3bd307", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/cd7040d4336e90d649d7f32fd1ce326151ca32243050ad91e2d1e79f0bbf77f70a967e7866b4e009395240a243b72d71b4c922922ab37f3c9684d501f1320edd"} build_url:https://queue.taskcluster.net/v1/task/EpF1zUodTk-tAcL3Hg-05Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011356 build_url: 'https://queue.taskcluster.net/v1/task/EpF1zUodTk-tAcL3Hg-05Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/203ae1ae6d9177f88fc072ca063fdd3987268133812002a44fc81664e70c7b7fed25a18757e1d52d598ff9731c6b287009b73d189e6c79cb059c3ede240b756e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/500e6a31f225d24679bf268353d542153f915f3d0747797d016f08d35cd9b4ddcf35c8aea6233004b0f8dc12d42237267acf599821718cd4fda897a6ae3bd307", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/cd7040d4336e90d649d7f32fd1ce326151ca32243050ad91e2d1e79f0bbf77f70a967e7866b4e009395240a243b72d71b4c922922ab37f3c9684d501f1320edd"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-14 03:50:48.137237) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-14 03:50:48.137612) ========= 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=df17445c3590ff7897617a0e00000225-1468492193.762447-1086351707 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004440 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-14 03:50:48.220999) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-14 03:50:48.221427) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-14 03:50:48.221892) ========= ========= Total master_lag: 0.17 =========