builder: autoland_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-017 starttime: 1467238815.19 results: success (0) buildid: 20160629140625 builduid: 12ed7521c92347c78eb529af87cfb8e3 revision: 8f6cca2a2cb491f0932aadeaf4c98c3e76eeb4c0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-29 15:20:15.187585) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-29 15:20:15.188019) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-29 15:20:15.188350) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-29 15:20:15.220141) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 15:20:15.220428) ========= 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=0333a256a5e4f052382dd180000001b1-1467238605.924074-374481223 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-29 15:20:15-- 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% 46.0M=0s 2016-06-29 15:20:15 (46.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.081971 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 15:20:15.317946) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 15:20:15.318329) ========= 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=0333a256a5e4f052382dd180000001b1-1467238605.924074-374481223 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019539 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 15:20:15.370924) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 15:20:15.371405) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 8f6cca2a2cb491f0932aadeaf4c98c3e76eeb4c0 --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 8f6cca2a2cb491f0932aadeaf4c98c3e76eeb4c0 --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=0333a256a5e4f052382dd180000001b1-1467238605.924074-374481223 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-29 15:20:15,704 truncating revision to first 12 chars 2016-06-29 15:20:15,704 Setting DEBUG logging. 2016-06-29 15:20:15,704 attempt 1/10 2016-06-29 15:20:15,704 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/8f6cca2a2cb4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-29 15:20:16,017 unpacking tar archive at: autoland-8f6cca2a2cb4/testing/mozharness/ program finished with exit code 0 elapsedTime=0.666535 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 15:20:16.052414) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-29 15:20:16.052771) ========= script_repo_revision: 8f6cca2a2cb491f0932aadeaf4c98c3e76eeb4c0 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-29 15:20:16.053176) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-29 15:20:16.053460) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-29 15:20:16.063870) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-06-29 15:20:16.064227) ========= /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=0333a256a5e4f052382dd180000001b1-1467238605.924074-374481223 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:20:16 INFO - MultiFileLogger online at 20160629 15:20:16 in /builds/slave/test 15:20:16 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 15:20:16 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:20:16 INFO - {'append_to_log': False, 15:20:16 INFO - 'base_work_dir': '/builds/slave/test', 15:20:16 INFO - 'blob_upload_branch': 'Autoland-Non-PGO', 15:20:16 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:20:16 INFO - 'branch': 'Autoland-Non-PGO', 15:20:16 INFO - 'buildbot_json_path': 'buildprops.json', 15:20:16 INFO - 'config_files': ('talos/linux_config.py',), 15:20:16 INFO - 'default_actions': ('clobber', 15:20:16 INFO - 'read-buildbot-config', 15:20:16 INFO - 'download-and-extract', 15:20:16 INFO - 'populate-webroot', 15:20:16 INFO - 'create-virtualenv', 15:20:16 INFO - 'install', 15:20:16 INFO - 'run-tests'), 15:20:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:20:16 INFO - 'download_minidump_stackwalk': True, 15:20:16 INFO - 'download_symbols': 'ondemand', 15:20:16 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:20:16 INFO - 'tooltool.py': '/tools/tooltool.py', 15:20:16 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:20:16 INFO - '/tools/misc-python/virtualenv.py')}, 15:20:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:20:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:20:16 INFO - 'installer_path': 'installer.exe', 15:20:16 INFO - 'log_level': 'info', 15:20:16 INFO - 'log_name': 'talos', 15:20:16 INFO - 'log_to_console': True, 15:20:16 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:20:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:20:16 INFO - 'opt_config_files': (), 15:20:16 INFO - 'pip_index': False, 15:20:16 INFO - 'sps_profile': False, 15:20:16 INFO - 'sps_profile_interval': 0, 15:20:16 INFO - 'suite': 'dromaeojs', 15:20:16 INFO - 'system_bits': '32', 15:20:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:20:16 INFO - 'title': 'talos-linux64-ix-017', 15:20:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:20:16 INFO - 'use_talos_json': True, 15:20:16 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:20:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:20:16 INFO - 'work_dir': 'build'} 15:20:16 INFO - ##### 15:20:16 INFO - ##### Running clobber step. 15:20:16 INFO - ##### 15:20:16 INFO - Running pre-action listener: _resource_record_pre_action 15:20:16 INFO - Running main action method: clobber 15:20:16 INFO - rmtree: /builds/slave/test/build 15:20:16 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:20:16 INFO - Running post-action listener: _resource_record_post_action 15:20:16 INFO - ##### 15:20:16 INFO - ##### Finished clobber step (success) 15:20:16 INFO - ##### 15:20:16 INFO - ##### 15:20:16 INFO - ##### Running read-buildbot-config step. 15:20:16 INFO - ##### 15:20:16 INFO - Running pre-action listener: _resource_record_pre_action 15:20:16 INFO - Running main action method: read_buildbot_config 15:20:16 INFO - Using buildbot properties: 15:20:16 INFO - { 15:20:16 INFO - "project": "", 15:20:16 INFO - "product": "firefox", 15:20:16 INFO - "script_repo_revision": "production", 15:20:16 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs", 15:20:16 INFO - "repository": "", 15:20:16 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland talos dromaeojs", 15:20:16 INFO - "buildid": "20160629140625", 15:20:16 INFO - "pgo_build": "False", 15:20:16 INFO - "basedir": "/builds/slave/test", 15:20:16 INFO - "buildnumber": 18, 15:20:16 INFO - "slavename": "talos-linux64-ix-017", 15:20:16 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 15:20:16 INFO - "platform": "ubuntu64_hw", 15:20:16 INFO - "scheduler": "tests-autoland-linux64-talos", 15:20:16 INFO - "branch": "autoland", 15:20:16 INFO - "repo_path": "integration/autoland", 15:20:16 INFO - "revision": "8f6cca2a2cb491f0932aadeaf4c98c3e76eeb4c0", 15:20:16 INFO - "stage_platform": "linux64", 15:20:16 INFO - "builduid": "12ed7521c92347c78eb529af87cfb8e3", 15:20:16 INFO - "slavebuilddir": "test" 15:20:16 INFO - } 15:20:16 INFO - Found installer url https://queue.taskcluster.net/v1/task/UE_RjZ7qQzuA0Sn8V77iHA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 15:20:16 INFO - Running post-action listener: _resource_record_post_action 15:20:16 INFO - ##### 15:20:16 INFO - ##### Finished read-buildbot-config step (success) 15:20:16 INFO - ##### 15:20:16 INFO - ##### 15:20:16 INFO - ##### Running download-and-extract step. 15:20:16 INFO - ##### 15:20:16 INFO - Running pre-action listener: _resource_record_pre_action 15:20:16 INFO - Running main action method: download_and_extract 15:20:16 INFO - mkdir: /builds/slave/test/build/tests 15:20:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:20:16 INFO - https://queue.taskcluster.net/v1/task/UE_RjZ7qQzuA0Sn8V77iHA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 15:20:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UE_RjZ7qQzuA0Sn8V77iHA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 15:20:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UE_RjZ7qQzuA0Sn8V77iHA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 15:20:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UE_RjZ7qQzuA0Sn8V77iHA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 15:20:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UE_RjZ7qQzuA0Sn8V77iHA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 15:20:23 INFO - Downloaded 1361 bytes. 15:20:23 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 15:20:23 INFO - Using the following test package requirements: 15:20:23 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 15:20:23 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:20:23 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 15:20:23 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:20:23 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 15:20:23 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:20:23 INFO - u'jsshell-linux-x86_64.zip'], 15:20:23 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:20:23 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 15:20:23 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 15:20:23 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:20:23 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 15:20:23 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:20:23 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 15:20:23 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:20:23 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 15:20:23 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:20:23 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 15:20:23 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:20:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:20:23 INFO - https://queue.taskcluster.net/v1/task/UE_RjZ7qQzuA0Sn8V77iHA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:20:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UE_RjZ7qQzuA0Sn8V77iHA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 15:20:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UE_RjZ7qQzuA0Sn8V77iHA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 15:20:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UE_RjZ7qQzuA0Sn8V77iHA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 15:20:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UE_RjZ7qQzuA0Sn8V77iHA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:20:26 INFO - Downloaded 22701709 bytes. 15:20:26 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:20:26 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 15:20:27 INFO - Return code: 0 15:20:27 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 15:20:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:20:27 INFO - https://queue.taskcluster.net/v1/task/UE_RjZ7qQzuA0Sn8V77iHA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:20:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UE_RjZ7qQzuA0Sn8V77iHA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 15:20:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UE_RjZ7qQzuA0Sn8V77iHA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 15:20:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UE_RjZ7qQzuA0Sn8V77iHA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 15:20:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UE_RjZ7qQzuA0Sn8V77iHA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:20:29 INFO - Downloaded 22701709 bytes. 15:20:29 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:20:29 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 15:20:31 INFO - Return code: 0 15:20:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:20:31 INFO - https://queue.taskcluster.net/v1/task/UE_RjZ7qQzuA0Sn8V77iHA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 15:20:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UE_RjZ7qQzuA0Sn8V77iHA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 15:20:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UE_RjZ7qQzuA0Sn8V77iHA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 15:20:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UE_RjZ7qQzuA0Sn8V77iHA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 15:20:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UE_RjZ7qQzuA0Sn8V77iHA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 15:20:35 INFO - Downloaded 14405245 bytes. 15:20:35 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:20:35 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 15:20:35 INFO - Return code: 0 15:20:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:20:35 INFO - https://queue.taskcluster.net/v1/task/UE_RjZ7qQzuA0Sn8V77iHA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 15:20:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UE_RjZ7qQzuA0Sn8V77iHA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 15:20:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UE_RjZ7qQzuA0Sn8V77iHA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 15:20:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UE_RjZ7qQzuA0Sn8V77iHA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 15:20:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UE_RjZ7qQzuA0Sn8V77iHA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 15:20:36 INFO - Downloaded 56476253 bytes. 15:20:36 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/UE_RjZ7qQzuA0Sn8V77iHA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 15:20:36 INFO - mkdir: /builds/slave/test/properties 15:20:36 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:20:36 INFO - Writing to file /builds/slave/test/properties/build_url 15:20:36 INFO - Contents: 15:20:36 INFO - build_url:https://queue.taskcluster.net/v1/task/UE_RjZ7qQzuA0Sn8V77iHA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 15:20:37 INFO - Running post-action listener: _resource_record_post_action 15:20:37 INFO - Running post-action listener: set_extra_try_arguments 15:20:37 INFO - ##### 15:20:37 INFO - ##### Finished download-and-extract step (success) 15:20:37 INFO - ##### 15:20:37 INFO - ##### 15:20:37 INFO - ##### Running populate-webroot step. 15:20:37 INFO - ##### 15:20:37 INFO - Running pre-action listener: _resource_record_pre_action 15:20:37 INFO - Running main action method: populate_webroot 15:20:37 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:20:37 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:20:37 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:20:37 INFO - '--tppagecycles', 15:20:37 INFO - '7'], 15:20:37 INFO - 'tests': ['tsvgm']}}, 15:20:37 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:20:37 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:20:37 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:20:37 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:20:37 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:20:37 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:20:37 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:20:37 INFO - 'talos_options': ['--disable-e10s'], 15:20:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:20:37 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:20:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:20:37 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:20:37 INFO - 'talos_options': ['--disable-e10s'], 15:20:37 INFO - 'tests': ['damp', 'tps']}, 15:20:37 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:20:37 INFO - 'tests': ['damp', 'tps']}, 15:20:37 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:20:37 INFO - 'tests': ['dromaeo_dom']}, 15:20:37 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:20:37 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:20:37 INFO - 'tests': ['basic_compositor_video']}, 15:20:37 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:20:37 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:20:37 INFO - 'tests': ['a11yr', 15:20:37 INFO - 'ts_paint', 15:20:37 INFO - 'tpaint', 15:20:37 INFO - 'sessionrestore', 15:20:37 INFO - 'sessionrestore_no_auto_restore', 15:20:37 INFO - 'tabpaint']}, 15:20:37 INFO - 'other-e10s': {'tests': ['a11yr', 15:20:37 INFO - 'ts_paint', 15:20:37 INFO - 'tpaint', 15:20:37 INFO - 'sessionrestore', 15:20:37 INFO - 'sessionrestore_no_auto_restore', 15:20:37 INFO - 'tabpaint']}, 15:20:37 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:20:37 INFO - 'ts_paint', 15:20:37 INFO - 'tpaint', 15:20:37 INFO - 'sessionrestore', 15:20:37 INFO - 'sessionrestore_no_auto_restore', 15:20:37 INFO - 'tabpaint']}, 15:20:37 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:20:37 INFO - 'ts_paint', 15:20:37 INFO - 'tpaint', 15:20:37 INFO - 'sessionrestore', 15:20:37 INFO - 'sessionrestore_no_auto_restore', 15:20:37 INFO - 'tabpaint']}, 15:20:37 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:20:37 INFO - 'tests': ['a11yr', 15:20:37 INFO - 'ts_paint', 15:20:37 INFO - 'tpaint', 15:20:37 INFO - 'sessionrestore', 15:20:37 INFO - 'sessionrestore_no_auto_restore', 15:20:37 INFO - 'tabpaint']}, 15:20:37 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:20:37 INFO - 'tests': ['a11yr', 15:20:37 INFO - 'ts_paint', 15:20:37 INFO - 'tpaint', 15:20:37 INFO - 'sessionrestore', 15:20:37 INFO - 'sessionrestore_no_auto_restore', 15:20:37 INFO - 'tabpaint']}, 15:20:37 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:20:37 INFO - 'tests': ['tsvgx', 15:20:37 INFO - 'tsvgr_opacity', 15:20:37 INFO - 'tart', 15:20:37 INFO - 'tscrollx', 15:20:37 INFO - 'cart']}, 15:20:37 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:20:37 INFO - 'tsvgr_opacity', 15:20:37 INFO - 'tart', 15:20:37 INFO - 'tscrollx', 15:20:37 INFO - 'cart']}, 15:20:37 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:20:37 INFO - 'talos_options': ['--disable-e10s'], 15:20:37 INFO - 'tests': ['tp5o']}, 15:20:37 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:20:37 INFO - 'tests': ['tp5o']}, 15:20:37 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:20:37 INFO - 'talos_options': ['--disable-e10s', 15:20:37 INFO - '--xperf_path', 15:20:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:20:37 INFO - 'tests': ['tp5n']}, 15:20:37 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:20:37 INFO - 'talos_options': ['--xperf_path', 15:20:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:20:37 INFO - 'tests': ['tp5n']}}, 15:20:37 INFO - 'talos.zip': {'path': '', 15:20:37 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:20:37 INFO - Running post-action listener: _resource_record_post_action 15:20:37 INFO - ##### 15:20:37 INFO - ##### Finished populate-webroot step (success) 15:20:37 INFO - ##### 15:20:37 INFO - ##### 15:20:37 INFO - ##### Running create-virtualenv step. 15:20:37 INFO - ##### 15:20:37 INFO - Running pre-action listener: _resource_record_pre_action 15:20:37 INFO - Running main action method: create_virtualenv 15:20:37 INFO - Creating virtualenv /builds/slave/test/build/venv 15:20:37 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 15:20:37 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:20:37 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:20:37 INFO - Using real prefix '/usr' 15:20:37 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:20:38 INFO - Installing distribute.............................................................................................................................................................................................done. 15:20:40 INFO - Installing pip.................done. 15:20:40 INFO - Return code: 0 15:20:40 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:20:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:20:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:20:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:20:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:20:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:20:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:20:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x221e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23818a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24df180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24dd3b0>, '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 0x24de2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24de740>, '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': '0333a256a5e4f052382dd180000001b1-1467238605.924074-374481223', '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 15:20:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 15:20:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 15:20:40 INFO - Using env: {'DISPLAY': ':0', 15:20:40 INFO - 'HOME': '/home/cltbld', 15:20:40 INFO - 'LANG': 'en_US.UTF-8', 15:20:40 INFO - 'LANGUAGE': 'en_US:en', 15:20:40 INFO - 'LOGNAME': 'cltbld', 15:20:40 INFO - 'MAIL': '/var/mail/cltbld', 15:20:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:20:40 INFO - 'MOZ_NO_REMOTE': '1', 15:20:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:20:40 INFO - 'NO_EM_RESTART': '1', 15:20:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:20:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:20:40 INFO - 'PWD': '/builds/slave/test', 15:20:40 INFO - 'SHELL': '/bin/bash', 15:20:40 INFO - 'SHLVL': '1', 15:20:40 INFO - 'TERM': 'linux', 15:20:40 INFO - 'TMOUT': '86400', 15:20:40 INFO - 'USER': 'cltbld', 15:20:40 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1467238605.924074-374481223', 15:20:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:20:40 INFO - '_': '/tools/buildbot/bin/python'} 15:20:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:20:40 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 15:20:40 INFO - Cleaning up... 15:20:40 INFO - Return code: 0 15:20:40 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:20:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:20:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:20:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:20:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:20:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:20:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:20:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x221e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23818a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24df180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24dd3b0>, '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 0x24de2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24de740>, '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': '0333a256a5e4f052382dd180000001b1-1467238605.924074-374481223', '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 15:20:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 15:20:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 15:20:40 INFO - Using env: {'DISPLAY': ':0', 15:20:40 INFO - 'HOME': '/home/cltbld', 15:20:40 INFO - 'LANG': 'en_US.UTF-8', 15:20:40 INFO - 'LANGUAGE': 'en_US:en', 15:20:40 INFO - 'LOGNAME': 'cltbld', 15:20:40 INFO - 'MAIL': '/var/mail/cltbld', 15:20:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:20:40 INFO - 'MOZ_NO_REMOTE': '1', 15:20:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:20:40 INFO - 'NO_EM_RESTART': '1', 15:20:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:20:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:20:40 INFO - 'PWD': '/builds/slave/test', 15:20:40 INFO - 'SHELL': '/bin/bash', 15:20:40 INFO - 'SHLVL': '1', 15:20:40 INFO - 'TERM': 'linux', 15:20:40 INFO - 'TMOUT': '86400', 15:20:40 INFO - 'USER': 'cltbld', 15:20:40 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1467238605.924074-374481223', 15:20:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:20:40 INFO - '_': '/tools/buildbot/bin/python'} 15:20:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:20:40 INFO - Downloading/unpacking psutil>=3.1.1 15:20:40 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 15:20:40 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 15:20:40 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 15:20:40 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 15:20:40 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 15:20:40 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 15:20:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:20:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:20:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:20:42 INFO - Installing collected packages: psutil 15:20:42 INFO - Running setup.py install for psutil 15:20:42 INFO - building 'psutil._psutil_linux' extension 15:20:42 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 15:20:43 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 15:20:43 INFO - building 'psutil._psutil_posix' extension 15:20:43 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 15:20:43 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 15:20:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:20:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:20:43 INFO - Successfully installed psutil 15:20:43 INFO - Cleaning up... 15:20:43 INFO - Return code: 0 15:20:43 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:20:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:20:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:20:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:20:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:20:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:20:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:20:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x221e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23818a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24df180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24dd3b0>, '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 0x24de2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24de740>, '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': '0333a256a5e4f052382dd180000001b1-1467238605.924074-374481223', '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 15:20:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 15:20:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 15:20:43 INFO - Using env: {'DISPLAY': ':0', 15:20:43 INFO - 'HOME': '/home/cltbld', 15:20:43 INFO - 'LANG': 'en_US.UTF-8', 15:20:43 INFO - 'LANGUAGE': 'en_US:en', 15:20:43 INFO - 'LOGNAME': 'cltbld', 15:20:43 INFO - 'MAIL': '/var/mail/cltbld', 15:20:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:20:43 INFO - 'MOZ_NO_REMOTE': '1', 15:20:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:20:43 INFO - 'NO_EM_RESTART': '1', 15:20:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:20:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:20:43 INFO - 'PWD': '/builds/slave/test', 15:20:43 INFO - 'SHELL': '/bin/bash', 15:20:43 INFO - 'SHLVL': '1', 15:20:43 INFO - 'TERM': 'linux', 15:20:43 INFO - 'TMOUT': '86400', 15:20:43 INFO - 'USER': 'cltbld', 15:20:43 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1467238605.924074-374481223', 15:20:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:20:43 INFO - '_': '/tools/buildbot/bin/python'} 15:20:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:20:43 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:20:43 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 15:20:43 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 15:20:43 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 15:20:43 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 15:20:43 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 15:20:43 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 15:20:45 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:20:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:20:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:20:45 INFO - Installing collected packages: mozsystemmonitor 15:20:45 INFO - Running setup.py install for mozsystemmonitor 15:20:45 INFO - Successfully installed mozsystemmonitor 15:20:45 INFO - Cleaning up... 15:20:45 INFO - Return code: 0 15:20:45 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:20:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:20:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:20:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:20:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:20:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:20:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:20:45 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 0x221e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23818a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24df180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24dd3b0>, '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 0x24de2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24de740>, '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': '0333a256a5e4f052382dd180000001b1-1467238605.924074-374481223', '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 15:20:45 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 15:20:45 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 15:20:45 INFO - Using env: {'DISPLAY': ':0', 15:20:45 INFO - 'HOME': '/home/cltbld', 15:20:45 INFO - 'LANG': 'en_US.UTF-8', 15:20:45 INFO - 'LANGUAGE': 'en_US:en', 15:20:45 INFO - 'LOGNAME': 'cltbld', 15:20:45 INFO - 'MAIL': '/var/mail/cltbld', 15:20:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:20:45 INFO - 'MOZ_NO_REMOTE': '1', 15:20:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:20:45 INFO - 'NO_EM_RESTART': '1', 15:20:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:20:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:20:45 INFO - 'PWD': '/builds/slave/test', 15:20:45 INFO - 'SHELL': '/bin/bash', 15:20:45 INFO - 'SHLVL': '1', 15:20:45 INFO - 'TERM': 'linux', 15:20:45 INFO - 'TMOUT': '86400', 15:20:45 INFO - 'USER': 'cltbld', 15:20:45 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1467238605.924074-374481223', 15:20:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:20:45 INFO - '_': '/tools/buildbot/bin/python'} 15:20:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:20:45 INFO - Downloading/unpacking jsonschema==2.5.1 15:20:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:20:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:20:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:20:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:20:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:20:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:20:47 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:20:47 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:20:47 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 15:20:47 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 15:20:47 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 15:20:47 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 15:20:47 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 15:20:47 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 15:20:48 INFO - Downloading functools32-3.2.3-2.tar.gz 15:20:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:20:48 INFO - warning: no files found matching '*.txt' 15:20:48 INFO - no previously-included directories found matching 'build' 15:20:48 INFO - no previously-included directories found matching 'dist' 15:20:48 INFO - no previously-included directories found matching '.git*' 15:20:48 INFO - Installing collected packages: jsonschema, functools32 15:20:48 INFO - Running setup.py install for functools32 15:20:48 INFO - warning: no files found matching '*.txt' 15:20:48 INFO - no previously-included directories found matching 'build' 15:20:48 INFO - no previously-included directories found matching 'dist' 15:20:48 INFO - no previously-included directories found matching '.git*' 15:20:48 INFO - Successfully installed jsonschema functools32 15:20:48 INFO - Cleaning up... 15:20:48 INFO - Return code: 0 15:20:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:20:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:20:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:20:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:20:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:20:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:20:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:20:48 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 0x221e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23818a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24df180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24dd3b0>, '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 0x24de2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24de740>, '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': '0333a256a5e4f052382dd180000001b1-1467238605.924074-374481223', '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 15:20:48 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 15:20:48 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 15:20:48 INFO - Using env: {'DISPLAY': ':0', 15:20:48 INFO - 'HOME': '/home/cltbld', 15:20:48 INFO - 'LANG': 'en_US.UTF-8', 15:20:48 INFO - 'LANGUAGE': 'en_US:en', 15:20:48 INFO - 'LOGNAME': 'cltbld', 15:20:48 INFO - 'MAIL': '/var/mail/cltbld', 15:20:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:20:48 INFO - 'MOZ_NO_REMOTE': '1', 15:20:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:20:48 INFO - 'NO_EM_RESTART': '1', 15:20:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:20:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:20:48 INFO - 'PWD': '/builds/slave/test', 15:20:48 INFO - 'SHELL': '/bin/bash', 15:20:48 INFO - 'SHLVL': '1', 15:20:48 INFO - 'TERM': 'linux', 15:20:48 INFO - 'TMOUT': '86400', 15:20:48 INFO - 'USER': 'cltbld', 15:20:48 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1467238605.924074-374481223', 15:20:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:20:48 INFO - '_': '/tools/buildbot/bin/python'} 15:20:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:20:48 INFO - Downloading/unpacking blobuploader==1.2.4 15:20:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:20:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:20:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:20:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:20:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:20:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:20:50 INFO - Downloading blobuploader-1.2.4.tar.gz 15:20:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:20:50 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:20:50 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 15:20:50 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 15:20:50 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 15:20:50 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 15:20:50 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 15:20:50 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 15:20:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:20:50 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:20:50 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 15:20:50 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 15:20:50 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 15:20:50 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 15:20:50 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 15:20:50 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 15:20:51 INFO - Downloading docopt-0.6.1.tar.gz 15:20:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:20:51 INFO - Installing collected packages: blobuploader, requests, docopt 15:20:51 INFO - Running setup.py install for blobuploader 15:20:51 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:20:51 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:20:51 INFO - Running setup.py install for requests 15:20:51 INFO - Running setup.py install for docopt 15:20:51 INFO - Successfully installed blobuploader requests docopt 15:20:51 INFO - Cleaning up... 15:20:51 INFO - Return code: 0 15:20:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:20:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:20:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:20:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:20:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:20:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:20:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:20:51 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 0x221e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23818a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24df180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24dd3b0>, '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 0x24de2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24de740>, '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': '0333a256a5e4f052382dd180000001b1-1467238605.924074-374481223', '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 15:20:51 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 15:20:51 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 15:20:51 INFO - Using env: {'DISPLAY': ':0', 15:20:51 INFO - 'HOME': '/home/cltbld', 15:20:51 INFO - 'LANG': 'en_US.UTF-8', 15:20:51 INFO - 'LANGUAGE': 'en_US:en', 15:20:51 INFO - 'LOGNAME': 'cltbld', 15:20:51 INFO - 'MAIL': '/var/mail/cltbld', 15:20:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:20:51 INFO - 'MOZ_NO_REMOTE': '1', 15:20:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:20:51 INFO - 'NO_EM_RESTART': '1', 15:20:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:20:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:20:51 INFO - 'PWD': '/builds/slave/test', 15:20:51 INFO - 'SHELL': '/bin/bash', 15:20:51 INFO - 'SHLVL': '1', 15:20:51 INFO - 'TERM': 'linux', 15:20:51 INFO - 'TMOUT': '86400', 15:20:51 INFO - 'USER': 'cltbld', 15:20:51 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1467238605.924074-374481223', 15:20:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:20:51 INFO - '_': '/tools/buildbot/bin/python'} 15:20:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:20:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:20:51 INFO - Running setup.py (path:/tmp/pip-33HoRR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:20:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:20:52 INFO - Running setup.py (path:/tmp/pip-R1T936-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:20:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:20:52 INFO - Running setup.py (path:/tmp/pip-wNeFED-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:20:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:20:52 INFO - Running setup.py (path:/tmp/pip-9QObID-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:20:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:20:52 INFO - Running setup.py (path:/tmp/pip-7Y2Kb9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:20:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:20:52 INFO - Running setup.py (path:/tmp/pip-QRXPj_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:20:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:20:52 INFO - Running setup.py (path:/tmp/pip-85g1iw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:20:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:20:52 INFO - Running setup.py (path:/tmp/pip-fpF2c9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:20:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:20:52 INFO - Running setup.py (path:/tmp/pip-gkMtM7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:20:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:20:52 INFO - Running setup.py (path:/tmp/pip-zMuklS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:20:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:20:52 INFO - Running setup.py (path:/tmp/pip-D2BYkk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:20:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:20:52 INFO - Running setup.py (path:/tmp/pip-7o6pfC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:20:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:20:52 INFO - Running setup.py (path:/tmp/pip-ATcdTa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:20:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:20:52 INFO - Running setup.py (path:/tmp/pip-JZkVXh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:20:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:20:52 INFO - Running setup.py (path:/tmp/pip-Uuf7_I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:20:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:20:53 INFO - Running setup.py (path:/tmp/pip-ZpFijv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:20:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:20:53 INFO - Running setup.py (path:/tmp/pip-1CikBd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:20:53 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:20:53 INFO - Running setup.py install for manifestparser 15:20:53 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:20:53 INFO - Running setup.py install for mozcrash 15:20:53 INFO - Running setup.py install for mozdebug 15:20:53 INFO - Running setup.py install for mozdevice 15:20:53 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:20:53 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:20:53 INFO - Running setup.py install for mozfile 15:20:53 INFO - Running setup.py install for mozhttpd 15:20:53 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:20:53 INFO - Running setup.py install for mozinfo 15:20:53 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:20:53 INFO - Running setup.py install for mozInstall 15:20:53 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:20:53 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:20:53 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:20:53 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:20:53 INFO - Running setup.py install for mozleak 15:20:54 INFO - Running setup.py install for mozlog 15:20:54 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:20:54 INFO - Running setup.py install for moznetwork 15:20:54 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:20:54 INFO - Running setup.py install for mozprocess 15:20:54 INFO - Running setup.py install for mozprofile 15:20:54 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:20:54 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:20:54 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:20:54 INFO - Running setup.py install for mozrunner 15:20:54 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:20:54 INFO - Running setup.py install for mozscreenshot 15:20:54 INFO - Running setup.py install for moztest 15:20:54 INFO - Running setup.py install for mozversion 15:20:54 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:20:54 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:20:54 INFO - Cleaning up... 15:20:54 INFO - Return code: 0 15:20:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:20: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:20:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:20:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:20: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:20:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:20:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:20:54 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 0x221e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23818a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24df180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24dd3b0>, '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 0x24de2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24de740>, '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': '0333a256a5e4f052382dd180000001b1-1467238605.924074-374481223', '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 15:20:54 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 15:20:54 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 15:20:54 INFO - Using env: {'DISPLAY': ':0', 15:20:54 INFO - 'HOME': '/home/cltbld', 15:20:54 INFO - 'LANG': 'en_US.UTF-8', 15:20:54 INFO - 'LANGUAGE': 'en_US:en', 15:20:54 INFO - 'LOGNAME': 'cltbld', 15:20:54 INFO - 'MAIL': '/var/mail/cltbld', 15:20:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:20:54 INFO - 'MOZ_NO_REMOTE': '1', 15:20:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:20:54 INFO - 'NO_EM_RESTART': '1', 15:20:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:20:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:20:54 INFO - 'PWD': '/builds/slave/test', 15:20:54 INFO - 'SHELL': '/bin/bash', 15:20:54 INFO - 'SHLVL': '1', 15:20:54 INFO - 'TERM': 'linux', 15:20:54 INFO - 'TMOUT': '86400', 15:20:54 INFO - 'USER': 'cltbld', 15:20:54 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1467238605.924074-374481223', 15:20:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:20:54 INFO - '_': '/tools/buildbot/bin/python'} 15:20:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:20:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:20:55 INFO - Running setup.py (path:/tmp/pip-NOCu6B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:20:55 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)) 15:20:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:20:55 INFO - Running setup.py (path:/tmp/pip-SeX6qG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:20:55 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)) 15:20:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:20:55 INFO - Running setup.py (path:/tmp/pip-vUprcF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:20:55 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)) 15:20:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:20:55 INFO - Running setup.py (path:/tmp/pip-Cts9vS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:20:55 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)) 15:20:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:20:55 INFO - Running setup.py (path:/tmp/pip-q0TChL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:20:55 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)) 15:20:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:20:55 INFO - Running setup.py (path:/tmp/pip-Ctazxm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:20:55 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)) 15:20:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:20:55 INFO - Running setup.py (path:/tmp/pip-cNe_DZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:20:55 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)) 15:20:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:20:55 INFO - Running setup.py (path:/tmp/pip-GJUjNp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:20:55 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)) 15:20:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:20:55 INFO - Running setup.py (path:/tmp/pip-s_G8dz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:20:55 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)) 15:20:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:20:55 INFO - Running setup.py (path:/tmp/pip-yt9RJT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:20:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:20:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:20:55 INFO - Running setup.py (path:/tmp/pip-CjS514-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:20:55 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)) 15:20:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:20:55 INFO - Running setup.py (path:/tmp/pip-e2_7kc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:20:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 15:20:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:20:56 INFO - Running setup.py (path:/tmp/pip-rE8fvg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:20:56 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)) 15:20:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:20:56 INFO - Running setup.py (path:/tmp/pip-UlaohP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:20:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 15:20:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:20:56 INFO - Running setup.py (path:/tmp/pip-JzuU6d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:20:56 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)) 15:20:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:20:56 INFO - Running setup.py (path:/tmp/pip-1XPP69-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:20:56 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)) 15:20:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:20:56 INFO - Running setup.py (path:/tmp/pip-Bh2AsV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:20:56 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)) 15:20:56 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)) 15:20:56 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)) 15:20:56 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)) 15:20:56 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)) 15:20:56 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)) 15:20:56 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:20: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 15:20: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 15:20: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 15:20: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 15:20: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 15:20: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 15:20:58 INFO - Downloading blessings-1.6.tar.gz 15:20:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:20:58 INFO - Installing collected packages: blessings 15:20:58 INFO - Running setup.py install for blessings 15:20:58 INFO - Successfully installed blessings 15:20:58 INFO - Cleaning up... 15:20:58 INFO - Return code: 0 15:20:58 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:20:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:20:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:20:58 INFO - Reading from file tmpfile_stdout 15:20:58 INFO - Current package versions: 15:20:58 INFO - argparse == 1.2.1 15:20:58 INFO - blessings == 1.6 15:20:58 INFO - blobuploader == 1.2.4 15:20:58 INFO - docopt == 0.6.1 15:20:58 INFO - functools32 == 3.2.3-2 15:20:58 INFO - jsonschema == 2.5.1 15:20:58 INFO - manifestparser == 1.1 15:20:58 INFO - mozInstall == 1.12 15:20:58 INFO - mozcrash == 0.17 15:20:58 INFO - mozdebug == 0.1 15:20:58 INFO - mozdevice == 0.48 15:20:58 INFO - mozfile == 1.2 15:20:58 INFO - mozhttpd == 0.7 15:20:58 INFO - mozinfo == 0.9 15:20:58 INFO - mozleak == 0.1 15:20:58 INFO - mozlog == 3.2 15:20:58 INFO - moznetwork == 0.27 15:20:58 INFO - mozprocess == 0.22 15:20:58 INFO - mozprofile == 0.28 15:20:58 INFO - mozrunner == 6.11 15:20:58 INFO - mozscreenshot == 0.1 15:20:58 INFO - mozsystemmonitor == 0.3 15:20:58 INFO - moztest == 0.7 15:20:58 INFO - mozversion == 1.4 15:20:58 INFO - psutil == 3.1.1 15:20:58 INFO - requests == 1.2.3 15:20:58 INFO - wsgiref == 0.1.2 15:20:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:20:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:20:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:20:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:20:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:20:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:20:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:20:58 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 0x221e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23818a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24df180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24dd3b0>, '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 0x24de2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24de740>, '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': '0333a256a5e4f052382dd180000001b1-1467238605.924074-374481223', '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 15:20:58 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 15:20:58 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 15:20:58 INFO - Using env: {'DISPLAY': ':0', 15:20:58 INFO - 'HOME': '/home/cltbld', 15:20:58 INFO - 'LANG': 'en_US.UTF-8', 15:20:58 INFO - 'LANGUAGE': 'en_US:en', 15:20:58 INFO - 'LOGNAME': 'cltbld', 15:20:58 INFO - 'MAIL': '/var/mail/cltbld', 15:20:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:20:58 INFO - 'MOZ_NO_REMOTE': '1', 15:20:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:20:58 INFO - 'NO_EM_RESTART': '1', 15:20:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:20:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:20:58 INFO - 'PWD': '/builds/slave/test', 15:20:58 INFO - 'SHELL': '/bin/bash', 15:20:58 INFO - 'SHLVL': '1', 15:20:58 INFO - 'TERM': 'linux', 15:20:58 INFO - 'TMOUT': '86400', 15:20:58 INFO - 'USER': 'cltbld', 15:20:58 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1467238605.924074-374481223', 15:20:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:20:58 INFO - '_': '/tools/buildbot/bin/python'} 15:20:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:20:58 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)) 15:20:58 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)) 15:20:58 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)) 15:20:58 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)) 15:20:58 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)) 15:20:58 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)) 15:20:58 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)) 15:20:58 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)) 15:20:58 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)) 15:20:58 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)) 15:20:58 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)) 15:20:58 INFO - Cleaning up... 15:20:58 INFO - Return code: 0 15:20:58 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:20:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:20:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:20:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:20:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:20:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:20:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:20:58 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 0x221e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23818a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24df180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24dd3b0>, '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 0x24de2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24de740>, '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': '0333a256a5e4f052382dd180000001b1-1467238605.924074-374481223', '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 15:20:58 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 15:20:58 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 15:20:58 INFO - Using env: {'DISPLAY': ':0', 15:20:58 INFO - 'HOME': '/home/cltbld', 15:20:58 INFO - 'LANG': 'en_US.UTF-8', 15:20:58 INFO - 'LANGUAGE': 'en_US:en', 15:20:58 INFO - 'LOGNAME': 'cltbld', 15:20:58 INFO - 'MAIL': '/var/mail/cltbld', 15:20:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:20:58 INFO - 'MOZ_NO_REMOTE': '1', 15:20:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:20:58 INFO - 'NO_EM_RESTART': '1', 15:20:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:20:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:20:58 INFO - 'PWD': '/builds/slave/test', 15:20:58 INFO - 'SHELL': '/bin/bash', 15:20:58 INFO - 'SHLVL': '1', 15:20:58 INFO - 'TERM': 'linux', 15:20:58 INFO - 'TMOUT': '86400', 15:20:58 INFO - 'USER': 'cltbld', 15:20:58 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1467238605.924074-374481223', 15:20:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:20:58 INFO - '_': '/tools/buildbot/bin/python'} 15:20:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:20:59 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:20:59 INFO - Cleaning up... 15:20:59 INFO - Return code: 0 15:20:59 INFO - Running post-action listener: _resource_record_post_action 15:20:59 INFO - Running post-action listener: _start_resource_monitoring 15:20:59 INFO - Starting resource monitoring. 15:20:59 INFO - ##### 15:20:59 INFO - ##### Finished create-virtualenv step (success) 15:20:59 INFO - ##### 15:20:59 INFO - ##### 15:20:59 INFO - ##### Running install step. 15:20:59 INFO - ##### 15:20:59 INFO - Running pre-action listener: _resource_record_pre_action 15:20:59 INFO - Running main action method: install 15:20:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:20:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:20:59 INFO - Reading from file tmpfile_stdout 15:20:59 INFO - Detecting whether we're running mozinstall >=1.0... 15:20:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:20:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:20:59 INFO - Reading from file tmpfile_stdout 15:20:59 INFO - Output received: 15:20:59 INFO - Usage: mozinstall [options] installer 15:20:59 INFO - Options: 15:20:59 INFO - -h, --help show this help message and exit 15:20:59 INFO - -d DEST, --destination=DEST 15:20:59 INFO - Directory to install application into. [default: 15:20:59 INFO - "/builds/slave/test"] 15:20:59 INFO - --app=APP Application being installed. [default: firefox] 15:20:59 INFO - mkdir: /builds/slave/test/build/application 15:20:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 15:20:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 15:21:15 INFO - Reading from file tmpfile_stdout 15:21:15 INFO - Output received: 15:21:15 INFO - /builds/slave/test/build/application/firefox/firefox 15:21:15 INFO - Running post-action listener: _resource_record_post_action 15:21:15 INFO - ##### 15:21:15 INFO - ##### Finished install step (success) 15:21:15 INFO - ##### 15:21:15 INFO - ##### 15:21:15 INFO - ##### Running run-tests step. 15:21:15 INFO - ##### 15:21:15 INFO - Running pre-action listener: _resource_record_pre_action 15:21:15 INFO - Running main action method: run_tests 15:21:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:21:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:21:15 INFO - Python 2.7.3 15:21:15 INFO - Return code: 0 15:21:15 INFO - grabbing minidump binary from tooltool 15:21:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:21:15 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 0x24dd3b0>, '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 0x24de2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24de740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:21:15 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 15:21:15 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 15:21:15 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 15:21:15 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:21:15 INFO - Return code: 0 15:21:15 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:21:15 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:21:15 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:21:15 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:21:15 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:21:15 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/UE_RjZ7qQzuA0Sn8V77iHA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--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 15:21:15 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/UE_RjZ7qQzuA0Sn8V77iHA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-017 --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 15:21:15 INFO - Using env: {'DISPLAY': ':0', 15:21:15 INFO - 'HOME': '/home/cltbld', 15:21:15 INFO - 'LANG': 'en_US.UTF-8', 15:21:15 INFO - 'LANGUAGE': 'en_US:en', 15:21:15 INFO - 'LOGNAME': 'cltbld', 15:21:15 INFO - 'MAIL': '/var/mail/cltbld', 15:21:15 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:21:15 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:21:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:21:15 INFO - 'MOZ_NO_REMOTE': '1', 15:21:15 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:21:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:21:15 INFO - 'NO_EM_RESTART': '1', 15:21:15 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:21:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:21:15 INFO - 'PWD': '/builds/slave/test', 15:21:15 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:21:15 INFO - 'SHELL': '/bin/bash', 15:21:15 INFO - 'SHLVL': '1', 15:21:15 INFO - 'TERM': 'linux', 15:21:15 INFO - 'TMOUT': '86400', 15:21:15 INFO - 'USER': 'cltbld', 15:21:15 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1467238605.924074-374481223', 15:21:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:21:15 INFO - '_': '/tools/buildbot/bin/python'} 15:21:15 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/UE_RjZ7qQzuA0Sn8V77iHA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--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 15:21:15 INFO - mozversion application_buildid: 20160629140625 15:21:15 INFO - mozversion application_changeset: 8f6cca2a2cb491f0932aadeaf4c98c3e76eeb4c0 15:21:15 INFO - mozversion application_display_name: Nightly 15:21:15 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:21:15 INFO - mozversion application_name: Firefox 15:21:15 INFO - mozversion application_remotingname: firefox 15:21:15 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 15:21:15 INFO - mozversion application_vendor: Mozilla 15:21:15 INFO - mozversion application_version: 50.0a1 15:21:15 INFO - mozversion platform_buildid: 20160629140625 15:21:15 INFO - mozversion platform_changeset: 8f6cca2a2cb491f0932aadeaf4c98c3e76eeb4c0 15:21:15 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 15:21:15 INFO - mozversion platform_version: 50.0a1 15:21:15 INFO - using testdate: 1467238875 15:21:15 INFO - actual date: 1467238875 15:21:15 INFO - starting webserver on 'localhost:53859' 15:21:15 INFO - SUITE-START | Running 2 tests 15:21:15 INFO - TEST-START | dromaeo_css 15:21:15 INFO - operating with platform_type : linux_ 15:21:15 INFO - Initialising browser for dromaeo_css test... 15:21:16 INFO - TEST-INFO | started process 32363 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6BisuD/profile http://localhost:53859/getInfo.html) 15:21:19 INFO - PROCESS | 32363 | __metrics Screen width/height:1600/1200 15:21:19 INFO - PROCESS | 32363 | colorDepth:24 15:21:19 INFO - PROCESS | 32363 | Browser inner width/height: 1024/697 15:21:19 INFO - PROCESS | 32363 | __metrics 15:21:20 INFO - PROCESS | 32363 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:21:21 INFO - TEST-INFO | 32363: exit 0 15:21:21 INFO - Browser initialized. 15:21:21 INFO - Running cycle 1/1 for dromaeo_css test... 15:21:21 INFO - TEST-INFO | started process 32447 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6BisuD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:21:33 INFO - PROCESS | 32447 | RSS: Main: 159019008 15:21:33 INFO - PROCESS | 32447 | 15:22:25 INFO - PROCESS | 32447 | 1467238945394 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] 15:24:37 INFO - PROCESS | 32447 | Cycle 1(1): loaded http://localhost:53859/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53859/tests/dromaeo/cssquery-ext.html) 15:24:38 INFO - PROCESS | 32447 | RSS: Main: 263368704 15:24:38 INFO - PROCESS | 32447 | 15:27:40 INFO - PROCESS | 32447 | Cycle 1(1): loaded http://localhost:53859/tests/dromaeo/cssquery-ext.html (next: http://localhost:53859/tests/dromaeo/cssquery-jquery.html) 15:27:41 INFO - PROCESS | 32447 | RSS: Main: 243625984 15:27:41 INFO - PROCESS | 32447 | 15:30:43 INFO - PROCESS | 32447 | Cycle 1(1): loaded http://localhost:53859/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53859/tests/dromaeo/cssquery-mootools.html) 15:30:44 INFO - PROCESS | 32447 | RSS: Main: 241836032 15:30:44 INFO - PROCESS | 32447 | 15:33:46 INFO - PROCESS | 32447 | Cycle 1(1): loaded http://localhost:53859/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53859/tests/dromaeo/cssquery-prototype.html) 15:33:47 INFO - PROCESS | 32447 | RSS: Main: 238080000 15:33:47 INFO - PROCESS | 32447 | 15:36:50 INFO - PROCESS | 32447 | Cycle 1(1): loaded http://localhost:53859/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53859/tests/dromaeo/cssquery-yui.html) 15:36:50 INFO - PROCESS | 32447 | RSS: Main: 215207936 15:36:50 INFO - PROCESS | 32447 | 15:39:53 INFO - PROCESS | 32447 | Cycle 1(1): loaded http://localhost:53859/tests/dromaeo/cssquery-yui.html (next: http://localhost:53859/tests/dromaeo/cssquery-dojo.html) 15:39:54 INFO - PROCESS | 32447 | RSS: Main: 275546112 15:39:54 INFO - PROCESS | 32447 | 15:39:54 INFO - PROCESS | 32447 | __start_tp_report 15:39:54 INFO - PROCESS | 32447 | _x_x_mozilla_page_load 15:39:54 INFO - PROCESS | 32447 | _x_x_mozilla_page_load_details 15:39:54 INFO - PROCESS | 32447 | |i|pagename|runs| 15:39:54 INFO - PROCESS | 32447 | |0;dojo.html;2646.31195889069;2659.0959073914864;2692.0577797770784;2692.5288074586956;2707.8239914405563;4677.929831052528;4721.763911804404;4740.241561350184;4829.372181616385;4871.634627402941;4760.2383618621025;4768.403949506312;4792.257200133985;4818.108649899771;4824.228123500241;4409.559044095581;4433.312836510346;4455.73265604064;4473.507914129443;4489.551044895517;4428.689991700582;4464.352668863013;4496.887577810565;4499.48255950565;4531.4109165808395;4495.707778994355;4542.8864278392975;4555.612772914306;4562.247229207177;4577.130345234395;4256.4679415073115;4320.4599425071865;4334.674899382559;4349.934750978738;4478.0596074824325;4359.084592235635;4364.061726728737;4371.846985355497;4403.119376124756;4405.845795397177;4825.638077144228;4825.662203645747;4833.492483289274;4844.709317440929;4844.951550484485;4966.950330496685;5035.571976382012;5104.259882317043;5106.846794596168;5150.175971844487;5184.455632158607;5201.635885488017;5203.375594928595;5209.140491818884;5220.399654039796;4784.043191361741;4791.257355109963;4825.986542825975;4832.275158726219;4835.274708793639;5114.923276150861;5228.111221092423;5281.207818827206;5283.6037297202865;5361.410244873061;5099.821506247264;5128;5150.0472412603785;5150.253213284052;5152.5877929766275;4966.826161084345;5168.715720635401;5179.2749015137915;5232.2674825524455;5241.711705856138;4938.43208031081;4976.129177393942;4988.575971042502;4991.4758950310425;5012.624053196025;4973.950260497349;4979.45226025137;4983.401991761012;4986.426560945465;5031.572316353077;4287.97856010718;4319.373690814814;4327.65378769704;4338.696291259582;4390.692651514363;3818.2745278397015;3847.788371639531;3856.9228615428096;3878.0886491674432;3885.2423777363706;4390.780460976938;4402.625776809007;4411.647068234533;4411.669124815651;4462.464504259509;5016.322796422436;5074.340335756402;5149.510796474329;5151.712071982004;5208.6874787512115;4336.544662810423;4357.607815296638;4388.253996820548;4398.252297109499;4402.823887044482;4585.037142200109;4599.5400459953735;4601.516840731675;4609.8156073757345;4654.767261636973;4678.578927896506;4785.473597904228;4787.569118779326;4796.136695394723;4831.444383895827;5038.470960549236;5105.7702403391195;5111.923321150111;5118.948810511847;5127.974360128175;4782.760861956958;4802.807887684454;4805.927911081407;4807.206810876306;4859.416869975626;4914.975425122851;5031.22016087507;5032.521910418504;5038.47096054909;5085.847424577269;5134.15286477727;5148.382194136578;5179.585633149263;5180.844574662766;5230.790768369375;5047.091523525801;5061.544460998528;5065.696058236517;5072.365954255718;5119.692818430906;4898.53463920927;4981.153203955264;5007.198848184273;5022.623303252344;5040.521150490697;4990.326305948651;4997.100521906092;5014.598832093497;5035.84892453227;5039.622028347815;5072.923906141337;5087.4403815581;5090.389153301628;5091.516305950929;5149.742512874266;4806.158922188673;4832.323474713613;4913.877153071202;4953.108440480604;4981.75091245429 15:39:54 INFO - PROCESS | 32447 | |1;ext.html;530.9041873535415;576.1962062922227;587.7972099625628;597.6055803169908;606.4360145065089;27677.16968490946;30652;40385.3942190867;41532.377014344806;41639.791801040956;43019.35470967938;43346;43359.78320108395;43406.565934340644;43410.65893410657;7813.296803287703;7942.602869856513;7944.523328600302;7951.72168974086;7955.840883182362;7561.395088392943;7623.123340815794;7649.158592554814;7651.693932242703;7653.693852245903;7641.885371719429;7689.115751688543;7695.576743279117;7698.03774528184;7698.191689872567;7594.278543538355;7608.277213664693;7648.770536883902;7651.043619547557;7659.425543084235;7817.726379576744;7910.762677119696;7917.7624671259955;7926.24700653437;7926.841463170762;39839.20321593552;40171.19657606861;40191.59808401937;40198;40244;3183.363327334542;3225.4194245035883;3690.4833323334756;3694.9261014779822;3730.421784623388;30091.247718806986;30664.386712265852;30891.536626950612;30967.535486967714;30968;3519.102628829632;3696.9630303696886;3734.533183352081;3793.639604237593;3796.3356412627954;257988;258838;258916;259019;259640;55033;55518.44481555214;56019.43980560224;56024;56035.71982140145;56590.43409565934;57061.71469142628;57101.428985710445;57197.428025720044;57237.71381143068;15169.08985460876;15381.38474461009;15384;15384.846151538566;15395.846041539442;11559.190856639954;11604.6518604442;11637.534498620129;11640.35978021217;11648.184627076193;17074.48776536706;17526.474205773848;17615.295388184586;17675.292988280326;17693.115344232996;6184.752609895644;6233.750649974041;6346.777862774781;6494.350564943468;6552.14822073137;717.734438257848;878.3544095090103;892.6786356911507;907.3104440625173;918.6417297254076;26240.737592624213;26307.736922630527;26740.8662956684;27544.586831197546;27556.72443275582;768.8577613141587;931.897491275959;945.1257586732245;945.4705364995624;976.1800087926176;14559.088182363357;15405.691886162214;15519.922400388152;16111.597210069842;16376.590585235226;393075;395809;396880;397555;397593;50759.49240507621;50955.49044509581;51000;51044.23433648424;51044.74477627588;1110.7722916802036;1187.192708957917;1201.7115892185811;1220.3593113615245;1225.9080568957543;27943.441131176856;29524;29593.40813183681;29893.551596725632;30109.69890301069;43201.78399107984;43598.12803743971;43602.78198608987;43609.56390436055;43640.56359436365;298759;304175;306692;307339;386522;22473.32580022602;22793;22865.542689146456;23725.881370593037;27689.44621107526;43160;43171.35242971421;43745;44085.559144408144;44181.55818441774;34860.82569587136;36572.81713591415;37471.625283747904;39437.48880351923;40458.39312410375;36868;37391.25217495581;37619.62380376161;37695.81152094222;37801.432978505894;35746.463803043494;36689.08277293089;37045.44431833579;37148.62851371452;37289.44065839069;31325.686743132275;33417.66582334146;33536.329273414885;33896;33991.32017359688;25222.49555008926;25689.357766055997;25754.227373178834;25768.355791105372;26221.213363599123 15:39:54 INFO - PROCESS | 32447 | |2;jquery.html;344.2941968963624;366.3442438035916;366.56561974060725;371.23710774358693;391.1999960081633;13329.800052999213;16737.832621673795;17168.82831171688;18204.089795510237;18225.908870455663;14395.712085758278;14620.4882829101;17622.559436014108;17646;17646.911765441157;4545.227311357061;5169.379674439073;5350.036993341197;5357.919631205535;5358.866028349303;5225.190095535198;5278.762455689484;5288.814891478799;5299.629025968184;5303.761330740107;5259.395169555492;5390.703511306877;5690.943090569103;5702.77188912443;5764.308283006045;5425.267588875491;5663.4336566343245;5684.261046064026;5689.374168841424;5693.971530142364;5442.482964118402;5453.590980676465;5472.097103977879;5476.315460567429;5479.397266300703;12618.432170552256;12713.809292860615;12820.807687884597;12849.807252891214;13039.087263891532;1974.2103158736477;1980.4553747719349;2222.411061068818;2267.183813827021;2376.560336337783;9519.904800952041;9550.761230969212;9603.135717785433;9936;9939.55272012761;1750.8511776499013;1774.547490389955;1790.7492950986873;1803.8376546110912;1875.4373687893715;72332;75184.24815751828;75501.62249188774;75702.24297757063;76531.23468765296;8883.289336853037;9481.09929556691;10104.191664666809;10109.29234953561;10509.84235236472;12526.498940042296;13496.730065398637;13501.864981350258;13973.79039314411;14015.50945716895;5851.824445266649;7049.365557099885;7133.92866071343;7237.565746055254;7262.2737726228015;6400.583962042452;6529.510286728514;6684.131062961784;6703.396694297439;6738.225104112992;4053.8986525336513;4212.53662097169;4378.233809083461;4411.647068234533;4531.45622525299;1762.480068379831;1763.8324359185856;1784.6519928614055;1809.5114319134022;1827.1229809691422;845.6532821543261;894.1505569708803;905.8143080668447;918.5590916360051;929.3494553812359;17381.478555643353;18173;18201.635967280847;18547.629047419246;18661.346852860086;826.5660528222732;837.7193640130503;842.4987132656059;859.6690274244336;864.2869632553169;9805.2646051545;10345.896541034494;10356.689299321033;10370.792584148425;10486;399191;399461;403449;406616;406872;80972;82325.17674823175;82517;82776;84224;882.8322618702426;904.8642703594513;915.1489115123;917.1653795046476;927.0081013315822;15924.363025478851;16081.839181608035;16251.837481625505;16314.83007466246;16421.835781642032;29478.557821632265;39142.80428597839;39718.404223936086;41119.58880411277;41154.58845411507;56064.71967640299;56194.1570876429;56226.718866405405;56552.717236413555;56678;7572.545647261182;7596.772096837104;7653.846923061619;7763.883541746765;7930.603469826601;7820.217978202134;10928.344299342065;11214.327140371604;11516.424178791194;11998;8506.106858779738;8803.471791692518;9288.674896378594;9448.385854919408;9818.116369526777;9609.807803844024;9668.226541876773;9958.253131015057;10049.899501004897;10195.184385249311;9292.39599426035;9709.174720148867;9735.610575576897;9738.756531086496;10226.181905447398;7242.02232698579;7277.781666550012;7354.595497247703;7362.815929601803;7386.113666360071;8844.292456603327;9789.755256118655;9879.654212102541;10000.899991000288;10115.59537618487 15:39:54 INFO - PROCESS | 32447 | |3;mootools.html;1209.1294268126946;1394.8884089272856;1408.8309402871653;1504.1877386211447;1746.9737953930694;6855.280195579461;7795.3763698904095;8018.238267364598;8019.839603207933;8283.213094756004;8055.91944080559;8100.756977290691;8143.470674406174;8157.143499932511;8170.754877353674;2202.2952655150357;2224.7219097612797;2226.109556177526;2229.5317983223545;2231.8884055797143;2144.0673307111456;2181.6182168120595;2182.15986845065;2184.9781502184933;2212.5353675728115;2163.588918105555;2175.8803265820375;2181.5309708412688;2182.334388011656;2201.2405720026563;2096.444442222812;2101.3800928726064;2103.5372218111993;2104.3792081335964;2106.178590349765;2113.4399384163207;2158.4927542027613;2169.078141789733;2171.0555908179836;2174.097749433983;7972.641231144612;8111.837763244761;8221.342292616577;8222.259996600334;8233.670653173866;4572.268437050089;4705.717656940595;4707.199776038047;4712.410948631421;4716.646251531149;2824.5480723084206;2879.280179955011;2931.7361437470518;2952.335724462;2957.512010518262;909.0818273543769;916.6012784438724;928.9907100929039;942.9717108486757;945.3099237556553;10811.18916081297;10883.78232435347;10932.398718070583;10966.342019478856;10968.067714244298;3836.8848934532007;4003.6997225208224;4043.332850079704;4048.109415928491;4088.6524645405475;8666.56667166639;8713.3464990126;8713.869291960626;8724.607392667345;8736.825263494822;4522.796474158671;4524.954750452519;4532.32015197723;4538.977305113453;4544.068465964469;3804.904877378088;4137.565555616678;4190.141021090669;4193.7903104845245;4285.849995250213;3468.6357932417236;3485.5294535237417;3546.556680414948;3574.392353299945;3591.2458383739186;1004.9849252261222;1008.742770593494;1015.2081376526321;1025.7692019295748;1059.95230214639;724.8695234857671;804.814892574711;826.4875777018287;829.9543525106177;837.660747397305;5266.789328426897;5319.2021196820015;5486.231927530149;5498.697571633518;5534.889302213933;823.5758584329076;835.3901651794102;837.3008537870825;844.6030365728097;861.9396642234983;3599.4420864766003;3789.5073640427117;3802.3155831950517;3876.437916502148;3902.2195560887935;9306.53467326631;9396.67111651089;9503.619855205714;9516.666916658021;9636.277279204087;9263.212626926652;9312.394694344846;9370.203532699798;9380.765480862896;9407.576659050223;7461.253874612496;7518.699252029857;7618.6667333216465;7692.73075442368;7704.422168337509;5326.813561525328;5354.759035843318;5362.329708786402;5388.245645609696;5528.778848846162;9339.112784285482;9345.252379809463;9393.389429687048;9398.812023759623;9428.811423771349;9208.217301529445;9596.376235544667;9680.709578712649;9681.322307438411;9806.901930980599;5898.882022359615;6481.4166724994975;6542.8364290893105;7286.198518162892;7595.962020189863;7614.771556853303;7880.05439347282;7960.3233725131695;7966.482178658369;7981.521108733263;6799.830004249736;7054.4003759681;7105.75129870452;7146.499745017799;7249.166345870081;6877.65611719402;6946.6179360135675;6960.825979350557;6984.301569842975;6993.965030174817;5809.767609295581;5987.670678112746;6012;6122.571420000735;6146.907796382969;4448.4439445069365;4473.5973762360245;4666.440027196758;4670;4734.981978874558;4258.084511829971;4333.653307735311;4655.557722016403;4680.7191568506;4744.857654270378 15:39:54 INFO - PROCESS | 32447 | |4;prototype.html;295.4843797573235;298.52385445214884;302.41331816276437;303.10734885761434;307.86915560886615;4908.852734417964;4918.75406229688;4921.606271498276;4957.355543779308;4970.602351811855;4816.8554943351755;4842.467328593852;4897.412310522734;4897.951020489794;4898.412190537131;3636.345457817592;3743.7753734776;3744.2885851688093;3851.9807400962954;3883.825227864753;3824.273388056274;3861.1891502784447;3866.9613303867022;3871.457995880579;3872.5740168581433;3637.436197389409;3840.6927445804267;3859.4982652255167;3866.961330386688;3867.361885288924;3716.8442303463926;3835.884923452287;3848.5574158971795;3856.5564960029674;3860.247251785903;3374.797512149279;3395.47370157626;3413.1808365991983;3422.401079811023;3430.27964127531;4732.929006064912;4751.738654374008;4755.334253204554;4767.809287628491;4784.808607655689;4244.821783996571;4366.214081465367;4374.300111982067;4384.671149663788;4414.889627759299;5023.899522009539;5039.168537191359;5048.444671086178;5052.696838189684;5061.772220250097;3732.309522738302;3748.5689145748315;3753.70497178473;3754.7559408638626;3754.9061273468383;5179.430262671141;5281.947180528223;5310;5331.2003199519995;5338.492843179892;3782.0544863784053;3791.962080379161;3794.59599948021;3797.810109494514;3814.980925095412;3839.212961342918;3843.327417701891;3843.385058390644;3853.865114720971;3859.710521710883;4354.586314300136;4357.193919124972;4359.38968544404;4361.433013708261;4365.825366985348;4889.535494128052;5034.8237811677145;5045.747712614355;5046.62150338726;5054.974725126351;1311.1215485624655;1317.4466723975954;1323.7418703352946;1324.5761356366063;1324.9536266230637;856.3577317012241;870.4037734152126;885.1590988560893;915.5834095486671;939.6617217801586;4406.3170208617075;4452.866414007585;4471.993801394725;4477.888052798641;4495.325701144789;5100.336956195745;5127.846164615067;5132.255822905658;5137.383513978271;5175.741212939413;4337.1249264562175;4396.318570621559;4431.889202769957;4455;4458.2420988431395;2756.710545392745;2758.889644414201;2763.9309017274327;2768.529350010503;2780.777537797012;4849.660523763303;4901.573721008123;4910.165271903785;4918.213085906238;4921.7785199666105;5099.36257967754;5288.550473209821;5301.727585379558;5324.787008519694;5453.6187563710755;4993.251012348177;5000.7999680013845;5009.12340340439;5025.120603894304;5027.748612569357;5272.6836389816735;5291.365036195527;5315.760790764502;5317.946820531745;5355.196720491957;4891.584215341736;5138.409082955508;5151.433342332415;5261.289725886956;5265.89468210626;4961.206207006861;4979.875503112306;4979.975100124476;4980.651354405301;4986.476419975996;3766.981165094157;3771.830267637908;3780.2250538640064;3782.338090834038;3784.6215378463035;5079.517445842639;5254.290670759551;5266.262723218829;5312.4156342803035;5332.093544097435;5085.694858308513;5089.312942752681;5107.591392688651;5116.386033675983;5132.10188217068;5098.133317335987;5144.331236939323;5150.278960945546;5162.225666150108;5183.352080989876;4812.855614331575;4958.305837182726;5033;5052.418971818288;5105.361829771278;4921.917178220929;4962.280469331999;5138.794448222029;5148.794048238028;5168.328117344721;5015.17249653803;5044.319016932667;5092.363454568179;5097.133487307093;5109.821156259513 15:39:54 INFO - PROCESS | 32447 | |5;yui.html;645.6384424722156;656.2387630348796;666.7966270287567;724.6376811594203;734.8456824066944;11220.775584488305;11509.712257193574;11538.076953843693;11666.241694289876;11673.649790506288;11275.718107047307;11454.828177577343;11485.196036277464;11513.424328783569;12465.252084874892;777.6189667063155;801.4910531812312;802.2138304461631;802.8113393352558;802.9116797152309;636.3318515558668;772.3357912195507;776.088096486626;787.5196130360475;798.0503201190564;820.3150369441523;826.6610689617258;828.3000864269683;828.8010877389444;833.1834801894117;824.418784756751;824.8102936324649;824.9175082491763;824.9587520624004;825.2078005115096;486.65690688065183;579.1573260905373;589.7051474262869;608.7777961044231;611.4252602553586;12060.939695301468;12082.516699332104;12155.756884862341;12220.450079746433;12235.388230588524;10455.529501172465;11207.495662695199;11253.820186564906;11387.943060284728;11514.078873690085;11257.605983790529;11396.80333564972;11398;11462.713432164179;11593.01459375954;4059.7361171523758;4065.9390109148385;4096.487939007624;4161.271777438936;4209.515905670856;59742.40257597412;60327.39672603262;60787.39212607906;60816.087758683214;61025.999999999556;8979.236764874928;9088.727338179866;9349.345545811864;9435.76410589727;9578.616855325849;16784.41254556085;17143.057131857866;17151;17151.142442878056;17185.31258749661;6326.398992095744;6545.541812073205;6677.532572719863;6753.31357638662;7116.786496405116;3735.290294843971;3765.5104836371097;3796.259729352805;3818.0836599215986;3831.4827498287373;2781.680106787705;2830.6461692288462;2842.090531030092;2845.928851778681;2862.270121119101;508.5575549272157;511.35058475735605;520.2560338715597;522.7412430846755;529.2696079410389;508.10826998617927;595.4521839907296;610.4292486525113;618.5082859127004;629.4901130084646;7547.773566793005;7758.3017528422715;7828.882566761503;7922.326602238874;8189.836203275901;604.4361651002512;604.9425304596057;615.9414855588711;624.257134010526;636.1602684456566;3756.511653485084;3949.229900169497;4002.3196056670436;4085.101277718897;4104.4048612950955;54144;73198;91333;94657.526712366;94804.52597736967;48129.75935120302;48322.27516587254;49651.75174124106;82213.17786822055;83079;43975.35722605225;46471.514636402404;49920.750396247786;69148.30851691419;72420;7439.590822504814;7614.7727385573335;7725.763877779528;7828.373730101692;7896.170902055202;44763.55236447594;45100.77449612731;45140.54859451495;45595.544044560454;45872.31191532063;59657;63883.3611663896;64641.15191360761;64863.67568162318;65262;9444.905550944677;9451.669191578261;9452.905470945203;9593.808123837345;9991.600335986479;10492.265541412027;10552.261341706315;10628.627998020032;10762.515686793957;10953.178511611502;9400.435973841591;9627.085426884434;9630.374025688308;9804.460754658277;9883.11052005323;10279.331843430153;10534.894651053391;10782.946085269523;11138.610148645083;11406.48670809799;11247.943760281147;11779.293242405483;11791.997680197279;11915.344656043653;11935.164538482222;9402.764930876509;9792.706218813448;9808.068233517804;10102.494875256061;10487.632932847313;8236.711715089943;9183.173514383738;9276.907230927603;9586.328956972944;9781.310139711637 15:39:54 INFO - PROCESS | 32447 | __end_tp_report 15:39:54 INFO - PROCESS | 32447 | __start_cc_report 15:39:54 INFO - PROCESS | 32447 | _x_x_mozilla_cycle_collect,1025 15:39:54 INFO - PROCESS | 32447 | __end_cc_report 15:39:54 INFO - PROCESS | 32447 | __startTimestamp1467239994040__endTimestamp 15:39:54 INFO - PROCESS | 32447 | 15:39:54 INFO - PROCESS | 32447 | ------- Summary: start ------- 15:39:54 INFO - PROCESS | 32447 | Number of tests: 6 15:39:54 INFO - PROCESS | 32447 | 15:39:54 INFO - PROCESS | 32447 | [#0] dojo.html Cycles:165 Average:4744.51 Median:4835.27 stddev:493.46 (10.2%) stddev-sans-first:466.72 15:39:54 INFO - PROCESS | 32447 | Values: 2646.3 2659.1 2692.1 2692.5 2707.8 4677.9 4721.8 4740.2 4829.4 4871.6 4760.2 4768.4 4792.3 4818.1 4824.2 4409.6 4433.3 4455.7 4473.5 4489.6 4428.7 4464.4 4496.9 4499.5 4531.4 4495.7 4542.9 4555.6 4562.2 4577.1 4256.5 4320.5 4334.7 4349.9 4478.1 4359.1 4364.1 4371.8 4403.1 4405.8 4825.6 4825.7 4833.5 4844.7 4845.0 4967.0 5035.6 5104.3 5106.8 5150.2 5184.5 5201.6 5203.4 5209.1 5220.4 4784.0 4791.3 4826.0 4832.3 4835.3 5114.9 5228.1 5281.2 5283.6 5361.4 5099.8 5128.0 5150.0 5150.3 5152.6 4966.8 5168.7 5179.3 5232.3 5241.7 4938.4 4976.1 4988.6 4991.5 5012.6 4974.0 4979.5 4983.4 4986.4 5031.6 4288.0 4319.4 4327.7 4338.7 4390.7 3818.3 3847.8 3856.9 3878.1 3885.2 4390.8 4402.6 4411.6 4411.7 4462.5 5016.3 5074.3 5149.5 5151.7 5208.7 4336.5 4357.6 4388.3 4398.3 4402.8 4585.0 4599.5 4601.5 4609.8 4654.8 4678.6 4785.5 4787.6 4796.1 4831.4 5038.5 5105.8 5111.9 5118.9 5128.0 4782.8 4802.8 4805.9 4807.2 4859.4 4915.0 5031.2 5032.5 5038.5 5085.8 5134.2 5148.4 5179.6 5180.8 5230.8 5047.1 5061.5 5065.7 5072.4 5119.7 4898.5 4981.2 5007.2 5022.6 5040.5 4990.3 4997.1 5014.6 5035.8 5039.6 5072.9 5087.4 5090.4 5091.5 5149.7 4806.2 4832.3 4913.9 4953.1 4981.8 15:39:54 INFO - PROCESS | 32447 | 15:39:54 INFO - PROCESS | 32447 | [#1] ext.html Cycles:180 Average:48454.41 Median:216256.24 stddev:87062.10 (40.3%) stddev-sans-first:87231.98 15:39:54 INFO - PROCESS | 32447 | Values: 530.9 576.2 587.8 597.6 606.4 27677.2 30652.0 40385.4 41532.4 41639.8 43019.4 43346.0 43359.8 43406.6 43410.7 7813.3 7942.6 7944.5 7951.7 7955.8 7561.4 7623.1 7649.2 7651.7 7653.7 7641.9 7689.1 7695.6 7698.0 7698.2 7594.3 7608.3 7648.8 7651.0 7659.4 7817.7 7910.8 7917.8 7926.2 7926.8 39839.2 40171.2 40191.6 40198.0 40244.0 3183.4 3225.4 3690.5 3694.9 3730.4 30091.2 30664.4 30891.5 30967.5 30968.0 3519.1 3697.0 3734.5 3793.6 3796.3 257988.0 258838.0 258916.0 259019.0 259640.0 55033.0 55518.4 56019.4 56024.0 56035.7 56590.4 57061.7 57101.4 57197.4 57237.7 15169.1 15381.4 15384.0 15384.8 15395.8 11559.2 11604.7 11637.5 11640.4 11648.2 17074.5 17526.5 17615.3 17675.3 17693.1 6184.8 6233.8 6346.8 6494.4 6552.1 717.7 878.4 892.7 907.3 918.6 26240.7 26307.7 26740.9 27544.6 27556.7 768.9 931.9 945.1 945.5 976.2 14559.1 15405.7 15519.9 16111.6 16376.6 393075.0 395809.0 396880.0 397555.0 397593.0 50759.5 50955.5 51000.0 51044.2 51044.7 1110.8 1187.2 1201.7 1220.4 1225.9 27943.4 29524.0 29593.4 29893.6 30109.7 43201.8 43598.1 43602.8 43609.6 43640.6 298759.0 304175.0 306692.0 307339.0 386522.0 22473.3 22793.0 22865.5 23725.9 27689.4 43160.0 43171.4 43745.0 44085.6 44181.6 34860.8 36572.8 37471.6 39437.5 40458.4 36868.0 37391.3 37619.6 37695.8 37801.4 35746.5 36689.1 37045.4 37148.6 37289.4 31325.7 33417.7 33536.3 33896.0 33991.3 25222.5 25689.4 25754.2 25768.4 26221.2 15:39:54 INFO - PROCESS | 32447 | 15:39:54 INFO - PROCESS | 32447 | [#2] jquery.html Cycles:180 Average:24910.65 Median:5358.39 stddev:66839.88 (1247.4%) stddev-sans-first:67001.93 15:39:54 INFO - PROCESS | 32447 | Values: 344.3 366.3 366.6 371.2 391.2 13329.8 16737.8 17168.8 18204.1 18225.9 14395.7 14620.5 17622.6 17646.0 17646.9 4545.2 5169.4 5350.0 5357.9 5358.9 5225.2 5278.8 5288.8 5299.6 5303.8 5259.4 5390.7 5690.9 5702.8 5764.3 5425.3 5663.4 5684.3 5689.4 5694.0 5442.5 5453.6 5472.1 5476.3 5479.4 12618.4 12713.8 12820.8 12849.8 13039.1 1974.2 1980.5 2222.4 2267.2 2376.6 9519.9 9550.8 9603.1 9936.0 9939.6 1750.9 1774.5 1790.7 1803.8 1875.4 72332.0 75184.2 75501.6 75702.2 76531.2 8883.3 9481.1 10104.2 10109.3 10509.8 12526.5 13496.7 13501.9 13973.8 14015.5 5851.8 7049.4 7133.9 7237.6 7262.3 6400.6 6529.5 6684.1 6703.4 6738.2 4053.9 4212.5 4378.2 4411.6 4531.5 1762.5 1763.8 1784.7 1809.5 1827.1 845.7 894.2 905.8 918.6 929.3 17381.5 18173.0 18201.6 18547.6 18661.3 826.6 837.7 842.5 859.7 864.3 9805.3 10345.9 10356.7 10370.8 10486.0 399191.0 399461.0 403449.0 406616.0 406872.0 80972.0 82325.2 82517.0 82776.0 84224.0 882.8 904.9 915.1 917.2 927.0 15924.4 16081.8 16251.8 16314.8 16421.8 29478.6 39142.8 39718.4 41119.6 41154.6 56064.7 56194.2 56226.7 56552.7 56678.0 7572.5 7596.8 7653.8 7763.9 7930.6 7820.2 10928.3 11214.3 11516.4 11998.0 8506.1 8803.5 9288.7 9448.4 9818.1 9609.8 9668.2 9958.3 10049.9 10195.2 9292.4 9709.2 9735.6 9738.8 10226.2 7242.0 7277.8 7354.6 7362.8 7386.1 8844.3 9789.8 9879.7 10000.9 10115.6 15:39:54 INFO - PROCESS | 32447 | 15:39:54 INFO - PROCESS | 32447 | [#3] mootools.html Cycles:180 Average:5199.72 Median:5437.24 stddev:2956.55 (54.4%) stddev-sans-first:2949.63 15:39:54 INFO - PROCESS | 32447 | Values: 1209.1 1394.9 1408.8 1504.2 1747.0 6855.3 7795.4 8018.2 8019.8 8283.2 8055.9 8100.8 8143.5 8157.1 8170.8 2202.3 2224.7 2226.1 2229.5 2231.9 2144.1 2181.6 2182.2 2185.0 2212.5 2163.6 2175.9 2181.5 2182.3 2201.2 2096.4 2101.4 2103.5 2104.4 2106.2 2113.4 2158.5 2169.1 2171.1 2174.1 7972.6 8111.8 8221.3 8222.3 8233.7 4572.3 4705.7 4707.2 4712.4 4716.6 2824.5 2879.3 2931.7 2952.3 2957.5 909.1 916.6 929.0 943.0 945.3 10811.2 10883.8 10932.4 10966.3 10968.1 3836.9 4003.7 4043.3 4048.1 4088.7 8666.6 8713.3 8713.9 8724.6 8736.8 4522.8 4525.0 4532.3 4539.0 4544.1 3804.9 4137.6 4190.1 4193.8 4285.8 3468.6 3485.5 3546.6 3574.4 3591.2 1005.0 1008.7 1015.2 1025.8 1060.0 724.9 804.8 826.5 830.0 837.7 5266.8 5319.2 5486.2 5498.7 5534.9 823.6 835.4 837.3 844.6 861.9 3599.4 3789.5 3802.3 3876.4 3902.2 9306.5 9396.7 9503.6 9516.7 9636.3 9263.2 9312.4 9370.2 9380.8 9407.6 7461.3 7518.7 7618.7 7692.7 7704.4 5326.8 5354.8 5362.3 5388.2 5528.8 9339.1 9345.3 9393.4 9398.8 9428.8 9208.2 9596.4 9680.7 9681.3 9806.9 5898.9 6481.4 6542.8 7286.2 7596.0 7614.8 7880.1 7960.3 7966.5 7981.5 6799.8 7054.4 7105.8 7146.5 7249.2 6877.7 6946.6 6960.8 6984.3 6994.0 5809.8 5987.7 6012.0 6122.6 6146.9 4448.4 4473.6 4666.4 4670.0 4735.0 4258.1 4333.7 4655.6 4680.7 4744.9 15:39:54 INFO - PROCESS | 32447 | 15:39:54 INFO - PROCESS | 32447 | [#4] prototype.html Cycles:180 Average:4251.06 Median:4894.50 stddev:1220.28 (24.9%) stddev-sans-first:1187.04 15:39:54 INFO - PROCESS | 32447 | Values: 295.5 298.5 302.4 303.1 307.9 4908.9 4918.8 4921.6 4957.4 4970.6 4816.9 4842.5 4897.4 4898.0 4898.4 3636.3 3743.8 3744.3 3852.0 3883.8 3824.3 3861.2 3867.0 3871.5 3872.6 3637.4 3840.7 3859.5 3867.0 3867.4 3716.8 3835.9 3848.6 3856.6 3860.2 3374.8 3395.5 3413.2 3422.4 3430.3 4732.9 4751.7 4755.3 4767.8 4784.8 4244.8 4366.2 4374.3 4384.7 4414.9 5023.9 5039.2 5048.4 5052.7 5061.8 3732.3 3748.6 3753.7 3754.8 3754.9 5179.4 5281.9 5310.0 5331.2 5338.5 3782.1 3792.0 3794.6 3797.8 3815.0 3839.2 3843.3 3843.4 3853.9 3859.7 4354.6 4357.2 4359.4 4361.4 4365.8 4889.5 5034.8 5045.7 5046.6 5055.0 1311.1 1317.4 1323.7 1324.6 1325.0 856.4 870.4 885.2 915.6 939.7 4406.3 4452.9 4472.0 4477.9 4495.3 5100.3 5127.8 5132.3 5137.4 5175.7 4337.1 4396.3 4431.9 4455.0 4458.2 2756.7 2758.9 2763.9 2768.5 2780.8 4849.7 4901.6 4910.2 4918.2 4921.8 5099.4 5288.6 5301.7 5324.8 5453.6 4993.3 5000.8 5009.1 5025.1 5027.7 5272.7 5291.4 5315.8 5317.9 5355.2 4891.6 5138.4 5151.4 5261.3 5265.9 4961.2 4979.9 4980.0 4980.7 4986.5 3767.0 3771.8 3780.2 3782.3 3784.6 5079.5 5254.3 5266.3 5312.4 5332.1 5085.7 5089.3 5107.6 5116.4 5132.1 5098.1 5144.3 5150.3 5162.2 5183.4 4812.9 4958.3 5033.0 5052.4 5105.4 4921.9 4962.3 5138.8 5148.8 5168.3 5015.2 5044.3 5092.4 5097.1 5109.8 15:39:54 INFO - PROCESS | 32447 | 15:39:54 INFO - PROCESS | 32447 | [#5] yui.html Cycles:180 Average:15800.85 Median:60034.90 stddev:21914.56 (36.5%) stddev-sans-first:21946.49 15:39:54 INFO - PROCESS | 32447 | Values: 645.6 656.2 666.8 724.6 734.8 11220.8 11509.7 11538.1 11666.2 11673.6 11275.7 11454.8 11485.2 11513.4 12465.3 777.6 801.5 802.2 802.8 802.9 636.3 772.3 776.1 787.5 798.1 820.3 826.7 828.3 828.8 833.2 824.4 824.8 824.9 825.0 825.2 486.7 579.2 589.7 608.8 611.4 12060.9 12082.5 12155.8 12220.5 12235.4 10455.5 11207.5 11253.8 11387.9 11514.1 11257.6 11396.8 11398.0 11462.7 11593.0 4059.7 4065.9 4096.5 4161.3 4209.5 59742.4 60327.4 60787.4 60816.1 61026.0 8979.2 9088.7 9349.3 9435.8 9578.6 16784.4 17143.1 17151.0 17151.1 17185.3 6326.4 6545.5 6677.5 6753.3 7116.8 3735.3 3765.5 3796.3 3818.1 3831.5 2781.7 2830.6 2842.1 2845.9 2862.3 508.6 511.4 520.3 522.7 529.3 508.1 595.5 610.4 618.5 629.5 7547.8 7758.3 7828.9 7922.3 8189.8 604.4 604.9 615.9 624.3 636.2 3756.5 3949.2 4002.3 4085.1 4104.4 54144.0 73198.0 91333.0 94657.5 94804.5 48129.8 48322.3 49651.8 82213.2 83079.0 43975.4 46471.5 49920.8 69148.3 72420.0 7439.6 7614.8 7725.8 7828.4 7896.2 44763.6 45100.8 45140.5 45595.5 45872.3 59657.0 63883.4 64641.2 64863.7 65262.0 9444.9 9451.7 9452.9 9593.8 9991.6 10492.3 10552.3 10628.6 10762.5 10953.2 9400.4 9627.1 9630.4 9804.5 9883.1 10279.3 10534.9 10782.9 11138.6 11406.5 11247.9 11779.3 11792.0 11915.3 11935.2 9402.8 9792.7 9808.1 10102.5 10487.6 8236.7 9183.2 9276.9 9586.3 9781.3 15:39:54 INFO - PROCESS | 32447 | -------- Summary: end -------- 15:39:54 INFO - PROCESS | 32447 | 15:39:54 INFO - TEST-INFO | 32447: exit 0 15:39:54 INFO - TEST-OK | dromaeo_css | took 1118802ms 15:39:54 INFO - TEST-START | kraken 15:39:54 INFO - operating with platform_type : linux_ 15:39:54 INFO - Initialising browser for kraken test... 15:39:54 INFO - TEST-INFO | started process 32637 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplAQcTo/profile http://localhost:53859/getInfo.html) 15:39:58 INFO - PROCESS | 32637 | __metrics Screen width/height:1600/1200 15:39:58 INFO - PROCESS | 32637 | colorDepth:24 15:39:58 INFO - PROCESS | 32637 | Browser inner width/height: 1024/697 15:39:58 INFO - PROCESS | 32637 | __metrics 15:39:59 INFO - PROCESS | 32637 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:40:00 INFO - TEST-INFO | 32637: exit 0 15:40:00 INFO - Browser initialized. 15:40:00 INFO - Running cycle 1/1 for kraken test... 15:40:00 INFO - TEST-INFO | started process 32718 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplAQcTo/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:40:12 INFO - PROCESS | 32718 | RSS: Main: 158965760 15:40:12 INFO - PROCESS | 32718 | 15:40:15 INFO - PROCESS | 32718 | Cycle 1(1): loaded http://localhost:53859/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53859/tests/kraken/driver.html?testName=audio-beat-detection) 15:40:16 INFO - PROCESS | 32718 | RSS: Main: 216829952 15:40:16 INFO - PROCESS | 32718 | 15:40:18 INFO - PROCESS | 32718 | Cycle 1(1): loaded http://localhost:53859/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53859/tests/kraken/driver.html?testName=audio-dft) 15:40:19 INFO - PROCESS | 32718 | RSS: Main: 204382208 15:40:19 INFO - PROCESS | 32718 | 15:40:22 INFO - PROCESS | 32718 | Cycle 1(1): loaded http://localhost:53859/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53859/tests/kraken/driver.html?testName=audio-fft) 15:40:23 INFO - PROCESS | 32718 | RSS: Main: 270934016 15:40:23 INFO - PROCESS | 32718 | 15:40:25 INFO - PROCESS | 32718 | Cycle 1(1): loaded http://localhost:53859/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53859/tests/kraken/driver.html?testName=audio-oscillator) 15:40:25 INFO - PROCESS | 32718 | RSS: Main: 181620736 15:40:25 INFO - PROCESS | 32718 | 15:40:28 INFO - PROCESS | 32718 | Cycle 1(1): loaded http://localhost:53859/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53859/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:40:28 INFO - PROCESS | 32718 | RSS: Main: 185962496 15:40:28 INFO - PROCESS | 32718 | 15:40:32 INFO - PROCESS | 32718 | Cycle 1(1): loaded http://localhost:53859/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53859/tests/kraken/driver.html?testName=imaging-darkroom) 15:40:32 INFO - PROCESS | 32718 | RSS: Main: 221925376 15:40:32 INFO - PROCESS | 32718 | 15:40:36 INFO - PROCESS | 32718 | Cycle 1(1): loaded http://localhost:53859/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53859/tests/kraken/driver.html?testName=imaging-desaturate) 15:40:36 INFO - PROCESS | 32718 | RSS: Main: 217513984 15:40:36 INFO - PROCESS | 32718 | 15:40:39 INFO - PROCESS | 32718 | Cycle 1(1): loaded http://localhost:53859/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53859/tests/kraken/driver.html?testName=json-parse-financial) 15:40:40 INFO - PROCESS | 32718 | RSS: Main: 220618752 15:40:40 INFO - PROCESS | 32718 | 15:40:41 INFO - PROCESS | 32718 | Cycle 1(1): loaded http://localhost:53859/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53859/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:40:42 INFO - PROCESS | 32718 | RSS: Main: 205381632 15:40:42 INFO - PROCESS | 32718 | 15:40:44 INFO - PROCESS | 32718 | Cycle 1(1): loaded http://localhost:53859/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53859/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:40:45 INFO - PROCESS | 32718 | RSS: Main: 210382848 15:40:45 INFO - PROCESS | 32718 | 15:40:47 INFO - PROCESS | 32718 | Cycle 1(1): loaded http://localhost:53859/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53859/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:40:47 INFO - PROCESS | 32718 | RSS: Main: 209883136 15:40:47 INFO - PROCESS | 32718 | 15:40:50 INFO - PROCESS | 32718 | Cycle 1(1): loaded http://localhost:53859/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53859/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:40:51 INFO - PROCESS | 32718 | RSS: Main: 224260096 15:40:51 INFO - PROCESS | 32718 | 15:40:54 INFO - PROCESS | 32718 | Cycle 1(1): loaded http://localhost:53859/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53859/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:40:54 INFO - PROCESS | 32718 | RSS: Main: 224366592 15:40:54 INFO - PROCESS | 32718 | 15:40:56 INFO - PROCESS | 32718 | Cycle 1(1): loaded http://localhost:53859/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53859/tests/kraken/driver.html?testName=ai-astar) 15:40:56 INFO - PROCESS | 32718 | RSS: Main: 267120640 15:40:56 INFO - PROCESS | 32718 | 15:40:56 INFO - PROCESS | 32718 | __start_tp_report 15:40:56 INFO - PROCESS | 32718 | _x_x_mozilla_page_load 15:40:56 INFO - PROCESS | 32718 | _x_x_mozilla_page_load_details 15:40:56 INFO - PROCESS | 32718 | |i|pagename|runs| 15:40:56 INFO - PROCESS | 32718 | |0;ai-astar;103;114;112;114;113;113;111;113;112;112 15:40:56 INFO - PROCESS | 32718 | |1;audio-beat-detection;143;125;130;168;126;124;151;124;193;121 15:40:56 INFO - PROCESS | 32718 | |2;audio-dft;160;162;162;161;161;161;162;162;161;163 15:40:56 INFO - PROCESS | 32718 | |3;audio-fft;76;76;77;123;77;76;76;76;100;76 15:40:56 INFO - PROCESS | 32718 | |4;audio-oscillator;84;85;107;85;86;85;130;85;87;126 15:40:56 INFO - PROCESS | 32718 | |5;imaging-gaussian-blur;118;118;118;118;116;117;118;119;118;118 15:40:56 INFO - PROCESS | 32718 | |6;imaging-darkroom;148;146;147;146;147;147;148;147;146;146 15:40:56 INFO - PROCESS | 32718 | |7;imaging-desaturate;95;95;95;94;95;95;95;95;95;94 15:40:56 INFO - PROCESS | 32718 | |8;json-parse-financial;63;63;64;63;65;64;63;64;63;63 15:40:56 INFO - PROCESS | 32718 | |9;json-stringify-tinderbox;66;65;66;65;66;65;65;64;65;64 15:40:56 INFO - PROCESS | 32718 | |10;stanford-crypto-aes;86;78;77;77;85;78;88;78;82;78 15:40:56 INFO - PROCESS | 32718 | |11;stanford-crypto-ccm;128;128;128;128;130;131;130;136;165;131 15:40:56 INFO - PROCESS | 32718 | |12;stanford-crypto-pbkdf2;168;167;169;164;168;168;166;168;166;166 15:40:56 INFO - PROCESS | 32718 | |13;stanford-crypto-sha256-iterative;67;67;68;67;67;67;67;69;68;69 15:40:56 INFO - PROCESS | 32718 | __end_tp_report 15:40:56 INFO - PROCESS | 32718 | __start_cc_report 15:40:56 INFO - PROCESS | 32718 | _x_x_mozilla_cycle_collect,1909 15:40:56 INFO - PROCESS | 32718 | __end_cc_report 15:40:56 INFO - PROCESS | 32718 | __startTimestamp1467240056764__endTimestamp 15:40:56 INFO - PROCESS | 32718 | 15:40:56 INFO - PROCESS | 32718 | ------- Summary: start ------- 15:40:56 INFO - PROCESS | 32718 | Number of tests: 14 15:40:56 INFO - PROCESS | 32718 | 15:40:56 INFO - PROCESS | 32718 | [#0] ai-astar Cycles:10 Average:111.70 Median:113.00 stddev:3.20 (2.8%) stddev-sans-first:1.00 15:40:56 INFO - PROCESS | 32718 | Values: 103.0 114.0 112.0 114.0 113.0 113.0 111.0 113.0 112.0 112.0 15:40:56 INFO - PROCESS | 32718 | 15:40:56 INFO - PROCESS | 32718 | [#1] audio-beat-detection Cycles:10 Average:140.50 Median:136.50 stddev:23.84 (17.5%) stddev-sans-first:25.27 15:40:56 INFO - PROCESS | 32718 | Values: 143.0 125.0 130.0 168.0 126.0 124.0 151.0 124.0 193.0 121.0 15:40:56 INFO - PROCESS | 32718 | 15:40:56 INFO - PROCESS | 32718 | [#2] audio-dft Cycles:10 Average:161.50 Median:162.00 stddev:0.85 (0.5%) stddev-sans-first:0.71 15:40:56 INFO - PROCESS | 32718 | Values: 160.0 162.0 162.0 161.0 161.0 161.0 162.0 162.0 161.0 163.0 15:40:56 INFO - PROCESS | 32718 | 15:40:56 INFO - PROCESS | 32718 | [#3] audio-fft Cycles:10 Average:83.30 Median:76.00 stddev:15.83 (20.8%) stddev-sans-first:16.56 15:40:56 INFO - PROCESS | 32718 | Values: 76.0 76.0 77.0 123.0 77.0 76.0 76.0 76.0 100.0 76.0 15:40:56 INFO - PROCESS | 32718 | 15:40:56 INFO - PROCESS | 32718 | [#4] audio-oscillator Cycles:10 Average:96.00 Median:85.00 stddev:18.21 (21.4%) stddev-sans-first:18.79 15:40:56 INFO - PROCESS | 32718 | Values: 84.0 85.0 107.0 85.0 86.0 85.0 130.0 85.0 87.0 126.0 15:40:56 INFO - PROCESS | 32718 | 15:40:56 INFO - PROCESS | 32718 | [#5] imaging-gaussian-blur Cycles:10 Average:117.80 Median:118.00 stddev:0.79 (0.7%) stddev-sans-first:0.83 15:40:56 INFO - PROCESS | 32718 | Values: 118.0 118.0 118.0 118.0 116.0 117.0 118.0 119.0 118.0 118.0 15:40:56 INFO - PROCESS | 32718 | 15:40:56 INFO - PROCESS | 32718 | [#6] imaging-darkroom Cycles:10 Average:146.80 Median:147.00 stddev:0.79 (0.5%) stddev-sans-first:0.71 15:40:56 INFO - PROCESS | 32718 | Values: 148.0 146.0 147.0 146.0 147.0 147.0 148.0 147.0 146.0 146.0 15:40:56 INFO - PROCESS | 32718 | 15:40:56 INFO - PROCESS | 32718 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 15:40:56 INFO - PROCESS | 32718 | Values: 95.0 95.0 95.0 94.0 95.0 95.0 95.0 95.0 95.0 94.0 15:40:56 INFO - PROCESS | 32718 | 15:40:56 INFO - PROCESS | 32718 | [#8] json-parse-financial Cycles:10 Average:63.50 Median:63.50 stddev:0.71 (1.1%) stddev-sans-first:0.73 15:40:56 INFO - PROCESS | 32718 | Values: 63.0 63.0 64.0 63.0 65.0 64.0 63.0 64.0 63.0 63.0 15:40:56 INFO - PROCESS | 32718 | 15:40:56 INFO - PROCESS | 32718 | [#9] json-stringify-tinderbox Cycles:10 Average:65.10 Median:65.00 stddev:0.74 (1.1%) stddev-sans-first:0.71 15:40:56 INFO - PROCESS | 32718 | Values: 66.0 65.0 66.0 65.0 66.0 65.0 65.0 64.0 65.0 64.0 15:40:56 INFO - PROCESS | 32718 | 15:40:56 INFO - PROCESS | 32718 | [#10] stanford-crypto-aes Cycles:10 Average:80.70 Median:80.00 stddev:4.19 (5.2%) stddev-sans-first:3.98 15:40:56 INFO - PROCESS | 32718 | Values: 86.0 78.0 77.0 77.0 85.0 78.0 88.0 78.0 82.0 78.0 15:40:56 INFO - PROCESS | 32718 | 15:40:56 INFO - PROCESS | 32718 | [#11] stanford-crypto-ccm Cycles:10 Average:133.50 Median:130.50 stddev:11.34 (8.7%) stddev-sans-first:11.85 15:40:56 INFO - PROCESS | 32718 | Values: 128.0 128.0 128.0 128.0 130.0 131.0 130.0 136.0 165.0 131.0 15:40:56 INFO - PROCESS | 32718 | 15:40:56 INFO - PROCESS | 32718 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.00 Median:168.00 stddev:1.49 (0.9%) stddev-sans-first:1.54 15:40:56 INFO - PROCESS | 32718 | Values: 168.0 167.0 169.0 164.0 168.0 168.0 166.0 168.0 166.0 166.0 15:40:56 INFO - PROCESS | 32718 | 15:40:56 INFO - PROCESS | 32718 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.60 Median:67.50 stddev:0.84 (1.2%) stddev-sans-first:0.87 15:40:56 INFO - PROCESS | 32718 | Values: 67.0 67.0 68.0 67.0 67.0 67.0 67.0 69.0 68.0 69.0 15:40:56 INFO - PROCESS | 32718 | -------- Summary: end -------- 15:40:56 INFO - PROCESS | 32718 | 15:40:57 INFO - TEST-INFO | 32718: exit 0 15:40:57 INFO - TEST-OK | kraken | took 62975ms 15:40:57 INFO - SUITE-END | took 1181s 15:40:57 INFO - Completed test suite (00:19:41) 15:40:57 INFO - javascript benchmark 15:40:57 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2646.31195889069, 2659.0959073914864, 2692.0577797770784, 2692.5288074586956, 2707.8239914405563, 4677.929831052528, 4721.763911804404, 4740.241561350184, 4829.372181616385, 4871.634627402941, 4760.2383618621025, 4768.403949506312, 4792.257200133985, 4818.108649899771, 4824.228123500241, 4409.559044095581, 4433.312836510346, 4455.73265604064, 4473.507914129443, 4489.551044895517, 4428.689991700582, 4464.352668863013, 4496.887577810565, 4499.48255950565, 4531.4109165808395, 4495.707778994355, 4542.8864278392975, 4555.612772914306, 4562.247229207177, 4577.130345234395, 4256.4679415073115, 4320.4599425071865, 4334.674899382559, 4349.934750978738, 4478.0596074824325, 4359.084592235635, 4364.061726728737, 4371.846985355497, 4403.119376124756, 4405.845795397177, 4825.638077144228, 4825.662203645747, 4833.492483289274, 4844.709317440929, 4844.951550484485, 4966.950330496685, 5035.571976382012, 5104.259882317043, 5106.846794596168, 5150.175971844487, 5184.455632158607, 5201.635885488017, 5203.375594928595, 5209.140491818884, 5220.399654039796, 4784.043191361741, 4791.257355109963, 4825.986542825975, 4832.275158726219, 4835.274708793639, 5114.923276150861, 5228.111221092423, 5281.207818827206, 5283.6037297202865, 5361.410244873061, 5099.821506247264, 5128.0, 5150.0472412603785, 5150.253213284052, 5152.5877929766275, 4966.826161084345, 5168.715720635401, 5179.2749015137915, 5232.2674825524455, 5241.711705856138, 4938.43208031081, 4976.129177393942, 4988.575971042502, 4991.4758950310425, 5012.624053196025, 4973.950260497349, 4979.45226025137, 4983.401991761012, 4986.426560945465, 5031.572316353077, 4287.97856010718, 4319.373690814814, 4327.65378769704, 4338.696291259582, 4390.692651514363, 3818.2745278397015, 3847.788371639531, 3856.9228615428096, 3878.0886491674432, 3885.2423777363706, 4390.780460976938, 4402.625776809007, 4411.647068234533, 4411.669124815651, 4462.464504259509, 5016.322796422436, 5074.340335756402, 5149.510796474329, 5151.712071982004, 5208.6874787512115, 4336.544662810423, 4357.607815296638, 4388.253996820548, 4398.252297109499, 4402.823887044482, 4585.037142200109, 4599.5400459953735, 4601.516840731675, 4609.8156073757345, 4654.767261636973, 4678.578927896506, 4785.473597904228, 4787.569118779326, 4796.136695394723, 4831.444383895827, 5038.470960549236, 5105.7702403391195, 5111.923321150111, 5118.948810511847, 5127.974360128175, 4782.760861956958, 4802.807887684454, 4805.927911081407, 4807.206810876306, 4859.416869975626, 4914.975425122851, 5031.22016087507, 5032.521910418504, 5038.47096054909, 5085.847424577269, 5134.15286477727, 5148.382194136578, 5179.585633149263, 5180.844574662766, 5230.790768369375, 5047.091523525801, 5061.544460998528, 5065.696058236517, 5072.365954255718, 5119.692818430906, 4898.53463920927, 4981.153203955264, 5007.198848184273, 5022.623303252344, 5040.521150490697, 4990.326305948651, 4997.100521906092, 5014.598832093497, 5035.84892453227, 5039.622028347815, 5072.923906141337, 5087.4403815581, 5090.389153301628, 5091.516305950929, 5149.742512874266, 4806.158922188673, 4832.323474713613, 4913.877153071202, 4953.108440480604, 4981.75091245429], "value": 4713.158905654381, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [530.9041873535415, 576.1962062922227, 587.7972099625628, 597.6055803169908, 606.4360145065089, 27677.16968490946, 30652.0, 40385.3942190867, 41532.377014344806, 41639.791801040956, 43019.35470967938, 43346.0, 43359.78320108395, 43406.565934340644, 43410.65893410657, 7813.296803287703, 7942.602869856513, 7944.523328600302, 7951.72168974086, 7955.840883182362, 7561.395088392943, 7623.123340815794, 7649.158592554814, 7651.693932242703, 7653.693852245903, 7641.885371719429, 7689.115751688543, 7695.576743279117, 7698.03774528184, 7698.191689872567, 7594.278543538355, 7608.277213664693, 7648.770536883902, 7651.043619547557, 7659.425543084235, 7817.726379576744, 7910.762677119696, 7917.7624671259955, 7926.24700653437, 7926.841463170762, 39839.20321593552, 40171.19657606861, 40191.59808401937, 40198.0, 40244.0, 3183.363327334542, 3225.4194245035883, 3690.4833323334756, 3694.9261014779822, 3730.421784623388, 30091.247718806986, 30664.386712265852, 30891.536626950612, 30967.535486967714, 30968.0, 3519.102628829632, 3696.9630303696886, 3734.533183352081, 3793.639604237593, 3796.3356412627954, 257988.0, 258838.0, 258916.0, 259019.0, 259640.0, 55033.0, 55518.44481555214, 56019.43980560224, 56024.0, 56035.71982140145, 56590.43409565934, 57061.71469142628, 57101.428985710445, 57197.428025720044, 57237.71381143068, 15169.08985460876, 15381.38474461009, 15384.0, 15384.846151538566, 15395.846041539442, 11559.190856639954, 11604.6518604442, 11637.534498620129, 11640.35978021217, 11648.184627076193, 17074.48776536706, 17526.474205773848, 17615.295388184586, 17675.292988280326, 17693.115344232996, 6184.752609895644, 6233.750649974041, 6346.777862774781, 6494.350564943468, 6552.14822073137, 717.734438257848, 878.3544095090103, 892.6786356911507, 907.3104440625173, 918.6417297254076, 26240.737592624213, 26307.736922630527, 26740.8662956684, 27544.586831197546, 27556.72443275582, 768.8577613141587, 931.897491275959, 945.1257586732245, 945.4705364995624, 976.1800087926176, 14559.088182363357, 15405.691886162214, 15519.922400388152, 16111.597210069842, 16376.590585235226, 393075.0, 395809.0, 396880.0, 397555.0, 397593.0, 50759.49240507621, 50955.49044509581, 51000.0, 51044.23433648424, 51044.74477627588, 1110.7722916802036, 1187.192708957917, 1201.7115892185811, 1220.3593113615245, 1225.9080568957543, 27943.441131176856, 29524.0, 29593.40813183681, 29893.551596725632, 30109.69890301069, 43201.78399107984, 43598.12803743971, 43602.78198608987, 43609.56390436055, 43640.56359436365, 298759.0, 304175.0, 306692.0, 307339.0, 386522.0, 22473.32580022602, 22793.0, 22865.542689146456, 23725.881370593037, 27689.44621107526, 43160.0, 43171.35242971421, 43745.0, 44085.559144408144, 44181.55818441774, 34860.82569587136, 36572.81713591415, 37471.625283747904, 39437.48880351923, 40458.39312410375, 36868.0, 37391.25217495581, 37619.62380376161, 37695.81152094222, 37801.432978505894, 35746.463803043494, 36689.08277293089, 37045.44431833579, 37148.62851371452, 37289.44065839069, 31325.686743132275, 33417.66582334146, 33536.329273414885, 33896.0, 33991.32017359688, 25222.49555008926, 25689.357766055997, 25754.227373178834, 25768.355791105372, 26221.213363599123], "value": 17792.00404646352, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [344.2941968963624, 366.3442438035916, 366.56561974060725, 371.23710774358693, 391.1999960081633, 13329.800052999213, 16737.832621673795, 17168.82831171688, 18204.089795510237, 18225.908870455663, 14395.712085758278, 14620.4882829101, 17622.559436014108, 17646.0, 17646.911765441157, 4545.227311357061, 5169.379674439073, 5350.036993341197, 5357.919631205535, 5358.866028349303, 5225.190095535198, 5278.762455689484, 5288.814891478799, 5299.629025968184, 5303.761330740107, 5259.395169555492, 5390.703511306877, 5690.943090569103, 5702.77188912443, 5764.308283006045, 5425.267588875491, 5663.4336566343245, 5684.261046064026, 5689.374168841424, 5693.971530142364, 5442.482964118402, 5453.590980676465, 5472.097103977879, 5476.315460567429, 5479.397266300703, 12618.432170552256, 12713.809292860615, 12820.807687884597, 12849.807252891214, 13039.087263891532, 1974.2103158736477, 1980.4553747719349, 2222.411061068818, 2267.183813827021, 2376.560336337783, 9519.904800952041, 9550.761230969212, 9603.135717785433, 9936.0, 9939.55272012761, 1750.8511776499013, 1774.547490389955, 1790.7492950986873, 1803.8376546110912, 1875.4373687893715, 72332.0, 75184.24815751828, 75501.62249188774, 75702.24297757063, 76531.23468765296, 8883.289336853037, 9481.09929556691, 10104.191664666809, 10109.29234953561, 10509.84235236472, 12526.498940042296, 13496.730065398637, 13501.864981350258, 13973.79039314411, 14015.50945716895, 5851.824445266649, 7049.365557099885, 7133.92866071343, 7237.565746055254, 7262.2737726228015, 6400.583962042452, 6529.510286728514, 6684.131062961784, 6703.396694297439, 6738.225104112992, 4053.8986525336513, 4212.53662097169, 4378.233809083461, 4411.647068234533, 4531.45622525299, 1762.480068379831, 1763.8324359185856, 1784.6519928614055, 1809.5114319134022, 1827.1229809691422, 845.6532821543261, 894.1505569708803, 905.8143080668447, 918.5590916360051, 929.3494553812359, 17381.478555643353, 18173.0, 18201.635967280847, 18547.629047419246, 18661.346852860086, 826.5660528222732, 837.7193640130503, 842.4987132656059, 859.6690274244336, 864.2869632553169, 9805.2646051545, 10345.896541034494, 10356.689299321033, 10370.792584148425, 10486.0, 399191.0, 399461.0, 403449.0, 406616.0, 406872.0, 80972.0, 82325.17674823175, 82517.0, 82776.0, 84224.0, 882.8322618702426, 904.8642703594513, 915.1489115123, 917.1653795046476, 927.0081013315822, 15924.363025478851, 16081.839181608035, 16251.837481625505, 16314.83007466246, 16421.835781642032, 29478.557821632265, 39142.80428597839, 39718.404223936086, 41119.58880411277, 41154.58845411507, 56064.71967640299, 56194.1570876429, 56226.718866405405, 56552.717236413555, 56678.0, 7572.545647261182, 7596.772096837104, 7653.846923061619, 7763.883541746765, 7930.603469826601, 7820.217978202134, 10928.344299342065, 11214.327140371604, 11516.424178791194, 11998.0, 8506.106858779738, 8803.471791692518, 9288.674896378594, 9448.385854919408, 9818.116369526777, 9609.807803844024, 9668.226541876773, 9958.253131015057, 10049.899501004897, 10195.184385249311, 9292.39599426035, 9709.174720148867, 9735.610575576897, 9738.756531086496, 10226.181905447398, 7242.02232698579, 7277.781666550012, 7354.595497247703, 7362.815929601803, 7386.113666360071, 8844.292456603327, 9789.755256118655, 9879.654212102541, 10000.899991000288, 10115.59537618487], "value": 8146.794783220978, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1209.1294268126946, 1394.8884089272856, 1408.8309402871653, 1504.1877386211447, 1746.9737953930694, 6855.280195579461, 7795.3763698904095, 8018.238267364598, 8019.839603207933, 8283.213094756004, 8055.91944080559, 8100.756977290691, 8143.470674406174, 8157.143499932511, 8170.754877353674, 2202.2952655150357, 2224.7219097612797, 2226.109556177526, 2229.5317983223545, 2231.8884055797143, 2144.0673307111456, 2181.6182168120595, 2182.15986845065, 2184.9781502184933, 2212.5353675728115, 2163.588918105555, 2175.8803265820375, 2181.5309708412688, 2182.334388011656, 2201.2405720026563, 2096.444442222812, 2101.3800928726064, 2103.5372218111993, 2104.3792081335964, 2106.178590349765, 2113.4399384163207, 2158.4927542027613, 2169.078141789733, 2171.0555908179836, 2174.097749433983, 7972.641231144612, 8111.837763244761, 8221.342292616577, 8222.259996600334, 8233.670653173866, 4572.268437050089, 4705.717656940595, 4707.199776038047, 4712.410948631421, 4716.646251531149, 2824.5480723084206, 2879.280179955011, 2931.7361437470518, 2952.335724462, 2957.512010518262, 909.0818273543769, 916.6012784438724, 928.9907100929039, 942.9717108486757, 945.3099237556553, 10811.18916081297, 10883.78232435347, 10932.398718070583, 10966.342019478856, 10968.067714244298, 3836.8848934532007, 4003.6997225208224, 4043.332850079704, 4048.109415928491, 4088.6524645405475, 8666.56667166639, 8713.3464990126, 8713.869291960626, 8724.607392667345, 8736.825263494822, 4522.796474158671, 4524.954750452519, 4532.32015197723, 4538.977305113453, 4544.068465964469, 3804.904877378088, 4137.565555616678, 4190.141021090669, 4193.7903104845245, 4285.849995250213, 3468.6357932417236, 3485.5294535237417, 3546.556680414948, 3574.392353299945, 3591.2458383739186, 1004.9849252261222, 1008.742770593494, 1015.2081376526321, 1025.7692019295748, 1059.95230214639, 724.8695234857671, 804.814892574711, 826.4875777018287, 829.9543525106177, 837.660747397305, 5266.789328426897, 5319.2021196820015, 5486.231927530149, 5498.697571633518, 5534.889302213933, 823.5758584329076, 835.3901651794102, 837.3008537870825, 844.6030365728097, 861.9396642234983, 3599.4420864766003, 3789.5073640427117, 3802.3155831950517, 3876.437916502148, 3902.2195560887935, 9306.53467326631, 9396.67111651089, 9503.619855205714, 9516.666916658021, 9636.277279204087, 9263.212626926652, 9312.394694344846, 9370.203532699798, 9380.765480862896, 9407.576659050223, 7461.253874612496, 7518.699252029857, 7618.6667333216465, 7692.73075442368, 7704.422168337509, 5326.813561525328, 5354.759035843318, 5362.329708786402, 5388.245645609696, 5528.778848846162, 9339.112784285482, 9345.252379809463, 9393.389429687048, 9398.812023759623, 9428.811423771349, 9208.217301529445, 9596.376235544667, 9680.709578712649, 9681.322307438411, 9806.901930980599, 5898.882022359615, 6481.4166724994975, 6542.8364290893105, 7286.198518162892, 7595.962020189863, 7614.771556853303, 7880.05439347282, 7960.3233725131695, 7966.482178658369, 7981.521108733263, 6799.830004249736, 7054.4003759681, 7105.75129870452, 7146.499745017799, 7249.166345870081, 6877.65611719402, 6946.6179360135675, 6960.825979350557, 6984.301569842975, 6993.965030174817, 5809.767609295581, 5987.670678112746, 6012.0, 6122.571420000735, 6146.907796382969, 4448.4439445069365, 4473.5973762360245, 4666.440027196758, 4670.0, 4734.981978874558, 4258.084511829971, 4333.653307735311, 4655.557722016403, 4680.7191568506, 4744.857654270378], "value": 4148.354623683578, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [295.4843797573235, 298.52385445214884, 302.41331816276437, 303.10734885761434, 307.86915560886615, 4908.852734417964, 4918.75406229688, 4921.606271498276, 4957.355543779308, 4970.602351811855, 4816.8554943351755, 4842.467328593852, 4897.412310522734, 4897.951020489794, 4898.412190537131, 3636.345457817592, 3743.7753734776, 3744.2885851688093, 3851.9807400962954, 3883.825227864753, 3824.273388056274, 3861.1891502784447, 3866.9613303867022, 3871.457995880579, 3872.5740168581433, 3637.436197389409, 3840.6927445804267, 3859.4982652255167, 3866.961330386688, 3867.361885288924, 3716.8442303463926, 3835.884923452287, 3848.5574158971795, 3856.5564960029674, 3860.247251785903, 3374.797512149279, 3395.47370157626, 3413.1808365991983, 3422.401079811023, 3430.27964127531, 4732.929006064912, 4751.738654374008, 4755.334253204554, 4767.809287628491, 4784.808607655689, 4244.821783996571, 4366.214081465367, 4374.300111982067, 4384.671149663788, 4414.889627759299, 5023.899522009539, 5039.168537191359, 5048.444671086178, 5052.696838189684, 5061.772220250097, 3732.309522738302, 3748.5689145748315, 3753.70497178473, 3754.7559408638626, 3754.9061273468383, 5179.430262671141, 5281.947180528223, 5310.0, 5331.2003199519995, 5338.492843179892, 3782.0544863784053, 3791.962080379161, 3794.59599948021, 3797.810109494514, 3814.980925095412, 3839.212961342918, 3843.327417701891, 3843.385058390644, 3853.865114720971, 3859.710521710883, 4354.586314300136, 4357.193919124972, 4359.38968544404, 4361.433013708261, 4365.825366985348, 4889.535494128052, 5034.8237811677145, 5045.747712614355, 5046.62150338726, 5054.974725126351, 1311.1215485624655, 1317.4466723975954, 1323.7418703352946, 1324.5761356366063, 1324.9536266230637, 856.3577317012241, 870.4037734152126, 885.1590988560893, 915.5834095486671, 939.6617217801586, 4406.3170208617075, 4452.866414007585, 4471.993801394725, 4477.888052798641, 4495.325701144789, 5100.336956195745, 5127.846164615067, 5132.255822905658, 5137.383513978271, 5175.741212939413, 4337.1249264562175, 4396.318570621559, 4431.889202769957, 4455.0, 4458.2420988431395, 2756.710545392745, 2758.889644414201, 2763.9309017274327, 2768.529350010503, 2780.777537797012, 4849.660523763303, 4901.573721008123, 4910.165271903785, 4918.213085906238, 4921.7785199666105, 5099.36257967754, 5288.550473209821, 5301.727585379558, 5324.787008519694, 5453.6187563710755, 4993.251012348177, 5000.7999680013845, 5009.12340340439, 5025.120603894304, 5027.748612569357, 5272.6836389816735, 5291.365036195527, 5315.760790764502, 5317.946820531745, 5355.196720491957, 4891.584215341736, 5138.409082955508, 5151.433342332415, 5261.289725886956, 5265.89468210626, 4961.206207006861, 4979.875503112306, 4979.975100124476, 4980.651354405301, 4986.476419975996, 3766.981165094157, 3771.830267637908, 3780.2250538640064, 3782.338090834038, 3784.6215378463035, 5079.517445842639, 5254.290670759551, 5266.262723218829, 5312.4156342803035, 5332.093544097435, 5085.694858308513, 5089.312942752681, 5107.591392688651, 5116.386033675983, 5132.10188217068, 5098.133317335987, 5144.331236939323, 5150.278960945546, 5162.225666150108, 5183.352080989876, 4812.855614331575, 4958.305837182726, 5033.0, 5052.418971818288, 5105.361829771278, 4921.917178220929, 4962.280469331999, 5138.794448222029, 5148.794048238028, 5168.328117344721, 5015.17249653803, 5044.319016932667, 5092.363454568179, 5097.133487307093, 5109.821156259513], "value": 3863.8994955291178, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [645.6384424722156, 656.2387630348796, 666.7966270287567, 724.6376811594203, 734.8456824066944, 11220.775584488305, 11509.712257193574, 11538.076953843693, 11666.241694289876, 11673.649790506288, 11275.718107047307, 11454.828177577343, 11485.196036277464, 11513.424328783569, 12465.252084874892, 777.6189667063155, 801.4910531812312, 802.2138304461631, 802.8113393352558, 802.9116797152309, 636.3318515558668, 772.3357912195507, 776.088096486626, 787.5196130360475, 798.0503201190564, 820.3150369441523, 826.6610689617258, 828.3000864269683, 828.8010877389444, 833.1834801894117, 824.418784756751, 824.8102936324649, 824.9175082491763, 824.9587520624004, 825.2078005115096, 486.65690688065183, 579.1573260905373, 589.7051474262869, 608.7777961044231, 611.4252602553586, 12060.939695301468, 12082.516699332104, 12155.756884862341, 12220.450079746433, 12235.388230588524, 10455.529501172465, 11207.495662695199, 11253.820186564906, 11387.943060284728, 11514.078873690085, 11257.605983790529, 11396.80333564972, 11398.0, 11462.713432164179, 11593.01459375954, 4059.7361171523758, 4065.9390109148385, 4096.487939007624, 4161.271777438936, 4209.515905670856, 59742.40257597412, 60327.39672603262, 60787.39212607906, 60816.087758683214, 61025.999999999556, 8979.236764874928, 9088.727338179866, 9349.345545811864, 9435.76410589727, 9578.616855325849, 16784.41254556085, 17143.057131857866, 17151.0, 17151.142442878056, 17185.31258749661, 6326.398992095744, 6545.541812073205, 6677.532572719863, 6753.31357638662, 7116.786496405116, 3735.290294843971, 3765.5104836371097, 3796.259729352805, 3818.0836599215986, 3831.4827498287373, 2781.680106787705, 2830.6461692288462, 2842.090531030092, 2845.928851778681, 2862.270121119101, 508.5575549272157, 511.35058475735605, 520.2560338715597, 522.7412430846755, 529.2696079410389, 508.10826998617927, 595.4521839907296, 610.4292486525113, 618.5082859127004, 629.4901130084646, 7547.773566793005, 7758.3017528422715, 7828.882566761503, 7922.326602238874, 8189.836203275901, 604.4361651002512, 604.9425304596057, 615.9414855588711, 624.257134010526, 636.1602684456566, 3756.511653485084, 3949.229900169497, 4002.3196056670436, 4085.101277718897, 4104.4048612950955, 54144.0, 73198.0, 91333.0, 94657.526712366, 94804.52597736967, 48129.75935120302, 48322.27516587254, 49651.75174124106, 82213.17786822055, 83079.0, 43975.35722605225, 46471.514636402404, 49920.750396247786, 69148.30851691419, 72420.0, 7439.590822504814, 7614.7727385573335, 7725.763877779528, 7828.373730101692, 7896.170902055202, 44763.55236447594, 45100.77449612731, 45140.54859451495, 45595.544044560454, 45872.31191532063, 59657.0, 63883.3611663896, 64641.15191360761, 64863.67568162318, 65262.0, 9444.905550944677, 9451.669191578261, 9452.905470945203, 9593.808123837345, 9991.600335986479, 10492.265541412027, 10552.261341706315, 10628.627998020032, 10762.515686793957, 10953.178511611502, 9400.435973841591, 9627.085426884434, 9630.374025688308, 9804.460754658277, 9883.11052005323, 10279.331843430153, 10534.894651053391, 10782.946085269523, 11138.610148645083, 11406.48670809799, 11247.943760281147, 11779.293242405483, 11791.997680197279, 11915.344656043653, 11935.164538482222, 9402.764930876509, 9792.706218813448, 9808.068233517804, 10102.494875256061, 10487.632932847313, 8236.711715089943, 9183.173514383738, 9276.907230927603, 9586.328956972944, 9781.310139711637], "value": 6237.672201087296, "unit": "score"}], "name": "dromaeo_css", "value": 6393.65939335177, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 114.0, 112.0, 114.0, 113.0, 113.0, 111.0, 113.0, 112.0, 112.0], "value": 111.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 125.0, 130.0, 168.0, 126.0, 124.0, 151.0, 124.0, 193.0, 121.0], "value": 140.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 162.0, 162.0, 161.0, 161.0, 161.0, 162.0, 162.0, 161.0, 163.0], "value": 161.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 77.0, 123.0, 77.0, 76.0, 76.0, 76.0, 100.0, 76.0], "value": 83.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 107.0, 85.0, 86.0, 85.0, 130.0, 85.0, 87.0, 126.0], "value": 96.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 118.0, 118.0, 116.0, 117.0, 118.0, 119.0, 118.0, 118.0], "value": 117.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 146.0, 147.0, 146.0, 147.0, 147.0, 148.0, 147.0, 146.0, 146.0], "value": 146.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 64.0, 63.0, 65.0, 64.0, 63.0, 64.0, 63.0, 63.0], "value": 63.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 66.0, 65.0, 66.0, 65.0, 65.0, 64.0, 65.0, 64.0], "value": 65.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 78.0, 77.0, 77.0, 85.0, 78.0, 88.0, 78.0, 82.0, 78.0], "value": 80.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 128.0, 128.0, 128.0, 130.0, 131.0, 130.0, 136.0, 165.0, 131.0], "value": 133.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 167.0, 169.0, 164.0, 168.0, 168.0, 166.0, 168.0, 166.0, 166.0], "value": 167.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 68.0, 67.0, 67.0, 67.0, 67.0, 69.0, 68.0, 69.0], "value": 67.6, "unit": "score"}], "name": "kraken", "value": 1529.7999999999997, "alertThreshold": 2.0}]} 15:40:57 INFO - Return code: 0 15:40:58 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:40:58 INFO - # TBPL SUCCESS # 15:40:58 INFO - Running post-action listener: _resource_record_post_action 15:40:58 INFO - ##### 15:40:58 INFO - ##### Finished run-tests step (success) 15:40:58 INFO - ##### 15:40:58 INFO - Running post-run listener: _resource_record_post_run 15:40:58 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 4096; Write bytes: 534454272; Read time: 12; Write time: 463080 15:40:58 INFO - TinderboxPrint: CPU usage
13.0% 15:40:58 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 15:40:58 INFO - TinderboxPrint: I/O write bytes / time
534,454,272 / 463,080 15:40:58 INFO - TinderboxPrint: CPU idle
8,321.4 (87.0%) 15:40:58 INFO - TinderboxPrint: CPU user
1,200.8 (12.6%) 15:40:58 INFO - TinderboxPrint: Swap in / out
0 / 0 15:40:58 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 245403648; Read time: 0; Write time: 248688 15:40:58 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 0; Write bytes: 288768000; Read time: 0; Write time: 214368 15:40:58 INFO - Running post-run listener: _upload_blobber_files 15:40:58 INFO - Blob upload gear active. 15:40:58 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:40:58 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 15:40:58 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'] 15:40:58 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 15:40:59 INFO - (blobuploader) - INFO - Open directory for files ... 15:40:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 15:40:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:40:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:40:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 15:40:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:40:59 INFO - (blobuploader) - INFO - Done attempting. 15:40:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 15:40:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:40:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:41:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 15:41:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:41:00 INFO - (blobuploader) - INFO - Done attempting. 15:41:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:41:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:41:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:41:04 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:41:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:41:04 INFO - (blobuploader) - INFO - Done attempting. 15:41:04 INFO - (blobuploader) - INFO - Iteration through files over. 15:41:04 INFO - Return code: 0 15:41:04 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:41:04 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:41:04 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/eb5ff58d181190ceeb6a8aefd262b5b1ac532d398e95514ece00c33294c72296c8419b1db1b15e18ec7f0fbe5cdec6acb8e301bcd377cd2e6909adb1319a8afa", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/f85ee3074d7110cf3f09c93ede64ad1eede733e0b041d0fd1348fa23e8cc0dd1ef0a212843da2303a2cbdd4261dfb492564272692013be05b726a16c28142a69", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/6445522db714258c8f0c9efaefa8b8589829b2620ae2f1aea0797d0a79f6bcf5525466accc9efbdad7b7e823da4518a7dd52df9b0d5a7bdccc70f68bda900cc9"} 15:41:04 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:41:04 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:41:04 INFO - Contents: 15:41:04 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/eb5ff58d181190ceeb6a8aefd262b5b1ac532d398e95514ece00c33294c72296c8419b1db1b15e18ec7f0fbe5cdec6acb8e301bcd377cd2e6909adb1319a8afa", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/f85ee3074d7110cf3f09c93ede64ad1eede733e0b041d0fd1348fa23e8cc0dd1ef0a212843da2303a2cbdd4261dfb492564272692013be05b726a16c28142a69", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/6445522db714258c8f0c9efaefa8b8589829b2620ae2f1aea0797d0a79f6bcf5525466accc9efbdad7b7e823da4518a7dd52df9b0d5a7bdccc70f68bda900cc9"} 15:41:04 INFO - Running post-run listener: copy_logs_to_upload_dir 15:41:04 INFO - Copying logs to upload dir... 15:41:04 INFO - mkdir: /builds/slave/test/build/upload/logs 15:41:04 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.099064 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-06-29 15:41:04.193842) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-29 15:41:04.198436) ========= 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=0333a256a5e4f052382dd180000001b1-1467238605.924074-374481223 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/eb5ff58d181190ceeb6a8aefd262b5b1ac532d398e95514ece00c33294c72296c8419b1db1b15e18ec7f0fbe5cdec6acb8e301bcd377cd2e6909adb1319a8afa", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/f85ee3074d7110cf3f09c93ede64ad1eede733e0b041d0fd1348fa23e8cc0dd1ef0a212843da2303a2cbdd4261dfb492564272692013be05b726a16c28142a69", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/6445522db714258c8f0c9efaefa8b8589829b2620ae2f1aea0797d0a79f6bcf5525466accc9efbdad7b7e823da4518a7dd52df9b0d5a7bdccc70f68bda900cc9"} build_url:https://queue.taskcluster.net/v1/task/UE_RjZ7qQzuA0Sn8V77iHA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011300 build_url: 'https://queue.taskcluster.net/v1/task/UE_RjZ7qQzuA0Sn8V77iHA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/eb5ff58d181190ceeb6a8aefd262b5b1ac532d398e95514ece00c33294c72296c8419b1db1b15e18ec7f0fbe5cdec6acb8e301bcd377cd2e6909adb1319a8afa", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/f85ee3074d7110cf3f09c93ede64ad1eede733e0b041d0fd1348fa23e8cc0dd1ef0a212843da2303a2cbdd4261dfb492564272692013be05b726a16c28142a69", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/6445522db714258c8f0c9efaefa8b8589829b2620ae2f1aea0797d0a79f6bcf5525466accc9efbdad7b7e823da4518a7dd52df9b0d5a7bdccc70f68bda900cc9"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-29 15:41:04.226649) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 15:41:04.226958) ========= 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=0333a256a5e4f052382dd180000001b1-1467238605.924074-374481223 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004415 ========= master_lag: 0.07 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 15:41:04.305831) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-29 15:41:04.309185) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-29 15:41:04.309462) ========= ========= Total master_lag: 0.18 =========