builder: autoland_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-058 starttime: 1467361894.23 results: success (0) buildid: 20160701000923 builduid: 9aed0462713e41458c0c0924940ddbff revision: cd5a30817ea4389a01482ef9df5fb0017d26d36c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-01 01:31:34.228200) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-01 01:31:34.228696) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-01 01:31:34.229008) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-01 01:31:34.266598) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 01:31:34.266902) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=0e2a256762fed810e2f0f810000001b3-1467348581.27826-223990481 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-01 01:31:35-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 218M=0s 2016-07-01 01:31:35 (218 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.146056 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 01:31:34.428534) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 01:31:34.428897) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=0e2a256762fed810e2f0f810000001b3-1467348581.27826-223990481 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014281 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 01:31:34.479437) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 01:31:34.480111) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev cd5a30817ea4389a01482ef9df5fb0017d26d36c --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 cd5a30817ea4389a01482ef9df5fb0017d26d36c --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=0e2a256762fed810e2f0f810000001b3-1467348581.27826-223990481 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-01 01:31:35,793 truncating revision to first 12 chars 2016-07-01 01:31:35,793 Setting DEBUG logging. 2016-07-01 01:31:35,793 attempt 1/10 2016-07-01 01:31:35,793 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/cd5a30817ea4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-01 01:31:36,190 unpacking tar archive at: autoland-cd5a30817ea4/testing/mozharness/ program finished with exit code 0 elapsedTime=0.727481 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 01:31:35.222429) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-01 01:31:35.222785) ========= script_repo_revision: cd5a30817ea4389a01482ef9df5fb0017d26d36c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-01 01:31:35.223254) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-01 01:31:35.223629) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-01 01:31:35.233361) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-07-01 01:31:35.233687) ========= /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=0e2a256762fed810e2f0f810000001b3-1467348581.27826-223990481 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 01:31:36 INFO - MultiFileLogger online at 20160701 01:31:36 in /builds/slave/test 01:31:36 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 01:31:36 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:31:36 INFO - {'append_to_log': False, 01:31:36 INFO - 'base_work_dir': '/builds/slave/test', 01:31:36 INFO - 'blob_upload_branch': 'Autoland-Non-PGO', 01:31:36 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:31:36 INFO - 'branch': 'Autoland-Non-PGO', 01:31:36 INFO - 'buildbot_json_path': 'buildprops.json', 01:31:36 INFO - 'config_files': ('talos/linux_config.py',), 01:31:36 INFO - 'default_actions': ('clobber', 01:31:36 INFO - 'read-buildbot-config', 01:31:36 INFO - 'download-and-extract', 01:31:36 INFO - 'populate-webroot', 01:31:36 INFO - 'create-virtualenv', 01:31:36 INFO - 'install', 01:31:36 INFO - 'run-tests'), 01:31:36 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:31:36 INFO - 'download_minidump_stackwalk': True, 01:31:36 INFO - 'download_symbols': 'ondemand', 01:31:36 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:31:36 INFO - 'tooltool.py': '/tools/tooltool.py', 01:31:36 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:31:36 INFO - '/tools/misc-python/virtualenv.py')}, 01:31:36 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:31:36 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:31:36 INFO - 'installer_path': 'installer.exe', 01:31:36 INFO - 'log_level': 'info', 01:31:36 INFO - 'log_name': 'talos', 01:31:36 INFO - 'log_to_console': True, 01:31:36 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 01:31:36 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 01:31:36 INFO - 'opt_config_files': (), 01:31:36 INFO - 'pip_index': False, 01:31:36 INFO - 'sps_profile': False, 01:31:36 INFO - 'sps_profile_interval': 0, 01:31:36 INFO - 'suite': 'dromaeojs', 01:31:36 INFO - 'system_bits': '32', 01:31:36 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:31:36 INFO - 'title': 'talos-linux64-ix-058', 01:31:36 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:31:36 INFO - 'use_talos_json': True, 01:31:36 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:31:36 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:31:36 INFO - 'work_dir': 'build'} 01:31:36 INFO - ##### 01:31:36 INFO - ##### Running clobber step. 01:31:36 INFO - ##### 01:31:36 INFO - Running pre-action listener: _resource_record_pre_action 01:31:36 INFO - Running main action method: clobber 01:31:36 INFO - rmtree: /builds/slave/test/build 01:31:36 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:31:37 INFO - Running post-action listener: _resource_record_post_action 01:31:37 INFO - ##### 01:31:37 INFO - ##### Finished clobber step (success) 01:31:37 INFO - ##### 01:31:37 INFO - ##### 01:31:37 INFO - ##### Running read-buildbot-config step. 01:31:37 INFO - ##### 01:31:37 INFO - Running pre-action listener: _resource_record_pre_action 01:31:37 INFO - Running main action method: read_buildbot_config 01:31:37 INFO - Using buildbot properties: 01:31:37 INFO - { 01:31:37 INFO - "project": "", 01:31:37 INFO - "product": "firefox", 01:31:37 INFO - "script_repo_revision": "production", 01:31:37 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs", 01:31:37 INFO - "repository": "", 01:31:37 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland talos dromaeojs", 01:31:37 INFO - "buildid": "20160701000923", 01:31:37 INFO - "pgo_build": "False", 01:31:37 INFO - "basedir": "/builds/slave/test", 01:31:37 INFO - "buildnumber": 26, 01:31:37 INFO - "slavename": "talos-linux64-ix-058", 01:31:37 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 01:31:37 INFO - "platform": "ubuntu64_hw", 01:31:37 INFO - "scheduler": "tests-autoland-linux64-talos", 01:31:37 INFO - "branch": "autoland", 01:31:37 INFO - "repo_path": "integration/autoland", 01:31:37 INFO - "revision": "cd5a30817ea4389a01482ef9df5fb0017d26d36c", 01:31:37 INFO - "stage_platform": "linux64", 01:31:37 INFO - "builduid": "9aed0462713e41458c0c0924940ddbff", 01:31:37 INFO - "slavebuilddir": "test" 01:31:37 INFO - } 01:31:37 INFO - Found installer url https://queue.taskcluster.net/v1/task/ArR8ucauQGy59IodfwlN_g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 01:31:37 INFO - Running post-action listener: _resource_record_post_action 01:31:37 INFO - ##### 01:31:37 INFO - ##### Finished read-buildbot-config step (success) 01:31:37 INFO - ##### 01:31:37 INFO - ##### 01:31:37 INFO - ##### Running download-and-extract step. 01:31:37 INFO - ##### 01:31:37 INFO - Running pre-action listener: _resource_record_pre_action 01:31:37 INFO - Running main action method: download_and_extract 01:31:37 INFO - mkdir: /builds/slave/test/build/tests 01:31: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')]} 01:31:37 INFO - https://queue.taskcluster.net/v1/task/ArR8ucauQGy59IodfwlN_g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 01:31:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ArR8ucauQGy59IodfwlN_g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 01:31:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ArR8ucauQGy59IodfwlN_g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 01:31:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ArR8ucauQGy59IodfwlN_g/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 01:31:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ArR8ucauQGy59IodfwlN_g/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 01:31:45 INFO - Downloaded 1361 bytes. 01:31:45 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 01:31:45 INFO - Using the following test package requirements: 01:31:45 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 01:31:45 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:31:45 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 01:31:45 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:31:45 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 01:31:45 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:31:45 INFO - u'jsshell-linux-x86_64.zip'], 01:31:45 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:31:45 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 01:31:45 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 01:31:45 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:31:45 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 01:31:45 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:31:45 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 01:31:45 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:31:45 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 01:31:45 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:31:45 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 01:31:45 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 01:31:45 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')]} 01:31:45 INFO - https://queue.taskcluster.net/v1/task/ArR8ucauQGy59IodfwlN_g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:31:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ArR8ucauQGy59IodfwlN_g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:31:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ArR8ucauQGy59IodfwlN_g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:31:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ArR8ucauQGy59IodfwlN_g/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 01:31:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ArR8ucauQGy59IodfwlN_g/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 01:31:49 INFO - Downloaded 22701821 bytes. 01:31:49 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'] 01:31:49 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 01:31:51 INFO - Return code: 0 01:31:51 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 01:31:51 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')]} 01:31:51 INFO - https://queue.taskcluster.net/v1/task/ArR8ucauQGy59IodfwlN_g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:31:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ArR8ucauQGy59IodfwlN_g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:31:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ArR8ucauQGy59IodfwlN_g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:31:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ArR8ucauQGy59IodfwlN_g/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 01:31:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ArR8ucauQGy59IodfwlN_g/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 01:31:52 INFO - Downloaded 22701821 bytes. 01:31:52 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'] 01:31:52 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 01:31:53 INFO - Return code: 0 01:31:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 01:31:53 INFO - https://queue.taskcluster.net/v1/task/ArR8ucauQGy59IodfwlN_g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 01:31:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ArR8ucauQGy59IodfwlN_g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 01:31:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ArR8ucauQGy59IodfwlN_g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 01:31:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ArR8ucauQGy59IodfwlN_g/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 01:31:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ArR8ucauQGy59IodfwlN_g/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 01:31:54 INFO - Downloaded 14405242 bytes. 01:31:54 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'] 01:31:54 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 01:31:55 INFO - Return code: 0 01:31: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')]} 01:31:55 INFO - https://queue.taskcluster.net/v1/task/ArR8ucauQGy59IodfwlN_g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 01:31:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ArR8ucauQGy59IodfwlN_g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 01:31:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ArR8ucauQGy59IodfwlN_g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 01:31:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ArR8ucauQGy59IodfwlN_g/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 01:31:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ArR8ucauQGy59IodfwlN_g/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 01:31:56 INFO - Downloaded 56454272 bytes. 01:31:56 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ArR8ucauQGy59IodfwlN_g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 01:31:56 INFO - mkdir: /builds/slave/test/properties 01:31:56 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:31:56 INFO - Writing to file /builds/slave/test/properties/build_url 01:31:56 INFO - Contents: 01:31:56 INFO - build_url:https://queue.taskcluster.net/v1/task/ArR8ucauQGy59IodfwlN_g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 01:31:57 INFO - Running post-action listener: _resource_record_post_action 01:31:57 INFO - Running post-action listener: set_extra_try_arguments 01:31:57 INFO - ##### 01:31:57 INFO - ##### Finished download-and-extract step (success) 01:31:57 INFO - ##### 01:31:57 INFO - ##### 01:31:57 INFO - ##### Running populate-webroot step. 01:31:57 INFO - ##### 01:31:57 INFO - Running pre-action listener: _resource_record_pre_action 01:31:57 INFO - Running main action method: populate_webroot 01:31:57 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:31:57 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:31:57 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:31:57 INFO - '--tppagecycles', 01:31:57 INFO - '7'], 01:31:57 INFO - 'tests': ['tsvgm']}}, 01:31:57 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 01:31:57 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:31:57 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 01:31:57 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 01:31:57 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:31:57 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 01:31:57 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:31:57 INFO - 'talos_options': ['--disable-e10s'], 01:31:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:31:57 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:31:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:31:57 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:31:57 INFO - 'talos_options': ['--disable-e10s'], 01:31:57 INFO - 'tests': ['damp', 'tps']}, 01:31:57 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:31:57 INFO - 'tests': ['damp', 'tps']}, 01:31:57 INFO - 'g3': {'talos_options': ['--disable-e10s'], 01:31:57 INFO - 'tests': ['dromaeo_dom']}, 01:31:57 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:31:57 INFO - 'g4': {'talos_options': ['--disable-e10s'], 01:31:57 INFO - 'tests': ['basic_compositor_video']}, 01:31:57 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 01:31:57 INFO - 'other': {'talos_options': ['--disable-e10s'], 01:31:57 INFO - 'tests': ['a11yr', 01:31:57 INFO - 'ts_paint', 01:31:57 INFO - 'tpaint', 01:31:57 INFO - 'sessionrestore', 01:31:57 INFO - 'sessionrestore_no_auto_restore', 01:31:57 INFO - 'tabpaint']}, 01:31:57 INFO - 'other-e10s': {'tests': ['a11yr', 01:31:57 INFO - 'ts_paint', 01:31:57 INFO - 'tpaint', 01:31:57 INFO - 'sessionrestore', 01:31:57 INFO - 'sessionrestore_no_auto_restore', 01:31:57 INFO - 'tabpaint']}, 01:31:57 INFO - 'other-e10s_l64': {'tests': ['a11yr', 01:31:57 INFO - 'ts_paint', 01:31:57 INFO - 'tpaint', 01:31:57 INFO - 'sessionrestore', 01:31:57 INFO - 'sessionrestore_no_auto_restore', 01:31:57 INFO - 'tabpaint']}, 01:31:57 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 01:31:57 INFO - 'ts_paint', 01:31:57 INFO - 'tpaint', 01:31:57 INFO - 'sessionrestore', 01:31:57 INFO - 'sessionrestore_no_auto_restore', 01:31:57 INFO - 'tabpaint']}, 01:31:57 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 01:31:57 INFO - 'tests': ['a11yr', 01:31:57 INFO - 'ts_paint', 01:31:57 INFO - 'tpaint', 01:31:57 INFO - 'sessionrestore', 01:31:57 INFO - 'sessionrestore_no_auto_restore', 01:31:57 INFO - 'tabpaint']}, 01:31:57 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 01:31:57 INFO - 'tests': ['a11yr', 01:31:57 INFO - 'ts_paint', 01:31:57 INFO - 'tpaint', 01:31:57 INFO - 'sessionrestore', 01:31:57 INFO - 'sessionrestore_no_auto_restore', 01:31:57 INFO - 'tabpaint']}, 01:31:57 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 01:31:57 INFO - 'tests': ['tsvgx', 01:31:57 INFO - 'tsvgr_opacity', 01:31:57 INFO - 'tart', 01:31:57 INFO - 'tscrollx', 01:31:57 INFO - 'cart']}, 01:31:57 INFO - 'svgr-e10s': {'tests': ['tsvgx', 01:31:57 INFO - 'tsvgr_opacity', 01:31:57 INFO - 'tart', 01:31:57 INFO - 'tscrollx', 01:31:57 INFO - 'cart']}, 01:31:57 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:31:57 INFO - 'talos_options': ['--disable-e10s'], 01:31:57 INFO - 'tests': ['tp5o']}, 01:31:57 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:31:57 INFO - 'tests': ['tp5o']}, 01:31:57 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:31:57 INFO - 'talos_options': ['--disable-e10s', 01:31:57 INFO - '--xperf_path', 01:31:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:31:57 INFO - 'tests': ['tp5n']}, 01:31:57 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:31:57 INFO - 'talos_options': ['--xperf_path', 01:31:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:31:57 INFO - 'tests': ['tp5n']}}, 01:31:57 INFO - 'talos.zip': {'path': '', 01:31:57 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:31:57 INFO - Running post-action listener: _resource_record_post_action 01:31:57 INFO - ##### 01:31:57 INFO - ##### Finished populate-webroot step (success) 01:31:57 INFO - ##### 01:31:57 INFO - ##### 01:31:57 INFO - ##### Running create-virtualenv step. 01:31:57 INFO - ##### 01:31:57 INFO - Running pre-action listener: _resource_record_pre_action 01:31:57 INFO - Running main action method: create_virtualenv 01:31:57 INFO - Creating virtualenv /builds/slave/test/build/venv 01:31:57 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 01:31:57 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:31:57 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:31:57 INFO - Using real prefix '/usr' 01:31:57 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:31:57 INFO - Installing distribute.............................................................................................................................................................................................done. 01:31:59 INFO - Installing pip.................done. 01:31:59 INFO - Return code: 0 01:31:59 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:31:59 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')]} 01:31:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:31:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:31:59 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')]} 01:31:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:31:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:31:59 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 0x142e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16ef180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16ed3b0>, '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 0x16ee2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16ee740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1467348581.27826-223990481', '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 01:31:59 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 01:31:59 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 01:31:59 INFO - Using env: {'DISPLAY': ':0', 01:31:59 INFO - 'HOME': '/home/cltbld', 01:31:59 INFO - 'LANG': 'en_US.UTF-8', 01:31:59 INFO - 'LANGUAGE': 'en_US:en', 01:31:59 INFO - 'LOGNAME': 'cltbld', 01:31:59 INFO - 'MAIL': '/var/mail/cltbld', 01:31:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:31:59 INFO - 'MOZ_NO_REMOTE': '1', 01:31:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:31:59 INFO - 'NO_EM_RESTART': '1', 01:31:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:31:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:31:59 INFO - 'PWD': '/builds/slave/test', 01:31:59 INFO - 'SHELL': '/bin/bash', 01:31:59 INFO - 'SHLVL': '1', 01:31:59 INFO - 'TERM': 'linux', 01:31:59 INFO - 'TMOUT': '86400', 01:31:59 INFO - 'USER': 'cltbld', 01:31:59 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1467348581.27826-223990481', 01:31:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:31:59 INFO - '_': '/tools/buildbot/bin/python'} 01:32:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:32:00 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 01:32:00 INFO - Cleaning up... 01:32:00 INFO - Return code: 0 01:32:00 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 01:32:00 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')]} 01:32:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:32:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:32:00 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')]} 01:32:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:32:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:32:00 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 0x142e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16ef180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16ed3b0>, '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 0x16ee2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16ee740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1467348581.27826-223990481', '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 01:32:00 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 01:32:00 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 01:32:00 INFO - Using env: {'DISPLAY': ':0', 01:32:00 INFO - 'HOME': '/home/cltbld', 01:32:00 INFO - 'LANG': 'en_US.UTF-8', 01:32:00 INFO - 'LANGUAGE': 'en_US:en', 01:32:00 INFO - 'LOGNAME': 'cltbld', 01:32:00 INFO - 'MAIL': '/var/mail/cltbld', 01:32:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:32:00 INFO - 'MOZ_NO_REMOTE': '1', 01:32:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:32:00 INFO - 'NO_EM_RESTART': '1', 01:32:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:32:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:32:00 INFO - 'PWD': '/builds/slave/test', 01:32:00 INFO - 'SHELL': '/bin/bash', 01:32:00 INFO - 'SHLVL': '1', 01:32:00 INFO - 'TERM': 'linux', 01:32:00 INFO - 'TMOUT': '86400', 01:32:00 INFO - 'USER': 'cltbld', 01:32:00 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1467348581.27826-223990481', 01:32:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:32:00 INFO - '_': '/tools/buildbot/bin/python'} 01:32:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:32:00 INFO - Downloading/unpacking psutil>=3.1.1 01:32:00 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 01:32:00 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 01:32:00 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 01:32:00 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 01:32:00 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 01:32:00 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 01:32:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:32:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:32:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:32:02 INFO - Installing collected packages: psutil 01:32:02 INFO - Running setup.py install for psutil 01:32:02 INFO - building 'psutil._psutil_linux' extension 01:32:02 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 01:32:02 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 01:32:02 INFO - building 'psutil._psutil_posix' extension 01:32:02 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 01:32:02 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 01:32:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:32:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:32:02 INFO - Successfully installed psutil 01:32:02 INFO - Cleaning up... 01:32:02 INFO - Return code: 0 01:32:02 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 01:32:02 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')]} 01:32:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:32:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:32:02 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')]} 01:32:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:32:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:32:02 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 0x142e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16ef180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16ed3b0>, '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 0x16ee2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16ee740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1467348581.27826-223990481', '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 01:32:02 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 01:32:02 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 01:32:02 INFO - Using env: {'DISPLAY': ':0', 01:32:02 INFO - 'HOME': '/home/cltbld', 01:32:02 INFO - 'LANG': 'en_US.UTF-8', 01:32:02 INFO - 'LANGUAGE': 'en_US:en', 01:32:02 INFO - 'LOGNAME': 'cltbld', 01:32:02 INFO - 'MAIL': '/var/mail/cltbld', 01:32:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:32:02 INFO - 'MOZ_NO_REMOTE': '1', 01:32:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:32:02 INFO - 'NO_EM_RESTART': '1', 01:32:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:32:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:32:02 INFO - 'PWD': '/builds/slave/test', 01:32:02 INFO - 'SHELL': '/bin/bash', 01:32:02 INFO - 'SHLVL': '1', 01:32:02 INFO - 'TERM': 'linux', 01:32:02 INFO - 'TMOUT': '86400', 01:32:02 INFO - 'USER': 'cltbld', 01:32:02 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1467348581.27826-223990481', 01:32:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:32:02 INFO - '_': '/tools/buildbot/bin/python'} 01:32:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:32:03 INFO - Downloading/unpacking mozsystemmonitor==0.3 01:32:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:32:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:32:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:32:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:32:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:32:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:32:04 INFO - Downloading mozsystemmonitor-0.3.tar.gz 01:32:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:32:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 01:32:05 INFO - Installing collected packages: mozsystemmonitor 01:32:05 INFO - Running setup.py install for mozsystemmonitor 01:32:05 INFO - Successfully installed mozsystemmonitor 01:32:05 INFO - Cleaning up... 01:32:05 INFO - Return code: 0 01:32:05 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 01:32:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 01:32:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:32:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:32:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 01:32:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:32:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:32:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x142e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16ef180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16ed3b0>, '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 0x16ee2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16ee740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1467348581.27826-223990481', '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 01:32:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 01:32:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 01:32:05 INFO - Using env: {'DISPLAY': ':0', 01:32:05 INFO - 'HOME': '/home/cltbld', 01:32:05 INFO - 'LANG': 'en_US.UTF-8', 01:32:05 INFO - 'LANGUAGE': 'en_US:en', 01:32:05 INFO - 'LOGNAME': 'cltbld', 01:32:05 INFO - 'MAIL': '/var/mail/cltbld', 01:32:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:32:05 INFO - 'MOZ_NO_REMOTE': '1', 01:32:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:32:05 INFO - 'NO_EM_RESTART': '1', 01:32:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:32:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:32:05 INFO - 'PWD': '/builds/slave/test', 01:32:05 INFO - 'SHELL': '/bin/bash', 01:32:05 INFO - 'SHLVL': '1', 01:32:05 INFO - 'TERM': 'linux', 01:32:05 INFO - 'TMOUT': '86400', 01:32:05 INFO - 'USER': 'cltbld', 01:32:05 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1467348581.27826-223990481', 01:32:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:32:05 INFO - '_': '/tools/buildbot/bin/python'} 01:32:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:32:05 INFO - Downloading/unpacking jsonschema==2.5.1 01:32:05 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 01:32:05 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 01:32:05 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 01:32:05 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 01:32:05 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 01:32:05 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 01:32:07 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:32:07 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 01:32:07 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 01:32:07 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 01:32:07 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 01:32:07 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 01:32:07 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 01:32:07 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 01:32:07 INFO - Downloading functools32-3.2.3-2.tar.gz 01:32:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:32:07 INFO - warning: no files found matching '*.txt' 01:32:07 INFO - no previously-included directories found matching 'build' 01:32:07 INFO - no previously-included directories found matching 'dist' 01:32:07 INFO - no previously-included directories found matching '.git*' 01:32:07 INFO - Installing collected packages: jsonschema, functools32 01:32:07 INFO - Running setup.py install for functools32 01:32:07 INFO - warning: no files found matching '*.txt' 01:32:07 INFO - no previously-included directories found matching 'build' 01:32:07 INFO - no previously-included directories found matching 'dist' 01:32:07 INFO - no previously-included directories found matching '.git*' 01:32:07 INFO - Successfully installed jsonschema functools32 01:32:07 INFO - Cleaning up... 01:32:07 INFO - Return code: 0 01:32:07 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:32:07 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')]} 01:32:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:32:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:32:07 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')]} 01:32:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:32:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:32:07 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 0x142e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16ef180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16ed3b0>, '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 0x16ee2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16ee740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1467348581.27826-223990481', '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 01:32:07 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 01:32:07 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 01:32:07 INFO - Using env: {'DISPLAY': ':0', 01:32:07 INFO - 'HOME': '/home/cltbld', 01:32:07 INFO - 'LANG': 'en_US.UTF-8', 01:32:07 INFO - 'LANGUAGE': 'en_US:en', 01:32:07 INFO - 'LOGNAME': 'cltbld', 01:32:07 INFO - 'MAIL': '/var/mail/cltbld', 01:32:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:32:07 INFO - 'MOZ_NO_REMOTE': '1', 01:32:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:32:07 INFO - 'NO_EM_RESTART': '1', 01:32:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:32:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:32:07 INFO - 'PWD': '/builds/slave/test', 01:32:07 INFO - 'SHELL': '/bin/bash', 01:32:07 INFO - 'SHLVL': '1', 01:32:07 INFO - 'TERM': 'linux', 01:32:07 INFO - 'TMOUT': '86400', 01:32:07 INFO - 'USER': 'cltbld', 01:32:07 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1467348581.27826-223990481', 01:32:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:32:07 INFO - '_': '/tools/buildbot/bin/python'} 01:32:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:32:07 INFO - Downloading/unpacking blobuploader==1.2.4 01:32:07 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 01:32:07 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 01:32:07 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 01:32:07 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 01:32:07 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 01:32:07 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 01:32:09 INFO - Downloading blobuploader-1.2.4.tar.gz 01:32:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:32:09 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:32:09 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 01:32:09 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 01:32:09 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 01:32:09 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 01:32:09 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 01:32:09 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 01:32:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:32:10 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:32:10 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 01:32:10 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 01:32:10 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 01:32:10 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 01:32:10 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 01:32:10 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 01:32:10 INFO - Downloading docopt-0.6.1.tar.gz 01:32:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:32:10 INFO - Installing collected packages: blobuploader, requests, docopt 01:32:10 INFO - Running setup.py install for blobuploader 01:32:10 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:32:10 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:32:10 INFO - Running setup.py install for requests 01:32:11 INFO - Running setup.py install for docopt 01:32:11 INFO - Successfully installed blobuploader requests docopt 01:32:11 INFO - Cleaning up... 01:32:11 INFO - Return code: 0 01:32:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:32: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')]} 01:32:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:32:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:32: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')]} 01:32:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:32:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:32:11 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 0x142e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16ef180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16ed3b0>, '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 0x16ee2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16ee740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1467348581.27826-223990481', '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 01:32:11 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 01:32:11 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 01:32:11 INFO - Using env: {'DISPLAY': ':0', 01:32:11 INFO - 'HOME': '/home/cltbld', 01:32:11 INFO - 'LANG': 'en_US.UTF-8', 01:32:11 INFO - 'LANGUAGE': 'en_US:en', 01:32:11 INFO - 'LOGNAME': 'cltbld', 01:32:11 INFO - 'MAIL': '/var/mail/cltbld', 01:32:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:32:11 INFO - 'MOZ_NO_REMOTE': '1', 01:32:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:32:11 INFO - 'NO_EM_RESTART': '1', 01:32:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:32:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:32:11 INFO - 'PWD': '/builds/slave/test', 01:32:11 INFO - 'SHELL': '/bin/bash', 01:32:11 INFO - 'SHLVL': '1', 01:32:11 INFO - 'TERM': 'linux', 01:32:11 INFO - 'TMOUT': '86400', 01:32:11 INFO - 'USER': 'cltbld', 01:32:11 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1467348581.27826-223990481', 01:32:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:32:11 INFO - '_': '/tools/buildbot/bin/python'} 01:32:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:32:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:32:11 INFO - Running setup.py (path:/tmp/pip-r6qj1r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:32:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:32:11 INFO - Running setup.py (path:/tmp/pip-St95RA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:32:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:32:11 INFO - Running setup.py (path:/tmp/pip-OhrLj0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:32:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:32:11 INFO - Running setup.py (path:/tmp/pip-kqNXTZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:32:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:32:11 INFO - Running setup.py (path:/tmp/pip-MCutq7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:32:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:32:11 INFO - Running setup.py (path:/tmp/pip-v7nfTw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:32:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:32:11 INFO - Running setup.py (path:/tmp/pip-vr4ftP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:32:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:32:11 INFO - Running setup.py (path:/tmp/pip-yFEV_V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:32:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:32:12 INFO - Running setup.py (path:/tmp/pip-fdapVz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:32:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:32:12 INFO - Running setup.py (path:/tmp/pip-pixuDb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:32:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:32:12 INFO - Running setup.py (path:/tmp/pip-UbH99z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:32:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:32:12 INFO - Running setup.py (path:/tmp/pip-kupCya-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:32:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:32:12 INFO - Running setup.py (path:/tmp/pip-JwuH0I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:32:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:32:12 INFO - Running setup.py (path:/tmp/pip-cCitOb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:32:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:32:12 INFO - Running setup.py (path:/tmp/pip-FsE486-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:32:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:32:12 INFO - Running setup.py (path:/tmp/pip-pTMi9P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:32:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:32:12 INFO - Running setup.py (path:/tmp/pip-05goVF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:32:12 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:32:12 INFO - Running setup.py install for manifestparser 01:32:12 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:32:12 INFO - Running setup.py install for mozcrash 01:32:12 INFO - Running setup.py install for mozdebug 01:32:12 INFO - Running setup.py install for mozdevice 01:32:13 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:32:13 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:32:13 INFO - Running setup.py install for mozfile 01:32:13 INFO - Running setup.py install for mozhttpd 01:32:13 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:32:13 INFO - Running setup.py install for mozinfo 01:32:13 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:32:13 INFO - Running setup.py install for mozInstall 01:32:13 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:32:13 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:32:13 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:32:13 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:32:13 INFO - Running setup.py install for mozleak 01:32:13 INFO - Running setup.py install for mozlog 01:32:13 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:32:13 INFO - Running setup.py install for moznetwork 01:32:13 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:32:13 INFO - Running setup.py install for mozprocess 01:32:13 INFO - Running setup.py install for mozprofile 01:32:14 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:32:14 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:32:14 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:32:14 INFO - Running setup.py install for mozrunner 01:32:14 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:32:14 INFO - Running setup.py install for mozscreenshot 01:32:14 INFO - Running setup.py install for moztest 01:32:14 INFO - Running setup.py install for mozversion 01:32:14 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:32:14 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:32:14 INFO - Cleaning up... 01:32:14 INFO - Return code: 0 01:32:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:32: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')]} 01:32:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:32:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:32: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')]} 01:32:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:32:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:32:14 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 0x142e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16ef180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16ed3b0>, '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 0x16ee2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16ee740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1467348581.27826-223990481', '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 01:32:14 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 01:32:14 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 01:32:14 INFO - Using env: {'DISPLAY': ':0', 01:32:14 INFO - 'HOME': '/home/cltbld', 01:32:14 INFO - 'LANG': 'en_US.UTF-8', 01:32:14 INFO - 'LANGUAGE': 'en_US:en', 01:32:14 INFO - 'LOGNAME': 'cltbld', 01:32:14 INFO - 'MAIL': '/var/mail/cltbld', 01:32:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:32:14 INFO - 'MOZ_NO_REMOTE': '1', 01:32:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:32:14 INFO - 'NO_EM_RESTART': '1', 01:32:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:32:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:32:14 INFO - 'PWD': '/builds/slave/test', 01:32:14 INFO - 'SHELL': '/bin/bash', 01:32:14 INFO - 'SHLVL': '1', 01:32:14 INFO - 'TERM': 'linux', 01:32:14 INFO - 'TMOUT': '86400', 01:32:14 INFO - 'USER': 'cltbld', 01:32:14 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1467348581.27826-223990481', 01:32:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:32:14 INFO - '_': '/tools/buildbot/bin/python'} 01:32:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:32:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:32:14 INFO - Running setup.py (path:/tmp/pip-tNtVus-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:32:14 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)) 01:32:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:32:14 INFO - Running setup.py (path:/tmp/pip-U2wRHF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:32:14 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)) 01:32:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:32:14 INFO - Running setup.py (path:/tmp/pip-fGWftW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:32:14 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)) 01:32:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:32:14 INFO - Running setup.py (path:/tmp/pip-Hh6iOI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:32:15 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)) 01:32:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:32:15 INFO - Running setup.py (path:/tmp/pip-ByiCjA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:32:15 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)) 01:32:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:32:15 INFO - Running setup.py (path:/tmp/pip-cWGs8j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:32:15 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)) 01:32:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:32:15 INFO - Running setup.py (path:/tmp/pip-x3VB5G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:32:15 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)) 01:32:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:32:15 INFO - Running setup.py (path:/tmp/pip-Vyz7iQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:32:15 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)) 01:32:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:32:15 INFO - Running setup.py (path:/tmp/pip-kcm6JB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:32:15 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)) 01:32:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:32:15 INFO - Running setup.py (path:/tmp/pip-gsJrAp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:32:15 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)) 01:32:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:32:15 INFO - Running setup.py (path:/tmp/pip-E5_k6d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:32:15 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)) 01:32:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:32:15 INFO - Running setup.py (path:/tmp/pip-upnZGl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:32:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 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)) 01:32:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:32:15 INFO - Running setup.py (path:/tmp/pip-x6hwoK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:32:15 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)) 01:32:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:32:15 INFO - Running setup.py (path:/tmp/pip-N8sPwf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:32:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 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)) 01:32:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:32:15 INFO - Running setup.py (path:/tmp/pip-nan6gA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:32:15 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)) 01:32:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:32:15 INFO - Running setup.py (path:/tmp/pip-1x6hxY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:32:15 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)) 01:32:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:32:15 INFO - Running setup.py (path:/tmp/pip-5t1CAw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:32:15 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)) 01:32:15 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)) 01:32:15 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)) 01:32:15 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)) 01:32:15 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)) 01:32:15 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)) 01:32:15 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:32:15 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 01:32:15 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 01:32:15 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 01:32:15 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 01:32:15 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 01:32:15 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 01:32:17 INFO - Downloading blessings-1.6.tar.gz 01:32:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:32:17 INFO - Installing collected packages: blessings 01:32:17 INFO - Running setup.py install for blessings 01:32:18 INFO - Successfully installed blessings 01:32:18 INFO - Cleaning up... 01:32:18 INFO - Return code: 0 01:32:18 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:32:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:32:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:32:18 INFO - Reading from file tmpfile_stdout 01:32:18 INFO - Current package versions: 01:32:18 INFO - argparse == 1.2.1 01:32:18 INFO - blessings == 1.6 01:32:18 INFO - blobuploader == 1.2.4 01:32:18 INFO - docopt == 0.6.1 01:32:18 INFO - functools32 == 3.2.3-2 01:32:18 INFO - jsonschema == 2.5.1 01:32:18 INFO - manifestparser == 1.1 01:32:18 INFO - mozInstall == 1.12 01:32:18 INFO - mozcrash == 0.17 01:32:18 INFO - mozdebug == 0.1 01:32:18 INFO - mozdevice == 0.48 01:32:18 INFO - mozfile == 1.2 01:32:18 INFO - mozhttpd == 0.7 01:32:18 INFO - mozinfo == 0.9 01:32:18 INFO - mozleak == 0.1 01:32:18 INFO - mozlog == 3.2 01:32:18 INFO - moznetwork == 0.27 01:32:18 INFO - mozprocess == 0.22 01:32:18 INFO - mozprofile == 0.28 01:32:18 INFO - mozrunner == 6.11 01:32:18 INFO - mozscreenshot == 0.1 01:32:18 INFO - mozsystemmonitor == 0.3 01:32:18 INFO - moztest == 0.7 01:32:18 INFO - mozversion == 1.4 01:32:18 INFO - psutil == 3.1.1 01:32:18 INFO - requests == 1.2.3 01:32:18 INFO - wsgiref == 0.1.2 01:32:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:32: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')]} 01:32:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:32:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:32: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')]} 01:32:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:32:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:32:18 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 0x142e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16ef180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16ed3b0>, '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 0x16ee2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16ee740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1467348581.27826-223990481', '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 01:32:18 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 01:32:18 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 01:32:18 INFO - Using env: {'DISPLAY': ':0', 01:32:18 INFO - 'HOME': '/home/cltbld', 01:32:18 INFO - 'LANG': 'en_US.UTF-8', 01:32:18 INFO - 'LANGUAGE': 'en_US:en', 01:32:18 INFO - 'LOGNAME': 'cltbld', 01:32:18 INFO - 'MAIL': '/var/mail/cltbld', 01:32:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:32:18 INFO - 'MOZ_NO_REMOTE': '1', 01:32:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:32:18 INFO - 'NO_EM_RESTART': '1', 01:32:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:32:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:32:18 INFO - 'PWD': '/builds/slave/test', 01:32:18 INFO - 'SHELL': '/bin/bash', 01:32:18 INFO - 'SHLVL': '1', 01:32:18 INFO - 'TERM': 'linux', 01:32:18 INFO - 'TMOUT': '86400', 01:32:18 INFO - 'USER': 'cltbld', 01:32:18 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1467348581.27826-223990481', 01:32:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:32:18 INFO - '_': '/tools/buildbot/bin/python'} 01:32:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:32:18 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)) 01:32:18 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)) 01:32:18 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)) 01:32:18 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)) 01:32:18 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)) 01:32:18 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)) 01:32:18 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)) 01:32:18 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)) 01:32:18 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)) 01:32:18 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)) 01:32:18 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)) 01:32:18 INFO - Cleaning up... 01:32:18 INFO - Return code: 0 01:32:18 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:32: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')]} 01:32:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:32:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:32: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')]} 01:32:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:32:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:32: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x142e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16ef180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16ed3b0>, '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 0x16ee2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16ee740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1467348581.27826-223990481', '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 01:32: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', 'jsonschema'] in /builds/slave/test/build 01:32: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 jsonschema 01:32:18 INFO - Using env: {'DISPLAY': ':0', 01:32:18 INFO - 'HOME': '/home/cltbld', 01:32:18 INFO - 'LANG': 'en_US.UTF-8', 01:32:18 INFO - 'LANGUAGE': 'en_US:en', 01:32:18 INFO - 'LOGNAME': 'cltbld', 01:32:18 INFO - 'MAIL': '/var/mail/cltbld', 01:32:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:32:18 INFO - 'MOZ_NO_REMOTE': '1', 01:32:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:32:18 INFO - 'NO_EM_RESTART': '1', 01:32:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:32:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:32:18 INFO - 'PWD': '/builds/slave/test', 01:32:18 INFO - 'SHELL': '/bin/bash', 01:32:18 INFO - 'SHLVL': '1', 01:32:18 INFO - 'TERM': 'linux', 01:32:18 INFO - 'TMOUT': '86400', 01:32:18 INFO - 'USER': 'cltbld', 01:32:18 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1467348581.27826-223990481', 01:32:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:32:18 INFO - '_': '/tools/buildbot/bin/python'} 01:32:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:32:18 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 01:32:18 INFO - Cleaning up... 01:32:18 INFO - Return code: 0 01:32:18 INFO - Running post-action listener: _resource_record_post_action 01:32:18 INFO - Running post-action listener: _start_resource_monitoring 01:32:18 INFO - Starting resource monitoring. 01:32:18 INFO - ##### 01:32:18 INFO - ##### Finished create-virtualenv step (success) 01:32:18 INFO - ##### 01:32:18 INFO - ##### 01:32:18 INFO - ##### Running install step. 01:32:18 INFO - ##### 01:32:18 INFO - Running pre-action listener: _resource_record_pre_action 01:32:18 INFO - Running main action method: install 01:32:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:32:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:32:19 INFO - Reading from file tmpfile_stdout 01:32:19 INFO - Detecting whether we're running mozinstall >=1.0... 01:32:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:32:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:32:19 INFO - Reading from file tmpfile_stdout 01:32:19 INFO - Output received: 01:32:19 INFO - Usage: mozinstall [options] installer 01:32:19 INFO - Options: 01:32:19 INFO - -h, --help show this help message and exit 01:32:19 INFO - -d DEST, --destination=DEST 01:32:19 INFO - Directory to install application into. [default: 01:32:19 INFO - "/builds/slave/test"] 01:32:19 INFO - --app=APP Application being installed. [default: firefox] 01:32:19 INFO - mkdir: /builds/slave/test/build/application 01:32:19 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'] 01:32:19 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 01:32:35 INFO - Reading from file tmpfile_stdout 01:32:35 INFO - Output received: 01:32:35 INFO - /builds/slave/test/build/application/firefox/firefox 01:32:35 INFO - Running post-action listener: _resource_record_post_action 01:32:35 INFO - ##### 01:32:35 INFO - ##### Finished install step (success) 01:32:35 INFO - ##### 01:32:35 INFO - ##### 01:32:35 INFO - ##### Running run-tests step. 01:32:35 INFO - ##### 01:32:35 INFO - Running pre-action listener: _resource_record_pre_action 01:32:35 INFO - Running main action method: run_tests 01:32:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:32:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:32:35 INFO - Python 2.7.3 01:32:35 INFO - Return code: 0 01:32:35 INFO - grabbing minidump binary from tooltool 01:32:35 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')]} 01:32:35 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 0x16ed3b0>, '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 0x16ee2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16ee740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:32:35 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 01:32:35 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 01:32:35 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 01:32:35 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:32:35 INFO - Return code: 0 01:32:35 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 01:32:35 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:32:35 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:32:35 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 01:32:35 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:32:35 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/ArR8ucauQGy59IodfwlN_g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-058', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 01:32:35 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/ArR8ucauQGy59IodfwlN_g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-058 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 01:32:35 INFO - Using env: {'DISPLAY': ':0', 01:32:35 INFO - 'HOME': '/home/cltbld', 01:32:35 INFO - 'LANG': 'en_US.UTF-8', 01:32:35 INFO - 'LANGUAGE': 'en_US:en', 01:32:35 INFO - 'LOGNAME': 'cltbld', 01:32:35 INFO - 'MAIL': '/var/mail/cltbld', 01:32:35 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:32:35 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 01:32:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:32:35 INFO - 'MOZ_NO_REMOTE': '1', 01:32:35 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:32:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:32:35 INFO - 'NO_EM_RESTART': '1', 01:32:35 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:32:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:32:35 INFO - 'PWD': '/builds/slave/test', 01:32:35 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:32:35 INFO - 'SHELL': '/bin/bash', 01:32:35 INFO - 'SHLVL': '1', 01:32:35 INFO - 'TERM': 'linux', 01:32:35 INFO - 'TMOUT': '86400', 01:32:35 INFO - 'USER': 'cltbld', 01:32:35 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1467348581.27826-223990481', 01:32:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:32:35 INFO - '_': '/tools/buildbot/bin/python'} 01:32:35 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/ArR8ucauQGy59IodfwlN_g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-058', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 01:32:35 INFO - mozversion application_buildid: 20160701000923 01:32:35 INFO - mozversion application_changeset: cd5a30817ea4389a01482ef9df5fb0017d26d36c 01:32:35 INFO - mozversion application_display_name: Nightly 01:32:35 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:32:35 INFO - mozversion application_name: Firefox 01:32:35 INFO - mozversion application_remotingname: firefox 01:32:35 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 01:32:35 INFO - mozversion application_vendor: Mozilla 01:32:35 INFO - mozversion application_version: 50.0a1 01:32:35 INFO - mozversion platform_buildid: 20160701000923 01:32:35 INFO - mozversion platform_changeset: cd5a30817ea4389a01482ef9df5fb0017d26d36c 01:32:35 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 01:32:35 INFO - mozversion platform_version: 50.0a1 01:32:35 INFO - using testdate: 1467361955 01:32:35 INFO - actual date: 1467361955 01:32:35 INFO - starting webserver on 'localhost:55521' 01:32:35 INFO - SUITE-START | Running 2 tests 01:32:35 INFO - TEST-START | dromaeo_css 01:32:35 INFO - operating with platform_type : linux_ 01:32:35 INFO - Initialising browser for dromaeo_css test... 01:32:35 INFO - TEST-INFO | started process 4397 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzCZ4Ps/profile http://localhost:55521/getInfo.html) 01:32:39 INFO - PROCESS | 4397 | __metrics Screen width/height:1600/1200 01:32:39 INFO - PROCESS | 4397 | colorDepth:24 01:32:39 INFO - PROCESS | 4397 | Browser inner width/height: 1024/697 01:32:39 INFO - PROCESS | 4397 | __metrics 01:32:40 INFO - PROCESS | 4397 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:32:41 INFO - TEST-INFO | 4397: exit 0 01:32:41 INFO - Browser initialized. 01:32:41 INFO - Running cycle 1/1 for dromaeo_css test... 01:32:41 INFO - TEST-INFO | started process 4479 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzCZ4Ps/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:32:53 INFO - PROCESS | 4479 | RSS: Main: 159219712 01:32:53 INFO - PROCESS | 4479 | 01:33:45 INFO - PROCESS | 4479 | 1467362025561 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] 01:35:57 INFO - PROCESS | 4479 | Cycle 1(1): loaded http://localhost:55521/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55521/tests/dromaeo/cssquery-ext.html) 01:35:58 INFO - PROCESS | 4479 | RSS: Main: 269795328 01:35:58 INFO - PROCESS | 4479 | 01:39:01 INFO - PROCESS | 4479 | Cycle 1(1): loaded http://localhost:55521/tests/dromaeo/cssquery-ext.html (next: http://localhost:55521/tests/dromaeo/cssquery-jquery.html) 01:39:01 INFO - PROCESS | 4479 | RSS: Main: 242229248 01:39:01 INFO - PROCESS | 4479 | 01:42:03 INFO - PROCESS | 4479 | Cycle 1(1): loaded http://localhost:55521/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55521/tests/dromaeo/cssquery-mootools.html) 01:42:04 INFO - PROCESS | 4479 | RSS: Main: 236937216 01:42:04 INFO - PROCESS | 4479 | 01:45:06 INFO - PROCESS | 4479 | Cycle 1(1): loaded http://localhost:55521/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55521/tests/dromaeo/cssquery-prototype.html) 01:45:07 INFO - PROCESS | 4479 | RSS: Main: 228851712 01:45:07 INFO - PROCESS | 4479 | 01:48:10 INFO - PROCESS | 4479 | Cycle 1(1): loaded http://localhost:55521/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55521/tests/dromaeo/cssquery-yui.html) 01:48:10 INFO - PROCESS | 4479 | RSS: Main: 216690688 01:48:10 INFO - PROCESS | 4479 | 01:51:13 INFO - PROCESS | 4479 | Cycle 1(1): loaded http://localhost:55521/tests/dromaeo/cssquery-yui.html (next: http://localhost:55521/tests/dromaeo/cssquery-dojo.html) 01:51:14 INFO - PROCESS | 4479 | RSS: Main: 275075072 01:51:14 INFO - PROCESS | 4479 | 01:51:14 INFO - PROCESS | 4479 | __start_tp_report 01:51:14 INFO - PROCESS | 4479 | _x_x_mozilla_page_load 01:51:14 INFO - PROCESS | 4479 | _x_x_mozilla_page_load_details 01:51:14 INFO - PROCESS | 4479 | |i|pagename|runs| 01:51:14 INFO - PROCESS | 4479 | |0;dojo.html;2589.8316609420385;2620.4104076582757;2641.5377308970924;2660.973390266098;2663.4539919316544;4562.338460923164;4634.930476042854;4724.858254252369;4732.361131247285;4733.739644319566;4652.3021546768005;4668.393108895847;4687.742174180418;4709.788059537321;4737.692050016746;4253.425787518684;4309.159713855799;4348.326009468537;4375.015621485156;4478.462584489866;4393.2970724684055;4425;4436.112777444508;4468.396766436522;4483.529229430896;4256.893577660552;4302.935455968163;4315.892102697427;4346.652267818598;4351.73889566627;4309.892252693677;4325.113351762881;4325.935110973338;4335.067960388532;4374.606285434326;4354.499232588261;4364.650827933758;4370.628496577795;4399.38408622793;4403.9559604404185;4618.399608050965;4667.393238878924;4704.717716936994;4818.71087734737;4822.758862056883;5070.112730272224;5106.897862042775;5147;5153.3558305211845;5157.381114266312;5132.640715149941;5166.457521960216;5170.431252562215;5174.663646862942;5174.793008279665;4603.240465323252;4674.298855171752;4700.741459219707;4765.475797662254;4805.9667171557585;5184.922226166611;5195.870103247449;5206.453322401169;5256.474352564713;5266.262723218752;4997.625178111656;5000;5043.621728370387;5051.419086805065;5064.34163558735;4939.382577177853;5041.319421878;5093.312402825572;5098.617603679739;5124.7950081996305;5059.241113832954;5068.543831055149;5070.7464626768515;5080.695158290514;5129.692218466904;5055.064813009605;5066.544011039025;5072.442031376546;5073.695578265316;5077.365329333833;4183.309753890635;4200.957990420118;4219.282721937278;4226.091390351028;4230.957690423118;3717.628237176315;3718.925621487555;3761.0409345616695;3769.717271204616;3774.094217387807;4341.674374421931;4351.717138386058;4357.607815296575;4395.296752519582;4401.977990110029;4933.679310844784;4991.5258050485145;5012.348394708737;5069.03688299222;5103.157978933508;4343.1747967886;4352.934705979413;4374.496932852762;4418.977905110454;4419.955800442019;4563.338315944169;4574.908501829945;4575.473820510617;4580.083983203373;4623.190941585209;4647.209974304444;4705.6000239979985;4738.763061846825;4785.59322457588;4790.473047964791;5033.748312584429;5050.696958182521;5052.014857102829;5062.088824011713;5093.541581257705;4730.858074257778;4759.28720629238;4760.523947605212;4761.285807128958;4799.136155491905;4869.659123861437;4971.850844474671;4976.950230497793;5018.347614810052;5020.974895125501;5094;5110.361204849394;5115.25828754821;5121.948780512147;5168.198929165986;4964.578010869117;4970.080535100873;4976.2286845539;4978.004399120118;4978.452370239198;4835.854924352275;4891.608671306216;4906.411230652202;4943.925841112315;4968.8757781055765;4819.783109759999;4852.102361063215;4861.295112208639;4906.607471402208;4910.165271903714;4846.103470857903;4959.231319145538;4966.304717339503;4968.975155124202;4995.300657907823;4765.237561990065;4776.188048031912;4789.042191561772;4810.903781924272;4822.469528351809 01:51:14 INFO - PROCESS | 4479 | |1;ext.html;536.8492788695565;583.0816464069093;588.2969851028022;595.9642421454715;599.736116108912;26770.866145669268;27251.5912261316;29157.708422915766;29388.412231755377;29406.852965735194;39522.40716389257;40752;40802.7959860201;44217.33673994893;44259;7658.846823063549;7725.343345815612;7789.948356971793;7797.415193860455;7801.297883190512;7648.158702542716;7719.459637825355;7722.227777222289;7723.845523089535;7724.9613751931165;7741.690332386698;7761.805954851117;7771.805704857367;7772.41706871984;7784.844303113934;7725.8068548286465;7746.612669366509;7754.573498457583;7754.961225193894;7769.300762931363;7676.884846727304;7745.070591529053;7759.8448031039625;7761.534307941542;7764;35708;35849.28301433957;35968.64031359679;35969;35982.280354392766;3076.9384612307854;3085.8765649374222;3134.843257837099;3141.1361875484426;3201.5037669161316;27988.16035518938;28045.719542804516;28338.716612833814;28385.57421638677;28727.856360718062;3343.632200457948;3384.086296699877;3389.068006298288;3421.127612458807;3454.7754395964434;208229;208795;209451;209538;210049.99999999846;31581;32651.346973060405;32714.345713085604;47781;48456.27315590269;33901;33913.49129763056;34003.48994765081;34033.659663403545;34054;12063.034957203403;12218.327991960528;12220.083493738006;12273.202241854251;12282.815757763641;9913.603455861685;10006.849897251546;10007;10012.69961901144;10015.449150296658;7947.880781788278;7953.0456345238945;7964.721234756756;8028.558429286329;8039.954805875199;3113.719765221141;3125.421796967523;3127.546505756698;3152;3169.176014236315;879.445949052093;881.2817553693719;893.9910600893908;986.3982970388057;995.3629677006721;28149.131695726388;28279.434411311657;28772.712272877423;28964.565531517044;29164.562531562042;842.4902933725008;961.7451375385529;969.6654654144309;984.7931934293736;1039.1271332080937;14642.926785366006;15379;15444.768328475082;15659.765103523456;15682.137482438575;380968;610376;620338;621063;622109;46371.768141159075;46997.530024699314;47270.52729472661;47273.527264726916;47320.290195647096;1095.6055819904827;1190.166883181759;1192.6124009696882;1222.975540489203;1223.9632811015683;25093.74906250914;29413.823447061877;29582.260443489085;29812.70187298186;29946.25134371658;41755.58244417517;47886.76056619694;49474.25788613102;49517.257241142135;53373.7331313341;332833;333416;336230;336464;336648;33063.50404743979;37606.24787504289;38779.41830872596;39174;39667.80166099266;42541.36187957121;42861.57138428576;42989;43088.569114308455;43436.78281608572;37075.443868341456;37547.81226093852;37765;37808;37830.62169378271;37352;37553.24893502169;37576.2484750298;37626.81186594049;38060;36213.27573448569;36216.65962365542;36515.087122822144;36614.26771464609;36814.81592592127;32150.517742233416;32475.512867306537;33693.83153084317;33826.32347353089;33910;25591.48817023612;25624.103156389436;25954.870225648752;25981.74018259869;26200.475990480463 01:51:14 INFO - PROCESS | 4479 | |2;jquery.html;340.91136304560837;362.98548058077677;366.5711117991949;367.6011527492671;384.1893604494516;13052.869471305285;16570.922890012156;16959.915200424013;18759.624807503842;18811.435656930313;16665.66668666626;17004.234809433576;17016.659666806656;17081.23134458949;17362.95822250666;5160.535551800328;5278.709670968095;5555.250041244441;5570.582206334521;5667.121596152603;3514.630963748808;5265.605079619025;5546.168074788774;5552.444755524456;5582.665040097607;5558.805441809537;5563.944360556403;5572.192032155335;5579.525740312079;5584.832455026356;5503.559715222793;6245.313015568284;6248.87502249957;6251.249850017982;6257.655828929407;4720.811167553328;5530.834074977757;5536.141898005815;5537.861553461195;5541.639793413416;12221.205621634565;12360.072994525357;12425.378731063502;12491.875081249162;12495.062870284764;1870.8690391672587;1927.8457723382096;1939.3309308288617;1990.2934458267252;2010.2059686423927;8799.736007919773;8824.35269419178;8992.325575581857;9181.449113053239;9341.532923353872;1721.6040310728476;1734.470986349163;1746.6332070265132;1773.2906837265068;1802.7476153338544;66771.66614166947;69797.65101174513;70148.6492567539;71623.64188179078;74018.25981740167;8227.794305142299;8734.257588105082;9193.49435781025;9534.761630959281;10136.797264054678;12187.45156467961;12977.35113244334;13031.478740850449;13067.34663266852;13621.659458513617;5512.2558454608115;6985.126859142607;7154.4991850571005;7190.748323808746;7255.564666119944;6643.1031810704935;6644.4020038196795;6727.394534491919;6764.763233286812;6783.491238157059;4325.264705000158;4329.372241025034;4402.449693788277;4496.415465989466;4568.109218702388;1750.719884818423;1802.9870382274999;1819.881707688996;1894.0719047666544;1896.2415033986515;827.6482494939627;855.5038077914794;864.7319331007408;927.7819712367589;932.9766755831023;16851.157442127846;16994.660106797794;17631.647367052843;17633.647327053386;18217.544561386072;849.6941101203562;859.3812455032366;861.039940466388;895.2748273898034;930.8417569013284;5799.420057994167;5905.852353691193;5968.343482216953;6025.276966763929;9872.259580531489;408393;418284;423322;428104;428172;77859;78771.21228787754;78795;80398.5980070096;81493;397.1897329447894;400.8917592250076;403.3908797715471;403.4613790589537;404.19968462444524;10136.543855526666;10157.492125393554;10183;10312.896871031193;10477.738056548647;35298.29403411969;36114.4582831263;38515.229695405375;40885.795571021954;42966;52800.735996319774;55008.724956374965;55012.174817378575;55146.72426637841;55239.72380138074;7402.925970740223;7493.325600695964;7615.581143037186;7625.618719064136;7685.193054729173;10962.177836662122;11989.400529973293;12009.939950300193;12179;12236.755264894475;10442.373457592568;10448.52981615814;10593.470326483492;10722.517486713272;10811.6215932442;10322.380657160295;10445.321054131457;10470.685879423629;10722.463876806285;10754.13966882632;10125.696229113139;10441.26911116245;10621.203409744454;10715.303505272132;10762.838557421488;7659;7720.652570634447;7738.264864837832;7868.213178682086;7954.085280192852;8014.078380986261;10264.127549158107;10425.635102771366;10685.839712404164;10736.409497477714 01:51:14 INFO - PROCESS | 4479 | |3;mootools.html;1206.9698257543566;1357.27385848571;1410.2173293821927;1459.2120255062266;1698.8980661160324;6617.305182955786;7400.814979625506;7621;7640.235976402357;7815.882761758578;7577.734779282726;7733.574653394061;7768.106667733213;7777.066751989755;7777.261160189787;2190.7261592301;2215.0475295622878;2216.1578600132007;2217.800397964183;2218.0240694094628;2150.6236408628506;2182.978170218293;2214.5017371091535;2216.390492614536;2217.4456385903522;2179.553191595727;2187.4203336115943;2187.485940803918;2191.1345018717598;2225.198928385788;2100.8214301784365;2107.873527588334;2109.209046607507;2110.7361579802523;2111.5249068959592;2079.3034333498294;2113.218109299554;2115.1433669363932;2115.8201552868027;2116.1112332820253;7609.847803043964;7760.146383897767;7789.415793815487;7823.608819559056;7840.372770178372;4462.527365969222;4586.495485496593;4588.4035075440315;4590.540945905383;4590.724556526619;2863.1124351451117;2930.223490774946;2978.7468065214484;2986.805857619248;2991.311998240395;913.5432283858071;919.5034681272105;932.9813403731955;938.0197693410403;951.1297163095759;10386.221033422524;10476.3190392625;10481.580736770444;10487.265891387606;10491.370517768883;3804.885853424402;3921.9803900980883;4015.437838702584;4016.357382818793;4026.778527181033;8281.17188281167;8322.958385208036;8324;8327.8334433311;8334.166583341617;4390.385346051556;4392.934105988413;4394.802233899482;4400;4401.449818772653;3642.399004164336;4003.8789139041114;4091.284025295561;4094.4677191965447;4153.646940010072;3350.246194606194;3398;3424.2637832865557;3441.15691655546;3500.6674365935196;1028.7736697926443;1033.560736686905;1041.6198087697935;1042.4162469017374;1048.528162326956;803.9187293090783;804.1998211779201;808.0908977400425;810.0562844286341;814.6334149632689;5079;5092.185250359925;5106.157484015096;5273.762680679379;5308.018016666929;400.4713777813317;403.6447925825255;408.7016477971098;421.9620234178939;424.757888003841;3352.5976882773734;3474.7915125092577;3563.3407819553468;3599.9640003600152;3626.676263163979;8949.328800340001;9278.350515463853;9317;9635.614575416905;9637.325387222967;9404.106609872051;9447.52762361893;9527.761805954768;9530.237580993504;9537.666181683746;7030.086088808524;7254.89117663246;7268.055152830098;7274.527155734861;7283.817904552428;5348.545373643128;5466.863328416822;5538.584606154474;5677.063284558001;5727.0550359190265;8690.565471726515;8869.556522173994;8972.775680608038;9033.051529589298;9040.41237319572;8863.202311791969;8974.685885993958;9173;9184.035676254165;9194.448333100036;5860.824175274749;6536.6731663415685;6754.662266886734;6846.212685541226;7015.894761578683;7390.445716571387;7396.3343299103335;7476.626168691435;7497.625118743932;7509.249075092447;6468.3855033771715;6589.47284217271;6592.406683398517;6731.596104233761;6748.561343512656;6552.508561857975;6568.441682457044;6629.569078009914;6670.966645166744;6699.162604674416;6033.095035744674;6060.212172417558;6092.2689277285235;6094.177286066501;6095.939040609537;4241.9363709545;4298.376735373291;4376.978115109404;4482.081173359518;4489.910201796011;4436.334549817553;4457.7771111444945;4465.441819772528;4521.706089104197;4586.220342541843 01:51:14 INFO - PROCESS | 4479 | |4;prototype.html;296.21503017004943;296.82783985288535;300.5596800686993;301.4092378937283;302.04553610590534;4781.18719817631;4791.425028996521;4792.544708252719;4795.448523419812;4860.805567777294;4748.76256187191;4773.4510531288915;4774.73738944358;4781.904361912769;4788.473267940523;3576.1774791797966;3681.9631803682023;3706.870259540917;3802.90492737681;3843.5964223756523;3746.9812650936706;3790.7915064671433;3801.5058042454443;3821.445890345912;3832.329342365075;3539.3098345822573;3760.2667479841443;3765.2281282337194;3769.886903392889;3776.8866933991885;3664.926701465969;3773.52830896138;3786.2995345861104;3799.6010418905894;3818.3890577507605;3353.815540145291;3355.798652080883;3359.260962588227;3360.092774950774;3362.260302733395;4686.625069994392;4733.644976626767;4735.242361222188;4740.478547359788;4740.881477963044;4226.640735537483;4311.8706438806885;4332.761698106603;4335.916020994751;4348.782560871944;4982.377202849644;4984.352034235562;5001.949980500185;5003.524665156804;5022.7990880365105;3650.963490365089;3660.1215708230097;3674.816259187057;3675.5405574303213;3693.6121707220623;5132.153194722866;5171.560417364529;5241.868953276123;5263.552598029172;5274.683518988834;3693.3167364037204;3695.722820788452;3725.981370093132;3744.0530923919955;3759.0978165240695;3772.5475691858833;3779.4708740776314;3787.2046870157574;3815.37046387343;3815.569161564413;4345.521992580813;4346.543612920598;4355.0854320593035;4355.455568053993;4364.279893817548;4977;5046.949530504721;5052.368453943257;5056.646034777604;5067.695938243717;1301.3688361144837;1307.843058832927;1316.6642506160867;1317.617890811654;1318.6637407461228;842.7345386203449;842.9114942931027;891.7681402835309;909.3316412436853;913.7167478081816;4359.912801744011;4366.454193225847;4383.846565370197;4392.494863090722;4415.646748260196;5086.923696144487;5090.923636145387;5093.567046801063;5135.3324067870935;5139.665921715076;4208.621224089786;4390.4511936008;4393.362962370438;4396;4405.735655860659;2727.59086137081;2729.0584748261817;2737.438825040862;2737.630419893329;2761.3096725818546;4854.757262136879;4854.927176092361;4862.690222144523;4867.829625963145;4874.683145595525;5102.897942041139;5237.009936224211;5255.684658920477;5267.236250743621;5292.4707529247535;4811.542903424169;4814.542618451312;4815.15734746418;4815.662903596854;4824.372831531879;5055.6713813602;5073.8731531712;5084.2881996521255;5087.99808113215;5118.257852611425;4759.547842954914;4997.175466048061;4997.650164488451;5022.547970682656;5042.168042272984;4790.592799612072;4799.592034676952;4801.591864691541;4807.543283388072;4818.277258411266;3754.7934863582764;3757.9060523487133;3777.773333599993;3780.697544196513;3783.146258333342;4970.986750366107;5087.847364579068;5102.897942041064;5122.769475373542;5272.420033796356;5048.368953880765;5085.211792172219;5092.108880945893;5092.41437234708;5097.915760964563;5058.128492457667;5072.858606813437;5078;5092.668976516515;5093;4789.976050119727;4818.277258411126;5016;5035.370578677665;5037.765747391913;4984.975075124601;5112.795488180431;5116.158183054172;5116.386033675983;5123.897522049464;4969.875753106056;4989.625778066732;5009.123403404463;5010.724410157476;5013.974930125326 01:51:14 INFO - PROCESS | 4479 | |5;yui.html;650.7982525417121;660.1550015979548;671.882420576399;687.3916583823318;701.277683985495;12577.937110314448;12773.169743966635;13037.478500859954;13047.543335983242;13060.804087938677;13540.39068241929;14037;14080.436782528712;14090;14097.788533171984;632.8639342541353;765.6286700950035;776.0919723923009;780.4536824223067;787.1144961917843;771.9228077192292;780.0327593783695;780.4848799792138;782.1669921533548;795.1333046978792;813.1786895235796;815.3395749442941;815.8980127484065;816.2123550773503;817.1624085312573;658.8517583543712;799.9000124984377;809.8501777171213;812.4110020235341;818.3657665309432;602.9819105426844;603.0020316376404;603.0652488642586;603.1525706382496;604.027515699723;13210.405531751094;13214;13237.13958592698;13272.800907986388;13276.203427794364;12330.013598912066;12850.485980560767;12855.935720321431;12887.806682899763;13049.54326598574;12205.572804951784;12514.499420023189;12517;12627.558035468715;12763.872361276453;4133.545310015896;4158.91682166355;4160.167966406731;4211.7051806373565;4232.090100628349;62166.37833621651;64012.679936600485;64084.3591564083;64110.35889641091;64136.67931660312;9675.840856435243;10105.242106842017;10200.132988696045;10621.415822129702;10656.520456579472;18951.90524047371;19136.138873750715;19221.32725354606;19231;19316.130774114918;6951.548149370275;6997.755078572327;7059.964700176466;7073.752418665322;7159.03353047332;3625.5286812714708;3677.191017976041;3880.4955355803563;3987.182627561343;4142.150859073882;2869.6986816384397;2953.4831404504125;2969.62879640045;2969.7178768017;2972.048944337791;484.68011112666176;486.11527020822473;487.90485855257884;499.2137383620812;503.6575128912375;503.55435439635454;604.2265899648457;619.7582942652369;620.9565330426917;635.1457289945016;8078.272955434039;8244.422890397615;8315.334773218128;8400.159984001551;8591.496488114555;468.5548728707673;531.4897698209685;536.715540763396;539.8974194902955;583.8832233553306;3710.8144592770254;4013.979930100331;4075.8573449929704;4110.46563946685;4243.384709217208;62006.41942225221;93469;93579;96748.51625741967;97658;80219;81301.59349203216;82397;83014;83626.74559881607;44820.17767385193;64726.352736472036;71826.281737183;75215.62392188005;77006;8118.918810811816;8123.197496863572;8199.344052475668;8295.917040829756;8367.205115514016;44563.554364455944;44565.331520027874;45260.32109518294;45505.77247113876;46148.30777538407;51345.486545134074;54738.178927315326;56665.43334566602;59747.40252597592;60548.697256513435;11708.238964467282;11784.646460606196;11858.822117668069;11984.820227696417;11993.759377133874;13657.248851313274;13692.041557090908;14002.57992260234;14418.062825916282;14557.85442145565;12617.558385456465;12691.238525688488;12711.872881271069;12839.743205135657;13661.86338136606;11934.761304774029;12116.15186936906;12283.140180187302;12395.132340736061;12423.813642795185;11628.88371116278;11741.119416044;11825.586104486301;12245.448954796877;12249.265044097383;9085.318601104811;9453.763655908657;9818.950905245714;9852.310338276251;10594.576216951544;9582.425054496753;9599.280053995839;9682.56428460735;9748.707538773848;10428.687139385831 01:51:14 INFO - PROCESS | 4479 | __end_tp_report 01:51:14 INFO - PROCESS | 4479 | __start_cc_report 01:51:14 INFO - PROCESS | 4479 | _x_x_mozilla_cycle_collect,1068 01:51:14 INFO - PROCESS | 4479 | __end_cc_report 01:51:14 INFO - PROCESS | 4479 | __startTimestamp1467363074075__endTimestamp 01:51:14 INFO - PROCESS | 4479 | 01:51:14 INFO - PROCESS | 4479 | ------- Summary: start ------- 01:51:14 INFO - PROCESS | 4479 | Number of tests: 6 01:51:14 INFO - PROCESS | 4479 | 01:51:14 INFO - PROCESS | 4479 | [#0] dojo.html Cycles:165 Average:4681.04 Median:4789.04 stddev:498.34 (10.4%) stddev-sans-first:472.09 01:51:14 INFO - PROCESS | 4479 | Values: 2589.8 2620.4 2641.5 2661.0 2663.5 4562.3 4634.9 4724.9 4732.4 4733.7 4652.3 4668.4 4687.7 4709.8 4737.7 4253.4 4309.2 4348.3 4375.0 4478.5 4393.3 4425.0 4436.1 4468.4 4483.5 4256.9 4302.9 4315.9 4346.7 4351.7 4309.9 4325.1 4325.9 4335.1 4374.6 4354.5 4364.7 4370.6 4399.4 4404.0 4618.4 4667.4 4704.7 4818.7 4822.8 5070.1 5106.9 5147.0 5153.4 5157.4 5132.6 5166.5 5170.4 5174.7 5174.8 4603.2 4674.3 4700.7 4765.5 4806.0 5184.9 5195.9 5206.5 5256.5 5266.3 4997.6 5000.0 5043.6 5051.4 5064.3 4939.4 5041.3 5093.3 5098.6 5124.8 5059.2 5068.5 5070.7 5080.7 5129.7 5055.1 5066.5 5072.4 5073.7 5077.4 4183.3 4201.0 4219.3 4226.1 4231.0 3717.6 3718.9 3761.0 3769.7 3774.1 4341.7 4351.7 4357.6 4395.3 4402.0 4933.7 4991.5 5012.3 5069.0 5103.2 4343.2 4352.9 4374.5 4419.0 4420.0 4563.3 4574.9 4575.5 4580.1 4623.2 4647.2 4705.6 4738.8 4785.6 4790.5 5033.7 5050.7 5052.0 5062.1 5093.5 4730.9 4759.3 4760.5 4761.3 4799.1 4869.7 4971.9 4977.0 5018.3 5021.0 5094.0 5110.4 5115.3 5121.9 5168.2 4964.6 4970.1 4976.2 4978.0 4978.5 4835.9 4891.6 4906.4 4943.9 4968.9 4819.8 4852.1 4861.3 4906.6 4910.2 4846.1 4959.2 4966.3 4969.0 4995.3 4765.2 4776.2 4789.0 4810.9 4822.5 01:51:14 INFO - PROCESS | 4479 | 01:51:14 INFO - PROCESS | 4479 | [#1] ext.html Cycles:180 Average:50675.78 Median:36365.87 stddev:108617.01 (298.7%) stddev-sans-first:108856.48 01:51:14 INFO - PROCESS | 4479 | Values: 536.8 583.1 588.3 596.0 599.7 26770.9 27251.6 29157.7 29388.4 29406.9 39522.4 40752.0 40802.8 44217.3 44259.0 7658.8 7725.3 7789.9 7797.4 7801.3 7648.2 7719.5 7722.2 7723.8 7725.0 7741.7 7761.8 7771.8 7772.4 7784.8 7725.8 7746.6 7754.6 7755.0 7769.3 7676.9 7745.1 7759.8 7761.5 7764.0 35708.0 35849.3 35968.6 35969.0 35982.3 3076.9 3085.9 3134.8 3141.1 3201.5 27988.2 28045.7 28338.7 28385.6 28727.9 3343.6 3384.1 3389.1 3421.1 3454.8 208229.0 208795.0 209451.0 209538.0 210050.0 31581.0 32651.3 32714.3 47781.0 48456.3 33901.0 33913.5 34003.5 34033.7 34054.0 12063.0 12218.3 12220.1 12273.2 12282.8 9913.6 10006.8 10007.0 10012.7 10015.4 7947.9 7953.0 7964.7 8028.6 8040.0 3113.7 3125.4 3127.5 3152.0 3169.2 879.4 881.3 894.0 986.4 995.4 28149.1 28279.4 28772.7 28964.6 29164.6 842.5 961.7 969.7 984.8 1039.1 14642.9 15379.0 15444.8 15659.8 15682.1 380968.0 610376.0 620338.0 621063.0 622109.0 46371.8 46997.5 47270.5 47273.5 47320.3 1095.6 1190.2 1192.6 1223.0 1224.0 25093.7 29413.8 29582.3 29812.7 29946.3 41755.6 47886.8 49474.3 49517.3 53373.7 332833.0 333416.0 336230.0 336464.0 336648.0 33063.5 37606.2 38779.4 39174.0 39667.8 42541.4 42861.6 42989.0 43088.6 43436.8 37075.4 37547.8 37765.0 37808.0 37830.6 37352.0 37553.2 37576.2 37626.8 38060.0 36213.3 36216.7 36515.1 36614.3 36814.8 32150.5 32475.5 33693.8 33826.3 33910.0 25591.5 25624.1 25954.9 25981.7 26200.5 01:51:14 INFO - PROCESS | 4479 | 01:51:14 INFO - PROCESS | 4479 | [#2] jquery.html Cycles:180 Average:24971.84 Median:23645.63 stddev:69584.28 (294.3%) stddev-sans-first:69754.90 01:51:14 INFO - PROCESS | 4479 | Values: 340.9 363.0 366.6 367.6 384.2 13052.9 16570.9 16959.9 18759.6 18811.4 16665.7 17004.2 17016.7 17081.2 17363.0 5160.5 5278.7 5555.3 5570.6 5667.1 3514.6 5265.6 5546.2 5552.4 5582.7 5558.8 5563.9 5572.2 5579.5 5584.8 5503.6 6245.3 6248.9 6251.2 6257.7 4720.8 5530.8 5536.1 5537.9 5541.6 12221.2 12360.1 12425.4 12491.9 12495.1 1870.9 1927.8 1939.3 1990.3 2010.2 8799.7 8824.4 8992.3 9181.4 9341.5 1721.6 1734.5 1746.6 1773.3 1802.7 66771.7 69797.7 70148.6 71623.6 74018.3 8227.8 8734.3 9193.5 9534.8 10136.8 12187.5 12977.4 13031.5 13067.3 13621.7 5512.3 6985.1 7154.5 7190.7 7255.6 6643.1 6644.4 6727.4 6764.8 6783.5 4325.3 4329.4 4402.4 4496.4 4568.1 1750.7 1803.0 1819.9 1894.1 1896.2 827.6 855.5 864.7 927.8 933.0 16851.2 16994.7 17631.6 17633.6 18217.5 849.7 859.4 861.0 895.3 930.8 5799.4 5905.9 5968.3 6025.3 9872.3 408393.0 418284.0 423322.0 428104.0 428172.0 77859.0 78771.2 78795.0 80398.6 81493.0 397.2 400.9 403.4 403.5 404.2 10136.5 10157.5 10183.0 10312.9 10477.7 35298.3 36114.5 38515.2 40885.8 42966.0 52800.7 55008.7 55012.2 55146.7 55239.7 7402.9 7493.3 7615.6 7625.6 7685.2 10962.2 11989.4 12009.9 12179.0 12236.8 10442.4 10448.5 10593.5 10722.5 10811.6 10322.4 10445.3 10470.7 10722.5 10754.1 10125.7 10441.3 10621.2 10715.3 10762.8 7659.0 7720.7 7738.3 7868.2 7954.1 8014.1 10264.1 10425.6 10685.8 10736.4 01:51:14 INFO - PROCESS | 4479 | 01:51:14 INFO - PROCESS | 4479 | [#3] mootools.html Cycles:180 Average:5027.48 Median:5085.59 stddev:2845.78 (56.0%) stddev-sans-first:2839.27 01:51:14 INFO - PROCESS | 4479 | Values: 1207.0 1357.3 1410.2 1459.2 1698.9 6617.3 7400.8 7621.0 7640.2 7815.9 7577.7 7733.6 7768.1 7777.1 7777.3 2190.7 2215.0 2216.2 2217.8 2218.0 2150.6 2183.0 2214.5 2216.4 2217.4 2179.6 2187.4 2187.5 2191.1 2225.2 2100.8 2107.9 2109.2 2110.7 2111.5 2079.3 2113.2 2115.1 2115.8 2116.1 7609.8 7760.1 7789.4 7823.6 7840.4 4462.5 4586.5 4588.4 4590.5 4590.7 2863.1 2930.2 2978.7 2986.8 2991.3 913.5 919.5 933.0 938.0 951.1 10386.2 10476.3 10481.6 10487.3 10491.4 3804.9 3922.0 4015.4 4016.4 4026.8 8281.2 8323.0 8324.0 8327.8 8334.2 4390.4 4392.9 4394.8 4400.0 4401.4 3642.4 4003.9 4091.3 4094.5 4153.6 3350.2 3398.0 3424.3 3441.2 3500.7 1028.8 1033.6 1041.6 1042.4 1048.5 803.9 804.2 808.1 810.1 814.6 5079.0 5092.2 5106.2 5273.8 5308.0 400.5 403.6 408.7 422.0 424.8 3352.6 3474.8 3563.3 3600.0 3626.7 8949.3 9278.4 9317.0 9635.6 9637.3 9404.1 9447.5 9527.8 9530.2 9537.7 7030.1 7254.9 7268.1 7274.5 7283.8 5348.5 5466.9 5538.6 5677.1 5727.1 8690.6 8869.6 8972.8 9033.1 9040.4 8863.2 8974.7 9173.0 9184.0 9194.4 5860.8 6536.7 6754.7 6846.2 7015.9 7390.4 7396.3 7476.6 7497.6 7509.2 6468.4 6589.5 6592.4 6731.6 6748.6 6552.5 6568.4 6629.6 6671.0 6699.2 6033.1 6060.2 6092.3 6094.2 6095.9 4241.9 4298.4 4377.0 4482.1 4489.9 4436.3 4457.8 4465.4 4521.7 4586.2 01:51:14 INFO - PROCESS | 4479 | 01:51:14 INFO - PROCESS | 4479 | [#4] prototype.html Cycles:180 Average:4186.16 Median:4785.19 stddev:1198.17 (25.0%) stddev-sans-first:1165.41 01:51:14 INFO - PROCESS | 4479 | Values: 296.2 296.8 300.6 301.4 302.0 4781.2 4791.4 4792.5 4795.4 4860.8 4748.8 4773.5 4774.7 4781.9 4788.5 3576.2 3682.0 3706.9 3802.9 3843.6 3747.0 3790.8 3801.5 3821.4 3832.3 3539.3 3760.3 3765.2 3769.9 3776.9 3664.9 3773.5 3786.3 3799.6 3818.4 3353.8 3355.8 3359.3 3360.1 3362.3 4686.6 4733.6 4735.2 4740.5 4740.9 4226.6 4311.9 4332.8 4335.9 4348.8 4982.4 4984.4 5001.9 5003.5 5022.8 3651.0 3660.1 3674.8 3675.5 3693.6 5132.2 5171.6 5241.9 5263.6 5274.7 3693.3 3695.7 3726.0 3744.1 3759.1 3772.5 3779.5 3787.2 3815.4 3815.6 4345.5 4346.5 4355.1 4355.5 4364.3 4977.0 5046.9 5052.4 5056.6 5067.7 1301.4 1307.8 1316.7 1317.6 1318.7 842.7 842.9 891.8 909.3 913.7 4359.9 4366.5 4383.8 4392.5 4415.6 5086.9 5090.9 5093.6 5135.3 5139.7 4208.6 4390.5 4393.4 4396.0 4405.7 2727.6 2729.1 2737.4 2737.6 2761.3 4854.8 4854.9 4862.7 4867.8 4874.7 5102.9 5237.0 5255.7 5267.2 5292.5 4811.5 4814.5 4815.2 4815.7 4824.4 5055.7 5073.9 5084.3 5088.0 5118.3 4759.5 4997.2 4997.7 5022.5 5042.2 4790.6 4799.6 4801.6 4807.5 4818.3 3754.8 3757.9 3777.8 3780.7 3783.1 4971.0 5087.8 5102.9 5122.8 5272.4 5048.4 5085.2 5092.1 5092.4 5097.9 5058.1 5072.9 5078.0 5092.7 5093.0 4790.0 4818.3 5016.0 5035.4 5037.8 4985.0 5112.8 5116.2 5116.4 5123.9 4969.9 4989.6 5009.1 5010.7 5014.0 01:51:14 INFO - PROCESS | 4479 | 01:51:14 INFO - PROCESS | 4479 | [#5] yui.html Cycles:180 Average:17364.17 Median:493.56 stddev:23878.25 (4838.0%) stddev-sans-first:23912.25 01:51:14 INFO - PROCESS | 4479 | Values: 650.8 660.2 671.9 687.4 701.3 12577.9 12773.2 13037.5 13047.5 13060.8 13540.4 14037.0 14080.4 14090.0 14097.8 632.9 765.6 776.1 780.5 787.1 771.9 780.0 780.5 782.2 795.1 813.2 815.3 815.9 816.2 817.2 658.9 799.9 809.9 812.4 818.4 603.0 603.0 603.1 603.2 604.0 13210.4 13214.0 13237.1 13272.8 13276.2 12330.0 12850.5 12855.9 12887.8 13049.5 12205.6 12514.5 12517.0 12627.6 12763.9 4133.5 4158.9 4160.2 4211.7 4232.1 62166.4 64012.7 64084.4 64110.4 64136.7 9675.8 10105.2 10200.1 10621.4 10656.5 18951.9 19136.1 19221.3 19231.0 19316.1 6951.5 6997.8 7060.0 7073.8 7159.0 3625.5 3677.2 3880.5 3987.2 4142.2 2869.7 2953.5 2969.6 2969.7 2972.0 484.7 486.1 487.9 499.2 503.7 503.6 604.2 619.8 621.0 635.1 8078.3 8244.4 8315.3 8400.2 8591.5 468.6 531.5 536.7 539.9 583.9 3710.8 4014.0 4075.9 4110.5 4243.4 62006.4 93469.0 93579.0 96748.5 97658.0 80219.0 81301.6 82397.0 83014.0 83626.7 44820.2 64726.4 71826.3 75215.6 77006.0 8118.9 8123.2 8199.3 8295.9 8367.2 44563.6 44565.3 45260.3 45505.8 46148.3 51345.5 54738.2 56665.4 59747.4 60548.7 11708.2 11784.6 11858.8 11984.8 11993.8 13657.2 13692.0 14002.6 14418.1 14557.9 12617.6 12691.2 12711.9 12839.7 13661.9 11934.8 12116.2 12283.1 12395.1 12423.8 11628.9 11741.1 11825.6 12245.4 12249.3 9085.3 9453.8 9819.0 9852.3 10594.6 9582.4 9599.3 9682.6 9748.7 10428.7 01:51:14 INFO - PROCESS | 4479 | -------- Summary: end -------- 01:51:14 INFO - PROCESS | 4479 | 01:51:14 INFO - TEST-INFO | 4479: exit 0 01:51:14 INFO - TEST-OK | dromaeo_css | took 1119178ms 01:51:14 INFO - TEST-START | kraken 01:51:14 INFO - operating with platform_type : linux_ 01:51:14 INFO - Initialising browser for kraken test... 01:51:14 INFO - TEST-INFO | started process 4674 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzG5G2M/profile http://localhost:55521/getInfo.html) 01:51:19 INFO - PROCESS | 4674 | __metrics Screen width/height:1600/1200 01:51:19 INFO - PROCESS | 4674 | colorDepth:24 01:51:19 INFO - PROCESS | 4674 | Browser inner width/height: 1024/697 01:51:19 INFO - PROCESS | 4674 | __metrics 01:51:19 INFO - PROCESS | 4674 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:51:20 INFO - TEST-INFO | 4674: exit 0 01:51:20 INFO - Browser initialized. 01:51:20 INFO - Running cycle 1/1 for kraken test... 01:51:20 INFO - TEST-INFO | started process 4755 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzG5G2M/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:51:32 INFO - PROCESS | 4755 | RSS: Main: 158490624 01:51:32 INFO - PROCESS | 4755 | 01:51:35 INFO - PROCESS | 4755 | Cycle 1(1): loaded http://localhost:55521/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55521/tests/kraken/driver.html?testName=audio-beat-detection) 01:51:36 INFO - PROCESS | 4755 | RSS: Main: 216563712 01:51:36 INFO - PROCESS | 4755 | 01:51:39 INFO - PROCESS | 4755 | Cycle 1(1): loaded http://localhost:55521/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55521/tests/kraken/driver.html?testName=audio-dft) 01:51:40 INFO - PROCESS | 4755 | RSS: Main: 204734464 01:51:40 INFO - PROCESS | 4755 | 01:51:43 INFO - PROCESS | 4755 | Cycle 1(1): loaded http://localhost:55521/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55521/tests/kraken/driver.html?testName=audio-fft) 01:51:43 INFO - PROCESS | 4755 | RSS: Main: 271695872 01:51:43 INFO - PROCESS | 4755 | 01:51:46 INFO - PROCESS | 4755 | Cycle 1(1): loaded http://localhost:55521/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55521/tests/kraken/driver.html?testName=audio-oscillator) 01:51:46 INFO - PROCESS | 4755 | RSS: Main: 181571584 01:51:46 INFO - PROCESS | 4755 | 01:51:48 INFO - PROCESS | 4755 | Cycle 1(1): loaded http://localhost:55521/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55521/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:51:49 INFO - PROCESS | 4755 | RSS: Main: 186167296 01:51:49 INFO - PROCESS | 4755 | 01:51:52 INFO - PROCESS | 4755 | Cycle 1(1): loaded http://localhost:55521/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55521/tests/kraken/driver.html?testName=imaging-darkroom) 01:51:53 INFO - PROCESS | 4755 | RSS: Main: 221450240 01:51:53 INFO - PROCESS | 4755 | 01:51:56 INFO - PROCESS | 4755 | Cycle 1(1): loaded http://localhost:55521/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55521/tests/kraken/driver.html?testName=imaging-desaturate) 01:51:57 INFO - PROCESS | 4755 | RSS: Main: 216924160 01:51:57 INFO - PROCESS | 4755 | 01:52:00 INFO - PROCESS | 4755 | Cycle 1(1): loaded http://localhost:55521/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55521/tests/kraken/driver.html?testName=json-parse-financial) 01:52:00 INFO - PROCESS | 4755 | RSS: Main: 220377088 01:52:00 INFO - PROCESS | 4755 | 01:52:02 INFO - PROCESS | 4755 | Cycle 1(1): loaded http://localhost:55521/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55521/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:52:03 INFO - PROCESS | 4755 | RSS: Main: 208662528 01:52:03 INFO - PROCESS | 4755 | 01:52:05 INFO - PROCESS | 4755 | Cycle 1(1): loaded http://localhost:55521/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55521/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:52:05 INFO - PROCESS | 4755 | RSS: Main: 212422656 01:52:05 INFO - PROCESS | 4755 | 01:52:07 INFO - PROCESS | 4755 | Cycle 1(1): loaded http://localhost:55521/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55521/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:52:08 INFO - PROCESS | 4755 | RSS: Main: 212389888 01:52:08 INFO - PROCESS | 4755 | 01:52:11 INFO - PROCESS | 4755 | Cycle 1(1): loaded http://localhost:55521/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55521/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:52:12 INFO - PROCESS | 4755 | RSS: Main: 226205696 01:52:12 INFO - PROCESS | 4755 | 01:52:14 INFO - PROCESS | 4755 | Cycle 1(1): loaded http://localhost:55521/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55521/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:52:15 INFO - PROCESS | 4755 | RSS: Main: 225693696 01:52:15 INFO - PROCESS | 4755 | 01:52:17 INFO - PROCESS | 4755 | Cycle 1(1): loaded http://localhost:55521/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55521/tests/kraken/driver.html?testName=ai-astar) 01:52:17 INFO - PROCESS | 4755 | RSS: Main: 268357632 01:52:17 INFO - PROCESS | 4755 | 01:52:17 INFO - PROCESS | 4755 | __start_tp_report 01:52:17 INFO - PROCESS | 4755 | _x_x_mozilla_page_load 01:52:17 INFO - PROCESS | 4755 | _x_x_mozilla_page_load_details 01:52:17 INFO - PROCESS | 4755 | |i|pagename|runs| 01:52:17 INFO - PROCESS | 4755 | |0;ai-astar;107;115;116;116;115;116;116;115;116;116 01:52:17 INFO - PROCESS | 4755 | |1;audio-beat-detection;148;124;131;175;126;133;147;124;181;125 01:52:17 INFO - PROCESS | 4755 | |2;audio-dft;161;161;161;161;162;161;160;161;163;162 01:52:17 INFO - PROCESS | 4755 | |3;audio-fft;77;76;77;125;76;77;76;76;100;76 01:52:17 INFO - PROCESS | 4755 | |4;audio-oscillator;83;83;120;84;85;84;124;84;84;138 01:52:17 INFO - PROCESS | 4755 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;117;116 01:52:17 INFO - PROCESS | 4755 | |6;imaging-darkroom;147;146;147;146;146;146;146;146;146;146 01:52:17 INFO - PROCESS | 4755 | |7;imaging-desaturate;95;94;95;95;94;95;95;96;95;95 01:52:17 INFO - PROCESS | 4755 | |8;json-parse-financial;65;65;64;63;64;64;64;65;63;65 01:52:17 INFO - PROCESS | 4755 | |9;json-stringify-tinderbox;64;63;64;64;65;64;63;65;64;64 01:52:17 INFO - PROCESS | 4755 | |10;stanford-crypto-aes;86;78;82;85;80;87;81;79;79;79 01:52:17 INFO - PROCESS | 4755 | |11;stanford-crypto-ccm;138;138;127;133;139;133;131;139;170;140 01:52:17 INFO - PROCESS | 4755 | |12;stanford-crypto-pbkdf2;172;164;170;164;173;172;168;172;165;165 01:52:17 INFO - PROCESS | 4755 | |13;stanford-crypto-sha256-iterative;70;68;69;68;72;69;67;67;66;67 01:52:17 INFO - PROCESS | 4755 | __end_tp_report 01:52:17 INFO - PROCESS | 4755 | __start_cc_report 01:52:17 INFO - PROCESS | 4755 | _x_x_mozilla_cycle_collect,1917 01:52:17 INFO - PROCESS | 4755 | __end_cc_report 01:52:17 INFO - PROCESS | 4755 | __startTimestamp1467363137513__endTimestamp 01:52:17 INFO - PROCESS | 4755 | 01:52:17 INFO - PROCESS | 4755 | ------- Summary: start ------- 01:52:17 INFO - PROCESS | 4755 | Number of tests: 14 01:52:17 INFO - PROCESS | 4755 | 01:52:17 INFO - PROCESS | 4755 | [#0] ai-astar Cycles:10 Average:114.80 Median:116.00 stddev:2.78 (2.4%) stddev-sans-first:0.50 01:52:17 INFO - PROCESS | 4755 | Values: 107.0 115.0 116.0 116.0 115.0 116.0 116.0 115.0 116.0 116.0 01:52:17 INFO - PROCESS | 4755 | 01:52:17 INFO - PROCESS | 4755 | [#1] audio-beat-detection Cycles:10 Average:141.40 Median:140.00 stddev:21.25 (15.2%) stddev-sans-first:22.40 01:52:17 INFO - PROCESS | 4755 | Values: 148.0 124.0 131.0 175.0 126.0 133.0 147.0 124.0 181.0 125.0 01:52:17 INFO - PROCESS | 4755 | 01:52:17 INFO - PROCESS | 4755 | [#2] audio-dft Cycles:10 Average:161.30 Median:161.00 stddev:0.82 (0.5%) stddev-sans-first:0.87 01:52:17 INFO - PROCESS | 4755 | Values: 161.0 161.0 161.0 161.0 162.0 161.0 160.0 161.0 163.0 162.0 01:52:17 INFO - PROCESS | 4755 | 01:52:17 INFO - PROCESS | 4755 | [#3] audio-fft Cycles:10 Average:83.60 Median:76.00 stddev:16.34 (21.5%) stddev-sans-first:17.15 01:52:17 INFO - PROCESS | 4755 | Values: 77.0 76.0 77.0 125.0 76.0 77.0 76.0 76.0 100.0 76.0 01:52:17 INFO - PROCESS | 4755 | 01:52:17 INFO - PROCESS | 4755 | [#4] audio-oscillator Cycles:10 Average:96.90 Median:84.00 stddev:21.48 (25.6%) stddev-sans-first:22.18 01:52:17 INFO - PROCESS | 4755 | Values: 83.0 83.0 120.0 84.0 85.0 84.0 124.0 84.0 84.0 138.0 01:52:17 INFO - PROCESS | 4755 | 01:52:17 INFO - PROCESS | 4755 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 01:52:17 INFO - PROCESS | 4755 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 116.0 01:52:17 INFO - PROCESS | 4755 | 01:52:17 INFO - PROCESS | 4755 | [#6] imaging-darkroom Cycles:10 Average:146.20 Median:146.00 stddev:0.42 (0.3%) stddev-sans-first:0.33 01:52:17 INFO - PROCESS | 4755 | Values: 147.0 146.0 147.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 01:52:17 INFO - PROCESS | 4755 | 01:52:17 INFO - PROCESS | 4755 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 01:52:17 INFO - PROCESS | 4755 | Values: 95.0 94.0 95.0 95.0 94.0 95.0 95.0 96.0 95.0 95.0 01:52:17 INFO - PROCESS | 4755 | 01:52:17 INFO - PROCESS | 4755 | [#8] json-parse-financial Cycles:10 Average:64.20 Median:64.50 stddev:0.79 (1.2%) stddev-sans-first:0.78 01:52:17 INFO - PROCESS | 4755 | Values: 65.0 65.0 64.0 63.0 64.0 64.0 64.0 65.0 63.0 65.0 01:52:17 INFO - PROCESS | 4755 | 01:52:17 INFO - PROCESS | 4755 | [#9] json-stringify-tinderbox Cycles:10 Average:64.00 Median:64.00 stddev:0.67 (1.0%) stddev-sans-first:0.71 01:52:17 INFO - PROCESS | 4755 | Values: 64.0 63.0 64.0 64.0 65.0 64.0 63.0 65.0 64.0 64.0 01:52:17 INFO - PROCESS | 4755 | 01:52:17 INFO - PROCESS | 4755 | [#10] stanford-crypto-aes Cycles:10 Average:81.60 Median:81.50 stddev:3.27 (4.0%) stddev-sans-first:3.06 01:52:17 INFO - PROCESS | 4755 | Values: 86.0 78.0 82.0 85.0 80.0 87.0 81.0 79.0 79.0 79.0 01:52:17 INFO - PROCESS | 4755 | 01:52:17 INFO - PROCESS | 4755 | [#11] stanford-crypto-ccm Cycles:10 Average:138.80 Median:138.50 stddev:11.75 (8.5%) stddev-sans-first:12.46 01:52:17 INFO - PROCESS | 4755 | Values: 138.0 138.0 127.0 133.0 139.0 133.0 131.0 139.0 170.0 140.0 01:52:17 INFO - PROCESS | 4755 | 01:52:17 INFO - PROCESS | 4755 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.50 Median:171.00 stddev:3.72 (2.2%) stddev-sans-first:3.72 01:52:17 INFO - PROCESS | 4755 | Values: 172.0 164.0 170.0 164.0 173.0 172.0 168.0 172.0 165.0 165.0 01:52:17 INFO - PROCESS | 4755 | 01:52:17 INFO - PROCESS | 4755 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.30 Median:68.50 stddev:1.77 (2.6%) stddev-sans-first:1.76 01:52:17 INFO - PROCESS | 4755 | Values: 70.0 68.0 69.0 68.0 72.0 69.0 67.0 67.0 66.0 67.0 01:52:17 INFO - PROCESS | 4755 | -------- Summary: end -------- 01:52:17 INFO - PROCESS | 4755 | 01:52:18 INFO - TEST-INFO | 4755: exit 0 01:52:18 INFO - TEST-OK | kraken | took 63705ms 01:52:18 INFO - SUITE-END | took 1182s 01:52:18 INFO - Completed test suite (00:19:42) 01:52:18 INFO - javascript benchmark 01:52:18 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2589.8316609420385, 2620.4104076582757, 2641.5377308970924, 2660.973390266098, 2663.4539919316544, 4562.338460923164, 4634.930476042854, 4724.858254252369, 4732.361131247285, 4733.739644319566, 4652.3021546768005, 4668.393108895847, 4687.742174180418, 4709.788059537321, 4737.692050016746, 4253.425787518684, 4309.159713855799, 4348.326009468537, 4375.015621485156, 4478.462584489866, 4393.2970724684055, 4425.0, 4436.112777444508, 4468.396766436522, 4483.529229430896, 4256.893577660552, 4302.935455968163, 4315.892102697427, 4346.652267818598, 4351.73889566627, 4309.892252693677, 4325.113351762881, 4325.935110973338, 4335.067960388532, 4374.606285434326, 4354.499232588261, 4364.650827933758, 4370.628496577795, 4399.38408622793, 4403.9559604404185, 4618.399608050965, 4667.393238878924, 4704.717716936994, 4818.71087734737, 4822.758862056883, 5070.112730272224, 5106.897862042775, 5147.0, 5153.3558305211845, 5157.381114266312, 5132.640715149941, 5166.457521960216, 5170.431252562215, 5174.663646862942, 5174.793008279665, 4603.240465323252, 4674.298855171752, 4700.741459219707, 4765.475797662254, 4805.9667171557585, 5184.922226166611, 5195.870103247449, 5206.453322401169, 5256.474352564713, 5266.262723218752, 4997.625178111656, 5000.0, 5043.621728370387, 5051.419086805065, 5064.34163558735, 4939.382577177853, 5041.319421878, 5093.312402825572, 5098.617603679739, 5124.7950081996305, 5059.241113832954, 5068.543831055149, 5070.7464626768515, 5080.695158290514, 5129.692218466904, 5055.064813009605, 5066.544011039025, 5072.442031376546, 5073.695578265316, 5077.365329333833, 4183.309753890635, 4200.957990420118, 4219.282721937278, 4226.091390351028, 4230.957690423118, 3717.628237176315, 3718.925621487555, 3761.0409345616695, 3769.717271204616, 3774.094217387807, 4341.674374421931, 4351.717138386058, 4357.607815296575, 4395.296752519582, 4401.977990110029, 4933.679310844784, 4991.5258050485145, 5012.348394708737, 5069.03688299222, 5103.157978933508, 4343.1747967886, 4352.934705979413, 4374.496932852762, 4418.977905110454, 4419.955800442019, 4563.338315944169, 4574.908501829945, 4575.473820510617, 4580.083983203373, 4623.190941585209, 4647.209974304444, 4705.6000239979985, 4738.763061846825, 4785.59322457588, 4790.473047964791, 5033.748312584429, 5050.696958182521, 5052.014857102829, 5062.088824011713, 5093.541581257705, 4730.858074257778, 4759.28720629238, 4760.523947605212, 4761.285807128958, 4799.136155491905, 4869.659123861437, 4971.850844474671, 4976.950230497793, 5018.347614810052, 5020.974895125501, 5094.0, 5110.361204849394, 5115.25828754821, 5121.948780512147, 5168.198929165986, 4964.578010869117, 4970.080535100873, 4976.2286845539, 4978.004399120118, 4978.452370239198, 4835.854924352275, 4891.608671306216, 4906.411230652202, 4943.925841112315, 4968.8757781055765, 4819.783109759999, 4852.102361063215, 4861.295112208639, 4906.607471402208, 4910.165271903714, 4846.103470857903, 4959.231319145538, 4966.304717339503, 4968.975155124202, 4995.300657907823, 4765.237561990065, 4776.188048031912, 4789.042191561772, 4810.903781924272, 4822.469528351809], "value": 4648.779075254495, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [536.8492788695565, 583.0816464069093, 588.2969851028022, 595.9642421454715, 599.736116108912, 26770.866145669268, 27251.5912261316, 29157.708422915766, 29388.412231755377, 29406.852965735194, 39522.40716389257, 40752.0, 40802.7959860201, 44217.33673994893, 44259.0, 7658.846823063549, 7725.343345815612, 7789.948356971793, 7797.415193860455, 7801.297883190512, 7648.158702542716, 7719.459637825355, 7722.227777222289, 7723.845523089535, 7724.9613751931165, 7741.690332386698, 7761.805954851117, 7771.805704857367, 7772.41706871984, 7784.844303113934, 7725.8068548286465, 7746.612669366509, 7754.573498457583, 7754.961225193894, 7769.300762931363, 7676.884846727304, 7745.070591529053, 7759.8448031039625, 7761.534307941542, 7764.0, 35708.0, 35849.28301433957, 35968.64031359679, 35969.0, 35982.280354392766, 3076.9384612307854, 3085.8765649374222, 3134.843257837099, 3141.1361875484426, 3201.5037669161316, 27988.16035518938, 28045.719542804516, 28338.716612833814, 28385.57421638677, 28727.856360718062, 3343.632200457948, 3384.086296699877, 3389.068006298288, 3421.127612458807, 3454.7754395964434, 208229.0, 208795.0, 209451.0, 209538.0, 210049.99999999846, 31581.0, 32651.346973060405, 32714.345713085604, 47781.0, 48456.27315590269, 33901.0, 33913.49129763056, 34003.48994765081, 34033.659663403545, 34054.0, 12063.034957203403, 12218.327991960528, 12220.083493738006, 12273.202241854251, 12282.815757763641, 9913.603455861685, 10006.849897251546, 10007.0, 10012.69961901144, 10015.449150296658, 7947.880781788278, 7953.0456345238945, 7964.721234756756, 8028.558429286329, 8039.954805875199, 3113.719765221141, 3125.421796967523, 3127.546505756698, 3152.0, 3169.176014236315, 879.445949052093, 881.2817553693719, 893.9910600893908, 986.3982970388057, 995.3629677006721, 28149.131695726388, 28279.434411311657, 28772.712272877423, 28964.565531517044, 29164.562531562042, 842.4902933725008, 961.7451375385529, 969.6654654144309, 984.7931934293736, 1039.1271332080937, 14642.926785366006, 15379.0, 15444.768328475082, 15659.765103523456, 15682.137482438575, 380968.0, 610376.0, 620338.0, 621063.0, 622109.0, 46371.768141159075, 46997.530024699314, 47270.52729472661, 47273.527264726916, 47320.290195647096, 1095.6055819904827, 1190.166883181759, 1192.6124009696882, 1222.975540489203, 1223.9632811015683, 25093.74906250914, 29413.823447061877, 29582.260443489085, 29812.70187298186, 29946.25134371658, 41755.58244417517, 47886.76056619694, 49474.25788613102, 49517.257241142135, 53373.7331313341, 332833.0, 333416.0, 336230.0, 336464.0, 336648.0, 33063.50404743979, 37606.24787504289, 38779.41830872596, 39174.0, 39667.80166099266, 42541.36187957121, 42861.57138428576, 42989.0, 43088.569114308455, 43436.78281608572, 37075.443868341456, 37547.81226093852, 37765.0, 37808.0, 37830.62169378271, 37352.0, 37553.24893502169, 37576.2484750298, 37626.81186594049, 38060.0, 36213.27573448569, 36216.65962365542, 36515.087122822144, 36614.26771464609, 36814.81592592127, 32150.517742233416, 32475.512867306537, 33693.83153084317, 33826.32347353089, 33910.0, 25591.48817023612, 25624.103156389436, 25954.870225648752, 25981.74018259869, 26200.475990480463], "value": 16537.762795894247, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [340.91136304560837, 362.98548058077677, 366.5711117991949, 367.6011527492671, 384.1893604494516, 13052.869471305285, 16570.922890012156, 16959.915200424013, 18759.624807503842, 18811.435656930313, 16665.66668666626, 17004.234809433576, 17016.659666806656, 17081.23134458949, 17362.95822250666, 5160.535551800328, 5278.709670968095, 5555.250041244441, 5570.582206334521, 5667.121596152603, 3514.630963748808, 5265.605079619025, 5546.168074788774, 5552.444755524456, 5582.665040097607, 5558.805441809537, 5563.944360556403, 5572.192032155335, 5579.525740312079, 5584.832455026356, 5503.559715222793, 6245.313015568284, 6248.87502249957, 6251.249850017982, 6257.655828929407, 4720.811167553328, 5530.834074977757, 5536.141898005815, 5537.861553461195, 5541.639793413416, 12221.205621634565, 12360.072994525357, 12425.378731063502, 12491.875081249162, 12495.062870284764, 1870.8690391672587, 1927.8457723382096, 1939.3309308288617, 1990.2934458267252, 2010.2059686423927, 8799.736007919773, 8824.35269419178, 8992.325575581857, 9181.449113053239, 9341.532923353872, 1721.6040310728476, 1734.470986349163, 1746.6332070265132, 1773.2906837265068, 1802.7476153338544, 66771.66614166947, 69797.65101174513, 70148.6492567539, 71623.64188179078, 74018.25981740167, 8227.794305142299, 8734.257588105082, 9193.49435781025, 9534.761630959281, 10136.797264054678, 12187.45156467961, 12977.35113244334, 13031.478740850449, 13067.34663266852, 13621.659458513617, 5512.2558454608115, 6985.126859142607, 7154.4991850571005, 7190.748323808746, 7255.564666119944, 6643.1031810704935, 6644.4020038196795, 6727.394534491919, 6764.763233286812, 6783.491238157059, 4325.264705000158, 4329.372241025034, 4402.449693788277, 4496.415465989466, 4568.109218702388, 1750.719884818423, 1802.9870382274999, 1819.881707688996, 1894.0719047666544, 1896.2415033986515, 827.6482494939627, 855.5038077914794, 864.7319331007408, 927.7819712367589, 932.9766755831023, 16851.157442127846, 16994.660106797794, 17631.647367052843, 17633.647327053386, 18217.544561386072, 849.6941101203562, 859.3812455032366, 861.039940466388, 895.2748273898034, 930.8417569013284, 5799.420057994167, 5905.852353691193, 5968.343482216953, 6025.276966763929, 9872.259580531489, 408393.0, 418284.0, 423322.0, 428104.0, 428172.0, 77859.0, 78771.21228787754, 78795.0, 80398.5980070096, 81493.0, 397.1897329447894, 400.8917592250076, 403.3908797715471, 403.4613790589537, 404.19968462444524, 10136.543855526666, 10157.492125393554, 10183.0, 10312.896871031193, 10477.738056548647, 35298.29403411969, 36114.4582831263, 38515.229695405375, 40885.795571021954, 42966.0, 52800.735996319774, 55008.724956374965, 55012.174817378575, 55146.72426637841, 55239.72380138074, 7402.925970740223, 7493.325600695964, 7615.581143037186, 7625.618719064136, 7685.193054729173, 10962.177836662122, 11989.400529973293, 12009.939950300193, 12179.0, 12236.755264894475, 10442.373457592568, 10448.52981615814, 10593.470326483492, 10722.517486713272, 10811.6215932442, 10322.380657160295, 10445.321054131457, 10470.685879423629, 10722.463876806285, 10754.13966882632, 10125.696229113139, 10441.26911116245, 10621.203409744454, 10715.303505272132, 10762.838557421488, 7659.0, 7720.652570634447, 7738.264864837832, 7868.213178682086, 7954.085280192852, 8014.078380986261, 10264.127549158107, 10425.635102771366, 10685.839712404164, 10736.409497477714], "value": 7814.1829372001885, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1206.9698257543566, 1357.27385848571, 1410.2173293821927, 1459.2120255062266, 1698.8980661160324, 6617.305182955786, 7400.814979625506, 7621.0, 7640.235976402357, 7815.882761758578, 7577.734779282726, 7733.574653394061, 7768.106667733213, 7777.066751989755, 7777.261160189787, 2190.7261592301, 2215.0475295622878, 2216.1578600132007, 2217.800397964183, 2218.0240694094628, 2150.6236408628506, 2182.978170218293, 2214.5017371091535, 2216.390492614536, 2217.4456385903522, 2179.553191595727, 2187.4203336115943, 2187.485940803918, 2191.1345018717598, 2225.198928385788, 2100.8214301784365, 2107.873527588334, 2109.209046607507, 2110.7361579802523, 2111.5249068959592, 2079.3034333498294, 2113.218109299554, 2115.1433669363932, 2115.8201552868027, 2116.1112332820253, 7609.847803043964, 7760.146383897767, 7789.415793815487, 7823.608819559056, 7840.372770178372, 4462.527365969222, 4586.495485496593, 4588.4035075440315, 4590.540945905383, 4590.724556526619, 2863.1124351451117, 2930.223490774946, 2978.7468065214484, 2986.805857619248, 2991.311998240395, 913.5432283858071, 919.5034681272105, 932.9813403731955, 938.0197693410403, 951.1297163095759, 10386.221033422524, 10476.3190392625, 10481.580736770444, 10487.265891387606, 10491.370517768883, 3804.885853424402, 3921.9803900980883, 4015.437838702584, 4016.357382818793, 4026.778527181033, 8281.17188281167, 8322.958385208036, 8324.0, 8327.8334433311, 8334.166583341617, 4390.385346051556, 4392.934105988413, 4394.802233899482, 4400.0, 4401.449818772653, 3642.399004164336, 4003.8789139041114, 4091.284025295561, 4094.4677191965447, 4153.646940010072, 3350.246194606194, 3398.0, 3424.2637832865557, 3441.15691655546, 3500.6674365935196, 1028.7736697926443, 1033.560736686905, 1041.6198087697935, 1042.4162469017374, 1048.528162326956, 803.9187293090783, 804.1998211779201, 808.0908977400425, 810.0562844286341, 814.6334149632689, 5079.0, 5092.185250359925, 5106.157484015096, 5273.762680679379, 5308.018016666929, 400.4713777813317, 403.6447925825255, 408.7016477971098, 421.9620234178939, 424.757888003841, 3352.5976882773734, 3474.7915125092577, 3563.3407819553468, 3599.9640003600152, 3626.676263163979, 8949.328800340001, 9278.350515463853, 9317.0, 9635.614575416905, 9637.325387222967, 9404.106609872051, 9447.52762361893, 9527.761805954768, 9530.237580993504, 9537.666181683746, 7030.086088808524, 7254.89117663246, 7268.055152830098, 7274.527155734861, 7283.817904552428, 5348.545373643128, 5466.863328416822, 5538.584606154474, 5677.063284558001, 5727.0550359190265, 8690.565471726515, 8869.556522173994, 8972.775680608038, 9033.051529589298, 9040.41237319572, 8863.202311791969, 8974.685885993958, 9173.0, 9184.035676254165, 9194.448333100036, 5860.824175274749, 6536.6731663415685, 6754.662266886734, 6846.212685541226, 7015.894761578683, 7390.445716571387, 7396.3343299103335, 7476.626168691435, 7497.625118743932, 7509.249075092447, 6468.3855033771715, 6589.47284217271, 6592.406683398517, 6731.596104233761, 6748.561343512656, 6552.508561857975, 6568.441682457044, 6629.569078009914, 6670.966645166744, 6699.162604674416, 6033.095035744674, 6060.212172417558, 6092.2689277285235, 6094.177286066501, 6095.939040609537, 4241.9363709545, 4298.376735373291, 4376.978115109404, 4482.081173359518, 4489.910201796011, 4436.334549817553, 4457.7771111444945, 4465.441819772528, 4521.706089104197, 4586.220342541843], "value": 3972.4367337836475, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [296.21503017004943, 296.82783985288535, 300.5596800686993, 301.4092378937283, 302.04553610590534, 4781.18719817631, 4791.425028996521, 4792.544708252719, 4795.448523419812, 4860.805567777294, 4748.76256187191, 4773.4510531288915, 4774.73738944358, 4781.904361912769, 4788.473267940523, 3576.1774791797966, 3681.9631803682023, 3706.870259540917, 3802.90492737681, 3843.5964223756523, 3746.9812650936706, 3790.7915064671433, 3801.5058042454443, 3821.445890345912, 3832.329342365075, 3539.3098345822573, 3760.2667479841443, 3765.2281282337194, 3769.886903392889, 3776.8866933991885, 3664.926701465969, 3773.52830896138, 3786.2995345861104, 3799.6010418905894, 3818.3890577507605, 3353.815540145291, 3355.798652080883, 3359.260962588227, 3360.092774950774, 3362.260302733395, 4686.625069994392, 4733.644976626767, 4735.242361222188, 4740.478547359788, 4740.881477963044, 4226.640735537483, 4311.8706438806885, 4332.761698106603, 4335.916020994751, 4348.782560871944, 4982.377202849644, 4984.352034235562, 5001.949980500185, 5003.524665156804, 5022.7990880365105, 3650.963490365089, 3660.1215708230097, 3674.816259187057, 3675.5405574303213, 3693.6121707220623, 5132.153194722866, 5171.560417364529, 5241.868953276123, 5263.552598029172, 5274.683518988834, 3693.3167364037204, 3695.722820788452, 3725.981370093132, 3744.0530923919955, 3759.0978165240695, 3772.5475691858833, 3779.4708740776314, 3787.2046870157574, 3815.37046387343, 3815.569161564413, 4345.521992580813, 4346.543612920598, 4355.0854320593035, 4355.455568053993, 4364.279893817548, 4977.0, 5046.949530504721, 5052.368453943257, 5056.646034777604, 5067.695938243717, 1301.3688361144837, 1307.843058832927, 1316.6642506160867, 1317.617890811654, 1318.6637407461228, 842.7345386203449, 842.9114942931027, 891.7681402835309, 909.3316412436853, 913.7167478081816, 4359.912801744011, 4366.454193225847, 4383.846565370197, 4392.494863090722, 4415.646748260196, 5086.923696144487, 5090.923636145387, 5093.567046801063, 5135.3324067870935, 5139.665921715076, 4208.621224089786, 4390.4511936008, 4393.362962370438, 4396.0, 4405.735655860659, 2727.59086137081, 2729.0584748261817, 2737.438825040862, 2737.630419893329, 2761.3096725818546, 4854.757262136879, 4854.927176092361, 4862.690222144523, 4867.829625963145, 4874.683145595525, 5102.897942041139, 5237.009936224211, 5255.684658920477, 5267.236250743621, 5292.4707529247535, 4811.542903424169, 4814.542618451312, 4815.15734746418, 4815.662903596854, 4824.372831531879, 5055.6713813602, 5073.8731531712, 5084.2881996521255, 5087.99808113215, 5118.257852611425, 4759.547842954914, 4997.175466048061, 4997.650164488451, 5022.547970682656, 5042.168042272984, 4790.592799612072, 4799.592034676952, 4801.591864691541, 4807.543283388072, 4818.277258411266, 3754.7934863582764, 3757.9060523487133, 3777.773333599993, 3780.697544196513, 3783.146258333342, 4970.986750366107, 5087.847364579068, 5102.897942041064, 5122.769475373542, 5272.420033796356, 5048.368953880765, 5085.211792172219, 5092.108880945893, 5092.41437234708, 5097.915760964563, 5058.128492457667, 5072.858606813437, 5078.0, 5092.668976516515, 5093.0, 4789.976050119727, 4818.277258411126, 5016.0, 5035.370578677665, 5037.765747391913, 4984.975075124601, 5112.795488180431, 5116.158183054172, 5116.386033675983, 5123.897522049464, 4969.875753106056, 4989.625778066732, 5009.123403404463, 5010.724410157476, 5013.974930125326], "value": 3807.01080147915, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [650.7982525417121, 660.1550015979548, 671.882420576399, 687.3916583823318, 701.277683985495, 12577.937110314448, 12773.169743966635, 13037.478500859954, 13047.543335983242, 13060.804087938677, 13540.39068241929, 14037.0, 14080.436782528712, 14090.0, 14097.788533171984, 632.8639342541353, 765.6286700950035, 776.0919723923009, 780.4536824223067, 787.1144961917843, 771.9228077192292, 780.0327593783695, 780.4848799792138, 782.1669921533548, 795.1333046978792, 813.1786895235796, 815.3395749442941, 815.8980127484065, 816.2123550773503, 817.1624085312573, 658.8517583543712, 799.9000124984377, 809.8501777171213, 812.4110020235341, 818.3657665309432, 602.9819105426844, 603.0020316376404, 603.0652488642586, 603.1525706382496, 604.027515699723, 13210.405531751094, 13214.0, 13237.13958592698, 13272.800907986388, 13276.203427794364, 12330.013598912066, 12850.485980560767, 12855.935720321431, 12887.806682899763, 13049.54326598574, 12205.572804951784, 12514.499420023189, 12517.0, 12627.558035468715, 12763.872361276453, 4133.545310015896, 4158.91682166355, 4160.167966406731, 4211.7051806373565, 4232.090100628349, 62166.37833621651, 64012.679936600485, 64084.3591564083, 64110.35889641091, 64136.67931660312, 9675.840856435243, 10105.242106842017, 10200.132988696045, 10621.415822129702, 10656.520456579472, 18951.90524047371, 19136.138873750715, 19221.32725354606, 19231.0, 19316.130774114918, 6951.548149370275, 6997.755078572327, 7059.964700176466, 7073.752418665322, 7159.03353047332, 3625.5286812714708, 3677.191017976041, 3880.4955355803563, 3987.182627561343, 4142.150859073882, 2869.6986816384397, 2953.4831404504125, 2969.62879640045, 2969.7178768017, 2972.048944337791, 484.68011112666176, 486.11527020822473, 487.90485855257884, 499.2137383620812, 503.6575128912375, 503.55435439635454, 604.2265899648457, 619.7582942652369, 620.9565330426917, 635.1457289945016, 8078.272955434039, 8244.422890397615, 8315.334773218128, 8400.159984001551, 8591.496488114555, 468.5548728707673, 531.4897698209685, 536.715540763396, 539.8974194902955, 583.8832233553306, 3710.8144592770254, 4013.979930100331, 4075.8573449929704, 4110.46563946685, 4243.384709217208, 62006.41942225221, 93469.0, 93579.0, 96748.51625741967, 97658.0, 80219.0, 81301.59349203216, 82397.0, 83014.0, 83626.74559881607, 44820.17767385193, 64726.352736472036, 71826.281737183, 75215.62392188005, 77006.0, 8118.918810811816, 8123.197496863572, 8199.344052475668, 8295.917040829756, 8367.205115514016, 44563.554364455944, 44565.331520027874, 45260.32109518294, 45505.77247113876, 46148.30777538407, 51345.486545134074, 54738.178927315326, 56665.43334566602, 59747.40252597592, 60548.697256513435, 11708.238964467282, 11784.646460606196, 11858.822117668069, 11984.820227696417, 11993.759377133874, 13657.248851313274, 13692.041557090908, 14002.57992260234, 14418.062825916282, 14557.85442145565, 12617.558385456465, 12691.238525688488, 12711.872881271069, 12839.743205135657, 13661.86338136606, 11934.761304774029, 12116.15186936906, 12283.140180187302, 12395.132340736061, 12423.813642795185, 11628.88371116278, 11741.119416044, 11825.586104486301, 12245.448954796877, 12249.265044097383, 9085.318601104811, 9453.763655908657, 9818.950905245714, 9852.310338276251, 10594.576216951544, 9582.425054496753, 9599.280053995839, 9682.56428460735, 9748.707538773848, 10428.687139385831], "value": 6640.253059258108, "unit": "score"}], "name": "dromaeo_css", "value": 6262.707919504388, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 115.0, 116.0, 116.0, 115.0, 116.0, 116.0, 115.0, 116.0, 116.0], "value": 114.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 124.0, 131.0, 175.0, 126.0, 133.0, 147.0, 124.0, 181.0, 125.0], "value": 141.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 161.0, 161.0, 162.0, 161.0, 160.0, 161.0, 163.0, 162.0], "value": 161.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 77.0, 125.0, 76.0, 77.0, 76.0, 76.0, 100.0, 76.0], "value": 83.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 120.0, 84.0, 85.0, 84.0, 124.0, 84.0, 84.0, 138.0], "value": 96.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 147.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0], "value": 146.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 95.0, 94.0, 95.0, 95.0, 96.0, 95.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 64.0, 63.0, 64.0, 64.0, 64.0, 65.0, 63.0, 65.0], "value": 64.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 64.0, 64.0, 65.0, 64.0, 63.0, 65.0, 64.0, 64.0], "value": 64.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 78.0, 82.0, 85.0, 80.0, 87.0, 81.0, 79.0, 79.0, 79.0], "value": 81.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 138.0, 127.0, 133.0, 139.0, 133.0, 131.0, 139.0, 170.0, 140.0], "value": 138.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 164.0, 170.0, 164.0, 173.0, 172.0, 168.0, 172.0, 165.0, 165.0], "value": 168.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 68.0, 69.0, 68.0, 72.0, 69.0, 67.0, 67.0, 66.0, 67.0], "value": 68.3, "unit": "score"}], "name": "kraken", "value": 1541.3999999999996, "alertThreshold": 2.0}]} 01:52:18 INFO - Return code: 0 01:52:18 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 01:52:18 INFO - # TBPL SUCCESS # 01:52:18 INFO - Running post-action listener: _resource_record_post_action 01:52:18 INFO - ##### 01:52:18 INFO - ##### Finished run-tests step (success) 01:52:18 INFO - ##### 01:52:18 INFO - Running post-run listener: _resource_record_post_run 01:52:18 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 0; Write bytes: 534249472; Read time: 0; Write time: 448636 01:52:18 INFO - TinderboxPrint: CPU usage
13.0% 01:52:18 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 01:52:18 INFO - TinderboxPrint: I/O write bytes / time
534,249,472 / 448,636 01:52:18 INFO - TinderboxPrint: CPU idle
8,327.8 (87.0%) 01:52:18 INFO - TinderboxPrint: CPU user
1,201.1 (12.5%) 01:52:18 INFO - TinderboxPrint: Swap in / out
0 / 0 01:52:18 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 245284864; Read time: 0; Write time: 243768 01:52:18 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 0; Write bytes: 288628736; Read time: 0; Write time: 204848 01:52:19 INFO - Running post-run listener: _upload_blobber_files 01:52:19 INFO - Blob upload gear active. 01:52:19 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 01:52:19 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 01:52:19 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'] 01:52:19 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 01:52:19 INFO - (blobuploader) - INFO - Open directory for files ... 01:52:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 01:52:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:52:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:52:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 01:52:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:52:20 INFO - (blobuploader) - INFO - Done attempting. 01:52:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 01:52:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:52:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:52:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 01:52:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:52:21 INFO - (blobuploader) - INFO - Done attempting. 01:52:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 01:52:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:52:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:52:25 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 01:52:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:52:25 INFO - (blobuploader) - INFO - Done attempting. 01:52:25 INFO - (blobuploader) - INFO - Iteration through files over. 01:52:25 INFO - Return code: 0 01:52:25 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 01:52:25 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 01:52:25 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/b31f5faf1ee5124e757f06dc8c808be09d795ba43768df632246869821289b76ed3dc5e8e3dd317be181292a573746dfc3a13e32cab437fcce75fbfd0340a42e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/f542a99dc4f9d219ca5583101ca25969997f0804555ca40fbb004ef689d20a4d1a21080fb1e340fbc8191dc43ae03c0b05fd638d41d0e7d9bd61d61f8be48b03", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/a95d00287ac6593530e65d76567b4738cf822d1ab765129bd525850f1a22275af796091c2492954ff7634ebcf94cb768e83725fa722ce39f99a8186145a373f5"} 01:52:25 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 01:52:25 INFO - Writing to file /builds/slave/test/properties/blobber_files 01:52:25 INFO - Contents: 01:52:25 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/b31f5faf1ee5124e757f06dc8c808be09d795ba43768df632246869821289b76ed3dc5e8e3dd317be181292a573746dfc3a13e32cab437fcce75fbfd0340a42e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/f542a99dc4f9d219ca5583101ca25969997f0804555ca40fbb004ef689d20a4d1a21080fb1e340fbc8191dc43ae03c0b05fd638d41d0e7d9bd61d61f8be48b03", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/a95d00287ac6593530e65d76567b4738cf822d1ab765129bd525850f1a22275af796091c2492954ff7634ebcf94cb768e83725fa722ce39f99a8186145a373f5"} 01:52:25 INFO - Running post-run listener: copy_logs_to_upload_dir 01:52:25 INFO - Copying logs to upload dir... 01:52:25 INFO - mkdir: /builds/slave/test/build/upload/logs 01:52:25 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.824690 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-07-01 01:52:24.076652) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-01 01:52:24.080600) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=0e2a256762fed810e2f0f810000001b3-1467348581.27826-223990481 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/b31f5faf1ee5124e757f06dc8c808be09d795ba43768df632246869821289b76ed3dc5e8e3dd317be181292a573746dfc3a13e32cab437fcce75fbfd0340a42e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/f542a99dc4f9d219ca5583101ca25969997f0804555ca40fbb004ef689d20a4d1a21080fb1e340fbc8191dc43ae03c0b05fd638d41d0e7d9bd61d61f8be48b03", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/a95d00287ac6593530e65d76567b4738cf822d1ab765129bd525850f1a22275af796091c2492954ff7634ebcf94cb768e83725fa722ce39f99a8186145a373f5"} build_url:https://queue.taskcluster.net/v1/task/ArR8ucauQGy59IodfwlN_g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011345 build_url: 'https://queue.taskcluster.net/v1/task/ArR8ucauQGy59IodfwlN_g/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/b31f5faf1ee5124e757f06dc8c808be09d795ba43768df632246869821289b76ed3dc5e8e3dd317be181292a573746dfc3a13e32cab437fcce75fbfd0340a42e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/f542a99dc4f9d219ca5583101ca25969997f0804555ca40fbb004ef689d20a4d1a21080fb1e340fbc8191dc43ae03c0b05fd638d41d0e7d9bd61d61f8be48b03", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/a95d00287ac6593530e65d76567b4738cf822d1ab765129bd525850f1a22275af796091c2492954ff7634ebcf94cb768e83725fa722ce39f99a8186145a373f5"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-01 01:52:24.108821) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 01:52:24.109317) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=0e2a256762fed810e2f0f810000001b3-1467348581.27826-223990481 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004424 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 01:52:24.194417) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-01 01:52:24.195096) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-01 01:52:24.195438) ========= ========= Total master_lag: 0.18 =========