builder: autoland_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-061 starttime: 1470889526.55 results: success (0) buildid: 20160810195520 builduid: 4c496e1149d141b083c82fa4c2ec2229 revision: f64f8bc8415f1cffff58478438d2a3af81272985 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-10 21:25:26.547652) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-10 21:25:26.548064) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-10 21:25:26.548359) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-10 21:25:26.563634) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-10 21:25:26.563887) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1470889525.835985-2117767061 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-10 21:25:26-- 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% 138K=0.09s 2016-08-10 21:25:27 (138 KB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.288228 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-10 21:25:26.866035) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-10 21:25:26.866330) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1470889525.835985-2117767061 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014047 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-10 21:25:26.914701) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-10 21:25:26.915000) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev f64f8bc8415f1cffff58478438d2a3af81272985 --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 f64f8bc8415f1cffff58478438d2a3af81272985 --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=516f8d7ca085b4d087ab0a71000001a4-1470889525.835985-2117767061 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-10 21:25:27,366 truncating revision to first 12 chars 2016-08-10 21:25:27,366 Setting DEBUG logging. 2016-08-10 21:25:27,366 attempt 1/10 2016-08-10 21:25:27,366 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/f64f8bc8415f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-10 21:25:28,515 unpacking tar archive at: autoland-f64f8bc8415f/testing/mozharness/ program finished with exit code 0 elapsedTime=1.472384 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-10 21:25:28.402019) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-10 21:25:28.402347) ========= script_repo_revision: f64f8bc8415f1cffff58478438d2a3af81272985 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-10 21:25:28.402733) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-10 21:25:28.403073) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-10 21:25:28.412632) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-08-10 21:25:28.412902) ========= /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=516f8d7ca085b4d087ab0a71000001a4-1470889525.835985-2117767061 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 21:25:29 INFO - MultiFileLogger online at 20160810 21:25:29 in /builds/slave/test 21:25:29 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 21:25:29 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:25:29 INFO - {'append_to_log': False, 21:25:29 INFO - 'base_work_dir': '/builds/slave/test', 21:25:29 INFO - 'blob_upload_branch': 'Autoland-Non-PGO', 21:25:29 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:25:29 INFO - 'branch': 'Autoland-Non-PGO', 21:25:29 INFO - 'buildbot_json_path': 'buildprops.json', 21:25:29 INFO - 'config_files': ('talos/linux_config.py',), 21:25:29 INFO - 'default_actions': ('clobber', 21:25:29 INFO - 'read-buildbot-config', 21:25:29 INFO - 'download-and-extract', 21:25:29 INFO - 'populate-webroot', 21:25:29 INFO - 'create-virtualenv', 21:25:29 INFO - 'install', 21:25:29 INFO - 'run-tests'), 21:25:29 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:25:29 INFO - 'download_minidump_stackwalk': True, 21:25:29 INFO - 'download_symbols': 'ondemand', 21:25:29 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:25:29 INFO - 'tooltool.py': '/tools/tooltool.py', 21:25:29 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:25:29 INFO - '/tools/misc-python/virtualenv.py')}, 21:25:29 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:25:29 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:25:29 INFO - 'installer_path': 'installer.exe', 21:25:29 INFO - 'log_level': 'info', 21:25:29 INFO - 'log_name': 'talos', 21:25:29 INFO - 'log_to_console': True, 21:25:29 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 21:25:29 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 21:25:29 INFO - 'opt_config_files': (), 21:25:29 INFO - 'pip_index': False, 21:25:29 INFO - 'sps_profile': False, 21:25:29 INFO - 'sps_profile_interval': 0, 21:25:29 INFO - 'suite': 'dromaeojs', 21:25:29 INFO - 'system_bits': '32', 21:25:29 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:25:29 INFO - 'title': 'talos-linux64-ix-061', 21:25:29 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:25:29 INFO - 'use_talos_json': True, 21:25:29 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:25:29 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:25:29 INFO - 'work_dir': 'build'} 21:25:29 INFO - [mozharness: 2016-08-11 04:25:29.028445Z] Running clobber step. 21:25:29 INFO - Running pre-action listener: _resource_record_pre_action 21:25:29 INFO - Running main action method: clobber 21:25:29 INFO - rmtree: /builds/slave/test/build 21:25:29 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:25:29 INFO - Running post-action listener: _resource_record_post_action 21:25:29 INFO - [mozharness: 2016-08-11 04:25:29.747469Z] Finished clobber step (success) 21:25:29 INFO - [mozharness: 2016-08-11 04:25:29.747572Z] Running read-buildbot-config step. 21:25:29 INFO - Running pre-action listener: _resource_record_pre_action 21:25:29 INFO - Running main action method: read_buildbot_config 21:25:29 INFO - Using buildbot properties: 21:25:29 INFO - { 21:25:29 INFO - "project": "", 21:25:29 INFO - "product": "firefox", 21:25:29 INFO - "script_repo_revision": "production", 21:25:29 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs", 21:25:29 INFO - "repository": "", 21:25:29 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland talos dromaeojs", 21:25:29 INFO - "buildid": "20160810195520", 21:25:29 INFO - "pgo_build": "False", 21:25:29 INFO - "basedir": "/builds/slave/test", 21:25:29 INFO - "buildnumber": 351, 21:25:29 INFO - "slavename": "talos-linux64-ix-061", 21:25:29 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 21:25:29 INFO - "platform": "ubuntu64_hw", 21:25:29 INFO - "scheduler": "tests-autoland-linux64-talos", 21:25:29 INFO - "branch": "autoland", 21:25:29 INFO - "repo_path": "integration/autoland", 21:25:29 INFO - "revision": "f64f8bc8415f1cffff58478438d2a3af81272985", 21:25:29 INFO - "stage_platform": "linux64", 21:25:29 INFO - "builduid": "4c496e1149d141b083c82fa4c2ec2229", 21:25:29 INFO - "slavebuilddir": "test" 21:25:29 INFO - } 21:25:29 INFO - Found installer url https://queue.taskcluster.net/v1/task/JlDi14UURwKHO9sCZtxh2Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 21:25:29 INFO - Running post-action listener: _resource_record_post_action 21:25:29 INFO - [mozharness: 2016-08-11 04:25:29.750013Z] Finished read-buildbot-config step (success) 21:25:29 INFO - [mozharness: 2016-08-11 04:25:29.750101Z] Running download-and-extract step. 21:25:29 INFO - Running pre-action listener: _resource_record_pre_action 21:25:29 INFO - Running main action method: download_and_extract 21:25:29 INFO - mkdir: /builds/slave/test/build/tests 21:25:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:25:29 INFO - trying https://queue.taskcluster.net/v1/task/JlDi14UURwKHO9sCZtxh2Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 21:25:29 INFO - Downloading https://queue.taskcluster.net/v1/task/JlDi14UURwKHO9sCZtxh2Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 21:25:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JlDi14UURwKHO9sCZtxh2Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 21:25:30 INFO - Downloaded 1361 bytes. 21:25:30 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 21:25:30 INFO - Using the following test package requirements: 21:25:30 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 21:25:30 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 21:25:30 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 21:25:30 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 21:25:30 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 21:25:30 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 21:25:30 INFO - u'jsshell-linux-x86_64.zip'], 21:25:30 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 21:25:30 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 21:25:30 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 21:25:30 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 21:25:30 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 21:25:30 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 21:25:30 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 21:25:30 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 21:25:30 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 21:25:30 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 21:25:30 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 21:25:30 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 21:25:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:25:30 INFO - trying https://queue.taskcluster.net/v1/task/JlDi14UURwKHO9sCZtxh2Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 21:25:30 INFO - Downloading https://queue.taskcluster.net/v1/task/JlDi14UURwKHO9sCZtxh2Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 21:25:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JlDi14UURwKHO9sCZtxh2Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 21:25:31 INFO - Downloaded 20262327 bytes. 21:25:31 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 21:25:31 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 21:25:32 INFO - Return code: 0 21:25:32 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 21:25:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:25:32 INFO - trying https://queue.taskcluster.net/v1/task/JlDi14UURwKHO9sCZtxh2Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 21:25:32 INFO - Downloading https://queue.taskcluster.net/v1/task/JlDi14UURwKHO9sCZtxh2Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 21:25:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JlDi14UURwKHO9sCZtxh2Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 21:25:33 INFO - Downloaded 20262327 bytes. 21:25:33 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 21:25:33 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 21:25:35 INFO - Return code: 0 21:25: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:25:35 INFO - trying https://queue.taskcluster.net/v1/task/JlDi14UURwKHO9sCZtxh2Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 21:25:35 INFO - Downloading https://queue.taskcluster.net/v1/task/JlDi14UURwKHO9sCZtxh2Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 21:25:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JlDi14UURwKHO9sCZtxh2Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 21:25:36 INFO - Downloaded 14413719 bytes. 21:25:36 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 21:25:36 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 21:25:36 INFO - Return code: 0 21:25:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:25:36 INFO - trying https://queue.taskcluster.net/v1/task/JlDi14UURwKHO9sCZtxh2Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 21:25:36 INFO - Downloading https://queue.taskcluster.net/v1/task/JlDi14UURwKHO9sCZtxh2Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 21:25:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JlDi14UURwKHO9sCZtxh2Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 21:25:37 INFO - Downloaded 55628018 bytes. 21:25:37 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JlDi14UURwKHO9sCZtxh2Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 21:25:37 INFO - mkdir: /builds/slave/test/properties 21:25:37 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:25:37 INFO - Writing to file /builds/slave/test/properties/build_url 21:25:37 INFO - Contents: 21:25:37 INFO - build_url:https://queue.taskcluster.net/v1/task/JlDi14UURwKHO9sCZtxh2Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 21:25:38 INFO - Running post-action listener: _resource_record_post_action 21:25:38 INFO - Running post-action listener: set_extra_try_arguments 21:25:38 INFO - [mozharness: 2016-08-11 04:25:38.251131Z] Finished download-and-extract step (success) 21:25:38 INFO - [mozharness: 2016-08-11 04:25:38.251366Z] Running populate-webroot step. 21:25:38 INFO - Running pre-action listener: _resource_record_pre_action 21:25:38 INFO - Running main action method: populate_webroot 21:25:38 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:25:38 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:25:38 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:25:38 INFO - '--tppagecycles', 21:25:38 INFO - '7'], 21:25:38 INFO - 'tests': ['tsvgm']}}, 21:25:38 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 21:25:38 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:25:38 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 21:25:38 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 21:25:38 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:25:38 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 21:25:38 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:25:38 INFO - 'talos_options': ['--disable-e10s'], 21:25:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:25:38 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:25:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:25:38 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:25:38 INFO - 'talos_options': ['--disable-e10s'], 21:25:38 INFO - 'tests': ['damp', 'tps']}, 21:25:38 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:25:38 INFO - 'tests': ['damp', 'tps']}, 21:25:38 INFO - 'g3': {'talos_options': ['--disable-e10s'], 21:25:38 INFO - 'tests': ['dromaeo_dom']}, 21:25:38 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:25:38 INFO - 'g4': {'talos_options': ['--disable-e10s'], 21:25:38 INFO - 'tests': ['basic_compositor_video']}, 21:25:38 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 21:25:38 INFO - 'other': {'talos_options': ['--disable-e10s'], 21:25:38 INFO - 'tests': ['a11yr', 21:25:38 INFO - 'ts_paint', 21:25:38 INFO - 'tpaint', 21:25:38 INFO - 'sessionrestore', 21:25:38 INFO - 'sessionrestore_no_auto_restore', 21:25:38 INFO - 'tabpaint']}, 21:25:38 INFO - 'other-e10s': {'tests': ['a11yr', 21:25:38 INFO - 'ts_paint', 21:25:38 INFO - 'tpaint', 21:25:38 INFO - 'sessionrestore', 21:25:38 INFO - 'sessionrestore_no_auto_restore', 21:25:38 INFO - 'tabpaint']}, 21:25:38 INFO - 'other-e10s_l64': {'tests': ['a11yr', 21:25:38 INFO - 'ts_paint', 21:25:38 INFO - 'tpaint', 21:25:38 INFO - 'sessionrestore', 21:25:38 INFO - 'sessionrestore_no_auto_restore', 21:25:38 INFO - 'tabpaint']}, 21:25:38 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 21:25:38 INFO - 'ts_paint', 21:25:38 INFO - 'tpaint', 21:25:38 INFO - 'sessionrestore', 21:25:38 INFO - 'sessionrestore_no_auto_restore', 21:25:38 INFO - 'tabpaint']}, 21:25:38 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 21:25:38 INFO - 'tests': ['a11yr', 21:25:38 INFO - 'ts_paint', 21:25:38 INFO - 'tpaint', 21:25:38 INFO - 'sessionrestore', 21:25:38 INFO - 'sessionrestore_no_auto_restore', 21:25:38 INFO - 'tabpaint']}, 21:25:38 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 21:25:38 INFO - 'tests': ['a11yr', 21:25:38 INFO - 'ts_paint', 21:25:38 INFO - 'tpaint', 21:25:38 INFO - 'sessionrestore', 21:25:38 INFO - 'sessionrestore_no_auto_restore', 21:25:38 INFO - 'tabpaint']}, 21:25:38 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 21:25:38 INFO - 'tests': ['tsvgx', 21:25:38 INFO - 'tsvgr_opacity', 21:25:38 INFO - 'tart', 21:25:38 INFO - 'tscrollx', 21:25:38 INFO - 'cart']}, 21:25:38 INFO - 'svgr-e10s': {'tests': ['tsvgx', 21:25:38 INFO - 'tsvgr_opacity', 21:25:38 INFO - 'tart', 21:25:38 INFO - 'tscrollx', 21:25:38 INFO - 'cart']}, 21:25:38 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:25:38 INFO - 'talos_options': ['--disable-e10s'], 21:25:38 INFO - 'tests': ['tp5o']}, 21:25:38 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:25:38 INFO - 'tests': ['tp5o']}, 21:25:38 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:25:38 INFO - 'talos_options': ['--disable-e10s', 21:25:38 INFO - '--xperf_path', 21:25:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:25:38 INFO - 'tests': ['tp5n']}, 21:25:38 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:25:38 INFO - 'talos_options': ['--xperf_path', 21:25:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:25:38 INFO - 'tests': ['tp5n']}}, 21:25:38 INFO - 'talos.zip': {'path': '', 21:25:38 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:25:38 INFO - Running post-action listener: _resource_record_post_action 21:25:38 INFO - [mozharness: 2016-08-11 04:25:38.273264Z] Finished populate-webroot step (success) 21:25:38 INFO - [mozharness: 2016-08-11 04:25:38.273353Z] Running create-virtualenv step. 21:25:38 INFO - Running pre-action listener: _resource_record_pre_action 21:25:38 INFO - Running main action method: create_virtualenv 21:25:38 INFO - Creating virtualenv /builds/slave/test/build/venv 21:25:38 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 21:25:38 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:25:38 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:25:38 INFO - Using real prefix '/usr' 21:25:38 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:25:39 INFO - Installing distribute.............................................................................................................................................................................................done. 21:25:41 INFO - Installing pip.................done. 21:25:41 INFO - Return code: 0 21:25:41 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:25:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:25:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:25:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:25:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:25:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:25:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:25:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e31030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20f2180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20f03b0>, '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 0x20f12b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20f1740>, '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': '516f8d7ca085b4d087ab0a71000001a4-1470889525.835985-2117767061', '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 21:25:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 21:25:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 21:25:41 INFO - Using env: {'DISPLAY': ':0', 21:25:41 INFO - 'HOME': '/home/cltbld', 21:25:41 INFO - 'LANG': 'en_US.UTF-8', 21:25:41 INFO - 'LANGUAGE': 'en_US:en', 21:25:41 INFO - 'LOGNAME': 'cltbld', 21:25:41 INFO - 'MAIL': '/var/mail/cltbld', 21:25:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:25:41 INFO - 'MOZ_NO_REMOTE': '1', 21:25:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:25:41 INFO - 'NO_EM_RESTART': '1', 21:25:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:25:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:25:41 INFO - 'PWD': '/builds/slave/test', 21:25:41 INFO - 'SHELL': '/bin/bash', 21:25:41 INFO - 'SHLVL': '1', 21:25:41 INFO - 'TERM': 'linux', 21:25:41 INFO - 'TMOUT': '86400', 21:25:41 INFO - 'USER': 'cltbld', 21:25:41 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1470889525.835985-2117767061', 21:25:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:25:41 INFO - '_': '/tools/buildbot/bin/python'} 21:25:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:25:42 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 21:25:42 INFO - Cleaning up... 21:25:42 INFO - Return code: 0 21:25:42 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 21:25:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:25:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:25:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:25:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:25:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:25:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:25:42 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 0x1e31030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20f2180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20f03b0>, '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 0x20f12b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20f1740>, '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': '516f8d7ca085b4d087ab0a71000001a4-1470889525.835985-2117767061', '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 21:25:42 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 21:25:42 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 21:25:42 INFO - Using env: {'DISPLAY': ':0', 21:25:42 INFO - 'HOME': '/home/cltbld', 21:25:42 INFO - 'LANG': 'en_US.UTF-8', 21:25:42 INFO - 'LANGUAGE': 'en_US:en', 21:25:42 INFO - 'LOGNAME': 'cltbld', 21:25:42 INFO - 'MAIL': '/var/mail/cltbld', 21:25:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:25:42 INFO - 'MOZ_NO_REMOTE': '1', 21:25:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:25:42 INFO - 'NO_EM_RESTART': '1', 21:25:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:25:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:25:42 INFO - 'PWD': '/builds/slave/test', 21:25:42 INFO - 'SHELL': '/bin/bash', 21:25:42 INFO - 'SHLVL': '1', 21:25:42 INFO - 'TERM': 'linux', 21:25:42 INFO - 'TMOUT': '86400', 21:25:42 INFO - 'USER': 'cltbld', 21:25:42 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1470889525.835985-2117767061', 21:25:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:25:42 INFO - '_': '/tools/buildbot/bin/python'} 21:25:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:25:42 INFO - Downloading/unpacking psutil>=3.1.1 21:25:42 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 21:25:42 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 21:25:42 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 21:25:42 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 21:25:42 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 21:25:42 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 21:25:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:25:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:25:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:25:44 INFO - Installing collected packages: psutil 21:25:44 INFO - Running setup.py install for psutil 21:25:44 INFO - building 'psutil._psutil_linux' extension 21:25:44 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 21:25:51 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 21:25:51 INFO - building 'psutil._psutil_posix' extension 21:25:51 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 21:25:51 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 21:25:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:25:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:25:52 INFO - Successfully installed psutil 21:25:52 INFO - Cleaning up... 21:25:52 INFO - Return code: 0 21:25:52 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 21:25:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:25:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:25:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:25:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:25:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:25:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:25:52 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 0x1e31030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20f2180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20f03b0>, '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 0x20f12b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20f1740>, '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': '516f8d7ca085b4d087ab0a71000001a4-1470889525.835985-2117767061', '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 21:25:52 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 21:25:52 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 21:25:52 INFO - Using env: {'DISPLAY': ':0', 21:25:52 INFO - 'HOME': '/home/cltbld', 21:25:52 INFO - 'LANG': 'en_US.UTF-8', 21:25:52 INFO - 'LANGUAGE': 'en_US:en', 21:25:52 INFO - 'LOGNAME': 'cltbld', 21:25:52 INFO - 'MAIL': '/var/mail/cltbld', 21:25:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:25:52 INFO - 'MOZ_NO_REMOTE': '1', 21:25:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:25:52 INFO - 'NO_EM_RESTART': '1', 21:25:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:25:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:25:52 INFO - 'PWD': '/builds/slave/test', 21:25:52 INFO - 'SHELL': '/bin/bash', 21:25:52 INFO - 'SHLVL': '1', 21:25:52 INFO - 'TERM': 'linux', 21:25:52 INFO - 'TMOUT': '86400', 21:25:52 INFO - 'USER': 'cltbld', 21:25:52 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1470889525.835985-2117767061', 21:25:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:25:52 INFO - '_': '/tools/buildbot/bin/python'} 21:25:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:25:52 INFO - Downloading/unpacking mozsystemmonitor==0.3 21:25:52 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 21:25:52 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 21:25:52 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 21:25:52 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 21:25:52 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 21:25:52 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 21:25:54 INFO - Downloading mozsystemmonitor-0.3.tar.gz 21:25:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:25:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 21:25:54 INFO - Installing collected packages: mozsystemmonitor 21:25:54 INFO - Running setup.py install for mozsystemmonitor 21:25:54 INFO - Successfully installed mozsystemmonitor 21:25:54 INFO - Cleaning up... 21:25:54 INFO - Return code: 0 21:25:54 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 21:25:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:25:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:25:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:25:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:25:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:25:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:25:54 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 0x1e31030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20f2180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20f03b0>, '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 0x20f12b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20f1740>, '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': '516f8d7ca085b4d087ab0a71000001a4-1470889525.835985-2117767061', '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 21:25:54 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 21:25:54 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 21:25:54 INFO - Using env: {'DISPLAY': ':0', 21:25:54 INFO - 'HOME': '/home/cltbld', 21:25:54 INFO - 'LANG': 'en_US.UTF-8', 21:25:54 INFO - 'LANGUAGE': 'en_US:en', 21:25:54 INFO - 'LOGNAME': 'cltbld', 21:25:54 INFO - 'MAIL': '/var/mail/cltbld', 21:25:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:25:54 INFO - 'MOZ_NO_REMOTE': '1', 21:25:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:25:54 INFO - 'NO_EM_RESTART': '1', 21:25:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:25:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:25:54 INFO - 'PWD': '/builds/slave/test', 21:25:54 INFO - 'SHELL': '/bin/bash', 21:25:54 INFO - 'SHLVL': '1', 21:25:54 INFO - 'TERM': 'linux', 21:25:54 INFO - 'TMOUT': '86400', 21:25:54 INFO - 'USER': 'cltbld', 21:25:54 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1470889525.835985-2117767061', 21:25:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:25:54 INFO - '_': '/tools/buildbot/bin/python'} 21:25:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:25:54 INFO - Downloading/unpacking jsonschema==2.5.1 21:25:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:25:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:25:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:25:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:25:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:25:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:25:56 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:25:56 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 21:25:56 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 21:25:56 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 21:25:56 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 21:25:56 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 21:25:56 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 21:25:56 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 21:25:56 INFO - Downloading functools32-3.2.3-2.tar.gz 21:25:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:25:57 INFO - warning: no files found matching '*.txt' 21:25:57 INFO - no previously-included directories found matching 'build' 21:25:57 INFO - no previously-included directories found matching 'dist' 21:25:57 INFO - no previously-included directories found matching '.git*' 21:25:57 INFO - Installing collected packages: jsonschema, functools32 21:25:57 INFO - Running setup.py install for functools32 21:25:57 INFO - warning: no files found matching '*.txt' 21:25:57 INFO - no previously-included directories found matching 'build' 21:25:57 INFO - no previously-included directories found matching 'dist' 21:25:57 INFO - no previously-included directories found matching '.git*' 21:25:57 INFO - Successfully installed jsonschema functools32 21:25:57 INFO - Cleaning up... 21:25:57 INFO - Return code: 0 21:25:57 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 21:25:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:25:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:25:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:25:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:25:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:25:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:25:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e31030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20f2180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20f03b0>, '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 0x20f12b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20f1740>, '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': '516f8d7ca085b4d087ab0a71000001a4-1470889525.835985-2117767061', '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 21:25:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 21:25:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 21:25:57 INFO - Using env: {'DISPLAY': ':0', 21:25:57 INFO - 'HOME': '/home/cltbld', 21:25:57 INFO - 'LANG': 'en_US.UTF-8', 21:25:57 INFO - 'LANGUAGE': 'en_US:en', 21:25:57 INFO - 'LOGNAME': 'cltbld', 21:25:57 INFO - 'MAIL': '/var/mail/cltbld', 21:25:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:25:57 INFO - 'MOZ_NO_REMOTE': '1', 21:25:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:25:57 INFO - 'NO_EM_RESTART': '1', 21:25:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:25:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:25:57 INFO - 'PWD': '/builds/slave/test', 21:25:57 INFO - 'SHELL': '/bin/bash', 21:25:57 INFO - 'SHLVL': '1', 21:25:57 INFO - 'TERM': 'linux', 21:25:57 INFO - 'TMOUT': '86400', 21:25:57 INFO - 'USER': 'cltbld', 21:25:57 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1470889525.835985-2117767061', 21:25:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:25:57 INFO - '_': '/tools/buildbot/bin/python'} 21:25:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:25:57 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 21:25:57 INFO - Cleaning up... 21:25:57 INFO - Return code: 0 21:25:57 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:25:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:25:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:25:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:25:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:25:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:25:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:25:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1e31030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20f2180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20f03b0>, '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 0x20f12b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20f1740>, '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': '516f8d7ca085b4d087ab0a71000001a4-1470889525.835985-2117767061', '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 21:25:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 21:25:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 21:25:57 INFO - Using env: {'DISPLAY': ':0', 21:25:57 INFO - 'HOME': '/home/cltbld', 21:25:57 INFO - 'LANG': 'en_US.UTF-8', 21:25:57 INFO - 'LANGUAGE': 'en_US:en', 21:25:57 INFO - 'LOGNAME': 'cltbld', 21:25:57 INFO - 'MAIL': '/var/mail/cltbld', 21:25:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:25:57 INFO - 'MOZ_NO_REMOTE': '1', 21:25:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:25:57 INFO - 'NO_EM_RESTART': '1', 21:25:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:25:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:25:57 INFO - 'PWD': '/builds/slave/test', 21:25:57 INFO - 'SHELL': '/bin/bash', 21:25:57 INFO - 'SHLVL': '1', 21:25:57 INFO - 'TERM': 'linux', 21:25:57 INFO - 'TMOUT': '86400', 21:25:57 INFO - 'USER': 'cltbld', 21:25:57 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1470889525.835985-2117767061', 21:25:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:25:57 INFO - '_': '/tools/buildbot/bin/python'} 21:25:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:25:57 INFO - Downloading/unpacking blobuploader==1.2.4 21:25:57 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 21:25:57 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 21:25:57 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 21:25:57 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 21:25:57 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 21:25:57 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 21:25:59 INFO - Downloading blobuploader-1.2.4.tar.gz 21:25:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:25:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:25:59 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 21:25:59 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 21:25:59 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 21:25:59 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 21:25:59 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 21:25:59 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 21:25:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:26:00 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:26: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 21:26: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 21:26: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 21:26: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 21:26: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 21:26: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 21:26:00 INFO - Downloading docopt-0.6.1.tar.gz 21:26:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:26:00 INFO - Installing collected packages: blobuploader, requests, docopt 21:26:00 INFO - Running setup.py install for blobuploader 21:26:00 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:26:00 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:26:00 INFO - Running setup.py install for requests 21:26:00 INFO - Running setup.py install for docopt 21:26:00 INFO - Successfully installed blobuploader requests docopt 21:26:00 INFO - Cleaning up... 21:26:00 INFO - Return code: 0 21:26:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:26: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:26:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:26:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:26: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:26:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:26:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:26:00 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 0x1e31030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20f2180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20f03b0>, '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 0x20f12b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20f1740>, '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': '516f8d7ca085b4d087ab0a71000001a4-1470889525.835985-2117767061', '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 21:26:00 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 21:26:00 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 21:26:00 INFO - Using env: {'DISPLAY': ':0', 21:26:00 INFO - 'HOME': '/home/cltbld', 21:26:00 INFO - 'LANG': 'en_US.UTF-8', 21:26:00 INFO - 'LANGUAGE': 'en_US:en', 21:26:00 INFO - 'LOGNAME': 'cltbld', 21:26:00 INFO - 'MAIL': '/var/mail/cltbld', 21:26:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:26:00 INFO - 'MOZ_NO_REMOTE': '1', 21:26:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:26:00 INFO - 'NO_EM_RESTART': '1', 21:26:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:26:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:26:00 INFO - 'PWD': '/builds/slave/test', 21:26:00 INFO - 'SHELL': '/bin/bash', 21:26:00 INFO - 'SHLVL': '1', 21:26:00 INFO - 'TERM': 'linux', 21:26:00 INFO - 'TMOUT': '86400', 21:26:00 INFO - 'USER': 'cltbld', 21:26:00 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1470889525.835985-2117767061', 21:26:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:26:00 INFO - '_': '/tools/buildbot/bin/python'} 21:26:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:26:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:26:01 INFO - Running setup.py (path:/tmp/pip-2ZxaOU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:26:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:26:01 INFO - Running setup.py (path:/tmp/pip-5ngALN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:26:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:26:01 INFO - Running setup.py (path:/tmp/pip-XHcsRs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:26:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:26:01 INFO - Running setup.py (path:/tmp/pip-X5dVbe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:26:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:26:01 INFO - Running setup.py (path:/tmp/pip-8RRrSk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:26:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:26:01 INFO - Running setup.py (path:/tmp/pip-VCsn5l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:26:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:26:01 INFO - Running setup.py (path:/tmp/pip-e73NTA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:26:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:26:01 INFO - Running setup.py (path:/tmp/pip-5dXr0K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:26:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:26:01 INFO - Running setup.py (path:/tmp/pip-9_6P6A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:26:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:26:01 INFO - Running setup.py (path:/tmp/pip-wuYvVg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:26:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:26:01 INFO - Running setup.py (path:/tmp/pip-sKCDag-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:26:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:26:01 INFO - Running setup.py (path:/tmp/pip-WjudZh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:26:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:26:02 INFO - Running setup.py (path:/tmp/pip-rarldz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:26:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:26:02 INFO - Running setup.py (path:/tmp/pip-geDbLp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:26:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:26:02 INFO - Running setup.py (path:/tmp/pip-7vBAci-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:26:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:26:02 INFO - Running setup.py (path:/tmp/pip-XA9fmy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:26:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:26:02 INFO - Running setup.py (path:/tmp/pip-GYhYLy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:26:02 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:26:02 INFO - Running setup.py install for manifestparser 21:26:02 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:26:02 INFO - Running setup.py install for mozcrash 21:26:02 INFO - Running setup.py install for mozdebug 21:26:02 INFO - Running setup.py install for mozdevice 21:26:02 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 21:26:02 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:26:02 INFO - Running setup.py install for mozfile 21:26:02 INFO - Running setup.py install for mozhttpd 21:26:02 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:26:02 INFO - Running setup.py install for mozinfo 21:26:03 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:26:03 INFO - Running setup.py install for mozInstall 21:26:03 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:26:03 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:26:03 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:26:03 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:26:03 INFO - Running setup.py install for mozleak 21:26:03 INFO - Running setup.py install for mozlog 21:26:03 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:26:03 INFO - Running setup.py install for moznetwork 21:26:03 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:26:03 INFO - Running setup.py install for mozprocess 21:26:03 INFO - Running setup.py install for mozprofile 21:26:03 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:26:03 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:26:03 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:26:03 INFO - Running setup.py install for mozrunner 21:26:03 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:26:03 INFO - Running setup.py install for mozscreenshot 21:26:03 INFO - Running setup.py install for moztest 21:26:04 INFO - Running setup.py install for mozversion 21:26:04 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:26:04 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:26:04 INFO - Cleaning up... 21:26:04 INFO - Return code: 0 21:26:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:26:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:26:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:26:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:26:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:26:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:26:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:26:04 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 0x1e31030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20f2180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20f03b0>, '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 0x20f12b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20f1740>, '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': '516f8d7ca085b4d087ab0a71000001a4-1470889525.835985-2117767061', '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 21:26:04 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 21:26:04 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 21:26:04 INFO - Using env: {'DISPLAY': ':0', 21:26:04 INFO - 'HOME': '/home/cltbld', 21:26:04 INFO - 'LANG': 'en_US.UTF-8', 21:26:04 INFO - 'LANGUAGE': 'en_US:en', 21:26:04 INFO - 'LOGNAME': 'cltbld', 21:26:04 INFO - 'MAIL': '/var/mail/cltbld', 21:26:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:26:04 INFO - 'MOZ_NO_REMOTE': '1', 21:26:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:26:04 INFO - 'NO_EM_RESTART': '1', 21:26:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:26:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:26:04 INFO - 'PWD': '/builds/slave/test', 21:26:04 INFO - 'SHELL': '/bin/bash', 21:26:04 INFO - 'SHLVL': '1', 21:26:04 INFO - 'TERM': 'linux', 21:26:04 INFO - 'TMOUT': '86400', 21:26:04 INFO - 'USER': 'cltbld', 21:26:04 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1470889525.835985-2117767061', 21:26:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:26:04 INFO - '_': '/tools/buildbot/bin/python'} 21:26:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:26:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:26:04 INFO - Running setup.py (path:/tmp/pip-tMKYxi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:26:04 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)) 21:26:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:26:04 INFO - Running setup.py (path:/tmp/pip-6Qm1tI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:26:04 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)) 21:26:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:26:04 INFO - Running setup.py (path:/tmp/pip-05OUuo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:26:04 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)) 21:26:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:26:04 INFO - Running setup.py (path:/tmp/pip-NJTMdD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:26:04 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)) 21:26:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:26:04 INFO - Running setup.py (path:/tmp/pip-5FtTTZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:26:04 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)) 21:26:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:26:04 INFO - Running setup.py (path:/tmp/pip-_8DHKf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:26:04 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)) 21:26:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:26:04 INFO - Running setup.py (path:/tmp/pip-7hSd6t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:26:04 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)) 21:26:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:26:04 INFO - Running setup.py (path:/tmp/pip-xunCGU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:26:04 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)) 21:26:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:26:04 INFO - Running setup.py (path:/tmp/pip-TwQ1NF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:26:05 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)) 21:26:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:26:05 INFO - Running setup.py (path:/tmp/pip-BsMPL_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:26:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 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)) 21:26:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:26:05 INFO - Running setup.py (path:/tmp/pip-CklnLN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:26:05 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)) 21:26:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:26:05 INFO - Running setup.py (path:/tmp/pip-mBcJHR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:26:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 21:26:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:26:05 INFO - Running setup.py (path:/tmp/pip-BPuVtJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:26:05 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)) 21:26:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:26:05 INFO - Running setup.py (path:/tmp/pip-sZljvA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:26:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 21:26:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:26:05 INFO - Running setup.py (path:/tmp/pip-Wgqjem-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:26:05 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)) 21:26:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:26:05 INFO - Running setup.py (path:/tmp/pip-q7lvZJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:26:05 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)) 21:26:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:26:05 INFO - Running setup.py (path:/tmp/pip-TEj1Zy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:26:05 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)) 21:26:05 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)) 21:26:05 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)) 21:26:05 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)) 21:26:05 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)) 21:26:05 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)) 21:26:05 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:26: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 21:26: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 21:26: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 21:26: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 21:26: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 21:26: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 21:26:07 INFO - Downloading blessings-1.6.tar.gz 21:26:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:26:07 INFO - Installing collected packages: blessings 21:26:07 INFO - Running setup.py install for blessings 21:26:07 INFO - Successfully installed blessings 21:26:07 INFO - Cleaning up... 21:26:07 INFO - Return code: 0 21:26:07 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:26:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:26:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:26:08 INFO - Reading from file tmpfile_stdout 21:26:08 INFO - Current package versions: 21:26:08 INFO - argparse == 1.2.1 21:26:08 INFO - blessings == 1.6 21:26:08 INFO - blobuploader == 1.2.4 21:26:08 INFO - docopt == 0.6.1 21:26:08 INFO - functools32 == 3.2.3-2 21:26:08 INFO - jsonschema == 2.5.1 21:26:08 INFO - manifestparser == 1.1 21:26:08 INFO - mozInstall == 1.12 21:26:08 INFO - mozcrash == 0.17 21:26:08 INFO - mozdebug == 0.1 21:26:08 INFO - mozdevice == 0.48 21:26:08 INFO - mozfile == 1.2 21:26:08 INFO - mozhttpd == 0.7 21:26:08 INFO - mozinfo == 0.9 21:26:08 INFO - mozleak == 0.1 21:26:08 INFO - mozlog == 3.3 21:26:08 INFO - moznetwork == 0.27 21:26:08 INFO - mozprocess == 0.23 21:26:08 INFO - mozprofile == 0.28 21:26:08 INFO - mozrunner == 6.12 21:26:08 INFO - mozscreenshot == 0.1 21:26:08 INFO - mozsystemmonitor == 0.3 21:26:08 INFO - moztest == 0.7 21:26:08 INFO - mozversion == 1.4 21:26:08 INFO - psutil == 3.1.1 21:26:08 INFO - requests == 1.2.3 21:26:08 INFO - wsgiref == 0.1.2 21:26:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:26:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:26:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:26:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:26:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:26:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:26:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:26:08 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 0x1e31030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20f2180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20f03b0>, '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 0x20f12b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20f1740>, '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': '516f8d7ca085b4d087ab0a71000001a4-1470889525.835985-2117767061', '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 21:26:08 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 21:26:08 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 21:26:08 INFO - Using env: {'DISPLAY': ':0', 21:26:08 INFO - 'HOME': '/home/cltbld', 21:26:08 INFO - 'LANG': 'en_US.UTF-8', 21:26:08 INFO - 'LANGUAGE': 'en_US:en', 21:26:08 INFO - 'LOGNAME': 'cltbld', 21:26:08 INFO - 'MAIL': '/var/mail/cltbld', 21:26:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:26:08 INFO - 'MOZ_NO_REMOTE': '1', 21:26:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:26:08 INFO - 'NO_EM_RESTART': '1', 21:26:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:26:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:26:08 INFO - 'PWD': '/builds/slave/test', 21:26:08 INFO - 'SHELL': '/bin/bash', 21:26:08 INFO - 'SHLVL': '1', 21:26:08 INFO - 'TERM': 'linux', 21:26:08 INFO - 'TMOUT': '86400', 21:26:08 INFO - 'USER': 'cltbld', 21:26:08 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1470889525.835985-2117767061', 21:26:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:26:08 INFO - '_': '/tools/buildbot/bin/python'} 21:26:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:26:08 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)) 21:26:08 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)) 21:26:08 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)) 21:26:08 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)) 21:26:08 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)) 21:26:08 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)) 21:26:08 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)) 21:26:08 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)) 21:26:08 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)) 21:26:08 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)) 21:26:08 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)) 21:26:08 INFO - Cleaning up... 21:26:08 INFO - Return code: 0 21:26:08 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:26:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:26:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:26:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:26:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:26:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:26:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:26:08 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 0x1e31030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f948a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20f2180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20f03b0>, '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 0x20f12b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20f1740>, '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': '516f8d7ca085b4d087ab0a71000001a4-1470889525.835985-2117767061', '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 21:26:08 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 21:26:08 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 21:26:08 INFO - Using env: {'DISPLAY': ':0', 21:26:08 INFO - 'HOME': '/home/cltbld', 21:26:08 INFO - 'LANG': 'en_US.UTF-8', 21:26:08 INFO - 'LANGUAGE': 'en_US:en', 21:26:08 INFO - 'LOGNAME': 'cltbld', 21:26:08 INFO - 'MAIL': '/var/mail/cltbld', 21:26:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:26:08 INFO - 'MOZ_NO_REMOTE': '1', 21:26:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:26:08 INFO - 'NO_EM_RESTART': '1', 21:26:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:26:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:26:08 INFO - 'PWD': '/builds/slave/test', 21:26:08 INFO - 'SHELL': '/bin/bash', 21:26:08 INFO - 'SHLVL': '1', 21:26:08 INFO - 'TERM': 'linux', 21:26:08 INFO - 'TMOUT': '86400', 21:26:08 INFO - 'USER': 'cltbld', 21:26:08 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1470889525.835985-2117767061', 21:26:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:26:08 INFO - '_': '/tools/buildbot/bin/python'} 21:26:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:26:08 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 21:26:08 INFO - Cleaning up... 21:26:08 INFO - Return code: 0 21:26:08 INFO - Running post-action listener: _resource_record_post_action 21:26:08 INFO - Running post-action listener: _start_resource_monitoring 21:26:08 INFO - Starting resource monitoring. 21:26:08 INFO - [mozharness: 2016-08-11 04:26:08.522008Z] Finished create-virtualenv step (success) 21:26:08 INFO - [mozharness: 2016-08-11 04:26:08.522488Z] Running install step. 21:26:08 INFO - Running pre-action listener: _resource_record_pre_action 21:26:08 INFO - Running main action method: install 21:26:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:26:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:26:08 INFO - Reading from file tmpfile_stdout 21:26:08 INFO - Detecting whether we're running mozinstall >=1.0... 21:26:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:26:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:26:08 INFO - Reading from file tmpfile_stdout 21:26:08 INFO - Output received: 21:26:08 INFO - Usage: mozinstall [options] installer 21:26:08 INFO - Options: 21:26:08 INFO - -h, --help show this help message and exit 21:26:08 INFO - -d DEST, --destination=DEST 21:26:08 INFO - Directory to install application into. [default: 21:26:08 INFO - "/builds/slave/test"] 21:26:08 INFO - --app=APP Application being installed. [default: firefox] 21:26:08 INFO - mkdir: /builds/slave/test/build/application 21:26:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 21:26:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 21:26:24 INFO - Reading from file tmpfile_stdout 21:26:24 INFO - Output received: 21:26:24 INFO - /builds/slave/test/build/application/firefox/firefox 21:26:24 INFO - Running post-action listener: _resource_record_post_action 21:26:24 INFO - [mozharness: 2016-08-11 04:26:24.850379Z] Finished install step (success) 21:26:24 INFO - [mozharness: 2016-08-11 04:26:24.850629Z] Running run-tests step. 21:26:24 INFO - Running pre-action listener: _resource_record_pre_action 21:26:24 INFO - Running main action method: run_tests 21:26:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:26:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:26:24 INFO - Python 2.7.3 21:26:24 INFO - Return code: 0 21:26:24 INFO - grabbing minidump binary from tooltool 21:26:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:26:24 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 0x20f03b0>, '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 0x20f12b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20f1740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:26:24 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 21:26:24 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 21:26:24 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 21:26:24 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:26:24 INFO - Return code: 0 21:26:24 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 21:26:24 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:26:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:26:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 21:26:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:26:24 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/JlDi14UURwKHO9sCZtxh2Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--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 21:26:24 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/JlDi14UURwKHO9sCZtxh2Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-061 --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 21:26:24 INFO - Using env: {'DISPLAY': ':0', 21:26:24 INFO - 'HOME': '/home/cltbld', 21:26:24 INFO - 'LANG': 'en_US.UTF-8', 21:26:24 INFO - 'LANGUAGE': 'en_US:en', 21:26:24 INFO - 'LOGNAME': 'cltbld', 21:26:24 INFO - 'MAIL': '/var/mail/cltbld', 21:26:24 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:26:24 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 21:26:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:26:24 INFO - 'MOZ_NO_REMOTE': '1', 21:26:24 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:26:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:26:24 INFO - 'NO_EM_RESTART': '1', 21:26:24 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:26:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:26:24 INFO - 'PWD': '/builds/slave/test', 21:26:24 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:26:24 INFO - 'SHELL': '/bin/bash', 21:26:24 INFO - 'SHLVL': '1', 21:26:24 INFO - 'TERM': 'linux', 21:26:24 INFO - 'TMOUT': '86400', 21:26:24 INFO - 'USER': 'cltbld', 21:26:24 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1470889525.835985-2117767061', 21:26:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:26:24 INFO - '_': '/tools/buildbot/bin/python'} 21:26:24 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/JlDi14UURwKHO9sCZtxh2Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--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 21:26:25 INFO - mozversion application_buildid: 20160810195520 21:26:25 INFO - mozversion application_changeset: f64f8bc8415f1cffff58478438d2a3af81272985 21:26:25 INFO - mozversion application_display_name: Nightly 21:26:25 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:26:25 INFO - mozversion application_name: Firefox 21:26:25 INFO - mozversion application_remotingname: firefox 21:26:25 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 21:26:25 INFO - mozversion application_vendor: Mozilla 21:26:25 INFO - mozversion application_version: 51.0a1 21:26:25 INFO - mozversion platform_buildid: 20160810195520 21:26:25 INFO - mozversion platform_changeset: f64f8bc8415f1cffff58478438d2a3af81272985 21:26:25 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 21:26:25 INFO - mozversion platform_version: 51.0a1 21:26:25 INFO - using testdate: 1470889585 21:26:25 INFO - actual date: 1470889585 21:26:25 INFO - starting webserver on 'localhost:33938' 21:26:25 INFO - SUITE-START | Running 2 tests 21:26:25 INFO - TEST-START | dromaeo_css 21:26:25 INFO - operating with platform_type : linux_ 21:26:25 INFO - Initialising browser for dromaeo_css test... 21:26:25 INFO - TEST-INFO | started process 3295 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRx2cCl/profile http://localhost:33938/getInfo.html) 21:26:30 INFO - PROCESS | 3295 | __metrics Screen width/height:1600/1200 21:26:30 INFO - PROCESS | 3295 | colorDepth:24 21:26:30 INFO - PROCESS | 3295 | Browser inner width/height: 1024/697 21:26:30 INFO - PROCESS | 3295 | __metrics 21:26:31 INFO - PROCESS | 3295 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 21:26:31 INFO - PROCESS | 3295 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:26:32 INFO - TEST-INFO | 3295: exit 0 21:26:32 INFO - Browser initialized. 21:26:32 INFO - Running cycle 1/1 for dromaeo_css test... 21:26:32 INFO - TEST-INFO | started process 3377 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRx2cCl/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:26:44 INFO - PROCESS | 3377 | RSS: Main: 157851648 21:26:44 INFO - PROCESS | 3377 | 21:27:35 INFO - PROCESS | 3377 | 1470889655396 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] 21:29:49 INFO - PROCESS | 3377 | Cycle 1(1): loaded http://localhost:33938/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33938/tests/dromaeo/cssquery-ext.html) 21:29:50 INFO - PROCESS | 3377 | RSS: Main: 253370368 21:29:50 INFO - PROCESS | 3377 | 21:32:53 INFO - PROCESS | 3377 | Cycle 1(1): loaded http://localhost:33938/tests/dromaeo/cssquery-ext.html (next: http://localhost:33938/tests/dromaeo/cssquery-jquery.html) 21:32:53 INFO - PROCESS | 3377 | RSS: Main: 244580352 21:32:53 INFO - PROCESS | 3377 | 21:35:56 INFO - PROCESS | 3377 | Cycle 1(1): loaded http://localhost:33938/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33938/tests/dromaeo/cssquery-mootools.html) 21:35:56 INFO - PROCESS | 3377 | RSS: Main: 189612032 21:35:56 INFO - PROCESS | 3377 | 21:38:59 INFO - PROCESS | 3377 | Cycle 1(1): loaded http://localhost:33938/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33938/tests/dromaeo/cssquery-prototype.html) 21:38:59 INFO - PROCESS | 3377 | RSS: Main: 189509632 21:38:59 INFO - PROCESS | 3377 | 21:42:02 INFO - PROCESS | 3377 | Cycle 1(1): loaded http://localhost:33938/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33938/tests/dromaeo/cssquery-yui.html) 21:42:03 INFO - PROCESS | 3377 | RSS: Main: 190431232 21:42:03 INFO - PROCESS | 3377 | 21:45:06 INFO - PROCESS | 3377 | Cycle 1(1): loaded http://localhost:33938/tests/dromaeo/cssquery-yui.html (next: http://localhost:33938/tests/dromaeo/cssquery-dojo.html) 21:45:06 INFO - PROCESS | 3377 | RSS: Main: 283840512 21:45:06 INFO - PROCESS | 3377 | 21:45:06 INFO - PROCESS | 3377 | __start_tp_report 21:45:06 INFO - PROCESS | 3377 | _x_x_mozilla_page_load 21:45:06 INFO - PROCESS | 3377 | _x_x_mozilla_page_load_details 21:45:06 INFO - PROCESS | 3377 | |i|pagename|runs| 21:45:06 INFO - PROCESS | 3377 | |0;dojo.html;2631.710511843697;2637.432951915338;2661.0952276226085;2679.12928298303;2680.517506848768;4709.9058018839605;4755.381800365952;4806.279058141281;4872.0499502597;4903.16646170151;4771.141194584973;4780;4784.545468180518;4800.135975524404;4845.297431872376;4407.955920440802;4417.447819022622;4437.556244375569;4499;4509.458864936212;4436.778161091933;4542.500324964251;4590.081983603276;4622.260438329868;4627.676062675614;4351.608355248043;4387;4401.2517871961845;4458.286674132123;4474.2841145416905;4429.534898835608;4444.933326000112;4451.465824101128;4451.755153466558;4456.866294011184;4411.647068234533;4416.315471101984;4418.116376724668;4444.577765112309;4476.664250181249;4729.148753224418;4774.880627984328;4796;4848.054629347279;4977.751112444364;5142.588592912558;5179.922301165486;5184.922226166573;5187.792488300463;5188.118019936582;5112;5182;5211.947880521222;5224.973875130638;5239.3712754469325;4922.138625740481;4924.8276310328965;4928.827491037797;4929.137400954819;4936.111499929975;5331.093714068617;5386.461353864661;5394.460553944574;5397.973010135002;5430.0768869292315;4992.400911890596;5050.797968081236;5063.645544811828;5112.9744351278005;5188.481151884856;5224.059669259494;5267.236250743621;5280.867978300574;5282.445343238982;5293.894122117536;5183.714895680699;5186.740662966837;5191.143461328838;5198.454162312978;5237.6071794615555;4961.627877909171;5026.145555255543;5045.016221836707;5159.716215608102;5163.941392014628;4021.3163762160502;4073.7759423231414;4074.5393426912988;4100.979495102505;4114.855980040744;3566.3045706087064;3582.6954708849516;3613.8012409317216;3615.6022837487853;3629.038304849217;4291.034517233597;4329.134173165379;4469.284914413678;4474.888127796766;4511.684182107287;5059.848204553869;5083.364579427572;5086.5422112009355;5179.766910489037;5243.318368612056;4504.887377815581;4509.053098849278;4538.29656403258;4544.363789069533;4545.068261006486;4729.597984171384;4766.976165119221;4768.546988036131;4770.522947705202;4810.42274927011;4695.460022097503;4709.835155769669;4954.826581069645;4964.2305442655;4996.925046124384;5191.169412893919;5229.032628963654;5256.685828542864;5269;5317.415084340797;4932.136876046749;4945.4807245238735;4945.901081978413;4947.455779864284;4990.126727822544;4915.754212289443;5173.5085166910585;5176.896462070662;5178.71517066565;5191;5115.897682046264;5148.716820574904;5158.664686795496;5185.688858668492;5234.842954711365;5007.324011258579;5033.597312214941;5038.370203724535;5042.873928151679;5087.516685914832;4959.652824302409;5014.222795466709;5025.497450254945;5030.924536131888;5031.924521132113;4915.164422048332;4930.4822993586595;4932.704037757746;4946.3817022872145;5007.599392048554;4972.378452693413;5025.095482813129;5067.366579177603;5071.949280507148;5110.5911527077005;4780.426348838162;4949.30709700635;4951.455339912679;4951.9752401237765;5011.574016208663 21:45:06 INFO - PROCESS | 3377 | |1;ext.html;561.7865211219736;576.5243673968977;582.3128708124411;583.6585597425506;584.4535359438928;28803.711962880367;31451.84274078629;31493;38520;39968.20063598726;39531;39892.800535997354;39909.401358979565;39943.40084898729;39973.40039899404;7580.204078571739;7718;7721.691132354699;7723.189065148163;7723.304902558769;7468.514546554484;7642.808929776772;9828.066333698287;10045.19638428924;10066;9695.515224238796;9758.072983066633;9762.170215531689;9763.75590610237;9766.316357854954;9865.06281903218;9900.158486528653;9914.256430767722;9915.603375864994;9927.652532161412;9691.90308096917;9773.267004974656;9773.902260977371;9784.853227201527;9790.902090979142;37556.24887502235;37826.243475130344;37841.62158378409;37849.81075094607;37888;2958.970410295891;3010.7741919356135;3117.8285194314303;3302.2239773653173;3329.20099176196;28377.574336384972;28664;28861.42277154445;28923.855380723173;30379.848100759576;3502.562179727534;3565.5899571549344;3567.5362202913457;3570.1610121621397;3604.567451905788;239739;240422;240495;240815;240913;31787.205319866727;51187;51478.74260628673;51497.22754158616;51560;32014.519782203286;33679;33821.49267760986;33854;33896.49155262673;13089.345532723326;13183.93408032973;13233.801492977613;13234.272115033573;13241.73516529664;9947.850782238273;10295.897041029644;10355.792884142274;10355.896441035644;10361.689149325532;7688.730894418669;7873;7942.602869856484;8023.598820058974;8093.838123237502;3044.3606842562867;3142.120206342228;3151.9054428367185;3190.7287880530416;3191.6010498687665;854.4873076154382;870.9520976346236;879.4723166100416;896.3859756067114;897.9820403591891;24463;24881.129160479657;24922.5015499689;24993.50012999766;25099.498010039697;945.333539854401;947.6588428165854;964.4068897628049;1044.6291566493785;1055.904968552834;13428.649986252367;13893.791593125909;14081.155130692192;14143.787843182361;14327;365996;370020;370921;371909;372462;49087.50912490901;49455;49656.50343496591;49813.25280120801;49821.75089124531;1087.1465899269194;1137.1641843245372;1141.4863311509687;1181.3207405741732;1187.9703007424885;26028.479430410905;28683.85658071696;28900.710992889803;29383;29777.404451910406;42791.144177116905;47862.76068619774;48009.75995120002;48069.75965120292;48116;350866;351733;355001;355399;355692.8799628016;24656.50686986286;25517.744822551536;25585;26981.190564283104;38619.22761544697;37667.81166094152;37745.81127094457;37864.242715146094;38350.23299534049;38809.41785873158;33156.1710957228;33657.32685346328;34154.14614634654;34276.31447371088;34503;32987.835060824546;33112.50331245081;33871.33688243157;34520.309593807484;34634.48048279328;33432.33135337231;34086.829565852015;34247.48628770521;34381;34640.82679586586;28821.711782882743;30948.22629434282;30963.225919352197;30981.8450907744;31220.37559248848;23788.52422951566;23890;24011.639825402282;24229.75770242275;24442.87778561096 21:45:06 INFO - PROCESS | 3377 | |2;jquery.html;319.788939300062;335.7263829978569;355.0838835803626;360.2722500548891;389.3031473662145;12416;15729.449469268578;15952.680946381066;17663.470095897144;17916.910415447936;17081.14594270288;17586.472405827815;17631.823681763177;17766.733498997524;17814.554636134104;4717.599004084657;4758.143534163849;4930.926036109461;4992;5027.4469808321055;3729.4965179700666;4988.226824842155;5053.873653158682;5572.637778544402;5857.707114644272;5877.030290002144;5909.556783241274;5912.881742365172;5922.052471604544;5945.31628862682;5324.414314425429;5617.943820561783;5638.013347664183;5734.713264336809;5945.346011938684;4947.6289278304275;5112.437631860493;5113.795448182068;5235.267062611199;5297.814576489843;12054.758904821854;12198.329091899943;12290.446929888087;12319.260844349277;14937.402503899832;1858.4738860083078;1866.887986720801;1894.1665667106568;1904.990475047616;2011.4971257185703;8936.32977526688;8982.955085224532;9048.547572621343;9251.907480925172;12798.936005319914;1679.6472740724462;1685.140578305061;1783.1478159165033;1799.4961410804995;1828.1590468384559;67411.66294168547;70432.647836761;72434;72754.63622681906;73185;8172.67309307633;8630.568471576396;8663.176998185163;9295.488748118783;10140.138088262433;11397.601083962021;11438.370889600985;11440.656780296604;11444.484998175101;11445.88554114465;6699.732010719516;6821.727130914708;6862.965685171542;6906.758263460855;6909.205441374306;6819.24988251292;6852.897206541906;6989.33601307875;7054.964725176341;7102.254263302382;3534.5581802274714;3670.3026424979703;3673.4673472346362;3742.214135031674;3757.098296408842;1734.1849330814498;1801.6937120689252;1824.4800231933834;1868.1219826681438;1879.8026207248315;845.3448577352601;855.9186877246651;882.2765332427476;937.161240689579;956.1346980982222;16905.49283521496;17072.061036643103;17799.46601601954;17860.642787144443;18254.81745182531;842.8988521377474;859.1623167411724;878.4202426398547;884.9292056635454;892.5180402582532;9444.527773611291;9833.901660983442;9980.900190998142;10007.49962501872;10215.744606384751;397054;400993;405105;408256;408264;73278.63360683163;73990.63004685049;75987.62006189933;76270.61864690641;76771;850.0734199722332;872.2760109109424;874.4097734029632;882.8808110904946;883.6244596046654;14985.475508357154;15359.616009599402;15546.533603991898;15556;16051.277692503632;27946.720532795225;36164;37955;38387;38961.220775584894;51528;52014.21978670247;52029.959400811014;52350.47649523456;52538.474615253355;6678.432333251728;6904.551204171713;7330.45021623391;7672.539647621161;7838;10848.783024339627;11166.944165279447;11492;12240.143189976972;12253.448594813433;9585.568649410654;10656.89343106559;10680;10822.134229261483;11008.834867476835;10470.516862425382;10544.420056896945;10661.840072398765;10805.351678899291;10845.945770271099;10026.598936042768;10564.630237941636;10589.205809564468;10863.837042444211;11161.609343672932;6698.095757072733;6842.521023528305;6863.210730766026;7091.82270443243;7126.109236345457;8525.531095789791;10684;10811.35131892089;10830.40432776205;11184.888151118384 21:45:06 INFO - PROCESS | 3377 | |3;mootools.html;1252.436403618372;1390.1242217403037;1439.7696368581028;1508.61530309771;1718.9054601996893;6265.843353916154;7365.779026629203;7606.84786304275;7616.88574671379;7801.492902961318;7578.469507134503;7615.77152685419;7637.885431718515;7645.197254288303;7647.197044310351;2132.264368792764;2156.202205184084;2159.276642324823;2159.84881058326;2160.6542953127505;2116.576684663066;2143.8928053597338;2163.286115581854;2168.3711723600136;2179.5640871825617;2131.328631481086;2141.903614337351;2151.8924053797327;2154.1814110637933;2180.4984853483707;2073.1810934680793;2079.511314841011;2079.6984437256515;2081.95836083279;2083.2396175396025;2036.2465887621527;2094.717213176217;2097.318371529259;2098.31804663485;2098.832093432537;7522.699092036367;7790.298873101391;7835.882461763078;7946.245106714853;7954.920450795534;4357.694961352707;4541.364209010741;4543;4543.432070991126;4548.704334218299;2793.6088947547155;2913.8688759005686;2953.808002479832;2958.2604348912773;2960.7779416543844;929.3355250995571;930.3952430919888;941.2940294778916;948.9857652135223;951.5147274889787;10536.841947370796;10568.68293951175;10583.576656933714;10635.308704934154;10636.787264254672;3820.7325487216185;3981.462502562175;3986.402039694069;4013.13717550728;4213.747175169499;8121.066077401175;8242.876356854653;8245.546494942835;8255.174482551696;8260.421770476129;4360.4767427908855;4452.198604251201;4455.465344158722;4458.9554104459185;4461.977690111594;3346.6151392589677;3950.762954222756;4112.835486580563;4119.073208528057;4163.958360416417;3218.2115381731624;3271.5583396241677;3361.6302206757236;3380.9323813524084;3382.797032178077;979.9020097990286;987.6740675577186;989.2531138990016;1002.4937406609615;1003.6236411345745;718.9496735228588;811.0834756724863;830.0205757206554;841.0706169682413;850.9914900850912;4991.151504244287;5075.87310317245;5088.6946783193125;5149.073166830007;5183.688978661293;375.1446701520538;903.4895284164426;905.2893478619252;913.1781396742851;992.4442312305132;3536.9469457958153;3666.944995825065;3729.813509324523;3742.6631603155847;3765.4163604641326;8691.130886911385;9005.729828105168;9066;9087.81824363509;9091.499967501852;8969.775755606162;8972.955135224282;8984.32617553686;8994.145556172152;9009.864852027225;6608.537402381883;6926.757563485254;7014.088168538057;7019.824504387431;7021.824454388579;5544.112941929433;5567.916481252865;5629.831105066854;5659.405762394889;5827.562932779973;8637.956810215908;8807.339449541438;8825.029246782977;8844.292456603585;9007.594658240527;8778.91221087781;9067.954660226656;9108.590113444778;9133.908660913306;9157.40476869028;5834.737436815439;6566.212054553484;6772.762953296611;6839.897401538881;6994.860102797814;7060.54106483077;7293.598852062975;7299.9270007301375;7448.1807001228735;7477.401807855467;6324.114623952558;6413.679316034087;6593.824038067522;6721.932780672326;6723.058771772054;6259.186305780401;6322.841928951629;6342.492600592034;6358.650274234777;6360.681965901594;5936.465718085393;6025.87948241024;6028.939710602838;6031.276246850406;6038.486728628116;4418.7348759073275;4499.617532509643;4507.368968344369;4569.634429245586;4611.216093264086;4398.340248962553;4444.111177764525;4484.551544845489;4541.704789188692;4561.156186105581 21:45:06 INFO - PROCESS | 3377 | |4;prototype.html;271.455731258826;276.1976458388382;279.4620355815057;285.66434439533543;291.14258508691887;4678.53214678532;4839.370881785372;4896.681715688483;4924.64572242633;4937.728424936627;4675.859724208271;4806.83176088837;4808.254720518316;4811.855644330676;4891.168501354769;3552.3428165789283;3851.2490064437447;3864.7487913285686;3880.961190388088;3882.864099756509;3657.4513822926506;3758.473813666089;3787.8674246401383;3798.0315019669947;3810.4474851146565;3753.3244016077097;3753.493278407407;3753.7747735135845;3755.8497660093562;3760.3231418344685;3745.7752534847723;3754.3617585010616;3757.9248415031684;3760.6085748273176;3767.9434808477895;3222.1622378181605;3295.0938491914676;3297.637259901409;3322.660725970384;3329.8002119872644;4652.837150699743;4689.249720044776;4694.788734506956;4711.104890070876;4752.5247475252545;4295.935560966588;4296.248156572618;4296.291111966521;4314.913701725979;4317.848875289381;4810.4467986181335;5000.799968001275;5021.899562008739;5049.64652474327;5058.570021548136;3572.6605972432576;3575.3743094958277;3576.338377400163;3593.119685677;3594.6405359464106;5274.892272622754;5289.44460831611;5333.226682131108;5397.136458166714;5404.973135074347;3547.450145227494;3672.9632703673155;3678.2091850252323;3723.255348930171;3725.795081270502;3730.813459327023;3731.402975523903;3737.747854468729;3755.342815007363;3756.1360886996144;4278.315469524861;4278.978605107017;4303.934111626374;4307.879951212644;4317.266064768997;4854.490278520775;4972.303877457159;5035.62232832539;5149.433562308143;5151.716655583904;1256.2588073036952;1277.0166971431945;1278.3735969374939;1281.884760258581;1289.1362786932777;774.6436639146056;807.3097501636134;810.854046271665;818.5170749257967;820.6102101501739;4039.51525816898;4043.0700938784244;4046.47395838545;4050.8987275318354;4065.654419374327;4540.500544940054;4599.977000114978;4630;4644.2801365788355;4683.625309975194;3990.38149086892;4022.4971878515184;4026.899287548571;4043.1913617276664;4058.492688413948;2296.2777916562577;2441.438469152105;2473.492933948536;2480.1443501991785;2489.3776555861036;4396.252637051709;4422.5356337584735;4427.29163333865;4429.667774916829;4438.134563760101;4671.95328046722;4691.601213896857;4719.315699223594;4738.19450693383;4793.304970779287;4373.278409062469;4411.448568928884;4586.22533367308;4903.964854585307;4984.476629953802;5147.768350424315;5154.974225128851;5164.746209887747;5194.168932970707;5230.712310822942;5156.922646160236;5177.534021938043;5235.136202526541;5238.240455133908;5256.526912577886;4685.882852928704;4952.678075925053;4953.678010929278;4963.280324353021;5024.020316038337;3598.4962105304753;3607.4949507068504;3610.891673249807;3622.873199438007;3626.836792344298;5093.726568357911;5305.363356397257;5313.468653134656;5320.920186197132;5321.2816269804625;4955.6531042826655;5055.848324550269;5069.188929771219;5070.923936141035;5078.21287700407;5032.220005899091;5049.974750126225;5051.393832739947;5056.241563765318;5064.468230835857;4876.122297986255;4941.357623509065;4962.925556116734;4993.900121997613;5033.798648054037;5060.645754797129;5070.847874563769;5073.162928116967;5075.695458272516;5079.87300317495;4962.851114466572;4971.900561988812;4996.325496057985;5028.460627383148;5050.116229659869 21:45:06 INFO - PROCESS | 3377 | |5;yui.html;612.1338306296591;618.477386608316;640.724488469958;641.788209890736;695.6765104226533;12783.872161278385;12921.418536165871;13777.51778687746;13803.723925521483;13840.446382144715;12908.290044047573;12934.547290844823;12979.156354836929;13020.609381718563;13038.478460861554;631.8862604731147;761.7752762934947;778.696308439709;783.4006984656713;784.9058113026445;755.3692666623376;781.7928249014016;785.83104632504;791.1416113516841;791.7228969860531;822.2599660305713;827.5283088639478;828.3083625172987;829.9626516806728;830.1822704635929;662.19543254945;821.7616891101574;821.876718492225;821.9178082191793;822.112118911574;580.216707444946;595.1221947627258;596.0403749962557;599.5952731905946;600.942910423509;13012.86987130126;13013.21920684762;13013.609591712264;13015.34923253843;13018.804717929144;11699.23954942926;11704.473298701494;12154;12749.298788566624;13360.665983350396;11902.702432439171;11974.281543107441;12098.697532561668;12191.695207619792;12222.511099556006;4150.439690641785;4192.979035104835;4276.593723596254;4356.194104090753;4361.869143925687;66678.33304167386;69544.6522767388;69943.30056699419;70012.2998770016;70045;9780.951095244478;9998.15015723657;10023.849642255373;10085.546150423248;10169.54237059334;18305;18588.44234672962;18635.161417736235;18638.627227455647;18652;6566.146400967844;6655.534112612071;6704.994250862312;6906.06768086312;6972.442204623618;3574.6246644102516;3584.8386822593047;3614.530111085542;3614.7650402724266;3697.2975134724315;2720.1023662191824;2797.9860100699366;2800;2812.54999200127;2817.802753807214;481.48481125196406;490.4996903158758;492.7610109097085;495.37830023320504;495.89090400111917;544.8038706065813;547.4170008940465;550.5678042736432;556.9081101618187;571.8398848322477;7256.564606123649;7766.728164514215;7955.602219888982;7961.442699011013;8100.756977290691;481.84099247248326;533.1283351719966;555.6610467614752;560.1905246918245;571.5456212311223;3625.2568223514118;3698.556173259226;3780.6030366811638;3785.242951409729;3877.399003154459;57508.424915751144;58036.419635803104;92922.0707792927;103170;107546.46226768816;89536.55231723799;90431.54784226036;91225;91408;91940.54029729808;79659.60170199227;81419.77870331949;81465.6680898722;81740.59129704314;81881.9999999988;7012.152812196379;7337.836217577047;7624.466287359832;7715.267049630276;7724.841273808974;45763.54236457726;46141.53858461372;46855.53144468648;48254.75872620614;48641.5135848637;62797.68601156965;67089;68052;68418;70036;8877.866831997397;8914.465132092095;9294.953525232331;9302.994106947239;9779.804403912025;10321.845172322572;10393.337066069393;10430.217733669853;10727.195460340661;10943.616973405893;9475.668351607661;9819.214462843098;9863.802723945337;9885.851712224467;10730.248882578457;9614.759631009281;9874.703758887244;10087.29388942767;10368.429736364573;10405.271630985759;9547.618095276111;9790.80418391614;10087.596496140366;10104.444255566015;10401.94799026;7814.413918956215;7849.3328067114935;7878.330341921001;8520.70177543783;8608.569571521524;7758.340541054074;8286.58567071632;8449.28181104613;8460.153984601491;8523.531205783493 21:45:06 INFO - PROCESS | 3377 | __end_tp_report 21:45:06 INFO - PROCESS | 3377 | __start_cc_report 21:45:06 INFO - PROCESS | 3377 | _x_x_mozilla_cycle_collect,1007 21:45:06 INFO - PROCESS | 3377 | __end_cc_report 21:45:06 INFO - PROCESS | 3377 | __startTimestamp1470890706769__endTimestamp 21:45:06 INFO - PROCESS | 3377 | 21:45:06 INFO - PROCESS | 3377 | ------- Summary: start ------- 21:45:06 INFO - PROCESS | 3377 | Number of tests: 6 21:45:06 INFO - PROCESS | 3377 | 21:45:06 INFO - PROCESS | 3377 | [#0] dojo.html Cycles:165 Average:4775.06 Median:4945.48 stddev:535.64 (10.8%) stddev-sans-first:510.21 21:45:06 INFO - PROCESS | 3377 | Values: 2631.7 2637.4 2661.1 2679.1 2680.5 4709.9 4755.4 4806.3 4872.0 4903.2 4771.1 4780.0 4784.5 4800.1 4845.3 4408.0 4417.4 4437.6 4499.0 4509.5 4436.8 4542.5 4590.1 4622.3 4627.7 4351.6 4387.0 4401.3 4458.3 4474.3 4429.5 4444.9 4451.5 4451.8 4456.9 4411.6 4416.3 4418.1 4444.6 4476.7 4729.1 4774.9 4796.0 4848.1 4977.8 5142.6 5179.9 5184.9 5187.8 5188.1 5112.0 5182.0 5211.9 5225.0 5239.4 4922.1 4924.8 4928.8 4929.1 4936.1 5331.1 5386.5 5394.5 5398.0 5430.1 4992.4 5050.8 5063.6 5113.0 5188.5 5224.1 5267.2 5280.9 5282.4 5293.9 5183.7 5186.7 5191.1 5198.5 5237.6 4961.6 5026.1 5045.0 5159.7 5163.9 4021.3 4073.8 4074.5 4101.0 4114.9 3566.3 3582.7 3613.8 3615.6 3629.0 4291.0 4329.1 4469.3 4474.9 4511.7 5059.8 5083.4 5086.5 5179.8 5243.3 4504.9 4509.1 4538.3 4544.4 4545.1 4729.6 4767.0 4768.5 4770.5 4810.4 4695.5 4709.8 4954.8 4964.2 4996.9 5191.2 5229.0 5256.7 5269.0 5317.4 4932.1 4945.5 4945.9 4947.5 4990.1 4915.8 5173.5 5176.9 5178.7 5191.0 5115.9 5148.7 5158.7 5185.7 5234.8 5007.3 5033.6 5038.4 5042.9 5087.5 4959.7 5014.2 5025.5 5030.9 5031.9 4915.2 4930.5 4932.7 4946.4 5007.6 4972.4 5025.1 5067.4 5071.9 5110.6 4780.4 4949.3 4951.5 4952.0 5011.6 21:45:06 INFO - PROCESS | 3377 | 21:45:06 INFO - PROCESS | 3377 | [#1] ext.html Cycles:180 Average:46222.31 Median:19071.69 stddev:86196.84 (452.0%) stddev-sans-first:86370.47 21:45:06 INFO - PROCESS | 3377 | Values: 561.8 576.5 582.3 583.7 584.5 28803.7 31451.8 31493.0 38520.0 39968.2 39531.0 39892.8 39909.4 39943.4 39973.4 7580.2 7718.0 7721.7 7723.2 7723.3 7468.5 7642.8 9828.1 10045.2 10066.0 9695.5 9758.1 9762.2 9763.8 9766.3 9865.1 9900.2 9914.3 9915.6 9927.7 9691.9 9773.3 9773.9 9784.9 9790.9 37556.2 37826.2 37841.6 37849.8 37888.0 2959.0 3010.8 3117.8 3302.2 3329.2 28377.6 28664.0 28861.4 28923.9 30379.8 3502.6 3565.6 3567.5 3570.2 3604.6 239739.0 240422.0 240495.0 240815.0 240913.0 31787.2 51187.0 51478.7 51497.2 51560.0 32014.5 33679.0 33821.5 33854.0 33896.5 13089.3 13183.9 13233.8 13234.3 13241.7 9947.9 10295.9 10355.8 10355.9 10361.7 7688.7 7873.0 7942.6 8023.6 8093.8 3044.4 3142.1 3151.9 3190.7 3191.6 854.5 871.0 879.5 896.4 898.0 24463.0 24881.1 24922.5 24993.5 25099.5 945.3 947.7 964.4 1044.6 1055.9 13428.6 13893.8 14081.2 14143.8 14327.0 365996.0 370020.0 370921.0 371909.0 372462.0 49087.5 49455.0 49656.5 49813.3 49821.8 1087.1 1137.2 1141.5 1181.3 1188.0 26028.5 28683.9 28900.7 29383.0 29777.4 42791.1 47862.8 48009.8 48069.8 48116.0 350866.0 351733.0 355001.0 355399.0 355692.9 24656.5 25517.7 25585.0 26981.2 38619.2 37667.8 37745.8 37864.2 38350.2 38809.4 33156.2 33657.3 34154.1 34276.3 34503.0 32987.8 33112.5 33871.3 34520.3 34634.5 33432.3 34086.8 34247.5 34381.0 34640.8 28821.7 30948.2 30963.2 30981.8 31220.4 23788.5 23890.0 24011.6 24229.8 24442.9 21:45:06 INFO - PROCESS | 3377 | 21:45:06 INFO - PROCESS | 3377 | [#2] jquery.html Cycles:180 Average:24403.85 Median:406680.50 stddev:66673.45 (16.4%) stddev-sans-first:66835.97 21:45:06 INFO - PROCESS | 3377 | Values: 319.8 335.7 355.1 360.3 389.3 12416.0 15729.4 15952.7 17663.5 17916.9 17081.1 17586.5 17631.8 17766.7 17814.6 4717.6 4758.1 4930.9 4992.0 5027.4 3729.5 4988.2 5053.9 5572.6 5857.7 5877.0 5909.6 5912.9 5922.1 5945.3 5324.4 5617.9 5638.0 5734.7 5945.3 4947.6 5112.4 5113.8 5235.3 5297.8 12054.8 12198.3 12290.4 12319.3 14937.4 1858.5 1866.9 1894.2 1905.0 2011.5 8936.3 8983.0 9048.5 9251.9 12798.9 1679.6 1685.1 1783.1 1799.5 1828.2 67411.7 70432.6 72434.0 72754.6 73185.0 8172.7 8630.6 8663.2 9295.5 10140.1 11397.6 11438.4 11440.7 11444.5 11445.9 6699.7 6821.7 6863.0 6906.8 6909.2 6819.2 6852.9 6989.3 7055.0 7102.3 3534.6 3670.3 3673.5 3742.2 3757.1 1734.2 1801.7 1824.5 1868.1 1879.8 845.3 855.9 882.3 937.2 956.1 16905.5 17072.1 17799.5 17860.6 18254.8 842.9 859.2 878.4 884.9 892.5 9444.5 9833.9 9980.9 10007.5 10215.7 397054.0 400993.0 405105.0 408256.0 408264.0 73278.6 73990.6 75987.6 76270.6 76771.0 850.1 872.3 874.4 882.9 883.6 14985.5 15359.6 15546.5 15556.0 16051.3 27946.7 36164.0 37955.0 38387.0 38961.2 51528.0 52014.2 52030.0 52350.5 52538.5 6678.4 6904.6 7330.5 7672.5 7838.0 10848.8 11166.9 11492.0 12240.1 12253.4 9585.6 10656.9 10680.0 10822.1 11008.8 10470.5 10544.4 10661.8 10805.4 10845.9 10026.6 10564.6 10589.2 10863.8 11161.6 6698.1 6842.5 6863.2 7091.8 7126.1 8525.5 10684.0 10811.4 10830.4 11184.9 21:45:06 INFO - PROCESS | 3377 | 21:45:06 INFO - PROCESS | 3377 | [#3] mootools.html Cycles:180 Average:4982.68 Median:5644.62 stddev:2778.09 (49.2%) stddev-sans-first:2771.74 21:45:06 INFO - PROCESS | 3377 | Values: 1252.4 1390.1 1439.8 1508.6 1718.9 6265.8 7365.8 7606.8 7616.9 7801.5 7578.5 7615.8 7637.9 7645.2 7647.2 2132.3 2156.2 2159.3 2159.8 2160.7 2116.6 2143.9 2163.3 2168.4 2179.6 2131.3 2141.9 2151.9 2154.2 2180.5 2073.2 2079.5 2079.7 2082.0 2083.2 2036.2 2094.7 2097.3 2098.3 2098.8 7522.7 7790.3 7835.9 7946.2 7954.9 4357.7 4541.4 4543.0 4543.4 4548.7 2793.6 2913.9 2953.8 2958.3 2960.8 929.3 930.4 941.3 949.0 951.5 10536.8 10568.7 10583.6 10635.3 10636.8 3820.7 3981.5 3986.4 4013.1 4213.7 8121.1 8242.9 8245.5 8255.2 8260.4 4360.5 4452.2 4455.5 4459.0 4462.0 3346.6 3950.8 4112.8 4119.1 4164.0 3218.2 3271.6 3361.6 3380.9 3382.8 979.9 987.7 989.3 1002.5 1003.6 718.9 811.1 830.0 841.1 851.0 4991.2 5075.9 5088.7 5149.1 5183.7 375.1 903.5 905.3 913.2 992.4 3536.9 3666.9 3729.8 3742.7 3765.4 8691.1 9005.7 9066.0 9087.8 9091.5 8969.8 8973.0 8984.3 8994.1 9009.9 6608.5 6926.8 7014.1 7019.8 7021.8 5544.1 5567.9 5629.8 5659.4 5827.6 8638.0 8807.3 8825.0 8844.3 9007.6 8778.9 9068.0 9108.6 9133.9 9157.4 5834.7 6566.2 6772.8 6839.9 6994.9 7060.5 7293.6 7299.9 7448.2 7477.4 6324.1 6413.7 6593.8 6721.9 6723.1 6259.2 6322.8 6342.5 6358.7 6360.7 5936.5 6025.9 6028.9 6031.3 6038.5 4418.7 4499.6 4507.4 4569.6 4611.2 4398.3 4444.1 4484.6 4541.7 4561.2 21:45:06 INFO - PROCESS | 3377 | 21:45:06 INFO - PROCESS | 3377 | [#4] prototype.html Cycles:180 Average:4119.57 Median:4637.14 stddev:1213.78 (26.2%) stddev-sans-first:1182.32 21:45:06 INFO - PROCESS | 3377 | Values: 271.5 276.2 279.5 285.7 291.1 4678.5 4839.4 4896.7 4924.6 4937.7 4675.9 4806.8 4808.3 4811.9 4891.2 3552.3 3851.2 3864.7 3881.0 3882.9 3657.5 3758.5 3787.9 3798.0 3810.4 3753.3 3753.5 3753.8 3755.8 3760.3 3745.8 3754.4 3757.9 3760.6 3767.9 3222.2 3295.1 3297.6 3322.7 3329.8 4652.8 4689.2 4694.8 4711.1 4752.5 4295.9 4296.2 4296.3 4314.9 4317.8 4810.4 5000.8 5021.9 5049.6 5058.6 3572.7 3575.4 3576.3 3593.1 3594.6 5274.9 5289.4 5333.2 5397.1 5405.0 3547.5 3673.0 3678.2 3723.3 3725.8 3730.8 3731.4 3737.7 3755.3 3756.1 4278.3 4279.0 4303.9 4307.9 4317.3 4854.5 4972.3 5035.6 5149.4 5151.7 1256.3 1277.0 1278.4 1281.9 1289.1 774.6 807.3 810.9 818.5 820.6 4039.5 4043.1 4046.5 4050.9 4065.7 4540.5 4600.0 4630.0 4644.3 4683.6 3990.4 4022.5 4026.9 4043.2 4058.5 2296.3 2441.4 2473.5 2480.1 2489.4 4396.3 4422.5 4427.3 4429.7 4438.1 4672.0 4691.6 4719.3 4738.2 4793.3 4373.3 4411.4 4586.2 4904.0 4984.5 5147.8 5155.0 5164.7 5194.2 5230.7 5156.9 5177.5 5235.1 5238.2 5256.5 4685.9 4952.7 4953.7 4963.3 5024.0 3598.5 3607.5 3610.9 3622.9 3626.8 5093.7 5305.4 5313.5 5320.9 5321.3 4955.7 5055.8 5069.2 5070.9 5078.2 5032.2 5050.0 5051.4 5056.2 5064.5 4876.1 4941.4 4962.9 4993.9 5033.8 5060.6 5070.8 5073.2 5075.7 5079.9 4962.9 4971.9 4996.3 5028.5 5050.1 21:45:06 INFO - PROCESS | 3377 | 21:45:06 INFO - PROCESS | 3377 | [#5] yui.html Cycles:180 Average:17797.90 Median:595.58 stddev:26230.08 (4404.1%) stddev-sans-first:26271.92 21:45:06 INFO - PROCESS | 3377 | Values: 612.1 618.5 640.7 641.8 695.7 12783.9 12921.4 13777.5 13803.7 13840.4 12908.3 12934.5 12979.2 13020.6 13038.5 631.9 761.8 778.7 783.4 784.9 755.4 781.8 785.8 791.1 791.7 822.3 827.5 828.3 830.0 830.2 662.2 821.8 821.9 821.9 822.1 580.2 595.1 596.0 599.6 600.9 13012.9 13013.2 13013.6 13015.3 13018.8 11699.2 11704.5 12154.0 12749.3 13360.7 11902.7 11974.3 12098.7 12191.7 12222.5 4150.4 4193.0 4276.6 4356.2 4361.9 66678.3 69544.7 69943.3 70012.3 70045.0 9781.0 9998.2 10023.8 10085.5 10169.5 18305.0 18588.4 18635.2 18638.6 18652.0 6566.1 6655.5 6705.0 6906.1 6972.4 3574.6 3584.8 3614.5 3614.8 3697.3 2720.1 2798.0 2800.0 2812.5 2817.8 481.5 490.5 492.8 495.4 495.9 544.8 547.4 550.6 556.9 571.8 7256.6 7766.7 7955.6 7961.4 8100.8 481.8 533.1 555.7 560.2 571.5 3625.3 3698.6 3780.6 3785.2 3877.4 57508.4 58036.4 92922.1 103170.0 107546.5 89536.6 90431.5 91225.0 91408.0 91940.5 79659.6 81419.8 81465.7 81740.6 81882.0 7012.2 7337.8 7624.5 7715.3 7724.8 45763.5 46141.5 46855.5 48254.8 48641.5 62797.7 67089.0 68052.0 68418.0 70036.0 8877.9 8914.5 9295.0 9303.0 9779.8 10321.8 10393.3 10430.2 10727.2 10943.6 9475.7 9819.2 9863.8 9885.9 10730.2 9614.8 9874.7 10087.3 10368.4 10405.3 9547.6 9790.8 10087.6 10104.4 10401.9 7814.4 7849.3 7878.3 8520.7 8608.6 7758.3 8286.6 8449.3 8460.2 8523.5 21:45:06 INFO - PROCESS | 3377 | -------- Summary: end -------- 21:45:06 INFO - PROCESS | 3377 | 21:45:07 INFO - TEST-INFO | 3377: exit 0 21:45:07 INFO - TEST-OK | dromaeo_css | took 1122386ms 21:45:07 INFO - TEST-START | kraken 21:45:07 INFO - operating with platform_type : linux_ 21:45:07 INFO - Initialising browser for kraken test... 21:45:07 INFO - TEST-INFO | started process 3568 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp57guKI/profile http://localhost:33938/getInfo.html) 21:45:11 INFO - PROCESS | 3568 | __metrics Screen width/height:1600/1200 21:45:11 INFO - PROCESS | 3568 | colorDepth:24 21:45:11 INFO - PROCESS | 3568 | Browser inner width/height: 1024/697 21:45:11 INFO - PROCESS | 3568 | __metrics 21:45:12 INFO - PROCESS | 3568 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 21:45:12 INFO - PROCESS | 3568 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:45:13 INFO - PROCESS | 3568 | console.error: PushService: 21:45:13 INFO - PROCESS | 3568 | stateChangeProcessEnqueue: Error transitioning state 21:45:13 INFO - PROCESS | 3568 | UnknownError 21:45:13 INFO - TEST-INFO | 3568: exit 0 21:45:13 INFO - Browser initialized. 21:45:13 INFO - Running cycle 1/1 for kraken test... 21:45:13 INFO - TEST-INFO | started process 3650 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp57guKI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:45:25 INFO - PROCESS | 3650 | RSS: Main: 157114368 21:45:25 INFO - PROCESS | 3650 | 21:45:28 INFO - PROCESS | 3650 | Cycle 1(1): loaded http://localhost:33938/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33938/tests/kraken/driver.html?testName=audio-beat-detection) 21:45:29 INFO - PROCESS | 3650 | RSS: Main: 213172224 21:45:29 INFO - PROCESS | 3650 | 21:45:31 INFO - PROCESS | 3650 | Cycle 1(1): loaded http://localhost:33938/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33938/tests/kraken/driver.html?testName=audio-dft) 21:45:32 INFO - PROCESS | 3650 | RSS: Main: 191180800 21:45:32 INFO - PROCESS | 3650 | 21:45:35 INFO - PROCESS | 3650 | Cycle 1(1): loaded http://localhost:33938/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33938/tests/kraken/driver.html?testName=audio-fft) 21:45:36 INFO - PROCESS | 3650 | RSS: Main: 270970880 21:45:36 INFO - PROCESS | 3650 | 21:45:38 INFO - PROCESS | 3650 | Cycle 1(1): loaded http://localhost:33938/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33938/tests/kraken/driver.html?testName=audio-oscillator) 21:45:39 INFO - PROCESS | 3650 | RSS: Main: 179269632 21:45:39 INFO - PROCESS | 3650 | 21:45:41 INFO - PROCESS | 3650 | Cycle 1(1): loaded http://localhost:33938/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33938/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:45:42 INFO - PROCESS | 3650 | RSS: Main: 184311808 21:45:42 INFO - PROCESS | 3650 | 21:45:45 INFO - PROCESS | 3650 | Cycle 1(1): loaded http://localhost:33938/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33938/tests/kraken/driver.html?testName=imaging-darkroom) 21:45:45 INFO - PROCESS | 3650 | RSS: Main: 220991488 21:45:45 INFO - PROCESS | 3650 | 21:45:49 INFO - PROCESS | 3650 | Cycle 1(1): loaded http://localhost:33938/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33938/tests/kraken/driver.html?testName=imaging-desaturate) 21:45:49 INFO - PROCESS | 3650 | RSS: Main: 214839296 21:45:49 INFO - PROCESS | 3650 | 21:45:52 INFO - PROCESS | 3650 | Cycle 1(1): loaded http://localhost:33938/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33938/tests/kraken/driver.html?testName=json-parse-financial) 21:45:53 INFO - PROCESS | 3650 | RSS: Main: 218234880 21:45:53 INFO - PROCESS | 3650 | 21:45:55 INFO - PROCESS | 3650 | Cycle 1(1): loaded http://localhost:33938/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33938/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:45:55 INFO - PROCESS | 3650 | RSS: Main: 183717888 21:45:55 INFO - PROCESS | 3650 | 21:45:57 INFO - PROCESS | 3650 | Cycle 1(1): loaded http://localhost:33938/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33938/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:45:58 INFO - PROCESS | 3650 | RSS: Main: 189194240 21:45:58 INFO - PROCESS | 3650 | 21:46:00 INFO - PROCESS | 3650 | Cycle 1(1): loaded http://localhost:33938/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33938/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:46:01 INFO - PROCESS | 3650 | RSS: Main: 193564672 21:46:01 INFO - PROCESS | 3650 | 21:46:03 INFO - PROCESS | 3650 | Cycle 1(1): loaded http://localhost:33938/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33938/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:46:04 INFO - PROCESS | 3650 | RSS: Main: 189251584 21:46:04 INFO - PROCESS | 3650 | 21:46:07 INFO - PROCESS | 3650 | Cycle 1(1): loaded http://localhost:33938/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33938/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:46:08 INFO - PROCESS | 3650 | RSS: Main: 191766528 21:46:08 INFO - PROCESS | 3650 | 21:46:09 INFO - PROCESS | 3650 | Cycle 1(1): loaded http://localhost:33938/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33938/tests/kraken/driver.html?testName=ai-astar) 21:46:10 INFO - PROCESS | 3650 | RSS: Main: 242683904 21:46:10 INFO - PROCESS | 3650 | 21:46:10 INFO - PROCESS | 3650 | __start_tp_report 21:46:10 INFO - PROCESS | 3650 | _x_x_mozilla_page_load 21:46:10 INFO - PROCESS | 3650 | _x_x_mozilla_page_load_details 21:46:10 INFO - PROCESS | 3650 | |i|pagename|runs| 21:46:10 INFO - PROCESS | 3650 | |0;ai-astar;104;114;113;114;113;114;113;113;114;114 21:46:10 INFO - PROCESS | 3650 | |1;audio-beat-detection;147;128;128;194;123;123;147;132;178;123 21:46:10 INFO - PROCESS | 3650 | |2;audio-dft;161;160;164;161;162;161;163;162;161;160 21:46:10 INFO - PROCESS | 3650 | |3;audio-fft;76;77;76;114;77;77;75;76;100;76 21:46:10 INFO - PROCESS | 3650 | |4;audio-oscillator;86;86;133;86;85;87;115;86;86;126 21:46:10 INFO - PROCESS | 3650 | |5;imaging-gaussian-blur;117;117;117;117;118;117;117;118;117;117 21:46:10 INFO - PROCESS | 3650 | |6;imaging-darkroom;146;147;146;145;145;147;146;146;146;145 21:46:10 INFO - PROCESS | 3650 | |7;imaging-desaturate;96;95;95;95;95;95;95;95;95;95 21:46:10 INFO - PROCESS | 3650 | |8;json-parse-financial;64;62;64;64;64;65;64;63;64;63 21:46:10 INFO - PROCESS | 3650 | |9;json-stringify-tinderbox;68;67;67;67;67;66;67;66;67;67 21:46:10 INFO - PROCESS | 3650 | |10;stanford-crypto-aes;87;79;82;79;78;80;78;85;80;80 21:46:10 INFO - PROCESS | 3650 | |11;stanford-crypto-ccm;134;135;137;132;138;145;138;134;155;132 21:46:10 INFO - PROCESS | 3650 | |12;stanford-crypto-pbkdf2;175;170;173;171;173;168;170;174;170;170 21:46:10 INFO - PROCESS | 3650 | |13;stanford-crypto-sha256-iterative;68;68;69;66;67;67;69;67;66;73 21:46:10 INFO - PROCESS | 3650 | __end_tp_report 21:46:10 INFO - PROCESS | 3650 | __start_cc_report 21:46:10 INFO - PROCESS | 3650 | _x_x_mozilla_cycle_collect,1948 21:46:10 INFO - PROCESS | 3650 | __end_cc_report 21:46:10 INFO - PROCESS | 3650 | __startTimestamp1470890770066__endTimestamp 21:46:10 INFO - PROCESS | 3650 | 21:46:10 INFO - PROCESS | 3650 | ------- Summary: start ------- 21:46:10 INFO - PROCESS | 3650 | Number of tests: 14 21:46:10 INFO - PROCESS | 3650 | 21:46:10 INFO - PROCESS | 3650 | [#0] ai-astar Cycles:10 Average:112.60 Median:114.00 stddev:3.06 (2.7%) stddev-sans-first:0.53 21:46:10 INFO - PROCESS | 3650 | Values: 104.0 114.0 113.0 114.0 113.0 114.0 113.0 113.0 114.0 114.0 21:46:10 INFO - PROCESS | 3650 | 21:46:10 INFO - PROCESS | 3650 | [#1] audio-beat-detection Cycles:10 Average:142.30 Median:139.50 stddev:25.00 (17.9%) stddev-sans-first:26.46 21:46:10 INFO - PROCESS | 3650 | Values: 147.0 128.0 128.0 194.0 123.0 123.0 147.0 132.0 178.0 123.0 21:46:10 INFO - PROCESS | 3650 | 21:46:10 INFO - PROCESS | 3650 | [#2] audio-dft Cycles:10 Average:161.50 Median:161.50 stddev:1.27 (0.8%) stddev-sans-first:1.33 21:46:10 INFO - PROCESS | 3650 | Values: 161.0 160.0 164.0 161.0 162.0 161.0 163.0 162.0 161.0 160.0 21:46:10 INFO - PROCESS | 3650 | 21:46:10 INFO - PROCESS | 3650 | [#3] audio-fft Cycles:10 Average:82.40 Median:76.00 stddev:13.39 (17.6%) stddev-sans-first:14.00 21:46:10 INFO - PROCESS | 3650 | Values: 76.0 77.0 76.0 114.0 77.0 77.0 75.0 76.0 100.0 76.0 21:46:10 INFO - PROCESS | 3650 | 21:46:10 INFO - PROCESS | 3650 | [#4] audio-oscillator Cycles:10 Average:97.60 Median:86.00 stddev:19.17 (22.3%) stddev-sans-first:19.86 21:46:10 INFO - PROCESS | 3650 | Values: 86.0 86.0 133.0 86.0 85.0 87.0 115.0 86.0 86.0 126.0 21:46:10 INFO - PROCESS | 3650 | 21:46:10 INFO - PROCESS | 3650 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 21:46:10 INFO - PROCESS | 3650 | Values: 117.0 117.0 117.0 117.0 118.0 117.0 117.0 118.0 117.0 117.0 21:46:10 INFO - PROCESS | 3650 | 21:46:10 INFO - PROCESS | 3650 | [#6] imaging-darkroom Cycles:10 Average:145.90 Median:146.00 stddev:0.74 (0.5%) stddev-sans-first:0.78 21:46:10 INFO - PROCESS | 3650 | Values: 146.0 147.0 146.0 145.0 145.0 147.0 146.0 146.0 146.0 145.0 21:46:10 INFO - PROCESS | 3650 | 21:46:10 INFO - PROCESS | 3650 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.00 21:46:10 INFO - PROCESS | 3650 | Values: 96.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 21:46:10 INFO - PROCESS | 3650 | 21:46:10 INFO - PROCESS | 3650 | [#8] json-parse-financial Cycles:10 Average:63.70 Median:64.00 stddev:0.82 (1.3%) stddev-sans-first:0.87 21:46:10 INFO - PROCESS | 3650 | Values: 64.0 62.0 64.0 64.0 64.0 65.0 64.0 63.0 64.0 63.0 21:46:10 INFO - PROCESS | 3650 | 21:46:10 INFO - PROCESS | 3650 | [#9] json-stringify-tinderbox Cycles:10 Average:66.90 Median:67.00 stddev:0.57 (0.8%) stddev-sans-first:0.44 21:46:10 INFO - PROCESS | 3650 | Values: 68.0 67.0 67.0 67.0 67.0 66.0 67.0 66.0 67.0 67.0 21:46:10 INFO - PROCESS | 3650 | 21:46:10 INFO - PROCESS | 3650 | [#10] stanford-crypto-aes Cycles:10 Average:80.80 Median:80.00 stddev:3.01 (3.8%) stddev-sans-first:2.20 21:46:10 INFO - PROCESS | 3650 | Values: 87.0 79.0 82.0 79.0 78.0 80.0 78.0 85.0 80.0 80.0 21:46:10 INFO - PROCESS | 3650 | 21:46:10 INFO - PROCESS | 3650 | [#11] stanford-crypto-ccm Cycles:10 Average:138.00 Median:137.50 stddev:7.09 (5.2%) stddev-sans-first:7.37 21:46:10 INFO - PROCESS | 3650 | Values: 134.0 135.0 137.0 132.0 138.0 145.0 138.0 134.0 155.0 132.0 21:46:10 INFO - PROCESS | 3650 | 21:46:10 INFO - PROCESS | 3650 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.40 Median:172.00 stddev:2.22 (1.3%) stddev-sans-first:1.94 21:46:10 INFO - PROCESS | 3650 | Values: 175.0 170.0 173.0 171.0 173.0 168.0 170.0 174.0 170.0 170.0 21:46:10 INFO - PROCESS | 3650 | 21:46:10 INFO - PROCESS | 3650 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.00 Median:68.00 stddev:2.05 (3.0%) stddev-sans-first:2.18 21:46:10 INFO - PROCESS | 3650 | Values: 68.0 68.0 69.0 66.0 67.0 67.0 69.0 67.0 66.0 73.0 21:46:10 INFO - PROCESS | 3650 | -------- Summary: end -------- 21:46:10 INFO - PROCESS | 3650 | 21:46:11 INFO - TEST-INFO | 3650: exit 0 21:46:11 INFO - TEST-OK | kraken | took 63580ms 21:46:11 INFO - SUITE-END | took 1185s 21:46:11 INFO - Completed test suite (00:19:45) 21:46:11 INFO - javascript benchmark 21:46:11 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2631.710511843697, 2637.432951915338, 2661.0952276226085, 2679.12928298303, 2680.517506848768, 4709.9058018839605, 4755.381800365952, 4806.279058141281, 4872.0499502597, 4903.16646170151, 4771.141194584973, 4780.0, 4784.545468180518, 4800.135975524404, 4845.297431872376, 4407.955920440802, 4417.447819022622, 4437.556244375569, 4499.0, 4509.458864936212, 4436.778161091933, 4542.500324964251, 4590.081983603276, 4622.260438329868, 4627.676062675614, 4351.608355248043, 4387.0, 4401.2517871961845, 4458.286674132123, 4474.2841145416905, 4429.534898835608, 4444.933326000112, 4451.465824101128, 4451.755153466558, 4456.866294011184, 4411.647068234533, 4416.315471101984, 4418.116376724668, 4444.577765112309, 4476.664250181249, 4729.148753224418, 4774.880627984328, 4796.0, 4848.054629347279, 4977.751112444364, 5142.588592912558, 5179.922301165486, 5184.922226166573, 5187.792488300463, 5188.118019936582, 5112.0, 5182.0, 5211.947880521222, 5224.973875130638, 5239.3712754469325, 4922.138625740481, 4924.8276310328965, 4928.827491037797, 4929.137400954819, 4936.111499929975, 5331.093714068617, 5386.461353864661, 5394.460553944574, 5397.973010135002, 5430.0768869292315, 4992.400911890596, 5050.797968081236, 5063.645544811828, 5112.9744351278005, 5188.481151884856, 5224.059669259494, 5267.236250743621, 5280.867978300574, 5282.445343238982, 5293.894122117536, 5183.714895680699, 5186.740662966837, 5191.143461328838, 5198.454162312978, 5237.6071794615555, 4961.627877909171, 5026.145555255543, 5045.016221836707, 5159.716215608102, 5163.941392014628, 4021.3163762160502, 4073.7759423231414, 4074.5393426912988, 4100.979495102505, 4114.855980040744, 3566.3045706087064, 3582.6954708849516, 3613.8012409317216, 3615.6022837487853, 3629.038304849217, 4291.034517233597, 4329.134173165379, 4469.284914413678, 4474.888127796766, 4511.684182107287, 5059.848204553869, 5083.364579427572, 5086.5422112009355, 5179.766910489037, 5243.318368612056, 4504.887377815581, 4509.053098849278, 4538.29656403258, 4544.363789069533, 4545.068261006486, 4729.597984171384, 4766.976165119221, 4768.546988036131, 4770.522947705202, 4810.42274927011, 4695.460022097503, 4709.835155769669, 4954.826581069645, 4964.2305442655, 4996.925046124384, 5191.169412893919, 5229.032628963654, 5256.685828542864, 5269.0, 5317.415084340797, 4932.136876046749, 4945.4807245238735, 4945.901081978413, 4947.455779864284, 4990.126727822544, 4915.754212289443, 5173.5085166910585, 5176.896462070662, 5178.71517066565, 5191.0, 5115.897682046264, 5148.716820574904, 5158.664686795496, 5185.688858668492, 5234.842954711365, 5007.324011258579, 5033.597312214941, 5038.370203724535, 5042.873928151679, 5087.516685914832, 4959.652824302409, 5014.222795466709, 5025.497450254945, 5030.924536131888, 5031.924521132113, 4915.164422048332, 4930.4822993586595, 4932.704037757746, 4946.3817022872145, 5007.599392048554, 4972.378452693413, 5025.095482813129, 5067.366579177603, 5071.949280507148, 5110.5911527077005, 4780.426348838162, 4949.30709700635, 4951.455339912679, 4951.9752401237765, 5011.574016208663], "value": 4738.502920077921, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [561.7865211219736, 576.5243673968977, 582.3128708124411, 583.6585597425506, 584.4535359438928, 28803.711962880367, 31451.84274078629, 31493.0, 38520.0, 39968.20063598726, 39531.0, 39892.800535997354, 39909.401358979565, 39943.40084898729, 39973.40039899404, 7580.204078571739, 7718.0, 7721.691132354699, 7723.189065148163, 7723.304902558769, 7468.514546554484, 7642.808929776772, 9828.066333698287, 10045.19638428924, 10066.0, 9695.515224238796, 9758.072983066633, 9762.170215531689, 9763.75590610237, 9766.316357854954, 9865.06281903218, 9900.158486528653, 9914.256430767722, 9915.603375864994, 9927.652532161412, 9691.90308096917, 9773.267004974656, 9773.902260977371, 9784.853227201527, 9790.902090979142, 37556.24887502235, 37826.243475130344, 37841.62158378409, 37849.81075094607, 37888.0, 2958.970410295891, 3010.7741919356135, 3117.8285194314303, 3302.2239773653173, 3329.20099176196, 28377.574336384972, 28664.0, 28861.42277154445, 28923.855380723173, 30379.848100759576, 3502.562179727534, 3565.5899571549344, 3567.5362202913457, 3570.1610121621397, 3604.567451905788, 239739.0, 240422.0, 240495.0, 240815.0, 240913.0, 31787.205319866727, 51187.0, 51478.74260628673, 51497.22754158616, 51560.0, 32014.519782203286, 33679.0, 33821.49267760986, 33854.0, 33896.49155262673, 13089.345532723326, 13183.93408032973, 13233.801492977613, 13234.272115033573, 13241.73516529664, 9947.850782238273, 10295.897041029644, 10355.792884142274, 10355.896441035644, 10361.689149325532, 7688.730894418669, 7873.0, 7942.602869856484, 8023.598820058974, 8093.838123237502, 3044.3606842562867, 3142.120206342228, 3151.9054428367185, 3190.7287880530416, 3191.6010498687665, 854.4873076154382, 870.9520976346236, 879.4723166100416, 896.3859756067114, 897.9820403591891, 24463.0, 24881.129160479657, 24922.5015499689, 24993.50012999766, 25099.498010039697, 945.333539854401, 947.6588428165854, 964.4068897628049, 1044.6291566493785, 1055.904968552834, 13428.649986252367, 13893.791593125909, 14081.155130692192, 14143.787843182361, 14327.0, 365996.0, 370020.0, 370921.0, 371909.0, 372462.0, 49087.50912490901, 49455.0, 49656.50343496591, 49813.25280120801, 49821.75089124531, 1087.1465899269194, 1137.1641843245372, 1141.4863311509687, 1181.3207405741732, 1187.9703007424885, 26028.479430410905, 28683.85658071696, 28900.710992889803, 29383.0, 29777.404451910406, 42791.144177116905, 47862.76068619774, 48009.75995120002, 48069.75965120292, 48116.0, 350866.0, 351733.0, 355001.0, 355399.0, 355692.8799628016, 24656.50686986286, 25517.744822551536, 25585.0, 26981.190564283104, 38619.22761544697, 37667.81166094152, 37745.81127094457, 37864.242715146094, 38350.23299534049, 38809.41785873158, 33156.1710957228, 33657.32685346328, 34154.14614634654, 34276.31447371088, 34503.0, 32987.835060824546, 33112.50331245081, 33871.33688243157, 34520.309593807484, 34634.48048279328, 33432.33135337231, 34086.829565852015, 34247.48628770521, 34381.0, 34640.82679586586, 28821.711782882743, 30948.22629434282, 30963.225919352197, 30981.8450907744, 31220.37559248848, 23788.52422951566, 23890.0, 24011.639825402282, 24229.75770242275, 24442.87778561096], "value": 16559.441365187235, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [319.788939300062, 335.7263829978569, 355.0838835803626, 360.2722500548891, 389.3031473662145, 12416.0, 15729.449469268578, 15952.680946381066, 17663.470095897144, 17916.910415447936, 17081.14594270288, 17586.472405827815, 17631.823681763177, 17766.733498997524, 17814.554636134104, 4717.599004084657, 4758.143534163849, 4930.926036109461, 4992.0, 5027.4469808321055, 3729.4965179700666, 4988.226824842155, 5053.873653158682, 5572.637778544402, 5857.707114644272, 5877.030290002144, 5909.556783241274, 5912.881742365172, 5922.052471604544, 5945.31628862682, 5324.414314425429, 5617.943820561783, 5638.013347664183, 5734.713264336809, 5945.346011938684, 4947.6289278304275, 5112.437631860493, 5113.795448182068, 5235.267062611199, 5297.814576489843, 12054.758904821854, 12198.329091899943, 12290.446929888087, 12319.260844349277, 14937.402503899832, 1858.4738860083078, 1866.887986720801, 1894.1665667106568, 1904.990475047616, 2011.4971257185703, 8936.32977526688, 8982.955085224532, 9048.547572621343, 9251.907480925172, 12798.936005319914, 1679.6472740724462, 1685.140578305061, 1783.1478159165033, 1799.4961410804995, 1828.1590468384559, 67411.66294168547, 70432.647836761, 72434.0, 72754.63622681906, 73185.0, 8172.67309307633, 8630.568471576396, 8663.176998185163, 9295.488748118783, 10140.138088262433, 11397.601083962021, 11438.370889600985, 11440.656780296604, 11444.484998175101, 11445.88554114465, 6699.732010719516, 6821.727130914708, 6862.965685171542, 6906.758263460855, 6909.205441374306, 6819.24988251292, 6852.897206541906, 6989.33601307875, 7054.964725176341, 7102.254263302382, 3534.5581802274714, 3670.3026424979703, 3673.4673472346362, 3742.214135031674, 3757.098296408842, 1734.1849330814498, 1801.6937120689252, 1824.4800231933834, 1868.1219826681438, 1879.8026207248315, 845.3448577352601, 855.9186877246651, 882.2765332427476, 937.161240689579, 956.1346980982222, 16905.49283521496, 17072.061036643103, 17799.46601601954, 17860.642787144443, 18254.81745182531, 842.8988521377474, 859.1623167411724, 878.4202426398547, 884.9292056635454, 892.5180402582532, 9444.527773611291, 9833.901660983442, 9980.900190998142, 10007.49962501872, 10215.744606384751, 397054.0, 400993.0, 405105.0, 408256.0, 408264.0, 73278.63360683163, 73990.63004685049, 75987.62006189933, 76270.61864690641, 76771.0, 850.0734199722332, 872.2760109109424, 874.4097734029632, 882.8808110904946, 883.6244596046654, 14985.475508357154, 15359.616009599402, 15546.533603991898, 15556.0, 16051.277692503632, 27946.720532795225, 36164.0, 37955.0, 38387.0, 38961.220775584894, 51528.0, 52014.21978670247, 52029.959400811014, 52350.47649523456, 52538.474615253355, 6678.432333251728, 6904.551204171713, 7330.45021623391, 7672.539647621161, 7838.0, 10848.783024339627, 11166.944165279447, 11492.0, 12240.143189976972, 12253.448594813433, 9585.568649410654, 10656.89343106559, 10680.0, 10822.134229261483, 11008.834867476835, 10470.516862425382, 10544.420056896945, 10661.840072398765, 10805.351678899291, 10845.945770271099, 10026.598936042768, 10564.630237941636, 10589.205809564468, 10863.837042444211, 11161.609343672932, 6698.095757072733, 6842.521023528305, 6863.210730766026, 7091.82270443243, 7126.109236345457, 8525.531095789791, 10684.0, 10811.35131892089, 10830.40432776205, 11184.888151118384], "value": 7991.353137888257, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1252.436403618372, 1390.1242217403037, 1439.7696368581028, 1508.61530309771, 1718.9054601996893, 6265.843353916154, 7365.779026629203, 7606.84786304275, 7616.88574671379, 7801.492902961318, 7578.469507134503, 7615.77152685419, 7637.885431718515, 7645.197254288303, 7647.197044310351, 2132.264368792764, 2156.202205184084, 2159.276642324823, 2159.84881058326, 2160.6542953127505, 2116.576684663066, 2143.8928053597338, 2163.286115581854, 2168.3711723600136, 2179.5640871825617, 2131.328631481086, 2141.903614337351, 2151.8924053797327, 2154.1814110637933, 2180.4984853483707, 2073.1810934680793, 2079.511314841011, 2079.6984437256515, 2081.95836083279, 2083.2396175396025, 2036.2465887621527, 2094.717213176217, 2097.318371529259, 2098.31804663485, 2098.832093432537, 7522.699092036367, 7790.298873101391, 7835.882461763078, 7946.245106714853, 7954.920450795534, 4357.694961352707, 4541.364209010741, 4543.0, 4543.432070991126, 4548.704334218299, 2793.6088947547155, 2913.8688759005686, 2953.808002479832, 2958.2604348912773, 2960.7779416543844, 929.3355250995571, 930.3952430919888, 941.2940294778916, 948.9857652135223, 951.5147274889787, 10536.841947370796, 10568.68293951175, 10583.576656933714, 10635.308704934154, 10636.787264254672, 3820.7325487216185, 3981.462502562175, 3986.402039694069, 4013.13717550728, 4213.747175169499, 8121.066077401175, 8242.876356854653, 8245.546494942835, 8255.174482551696, 8260.421770476129, 4360.4767427908855, 4452.198604251201, 4455.465344158722, 4458.9554104459185, 4461.977690111594, 3346.6151392589677, 3950.762954222756, 4112.835486580563, 4119.073208528057, 4163.958360416417, 3218.2115381731624, 3271.5583396241677, 3361.6302206757236, 3380.9323813524084, 3382.797032178077, 979.9020097990286, 987.6740675577186, 989.2531138990016, 1002.4937406609615, 1003.6236411345745, 718.9496735228588, 811.0834756724863, 830.0205757206554, 841.0706169682413, 850.9914900850912, 4991.151504244287, 5075.87310317245, 5088.6946783193125, 5149.073166830007, 5183.688978661293, 375.1446701520538, 903.4895284164426, 905.2893478619252, 913.1781396742851, 992.4442312305132, 3536.9469457958153, 3666.944995825065, 3729.813509324523, 3742.6631603155847, 3765.4163604641326, 8691.130886911385, 9005.729828105168, 9066.0, 9087.81824363509, 9091.499967501852, 8969.775755606162, 8972.955135224282, 8984.32617553686, 8994.145556172152, 9009.864852027225, 6608.537402381883, 6926.757563485254, 7014.088168538057, 7019.824504387431, 7021.824454388579, 5544.112941929433, 5567.916481252865, 5629.831105066854, 5659.405762394889, 5827.562932779973, 8637.956810215908, 8807.339449541438, 8825.029246782977, 8844.292456603585, 9007.594658240527, 8778.91221087781, 9067.954660226656, 9108.590113444778, 9133.908660913306, 9157.40476869028, 5834.737436815439, 6566.212054553484, 6772.762953296611, 6839.897401538881, 6994.860102797814, 7060.54106483077, 7293.598852062975, 7299.9270007301375, 7448.1807001228735, 7477.401807855467, 6324.114623952558, 6413.679316034087, 6593.824038067522, 6721.932780672326, 6723.058771772054, 6259.186305780401, 6322.841928951629, 6342.492600592034, 6358.650274234777, 6360.681965901594, 5936.465718085393, 6025.87948241024, 6028.939710602838, 6031.276246850406, 6038.486728628116, 4418.7348759073275, 4499.617532509643, 4507.368968344369, 4569.634429245586, 4611.216093264086, 4398.340248962553, 4444.111177764525, 4484.551544845489, 4541.704789188692, 4561.156186105581], "value": 4012.516344187153, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [271.455731258826, 276.1976458388382, 279.4620355815057, 285.66434439533543, 291.14258508691887, 4678.53214678532, 4839.370881785372, 4896.681715688483, 4924.64572242633, 4937.728424936627, 4675.859724208271, 4806.83176088837, 4808.254720518316, 4811.855644330676, 4891.168501354769, 3552.3428165789283, 3851.2490064437447, 3864.7487913285686, 3880.961190388088, 3882.864099756509, 3657.4513822926506, 3758.473813666089, 3787.8674246401383, 3798.0315019669947, 3810.4474851146565, 3753.3244016077097, 3753.493278407407, 3753.7747735135845, 3755.8497660093562, 3760.3231418344685, 3745.7752534847723, 3754.3617585010616, 3757.9248415031684, 3760.6085748273176, 3767.9434808477895, 3222.1622378181605, 3295.0938491914676, 3297.637259901409, 3322.660725970384, 3329.8002119872644, 4652.837150699743, 4689.249720044776, 4694.788734506956, 4711.104890070876, 4752.5247475252545, 4295.935560966588, 4296.248156572618, 4296.291111966521, 4314.913701725979, 4317.848875289381, 4810.4467986181335, 5000.799968001275, 5021.899562008739, 5049.64652474327, 5058.570021548136, 3572.6605972432576, 3575.3743094958277, 3576.338377400163, 3593.119685677, 3594.6405359464106, 5274.892272622754, 5289.44460831611, 5333.226682131108, 5397.136458166714, 5404.973135074347, 3547.450145227494, 3672.9632703673155, 3678.2091850252323, 3723.255348930171, 3725.795081270502, 3730.813459327023, 3731.402975523903, 3737.747854468729, 3755.342815007363, 3756.1360886996144, 4278.315469524861, 4278.978605107017, 4303.934111626374, 4307.879951212644, 4317.266064768997, 4854.490278520775, 4972.303877457159, 5035.62232832539, 5149.433562308143, 5151.716655583904, 1256.2588073036952, 1277.0166971431945, 1278.3735969374939, 1281.884760258581, 1289.1362786932777, 774.6436639146056, 807.3097501636134, 810.854046271665, 818.5170749257967, 820.6102101501739, 4039.51525816898, 4043.0700938784244, 4046.47395838545, 4050.8987275318354, 4065.654419374327, 4540.500544940054, 4599.977000114978, 4630.0, 4644.2801365788355, 4683.625309975194, 3990.38149086892, 4022.4971878515184, 4026.899287548571, 4043.1913617276664, 4058.492688413948, 2296.2777916562577, 2441.438469152105, 2473.492933948536, 2480.1443501991785, 2489.3776555861036, 4396.252637051709, 4422.5356337584735, 4427.29163333865, 4429.667774916829, 4438.134563760101, 4671.95328046722, 4691.601213896857, 4719.315699223594, 4738.19450693383, 4793.304970779287, 4373.278409062469, 4411.448568928884, 4586.22533367308, 4903.964854585307, 4984.476629953802, 5147.768350424315, 5154.974225128851, 5164.746209887747, 5194.168932970707, 5230.712310822942, 5156.922646160236, 5177.534021938043, 5235.136202526541, 5238.240455133908, 5256.526912577886, 4685.882852928704, 4952.678075925053, 4953.678010929278, 4963.280324353021, 5024.020316038337, 3598.4962105304753, 3607.4949507068504, 3610.891673249807, 3622.873199438007, 3626.836792344298, 5093.726568357911, 5305.363356397257, 5313.468653134656, 5320.920186197132, 5321.2816269804625, 4955.6531042826655, 5055.848324550269, 5069.188929771219, 5070.923936141035, 5078.21287700407, 5032.220005899091, 5049.974750126225, 5051.393832739947, 5056.241563765318, 5064.468230835857, 4876.122297986255, 4941.357623509065, 4962.925556116734, 4993.900121997613, 5033.798648054037, 5060.645754797129, 5070.847874563769, 5073.162928116967, 5075.695458272516, 5079.87300317495, 4962.851114466572, 4971.900561988812, 4996.325496057985, 5028.460627383148, 5050.116229659869], "value": 3727.6618343452988, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [612.1338306296591, 618.477386608316, 640.724488469958, 641.788209890736, 695.6765104226533, 12783.872161278385, 12921.418536165871, 13777.51778687746, 13803.723925521483, 13840.446382144715, 12908.290044047573, 12934.547290844823, 12979.156354836929, 13020.609381718563, 13038.478460861554, 631.8862604731147, 761.7752762934947, 778.696308439709, 783.4006984656713, 784.9058113026445, 755.3692666623376, 781.7928249014016, 785.83104632504, 791.1416113516841, 791.7228969860531, 822.2599660305713, 827.5283088639478, 828.3083625172987, 829.9626516806728, 830.1822704635929, 662.19543254945, 821.7616891101574, 821.876718492225, 821.9178082191793, 822.112118911574, 580.216707444946, 595.1221947627258, 596.0403749962557, 599.5952731905946, 600.942910423509, 13012.86987130126, 13013.21920684762, 13013.609591712264, 13015.34923253843, 13018.804717929144, 11699.23954942926, 11704.473298701494, 12154.0, 12749.298788566624, 13360.665983350396, 11902.702432439171, 11974.281543107441, 12098.697532561668, 12191.695207619792, 12222.511099556006, 4150.439690641785, 4192.979035104835, 4276.593723596254, 4356.194104090753, 4361.869143925687, 66678.33304167386, 69544.6522767388, 69943.30056699419, 70012.2998770016, 70045.0, 9780.951095244478, 9998.15015723657, 10023.849642255373, 10085.546150423248, 10169.54237059334, 18305.0, 18588.44234672962, 18635.161417736235, 18638.627227455647, 18652.0, 6566.146400967844, 6655.534112612071, 6704.994250862312, 6906.06768086312, 6972.442204623618, 3574.6246644102516, 3584.8386822593047, 3614.530111085542, 3614.7650402724266, 3697.2975134724315, 2720.1023662191824, 2797.9860100699366, 2800.0, 2812.54999200127, 2817.802753807214, 481.48481125196406, 490.4996903158758, 492.7610109097085, 495.37830023320504, 495.89090400111917, 544.8038706065813, 547.4170008940465, 550.5678042736432, 556.9081101618187, 571.8398848322477, 7256.564606123649, 7766.728164514215, 7955.602219888982, 7961.442699011013, 8100.756977290691, 481.84099247248326, 533.1283351719966, 555.6610467614752, 560.1905246918245, 571.5456212311223, 3625.2568223514118, 3698.556173259226, 3780.6030366811638, 3785.242951409729, 3877.399003154459, 57508.424915751144, 58036.419635803104, 92922.0707792927, 103170.0, 107546.46226768816, 89536.55231723799, 90431.54784226036, 91225.0, 91408.0, 91940.54029729808, 79659.60170199227, 81419.77870331949, 81465.6680898722, 81740.59129704314, 81881.9999999988, 7012.152812196379, 7337.836217577047, 7624.466287359832, 7715.267049630276, 7724.841273808974, 45763.54236457726, 46141.53858461372, 46855.53144468648, 48254.75872620614, 48641.5135848637, 62797.68601156965, 67089.0, 68052.0, 68418.0, 70036.0, 8877.866831997397, 8914.465132092095, 9294.953525232331, 9302.994106947239, 9779.804403912025, 10321.845172322572, 10393.337066069393, 10430.217733669853, 10727.195460340661, 10943.616973405893, 9475.668351607661, 9819.214462843098, 9863.802723945337, 9885.851712224467, 10730.248882578457, 9614.759631009281, 9874.703758887244, 10087.29388942767, 10368.429736364573, 10405.271630985759, 9547.618095276111, 9790.80418391614, 10087.596496140366, 10104.444255566015, 10401.94799026, 7814.413918956215, 7849.3328067114935, 7878.330341921001, 8520.70177543783, 8608.569571521524, 7758.340541054074, 8286.58567071632, 8449.28181104613, 8460.153984601491, 8523.531205783493], "value": 6346.577968591844, "unit": "score"}], "name": "dromaeo_css", "value": 6248.724992421296, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 114.0, 113.0, 114.0, 113.0, 114.0, 113.0, 113.0, 114.0, 114.0], "value": 112.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 128.0, 128.0, 194.0, 123.0, 123.0, 147.0, 132.0, 178.0, 123.0], "value": 142.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 164.0, 161.0, 162.0, 161.0, 163.0, 162.0, 161.0, 160.0], "value": 161.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 76.0, 114.0, 77.0, 77.0, 75.0, 76.0, 100.0, 76.0], "value": 82.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 133.0, 86.0, 85.0, 87.0, 115.0, 86.0, 86.0, 126.0], "value": 97.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 118.0, 117.0, 117.0, 118.0, 117.0, 117.0], "value": 117.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 146.0, 145.0, 145.0, 147.0, 146.0, 146.0, 146.0, 145.0], "value": 145.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 62.0, 64.0, 64.0, 64.0, 65.0, 64.0, 63.0, 64.0, 63.0], "value": 63.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 67.0, 67.0, 67.0, 66.0, 67.0, 66.0, 67.0, 67.0], "value": 66.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 79.0, 82.0, 79.0, 78.0, 80.0, 78.0, 85.0, 80.0, 80.0], "value": 80.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 135.0, 137.0, 132.0, 138.0, 145.0, 138.0, 134.0, 155.0, 132.0], "value": 138.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 170.0, 173.0, 171.0, 173.0, 168.0, 170.0, 174.0, 170.0, 170.0], "value": 171.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 69.0, 66.0, 67.0, 67.0, 69.0, 67.0, 66.0, 73.0], "value": 68.0, "unit": "score"}], "name": "kraken", "value": 1543.4, "alertThreshold": 2.0}]} 21:46:11 INFO - Return code: 0 21:46:11 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 21:46:11 INFO - # TBPL SUCCESS # 21:46:11 INFO - Running post-action listener: _resource_record_post_action 21:46:11 INFO - [mozharness: 2016-08-11 04:46:11.337334Z] Finished run-tests step (success) 21:46:11 INFO - Running post-run listener: _resource_record_post_run 21:46:11 INFO - Total resource usage - Wall time: 1202s; CPU: 13.0%; Read bytes: 7766016; Write bytes: 414019584; Read time: 1652; Write time: 373828 21:46:11 INFO - TinderboxPrint: CPU usage
13.0% 21:46:11 INFO - TinderboxPrint: I/O read bytes / time
7,766,016 / 1,652 21:46:11 INFO - TinderboxPrint: I/O write bytes / time
414,019,584 / 373,828 21:46:11 INFO - TinderboxPrint: CPU idle
8,344.1 (87.0%) 21:46:11 INFO - TinderboxPrint: CPU user
1,204.5 (12.6%) 21:46:11 INFO - TinderboxPrint: Swap in / out
0 / 0 21:46:11 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 80773120; Read time: 0; Write time: 79900 21:46:11 INFO - run-tests - Wall time: 1186s; CPU: 13.0%; Read bytes: 5525504; Write bytes: 333246464; Read time: 1508; Write time: 293928 21:46:11 INFO - Running post-run listener: _upload_blobber_files 21:46:11 INFO - Blob upload gear active. 21:46:11 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 21:46:11 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 21:46:11 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'] 21:46:11 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 21:46:12 INFO - (blobuploader) - INFO - Open directory for files ... 21:46:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 21:46:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:46:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:46:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 21:46:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:46:13 INFO - (blobuploader) - INFO - Done attempting. 21:46:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 21:46:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:46:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:46:16 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 21:46:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:46:16 INFO - (blobuploader) - INFO - Done attempting. 21:46:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 21:46:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:46:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:46:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 21:46:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:46:17 INFO - (blobuploader) - INFO - Done attempting. 21:46:17 INFO - (blobuploader) - INFO - Iteration through files over. 21:46:17 INFO - Return code: 0 21:46:17 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 21:46:17 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 21:46:17 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/da97e5f25253d60ece7c656a67fc4cff2073daf91ee273a40d32e621cbffdb793f86c74268371f3d968affb5d5119eee5f8bcb9e6925eee212231ad26b92ddaa", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/810586e433b4ec623cd63ec6f5aab1665e4013e062b61dab34000668abaa3647cdadafb239131fda6c1211ebd3f3d421691f0d3457df86c8f2656d4c715d57c8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/7a4cce7428ebedb1298613d7bb4e237c047f8ba3bee997644dc1bbd45115b6bcd608b86f4767bc7045bdddd4a9c865c435f4a662b4e4040fc3681d6f68a29853"} 21:46:17 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 21:46:17 INFO - Writing to file /builds/slave/test/properties/blobber_files 21:46:17 INFO - Contents: 21:46:17 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/da97e5f25253d60ece7c656a67fc4cff2073daf91ee273a40d32e621cbffdb793f86c74268371f3d968affb5d5119eee5f8bcb9e6925eee212231ad26b92ddaa", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/810586e433b4ec623cd63ec6f5aab1665e4013e062b61dab34000668abaa3647cdadafb239131fda6c1211ebd3f3d421691f0d3457df86c8f2656d4c715d57c8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/7a4cce7428ebedb1298613d7bb4e237c047f8ba3bee997644dc1bbd45115b6bcd608b86f4767bc7045bdddd4a9c865c435f4a662b4e4040fc3681d6f68a29853"} 21:46:17 INFO - Running post-run listener: copy_logs_to_upload_dir 21:46:17 INFO - Copying logs to upload dir... 21:46:17 INFO - mkdir: /builds/slave/test/build/upload/logs 21:46:17 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.888844 ========= master_lag: 0.45 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-08-10 21:46:17.755839) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-10 21:46:17.759596) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1470889525.835985-2117767061 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/da97e5f25253d60ece7c656a67fc4cff2073daf91ee273a40d32e621cbffdb793f86c74268371f3d968affb5d5119eee5f8bcb9e6925eee212231ad26b92ddaa", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/810586e433b4ec623cd63ec6f5aab1665e4013e062b61dab34000668abaa3647cdadafb239131fda6c1211ebd3f3d421691f0d3457df86c8f2656d4c715d57c8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/7a4cce7428ebedb1298613d7bb4e237c047f8ba3bee997644dc1bbd45115b6bcd608b86f4767bc7045bdddd4a9c865c435f4a662b4e4040fc3681d6f68a29853"} build_url:https://queue.taskcluster.net/v1/task/JlDi14UURwKHO9sCZtxh2Q/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011364 build_url: 'https://queue.taskcluster.net/v1/task/JlDi14UURwKHO9sCZtxh2Q/artifacts/public/build/firefox-51.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/da97e5f25253d60ece7c656a67fc4cff2073daf91ee273a40d32e621cbffdb793f86c74268371f3d968affb5d5119eee5f8bcb9e6925eee212231ad26b92ddaa", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/810586e433b4ec623cd63ec6f5aab1665e4013e062b61dab34000668abaa3647cdadafb239131fda6c1211ebd3f3d421691f0d3457df86c8f2656d4c715d57c8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/7a4cce7428ebedb1298613d7bb4e237c047f8ba3bee997644dc1bbd45115b6bcd608b86f4767bc7045bdddd4a9c865c435f4a662b4e4040fc3681d6f68a29853"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-10 21:46:17.784927) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-10 21:46:17.785372) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1470889525.835985-2117767061 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004395 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-10 21:46:17.870101) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-10 21:46:17.870434) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-10 21:46:17.870740) ========= ========= Total master_lag: 0.61 =========