builder: autoland_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-033 starttime: 1468456035.26 results: success (0) buildid: 20160713160841 builduid: 4744716af19b417399409d1164f8501c revision: fa68522872c780d95940a60c83818d66864104e7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-13 17:27:15.260376) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-13 17:27:15.260755) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-13 17:27:15.261075) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-13 17:27:15.305812) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 17:27:15.306067) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1468454512.712890-1328747229 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-13 17:27: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% 49.9M=0s 2016-07-13 17:27:15 (49.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.082100 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 17:27:15.410137) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 17:27:15.410450) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1468454512.712890-1328747229 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017353 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 17:27:15.461200) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 17:27:15.461516) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev fa68522872c780d95940a60c83818d66864104e7 --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 fa68522872c780d95940a60c83818d66864104e7 --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=edae0fb5fee9fb758e8af6d3000002a4-1468454512.712890-1328747229 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-13 17:27:15,474 truncating revision to first 12 chars 2016-07-13 17:27:15,474 Setting DEBUG logging. 2016-07-13 17:27:15,474 attempt 1/10 2016-07-13 17:27:15,474 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/fa68522872c7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-13 17:27:15,766 unpacking tar archive at: autoland-fa68522872c7/testing/mozharness/ program finished with exit code 0 elapsedTime=0.712909 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 17:27:16.193606) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-13 17:27:16.194184) ========= script_repo_revision: fa68522872c780d95940a60c83818d66864104e7 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-13 17:27:16.197458) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-13 17:27:16.198156) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-13 17:27:16.218410) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-07-13 17:27:16.218966) ========= /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=edae0fb5fee9fb758e8af6d3000002a4-1468454512.712890-1328747229 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:27:16 INFO - MultiFileLogger online at 20160713 17:27:16 in /builds/slave/test 17:27: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 17:27:16 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:27:16 INFO - {'append_to_log': False, 17:27:16 INFO - 'base_work_dir': '/builds/slave/test', 17:27:16 INFO - 'blob_upload_branch': 'Autoland-Non-PGO', 17:27:16 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:27:16 INFO - 'branch': 'Autoland-Non-PGO', 17:27:16 INFO - 'buildbot_json_path': 'buildprops.json', 17:27:16 INFO - 'config_files': ('talos/linux_config.py',), 17:27:16 INFO - 'default_actions': ('clobber', 17:27:16 INFO - 'read-buildbot-config', 17:27:16 INFO - 'download-and-extract', 17:27:16 INFO - 'populate-webroot', 17:27:16 INFO - 'create-virtualenv', 17:27:16 INFO - 'install', 17:27:16 INFO - 'run-tests'), 17:27:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:27:16 INFO - 'download_minidump_stackwalk': True, 17:27:16 INFO - 'download_symbols': 'ondemand', 17:27:16 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:27:16 INFO - 'tooltool.py': '/tools/tooltool.py', 17:27:16 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:27:16 INFO - '/tools/misc-python/virtualenv.py')}, 17:27:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:27:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:27:16 INFO - 'installer_path': 'installer.exe', 17:27:16 INFO - 'log_level': 'info', 17:27:16 INFO - 'log_name': 'talos', 17:27:16 INFO - 'log_to_console': True, 17:27:16 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:27:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:27:16 INFO - 'opt_config_files': (), 17:27:16 INFO - 'pip_index': False, 17:27:16 INFO - 'sps_profile': False, 17:27:16 INFO - 'sps_profile_interval': 0, 17:27:16 INFO - 'suite': 'dromaeojs', 17:27:16 INFO - 'system_bits': '32', 17:27:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:27:16 INFO - 'title': 'talos-linux64-ix-033', 17:27:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:27:16 INFO - 'use_talos_json': True, 17:27:16 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:27:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:27:16 INFO - 'work_dir': 'build'} 17:27:16 INFO - ##### 17:27:16 INFO - ##### Running clobber step. 17:27:16 INFO - ##### 17:27:16 INFO - Running pre-action listener: _resource_record_pre_action 17:27:16 INFO - Running main action method: clobber 17:27:16 INFO - rmtree: /builds/slave/test/build 17:27:16 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:27:16 INFO - Running post-action listener: _resource_record_post_action 17:27:16 INFO - ##### 17:27:16 INFO - ##### Finished clobber step (success) 17:27:16 INFO - ##### 17:27:16 INFO - ##### 17:27:16 INFO - ##### Running read-buildbot-config step. 17:27:16 INFO - ##### 17:27:16 INFO - Running pre-action listener: _resource_record_pre_action 17:27:16 INFO - Running main action method: read_buildbot_config 17:27:16 INFO - Using buildbot properties: 17:27:16 INFO - { 17:27:16 INFO - "project": "", 17:27:16 INFO - "product": "firefox", 17:27:16 INFO - "script_repo_revision": "production", 17:27:16 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs", 17:27:16 INFO - "repository": "", 17:27:16 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland talos dromaeojs", 17:27:16 INFO - "buildid": "20160713160841", 17:27:16 INFO - "pgo_build": "False", 17:27:16 INFO - "basedir": "/builds/slave/test", 17:27:16 INFO - "buildnumber": 138, 17:27:16 INFO - "slavename": "talos-linux64-ix-033", 17:27:16 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 17:27:16 INFO - "platform": "ubuntu64_hw", 17:27:16 INFO - "scheduler": "tests-autoland-linux64-talos", 17:27:16 INFO - "branch": "autoland", 17:27:16 INFO - "repo_path": "integration/autoland", 17:27:16 INFO - "revision": "fa68522872c780d95940a60c83818d66864104e7", 17:27:16 INFO - "stage_platform": "linux64", 17:27:16 INFO - "builduid": "4744716af19b417399409d1164f8501c", 17:27:16 INFO - "slavebuilddir": "test" 17:27:16 INFO - } 17:27:16 INFO - Found installer url https://queue.taskcluster.net/v1/task/ACicjUrcQCW01OzNCv9oDw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 17:27:16 INFO - Running post-action listener: _resource_record_post_action 17:27:16 INFO - ##### 17:27:16 INFO - ##### Finished read-buildbot-config step (success) 17:27:16 INFO - ##### 17:27:16 INFO - ##### 17:27:16 INFO - ##### Running download-and-extract step. 17:27:16 INFO - ##### 17:27:16 INFO - Running pre-action listener: _resource_record_pre_action 17:27:16 INFO - Running main action method: download_and_extract 17:27:16 INFO - mkdir: /builds/slave/test/build/tests 17:27: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')]} 17:27:16 INFO - https://queue.taskcluster.net/v1/task/ACicjUrcQCW01OzNCv9oDw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 17:27:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ACicjUrcQCW01OzNCv9oDw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 17:27:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ACicjUrcQCW01OzNCv9oDw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 17:27:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ACicjUrcQCW01OzNCv9oDw/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 17:27:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ACicjUrcQCW01OzNCv9oDw/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 17:27:24 INFO - Downloaded 1361 bytes. 17:27:24 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 17:27:24 INFO - Using the following test package requirements: 17:27:24 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 17:27:24 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:27:24 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 17:27:24 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:27:24 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 17:27:24 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:27:24 INFO - u'jsshell-linux-x86_64.zip'], 17:27:24 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:27:24 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 17:27:24 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 17:27:24 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:27:24 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 17:27:24 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:27:24 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 17:27:24 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:27:24 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 17:27:24 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 17:27:24 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 17:27:24 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:27:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:27:24 INFO - https://queue.taskcluster.net/v1/task/ACicjUrcQCW01OzNCv9oDw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:27:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ACicjUrcQCW01OzNCv9oDw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 17:27:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ACicjUrcQCW01OzNCv9oDw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 17:27:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ACicjUrcQCW01OzNCv9oDw/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 17:27:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ACicjUrcQCW01OzNCv9oDw/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 17:27:30 INFO - Downloaded 22755613 bytes. 17:27:30 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'] 17:27:30 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 17:27:31 INFO - Return code: 0 17:27:31 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 17:27: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')]} 17:27:31 INFO - https://queue.taskcluster.net/v1/task/ACicjUrcQCW01OzNCv9oDw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:27:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ACicjUrcQCW01OzNCv9oDw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 17:27:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ACicjUrcQCW01OzNCv9oDw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 17:27:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ACicjUrcQCW01OzNCv9oDw/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 17:27:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ACicjUrcQCW01OzNCv9oDw/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 17:27:42 INFO - Downloaded 22755613 bytes. 17:27:42 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'] 17:27:42 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 17:27:44 INFO - Return code: 0 17:27:44 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')]} 17:27:44 INFO - https://queue.taskcluster.net/v1/task/ACicjUrcQCW01OzNCv9oDw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 17:27:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ACicjUrcQCW01OzNCv9oDw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 17:27:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ACicjUrcQCW01OzNCv9oDw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 17:27:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ACicjUrcQCW01OzNCv9oDw/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 17:27:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ACicjUrcQCW01OzNCv9oDw/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 17:27:45 INFO - Downloaded 14403317 bytes. 17:27:45 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'] 17:27:45 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 17:27:45 INFO - Return code: 0 17:27: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')]} 17:27:45 INFO - https://queue.taskcluster.net/v1/task/ACicjUrcQCW01OzNCv9oDw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 17:27:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ACicjUrcQCW01OzNCv9oDw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 17:27:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ACicjUrcQCW01OzNCv9oDw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 17:27:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ACicjUrcQCW01OzNCv9oDw/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 17:27:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ACicjUrcQCW01OzNCv9oDw/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 17:27:46 INFO - Downloaded 57048579 bytes. 17:27:46 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ACicjUrcQCW01OzNCv9oDw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 17:27:46 INFO - mkdir: /builds/slave/test/properties 17:27:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:27:46 INFO - Writing to file /builds/slave/test/properties/build_url 17:27:46 INFO - Contents: 17:27:46 INFO - build_url:https://queue.taskcluster.net/v1/task/ACicjUrcQCW01OzNCv9oDw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 17:27:47 INFO - Running post-action listener: _resource_record_post_action 17:27:47 INFO - Running post-action listener: set_extra_try_arguments 17:27:47 INFO - ##### 17:27:47 INFO - ##### Finished download-and-extract step (success) 17:27:47 INFO - ##### 17:27:47 INFO - ##### 17:27:47 INFO - ##### Running populate-webroot step. 17:27:47 INFO - ##### 17:27:47 INFO - Running pre-action listener: _resource_record_pre_action 17:27:47 INFO - Running main action method: populate_webroot 17:27:47 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:27:47 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:27:47 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:27:47 INFO - '--tppagecycles', 17:27:47 INFO - '7'], 17:27:47 INFO - 'tests': ['tsvgm']}}, 17:27:47 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:27:47 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:27:47 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:27:47 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:27:47 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:27:47 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:27:47 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:27:47 INFO - 'talos_options': ['--disable-e10s'], 17:27:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:27:47 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:27:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:27:47 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:27:47 INFO - 'talos_options': ['--disable-e10s'], 17:27:47 INFO - 'tests': ['damp', 'tps']}, 17:27:47 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:27:47 INFO - 'tests': ['damp', 'tps']}, 17:27:47 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:27:47 INFO - 'tests': ['dromaeo_dom']}, 17:27:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:27:47 INFO - 'g4': {'talos_options': ['--disable-e10s'], 17:27:47 INFO - 'tests': ['basic_compositor_video']}, 17:27:47 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 17:27:47 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:27:47 INFO - 'tests': ['a11yr', 17:27:47 INFO - 'ts_paint', 17:27:47 INFO - 'tpaint', 17:27:47 INFO - 'sessionrestore', 17:27:47 INFO - 'sessionrestore_no_auto_restore', 17:27:47 INFO - 'tabpaint']}, 17:27:47 INFO - 'other-e10s': {'tests': ['a11yr', 17:27:47 INFO - 'ts_paint', 17:27:47 INFO - 'tpaint', 17:27:47 INFO - 'sessionrestore', 17:27:47 INFO - 'sessionrestore_no_auto_restore', 17:27:47 INFO - 'tabpaint']}, 17:27:47 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:27:47 INFO - 'ts_paint', 17:27:47 INFO - 'tpaint', 17:27:47 INFO - 'sessionrestore', 17:27:47 INFO - 'sessionrestore_no_auto_restore', 17:27:47 INFO - 'tabpaint']}, 17:27:47 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:27:47 INFO - 'ts_paint', 17:27:47 INFO - 'tpaint', 17:27:47 INFO - 'sessionrestore', 17:27:47 INFO - 'sessionrestore_no_auto_restore', 17:27:47 INFO - 'tabpaint']}, 17:27:47 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:27:47 INFO - 'tests': ['a11yr', 17:27:47 INFO - 'ts_paint', 17:27:47 INFO - 'tpaint', 17:27:47 INFO - 'sessionrestore', 17:27:47 INFO - 'sessionrestore_no_auto_restore', 17:27:47 INFO - 'tabpaint']}, 17:27:47 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:27:47 INFO - 'tests': ['a11yr', 17:27:47 INFO - 'ts_paint', 17:27:47 INFO - 'tpaint', 17:27:47 INFO - 'sessionrestore', 17:27:47 INFO - 'sessionrestore_no_auto_restore', 17:27:47 INFO - 'tabpaint']}, 17:27:47 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:27:47 INFO - 'tests': ['tsvgx', 17:27:47 INFO - 'tsvgr_opacity', 17:27:47 INFO - 'tart', 17:27:47 INFO - 'tscrollx', 17:27:47 INFO - 'cart']}, 17:27:47 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:27:47 INFO - 'tsvgr_opacity', 17:27:47 INFO - 'tart', 17:27:47 INFO - 'tscrollx', 17:27:47 INFO - 'cart']}, 17:27:47 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:27:47 INFO - 'talos_options': ['--disable-e10s'], 17:27:47 INFO - 'tests': ['tp5o']}, 17:27:47 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:27:47 INFO - 'tests': ['tp5o']}, 17:27:47 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:27:47 INFO - 'talos_options': ['--disable-e10s', 17:27:47 INFO - '--xperf_path', 17:27:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:27:47 INFO - 'tests': ['tp5n']}, 17:27:47 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:27:47 INFO - 'talos_options': ['--xperf_path', 17:27:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:27:47 INFO - 'tests': ['tp5n']}}, 17:27:47 INFO - 'talos.zip': {'path': '', 17:27:47 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:27:47 INFO - Running post-action listener: _resource_record_post_action 17:27:47 INFO - ##### 17:27:47 INFO - ##### Finished populate-webroot step (success) 17:27:47 INFO - ##### 17:27:47 INFO - ##### 17:27:47 INFO - ##### Running create-virtualenv step. 17:27:47 INFO - ##### 17:27:47 INFO - Running pre-action listener: _resource_record_pre_action 17:27:47 INFO - Running main action method: create_virtualenv 17:27:47 INFO - Creating virtualenv /builds/slave/test/build/venv 17:27:47 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 17:27:47 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:27:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:27:47 INFO - Using real prefix '/usr' 17:27:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:27:48 INFO - Installing distribute.............................................................................................................................................................................................done. 17:27:50 INFO - Installing pip.................done. 17:27:50 INFO - Return code: 0 17:27:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:27:50 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')]} 17:27:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:27:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:27:50 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')]} 17:27:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:27:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:27:50 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 0xde0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a1180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109f3b0>, '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 0x10a02b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a0740>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1468454512.712890-1328747229', '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 17:27:50 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 17:27:50 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 17:27:50 INFO - Using env: {'DISPLAY': ':0', 17:27:50 INFO - 'HOME': '/home/cltbld', 17:27:50 INFO - 'LANG': 'en_US.UTF-8', 17:27:50 INFO - 'LANGUAGE': 'en_US:en', 17:27:50 INFO - 'LOGNAME': 'cltbld', 17:27:50 INFO - 'MAIL': '/var/mail/cltbld', 17:27:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:27:50 INFO - 'MOZ_NO_REMOTE': '1', 17:27:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:27:50 INFO - 'NO_EM_RESTART': '1', 17:27:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:27:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:27:50 INFO - 'PWD': '/builds/slave/test', 17:27:50 INFO - 'SHELL': '/bin/bash', 17:27:50 INFO - 'SHLVL': '1', 17:27:50 INFO - 'TERM': 'linux', 17:27:50 INFO - 'TMOUT': '86400', 17:27:50 INFO - 'USER': 'cltbld', 17:27:50 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1468454512.712890-1328747229', 17:27:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:27:50 INFO - '_': '/tools/buildbot/bin/python'} 17:27:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:27:50 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 17:27:50 INFO - Cleaning up... 17:27:50 INFO - Return code: 0 17:27:50 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:27:50 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')]} 17:27:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:27:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:27:50 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')]} 17:27:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:27:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:27:50 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 0xde0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a1180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109f3b0>, '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 0x10a02b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a0740>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1468454512.712890-1328747229', '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 17:27:50 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 17:27:50 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 17:27:50 INFO - Using env: {'DISPLAY': ':0', 17:27:50 INFO - 'HOME': '/home/cltbld', 17:27:50 INFO - 'LANG': 'en_US.UTF-8', 17:27:50 INFO - 'LANGUAGE': 'en_US:en', 17:27:50 INFO - 'LOGNAME': 'cltbld', 17:27:50 INFO - 'MAIL': '/var/mail/cltbld', 17:27:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:27:50 INFO - 'MOZ_NO_REMOTE': '1', 17:27:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:27:50 INFO - 'NO_EM_RESTART': '1', 17:27:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:27:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:27:50 INFO - 'PWD': '/builds/slave/test', 17:27:50 INFO - 'SHELL': '/bin/bash', 17:27:50 INFO - 'SHLVL': '1', 17:27:50 INFO - 'TERM': 'linux', 17:27:50 INFO - 'TMOUT': '86400', 17:27:50 INFO - 'USER': 'cltbld', 17:27:50 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1468454512.712890-1328747229', 17:27:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:27:50 INFO - '_': '/tools/buildbot/bin/python'} 17:27:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:27:50 INFO - Downloading/unpacking psutil>=3.1.1 17:27: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 17:27: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 17:27: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 17:27: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 17:27: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 17:27: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 17:27:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:27:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:27:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:27:52 INFO - Installing collected packages: psutil 17:27:52 INFO - Running setup.py install for psutil 17:27:52 INFO - building 'psutil._psutil_linux' extension 17:27:52 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 17:27:52 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 17:27:52 INFO - building 'psutil._psutil_posix' extension 17:27:52 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 17:27:53 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 17:27:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:27:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:27:53 INFO - Successfully installed psutil 17:27:53 INFO - Cleaning up... 17:27:55 INFO - Return code: 0 17:27:55 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:27:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:27:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:27:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:27:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:27:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:27:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:27:55 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 0xde0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a1180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109f3b0>, '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 0x10a02b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a0740>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1468454512.712890-1328747229', '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 17:27:55 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 17:27:55 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 17:27:55 INFO - Using env: {'DISPLAY': ':0', 17:27:55 INFO - 'HOME': '/home/cltbld', 17:27:55 INFO - 'LANG': 'en_US.UTF-8', 17:27:55 INFO - 'LANGUAGE': 'en_US:en', 17:27:55 INFO - 'LOGNAME': 'cltbld', 17:27:55 INFO - 'MAIL': '/var/mail/cltbld', 17:27:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:27:55 INFO - 'MOZ_NO_REMOTE': '1', 17:27:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:27:55 INFO - 'NO_EM_RESTART': '1', 17:27:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:27:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:27:55 INFO - 'PWD': '/builds/slave/test', 17:27:55 INFO - 'SHELL': '/bin/bash', 17:27:55 INFO - 'SHLVL': '1', 17:27:55 INFO - 'TERM': 'linux', 17:27:55 INFO - 'TMOUT': '86400', 17:27:55 INFO - 'USER': 'cltbld', 17:27:55 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1468454512.712890-1328747229', 17:27:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:27:55 INFO - '_': '/tools/buildbot/bin/python'} 17:27:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:27:55 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:27:55 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 17:27:55 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 17:27:55 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 17:27:55 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 17:27:55 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 17:27:55 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 17:27:57 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:27:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:27:57 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:27:57 INFO - Installing collected packages: mozsystemmonitor 17:27:57 INFO - Running setup.py install for mozsystemmonitor 17:27:57 INFO - Successfully installed mozsystemmonitor 17:27:57 INFO - Cleaning up... 17:27:57 INFO - Return code: 0 17:27:57 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:27:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 17:27:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:27:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:27:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 17:27:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:27:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:27:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xde0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a1180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109f3b0>, '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 0x10a02b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a0740>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1468454512.712890-1328747229', '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 17:27:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 17:27:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 17:27:57 INFO - Using env: {'DISPLAY': ':0', 17:27:57 INFO - 'HOME': '/home/cltbld', 17:27:57 INFO - 'LANG': 'en_US.UTF-8', 17:27:57 INFO - 'LANGUAGE': 'en_US:en', 17:27:57 INFO - 'LOGNAME': 'cltbld', 17:27:57 INFO - 'MAIL': '/var/mail/cltbld', 17:27:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:27:57 INFO - 'MOZ_NO_REMOTE': '1', 17:27:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:27:57 INFO - 'NO_EM_RESTART': '1', 17:27:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:27:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:27:57 INFO - 'PWD': '/builds/slave/test', 17:27:57 INFO - 'SHELL': '/bin/bash', 17:27:57 INFO - 'SHLVL': '1', 17:27:57 INFO - 'TERM': 'linux', 17:27:57 INFO - 'TMOUT': '86400', 17:27:57 INFO - 'USER': 'cltbld', 17:27:57 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1468454512.712890-1328747229', 17:27:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:27:57 INFO - '_': '/tools/buildbot/bin/python'} 17:27:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:27:57 INFO - Downloading/unpacking jsonschema==2.5.1 17:27:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:27:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:27:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:27:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:27:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:27:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:27:59 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:27:59 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:27:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:27:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:27:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:27:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:27:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:27:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:27:59 INFO - Downloading functools32-3.2.3-2.tar.gz 17:27:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:27:59 INFO - warning: no files found matching '*.txt' 17:27:59 INFO - no previously-included directories found matching 'build' 17:27:59 INFO - no previously-included directories found matching 'dist' 17:27:59 INFO - no previously-included directories found matching '.git*' 17:27:59 INFO - Installing collected packages: jsonschema, functools32 17:27:59 INFO - Running setup.py install for functools32 17:27:59 INFO - warning: no files found matching '*.txt' 17:27:59 INFO - no previously-included directories found matching 'build' 17:27:59 INFO - no previously-included directories found matching 'dist' 17:27:59 INFO - no previously-included directories found matching '.git*' 17:27:59 INFO - Successfully installed jsonschema functools32 17:27:59 INFO - Cleaning up... 17:28:00 INFO - Return code: 0 17:28:00 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:28:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:28:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:28:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:28:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:28:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:28:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:28:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xde0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a1180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109f3b0>, '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 0x10a02b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a0740>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1468454512.712890-1328747229', '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 17:28:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 17:28:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 17:28:00 INFO - Using env: {'DISPLAY': ':0', 17:28:00 INFO - 'HOME': '/home/cltbld', 17:28:00 INFO - 'LANG': 'en_US.UTF-8', 17:28:00 INFO - 'LANGUAGE': 'en_US:en', 17:28:00 INFO - 'LOGNAME': 'cltbld', 17:28:00 INFO - 'MAIL': '/var/mail/cltbld', 17:28:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:28:00 INFO - 'MOZ_NO_REMOTE': '1', 17:28:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:28:00 INFO - 'NO_EM_RESTART': '1', 17:28:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:28:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:28:00 INFO - 'PWD': '/builds/slave/test', 17:28:00 INFO - 'SHELL': '/bin/bash', 17:28:00 INFO - 'SHLVL': '1', 17:28:00 INFO - 'TERM': 'linux', 17:28:00 INFO - 'TMOUT': '86400', 17:28:00 INFO - 'USER': 'cltbld', 17:28:00 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1468454512.712890-1328747229', 17:28:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:28:00 INFO - '_': '/tools/buildbot/bin/python'} 17:28:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:28:00 INFO - Downloading/unpacking blobuploader==1.2.4 17:28:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:28:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:28:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:28:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:28:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:28:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:28:02 INFO - Downloading blobuploader-1.2.4.tar.gz 17:28:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:28:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:28:02 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 17:28:02 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 17:28:02 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 17:28:02 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 17:28:02 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 17:28:02 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 17:28:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:28:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:28:02 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 17:28:02 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 17:28:02 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 17:28:02 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 17:28:02 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 17:28:02 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 17:28:02 INFO - Downloading docopt-0.6.1.tar.gz 17:28:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:28:03 INFO - Installing collected packages: blobuploader, requests, docopt 17:28:03 INFO - Running setup.py install for blobuploader 17:28:03 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:28:03 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:28:03 INFO - Running setup.py install for requests 17:28:03 INFO - Running setup.py install for docopt 17:28:03 INFO - Successfully installed blobuploader requests docopt 17:28:03 INFO - Cleaning up... 17:28:03 INFO - Return code: 0 17:28:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:28:03 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')]} 17:28:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:28:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:28:03 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')]} 17:28:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:28:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:28:03 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 0xde0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a1180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109f3b0>, '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 0x10a02b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a0740>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1468454512.712890-1328747229', '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 17:28:03 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 17:28:03 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 17:28:03 INFO - Using env: {'DISPLAY': ':0', 17:28:03 INFO - 'HOME': '/home/cltbld', 17:28:03 INFO - 'LANG': 'en_US.UTF-8', 17:28:03 INFO - 'LANGUAGE': 'en_US:en', 17:28:03 INFO - 'LOGNAME': 'cltbld', 17:28:03 INFO - 'MAIL': '/var/mail/cltbld', 17:28:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:28:03 INFO - 'MOZ_NO_REMOTE': '1', 17:28:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:28:03 INFO - 'NO_EM_RESTART': '1', 17:28:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:28:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:28:03 INFO - 'PWD': '/builds/slave/test', 17:28:03 INFO - 'SHELL': '/bin/bash', 17:28:03 INFO - 'SHLVL': '1', 17:28:03 INFO - 'TERM': 'linux', 17:28:03 INFO - 'TMOUT': '86400', 17:28:03 INFO - 'USER': 'cltbld', 17:28:03 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1468454512.712890-1328747229', 17:28:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:28:03 INFO - '_': '/tools/buildbot/bin/python'} 17:28:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:28:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:28:03 INFO - Running setup.py (path:/tmp/pip-T0HYAc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:28:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:28:03 INFO - Running setup.py (path:/tmp/pip-dFBNRV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:28:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:28:03 INFO - Running setup.py (path:/tmp/pip-qFzJDb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:28:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:28:04 INFO - Running setup.py (path:/tmp/pip-_xTpWB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:28:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:28:04 INFO - Running setup.py (path:/tmp/pip-6epQni-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:28:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:28:04 INFO - Running setup.py (path:/tmp/pip-iUR2Gt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:28:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:28:04 INFO - Running setup.py (path:/tmp/pip-CMWUKx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:28:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:28:04 INFO - Running setup.py (path:/tmp/pip-s6Vwbw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:28:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:28:04 INFO - Running setup.py (path:/tmp/pip-0wNvR4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:28:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:28:04 INFO - Running setup.py (path:/tmp/pip-9WEp23-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:28:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:28:04 INFO - Running setup.py (path:/tmp/pip-7g4h2H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:28:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:28:04 INFO - Running setup.py (path:/tmp/pip-r39PVb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:28:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:28:04 INFO - Running setup.py (path:/tmp/pip-dpdEd7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:28:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:28:04 INFO - Running setup.py (path:/tmp/pip-is5Ia2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:28:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:28:04 INFO - Running setup.py (path:/tmp/pip-4iVCHA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:28:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:28:04 INFO - Running setup.py (path:/tmp/pip-zBRFSa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:28:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:28:04 INFO - Running setup.py (path:/tmp/pip-Lmxr0T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:28:05 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:28:05 INFO - Running setup.py install for manifestparser 17:28:05 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:28:05 INFO - Running setup.py install for mozcrash 17:28:05 INFO - Running setup.py install for mozdebug 17:28:05 INFO - Running setup.py install for mozdevice 17:28:05 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:28:05 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:28:05 INFO - Running setup.py install for mozfile 17:28:05 INFO - Running setup.py install for mozhttpd 17:28:05 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:28:05 INFO - Running setup.py install for mozinfo 17:28:05 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:28:05 INFO - Running setup.py install for mozInstall 17:28:05 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:28:05 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:28:05 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:28:05 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:28:05 INFO - Running setup.py install for mozleak 17:28:05 INFO - Running setup.py install for mozlog 17:28:06 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:28:06 INFO - Running setup.py install for moznetwork 17:28:06 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:28:06 INFO - Running setup.py install for mozprocess 17:28:06 INFO - Running setup.py install for mozprofile 17:28:06 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:28:06 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:28:06 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:28:06 INFO - Running setup.py install for mozrunner 17:28:06 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:28:06 INFO - Running setup.py install for mozscreenshot 17:28:06 INFO - Running setup.py install for moztest 17:28:06 INFO - Running setup.py install for mozversion 17:28:06 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:28:06 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:28:06 INFO - Cleaning up... 17:28:06 INFO - Return code: 0 17:28:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:28:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:28:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:28:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:28:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:28:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:28:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:28:06 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 0xde0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a1180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109f3b0>, '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 0x10a02b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a0740>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1468454512.712890-1328747229', '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 17:28:06 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 17:28:06 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 17:28:06 INFO - Using env: {'DISPLAY': ':0', 17:28:06 INFO - 'HOME': '/home/cltbld', 17:28:06 INFO - 'LANG': 'en_US.UTF-8', 17:28:06 INFO - 'LANGUAGE': 'en_US:en', 17:28:06 INFO - 'LOGNAME': 'cltbld', 17:28:06 INFO - 'MAIL': '/var/mail/cltbld', 17:28:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:28:06 INFO - 'MOZ_NO_REMOTE': '1', 17:28:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:28:06 INFO - 'NO_EM_RESTART': '1', 17:28:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:28:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:28:06 INFO - 'PWD': '/builds/slave/test', 17:28:06 INFO - 'SHELL': '/bin/bash', 17:28:06 INFO - 'SHLVL': '1', 17:28:06 INFO - 'TERM': 'linux', 17:28:06 INFO - 'TMOUT': '86400', 17:28:06 INFO - 'USER': 'cltbld', 17:28:06 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1468454512.712890-1328747229', 17:28:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:28:06 INFO - '_': '/tools/buildbot/bin/python'} 17:28:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:28:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:28:07 INFO - Running setup.py (path:/tmp/pip-AMRc5X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:28:07 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)) 17:28:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:28:07 INFO - Running setup.py (path:/tmp/pip-mLHD8t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:28:07 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)) 17:28:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:28:07 INFO - Running setup.py (path:/tmp/pip-v_91nb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:28:07 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)) 17:28:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:28:07 INFO - Running setup.py (path:/tmp/pip-3GukmE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:28:07 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)) 17:28:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:28:07 INFO - Running setup.py (path:/tmp/pip-SOLszt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:28:07 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)) 17:28:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:28:07 INFO - Running setup.py (path:/tmp/pip-0IUNOy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:28:07 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)) 17:28:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:28:07 INFO - Running setup.py (path:/tmp/pip-1H7Jk4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:28:07 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)) 17:28:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:28:07 INFO - Running setup.py (path:/tmp/pip-Fy1i0Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:28:07 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)) 17:28:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:28:07 INFO - Running setup.py (path:/tmp/pip-e4vJbi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:28:07 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)) 17:28:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:28:07 INFO - Running setup.py (path:/tmp/pip-OkybP3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:28:07 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)) 17:28:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:28:07 INFO - Running setup.py (path:/tmp/pip-Q78qhO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:28:07 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)) 17:28:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:28:07 INFO - Running setup.py (path:/tmp/pip-N_IlCp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:28:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 17:28:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:28:07 INFO - Running setup.py (path:/tmp/pip-V5Lf6E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:28:08 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)) 17:28:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:28:08 INFO - Running setup.py (path:/tmp/pip-sgqFWv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:28:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 17:28:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:28:08 INFO - Running setup.py (path:/tmp/pip-mFyO9x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:28:08 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)) 17:28:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:28:08 INFO - Running setup.py (path:/tmp/pip-kTevcn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:28:08 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)) 17:28:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:28:08 INFO - Running setup.py (path:/tmp/pip-45Qjk2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:28:08 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)) 17:28:08 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)) 17:28:08 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)) 17:28:08 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)) 17:28:08 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)) 17:28:08 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)) 17:28:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:28:08 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 17:28:08 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 17:28:08 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 17:28:08 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 17:28:08 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 17:28:08 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 17:28:10 INFO - Downloading blessings-1.6.tar.gz 17:28:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:28:10 INFO - Installing collected packages: blessings 17:28:10 INFO - Running setup.py install for blessings 17:28:10 INFO - Successfully installed blessings 17:28:10 INFO - Cleaning up... 17:28:10 INFO - Return code: 0 17:28:10 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:28:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:28:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:28:10 INFO - Reading from file tmpfile_stdout 17:28:10 INFO - Current package versions: 17:28:10 INFO - argparse == 1.2.1 17:28:10 INFO - blessings == 1.6 17:28:10 INFO - blobuploader == 1.2.4 17:28:10 INFO - docopt == 0.6.1 17:28:10 INFO - functools32 == 3.2.3-2 17:28:10 INFO - jsonschema == 2.5.1 17:28:10 INFO - manifestparser == 1.1 17:28:10 INFO - mozInstall == 1.12 17:28:10 INFO - mozcrash == 0.17 17:28:10 INFO - mozdebug == 0.1 17:28:10 INFO - mozdevice == 0.48 17:28:10 INFO - mozfile == 1.2 17:28:10 INFO - mozhttpd == 0.7 17:28:10 INFO - mozinfo == 0.9 17:28:10 INFO - mozleak == 0.1 17:28:10 INFO - mozlog == 3.2 17:28:10 INFO - moznetwork == 0.27 17:28:10 INFO - mozprocess == 0.23 17:28:10 INFO - mozprofile == 0.28 17:28:10 INFO - mozrunner == 6.12 17:28:10 INFO - mozscreenshot == 0.1 17:28:10 INFO - mozsystemmonitor == 0.3 17:28:10 INFO - moztest == 0.7 17:28:10 INFO - mozversion == 1.4 17:28:10 INFO - psutil == 3.1.1 17:28:10 INFO - requests == 1.2.3 17:28:10 INFO - wsgiref == 0.1.2 17:28:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:28:10 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')]} 17:28:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:28:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:28:10 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')]} 17:28:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:28:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:28:10 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 0xde0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a1180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109f3b0>, '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 0x10a02b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a0740>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1468454512.712890-1328747229', '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 17:28:10 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 17:28:10 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 17:28:10 INFO - Using env: {'DISPLAY': ':0', 17:28:10 INFO - 'HOME': '/home/cltbld', 17:28:10 INFO - 'LANG': 'en_US.UTF-8', 17:28:10 INFO - 'LANGUAGE': 'en_US:en', 17:28:10 INFO - 'LOGNAME': 'cltbld', 17:28:10 INFO - 'MAIL': '/var/mail/cltbld', 17:28:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:28:10 INFO - 'MOZ_NO_REMOTE': '1', 17:28:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:28:10 INFO - 'NO_EM_RESTART': '1', 17:28:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:28:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:28:10 INFO - 'PWD': '/builds/slave/test', 17:28:10 INFO - 'SHELL': '/bin/bash', 17:28:10 INFO - 'SHLVL': '1', 17:28:10 INFO - 'TERM': 'linux', 17:28:10 INFO - 'TMOUT': '86400', 17:28:10 INFO - 'USER': 'cltbld', 17:28:10 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1468454512.712890-1328747229', 17:28:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:28:10 INFO - '_': '/tools/buildbot/bin/python'} 17:28:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:28:10 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)) 17:28:10 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)) 17:28:10 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)) 17:28:10 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)) 17:28:10 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)) 17:28:10 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)) 17:28:10 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)) 17:28:10 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)) 17:28:10 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)) 17:28:10 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)) 17:28:10 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)) 17:28:10 INFO - Cleaning up... 17:28:10 INFO - Return code: 0 17:28:10 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:28:10 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')]} 17:28:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:28:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:28:10 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')]} 17:28:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:28:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:28:10 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 0xde0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf438a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a1180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109f3b0>, '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 0x10a02b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a0740>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1468454512.712890-1328747229', '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 17:28:10 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 17:28:10 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 17:28:10 INFO - Using env: {'DISPLAY': ':0', 17:28:10 INFO - 'HOME': '/home/cltbld', 17:28:10 INFO - 'LANG': 'en_US.UTF-8', 17:28:10 INFO - 'LANGUAGE': 'en_US:en', 17:28:10 INFO - 'LOGNAME': 'cltbld', 17:28:10 INFO - 'MAIL': '/var/mail/cltbld', 17:28:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:28:10 INFO - 'MOZ_NO_REMOTE': '1', 17:28:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:28:10 INFO - 'NO_EM_RESTART': '1', 17:28:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:28:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:28:10 INFO - 'PWD': '/builds/slave/test', 17:28:10 INFO - 'SHELL': '/bin/bash', 17:28:10 INFO - 'SHLVL': '1', 17:28:10 INFO - 'TERM': 'linux', 17:28:10 INFO - 'TMOUT': '86400', 17:28:10 INFO - 'USER': 'cltbld', 17:28:10 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1468454512.712890-1328747229', 17:28:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:28:10 INFO - '_': '/tools/buildbot/bin/python'} 17:28:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:28:11 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:28:11 INFO - Cleaning up... 17:28:11 INFO - Return code: 0 17:28:11 INFO - Running post-action listener: _resource_record_post_action 17:28:11 INFO - Running post-action listener: _start_resource_monitoring 17:28:11 INFO - Starting resource monitoring. 17:28:11 INFO - ##### 17:28:11 INFO - ##### Finished create-virtualenv step (success) 17:28:11 INFO - ##### 17:28:11 INFO - ##### 17:28:11 INFO - ##### Running install step. 17:28:11 INFO - ##### 17:28:11 INFO - Running pre-action listener: _resource_record_pre_action 17:28:11 INFO - Running main action method: install 17:28:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:28:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:28:11 INFO - Reading from file tmpfile_stdout 17:28:11 INFO - Detecting whether we're running mozinstall >=1.0... 17:28:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:28:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:28:11 INFO - Reading from file tmpfile_stdout 17:28:11 INFO - Output received: 17:28:11 INFO - Usage: mozinstall [options] installer 17:28:11 INFO - Options: 17:28:11 INFO - -h, --help show this help message and exit 17:28:11 INFO - -d DEST, --destination=DEST 17:28:11 INFO - Directory to install application into. [default: 17:28:11 INFO - "/builds/slave/test"] 17:28:11 INFO - --app=APP Application being installed. [default: firefox] 17:28:11 INFO - mkdir: /builds/slave/test/build/application 17:28:11 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'] 17:28:11 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 17:28:27 INFO - Reading from file tmpfile_stdout 17:28:27 INFO - Output received: 17:28:27 INFO - /builds/slave/test/build/application/firefox/firefox 17:28:27 INFO - Running post-action listener: _resource_record_post_action 17:28:27 INFO - ##### 17:28:27 INFO - ##### Finished install step (success) 17:28:27 INFO - ##### 17:28:27 INFO - ##### 17:28:27 INFO - ##### Running run-tests step. 17:28:27 INFO - ##### 17:28:27 INFO - Running pre-action listener: _resource_record_pre_action 17:28:27 INFO - Running main action method: run_tests 17:28:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:28:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:28:27 INFO - Python 2.7.3 17:28:27 INFO - Return code: 0 17:28:27 INFO - grabbing minidump binary from tooltool 17:28: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')]} 17:28:27 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 0x109f3b0>, '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 0x10a02b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a0740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:28:27 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 17:28:27 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 17:28:27 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 17:28:27 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:28:27 INFO - Return code: 0 17:28:27 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:28:27 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:28:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:28:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:28:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:28:27 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/ACicjUrcQCW01OzNCv9oDw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-033', '--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 17:28:27 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/ACicjUrcQCW01OzNCv9oDw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-033 --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 17:28:27 INFO - Using env: {'DISPLAY': ':0', 17:28:27 INFO - 'HOME': '/home/cltbld', 17:28:27 INFO - 'LANG': 'en_US.UTF-8', 17:28:27 INFO - 'LANGUAGE': 'en_US:en', 17:28:27 INFO - 'LOGNAME': 'cltbld', 17:28:27 INFO - 'MAIL': '/var/mail/cltbld', 17:28:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:28:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:28:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:28:27 INFO - 'MOZ_NO_REMOTE': '1', 17:28:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:28:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:28:27 INFO - 'NO_EM_RESTART': '1', 17:28:27 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:28:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:28:27 INFO - 'PWD': '/builds/slave/test', 17:28:27 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:28:27 INFO - 'SHELL': '/bin/bash', 17:28:27 INFO - 'SHLVL': '1', 17:28:27 INFO - 'TERM': 'linux', 17:28:27 INFO - 'TMOUT': '86400', 17:28:27 INFO - 'USER': 'cltbld', 17:28:27 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1468454512.712890-1328747229', 17:28:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:28:27 INFO - '_': '/tools/buildbot/bin/python'} 17:28:27 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/ACicjUrcQCW01OzNCv9oDw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-033', '--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 17:28:28 INFO - mozversion application_buildid: 20160713160841 17:28:28 INFO - mozversion application_changeset: fa68522872c780d95940a60c83818d66864104e7 17:28:28 INFO - mozversion application_display_name: Nightly 17:28:28 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:28:28 INFO - mozversion application_name: Firefox 17:28:28 INFO - mozversion application_remotingname: firefox 17:28:28 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 17:28:28 INFO - mozversion application_vendor: Mozilla 17:28:28 INFO - mozversion application_version: 50.0a1 17:28:28 INFO - mozversion platform_buildid: 20160713160841 17:28:28 INFO - mozversion platform_changeset: fa68522872c780d95940a60c83818d66864104e7 17:28:28 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 17:28:28 INFO - mozversion platform_version: 50.0a1 17:28:28 INFO - using testdate: 1468456108 17:28:28 INFO - actual date: 1468456108 17:28:28 INFO - starting webserver on 'localhost:38096' 17:28:28 INFO - SUITE-START | Running 2 tests 17:28:28 INFO - TEST-START | dromaeo_css 17:28:28 INFO - operating with platform_type : linux_ 17:28:28 INFO - Initialising browser for dromaeo_css test... 17:28:28 INFO - TEST-INFO | started process 3930 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbCFcof/profile http://localhost:38096/getInfo.html) 17:28:33 INFO - PROCESS | 3930 | __metrics Screen width/height:1600/1200 17:28:33 INFO - PROCESS | 3930 | colorDepth:24 17:28:33 INFO - PROCESS | 3930 | Browser inner width/height: 1024/697 17:28:33 INFO - PROCESS | 3930 | __metrics 17:28:34 INFO - PROCESS | 3930 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 17:28:34 INFO - PROCESS | 3930 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:28:35 INFO - PROCESS | 3930 | console.error: PushService: 17:28:35 INFO - PROCESS | 3930 | stateChangeProcessEnqueue: Error transitioning state 17:28:35 INFO - PROCESS | 3930 | UnknownError 17:28:35 INFO - TEST-INFO | 3930: exit 0 17:28:35 INFO - Browser initialized. 17:28:35 INFO - Running cycle 1/1 for dromaeo_css test... 17:28:35 INFO - TEST-INFO | started process 4012 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbCFcof/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:28:47 INFO - PROCESS | 4012 | RSS: Main: 158879744 17:28:47 INFO - PROCESS | 4012 | 17:29:38 INFO - PROCESS | 4012 | 1468456178933 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] 17:31:52 INFO - PROCESS | 4012 | Cycle 1(1): loaded http://localhost:38096/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38096/tests/dromaeo/cssquery-ext.html) 17:31:53 INFO - PROCESS | 4012 | RSS: Main: 266575872 17:31:53 INFO - PROCESS | 4012 | 17:34:56 INFO - PROCESS | 4012 | Cycle 1(1): loaded http://localhost:38096/tests/dromaeo/cssquery-ext.html (next: http://localhost:38096/tests/dromaeo/cssquery-jquery.html) 17:34:56 INFO - PROCESS | 4012 | RSS: Main: 237522944 17:34:56 INFO - PROCESS | 4012 | 17:37:58 INFO - PROCESS | 4012 | Cycle 1(1): loaded http://localhost:38096/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38096/tests/dromaeo/cssquery-mootools.html) 17:37:59 INFO - PROCESS | 4012 | RSS: Main: 242135040 17:37:59 INFO - PROCESS | 4012 | 17:41:01 INFO - PROCESS | 4012 | Cycle 1(1): loaded http://localhost:38096/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38096/tests/dromaeo/cssquery-prototype.html) 17:41:02 INFO - PROCESS | 4012 | RSS: Main: 244531200 17:41:02 INFO - PROCESS | 4012 | 17:44:05 INFO - PROCESS | 4012 | Cycle 1(1): loaded http://localhost:38096/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38096/tests/dromaeo/cssquery-yui.html) 17:44:05 INFO - PROCESS | 4012 | RSS: Main: 224489472 17:44:05 INFO - PROCESS | 4012 | 17:47:08 INFO - PROCESS | 4012 | Cycle 1(1): loaded http://localhost:38096/tests/dromaeo/cssquery-yui.html (next: http://localhost:38096/tests/dromaeo/cssquery-dojo.html) 17:47:08 INFO - PROCESS | 4012 | RSS: Main: 279441408 17:47:08 INFO - PROCESS | 4012 | 17:47:08 INFO - PROCESS | 4012 | __start_tp_report 17:47:08 INFO - PROCESS | 4012 | _x_x_mozilla_page_load 17:47:08 INFO - PROCESS | 4012 | _x_x_mozilla_page_load_details 17:47:08 INFO - PROCESS | 4012 | |i|pagename|runs| 17:47:08 INFO - PROCESS | 4012 | |0;dojo.html;2620.882060307287;2627.461370419064;2667.399835037116;2675.879585418656;2675.892964281428;4526.932096018562;4597.5402459754005;4671.4861365249835;4689.906201875965;4737.147313483576;4679.485256621769;4748.786304616292;4760.976195119019;4806.543378379049;4856.902861942759;4258.361245813137;4320.783960801955;4374.321980093091;4428.092241090569;4502.77486125694;4412.294032954728;4452.376667266585;4469.463664360282;4470.843520476784;4482.820687172509;4269.807858646368;4308.18144552534;4309.375140604595;4317.330813723846;4346.087321662455;4340.240457919851;4353.346997950302;4355.194289056503;4355.433793606842;4446.288593825005;4380.0582874682095;4381.4961279452955;4390.121975604892;4422.137683151786;4424.60178583929;4581.587657110843;4639.396878405786;4771.045790841846;4771.66598338113;4833.927491087637;5018.121828679967;5054.7472626368535;5099.056674515226;5106;5111.795528178868;5088.211327244283;5126.256692779526;5129.025485157808;5131.486851314876;5142.665726727751;4582.9541704582525;4681.882952926204;4746.240601503778;4754.334393184957;4792.9281060784115;5165.354330708661;5172.922406163911;5183.948160518422;5233.345831771028;5242.606804489678;4975.004999000214;4991.50084991498;5019.02129084825;5043.949560504421;5047.293378926953;4830.347903033045;4997.450280469146;5020.899582008413;5061.240813877874;5063.341765570526;5008.474110218374;5024.397072351341;5024.648274620741;5029.84910452687;5101.974490127525;5022.221555658879;5026.824061157915;5027.974860125749;5035.320231768737;5038.773255203525;4211.947013246689;4254.957450425518;4259.765712885821;4289.549597292302;4298.699091063596;3699.241655460678;3721.3115573618966;3742.9064273393383;3775.9804852690168;3798.4492248624347;4216.978915105405;4219.38818871262;4220.599043090901;4231.597998190228;4276.5082015568605;4911.16510193268;4963.5780958618925;4965.602751779849;4973.079980203602;5007.899842003139;4250.149970006011;4304.634106100953;4305.203537345601;4310.978445107754;4314.654827613784;4562.954370456319;4567.497575266718;4579.7252164870215;4611.584957353787;4613.6770426070525;4555.658325625525;4719;4726.71639701619;4754.120487709715;4765.833195838268;5036.169032109808;5041.42023667283;5064.518870707277;5068.037072956126;5101;4757.33397324368;4765.142274390504;4767.284907263938;4774.665773395829;4825.300331451849;4787.162246606899;4978.452370239198;5026.698398096126;5030.0945829751;5072.67027643202;5074.492550744896;5081.669691470042;5105.897882042413;5115.769790359517;5153.175491921274;4998.60011199096;5003.874903127451;5015.2978582997675;5016.573591244785;5039.470855560114;4755.667103302736;4846.103470857903;4874.122657921608;4923.753812309442;4977.104121258209;4820.325154478446;4839.1531481991215;4841.419029716316;4888.364512613338;4905.337779399735;4919.950800492093;4929.580985616263;4932.4327702314695;4947.282644016669;4988.2018876980965;4651.697639653412;4823.493533178966;4862.222044473009;4867.732274724783;4886.291487734187 17:47:08 INFO - PROCESS | 4012 | |1;ext.html;566.9737774627922;574.4973148495067;578.5689661202402;578.878435528539;579.1775678536478;27691;39841;41020.17959640805;41292.38061429077;44664.55335446644;41595.79202103993;41870.39425663175;41874.7906260469;41875.371869421906;41932.37101443481;7467.738629147953;7915.366770658348;8042.075161356431;8052.718154864581;8060.355171586259;7435.070616172979;7654.8469030619635;7662.770116896474;10070.395776253412;10324.58701651933;10325.638602648909;10358.326708763943;10382.636607718732;10409.947950260239;10411.375317480937;10199.796004079913;10210.540525676362;10259.69220923366;10293.2280078994;10301.175905927583;7518;9932.851007234898;10259.384436933808;10264.178865690727;10604.469776511143;39001;39261.21477570433;39292;39310.21379572421;39391.8030409849;2975;3031.1058237819675;3035.453618348696;3131.0998685416002;3465.6880880720605;29256.122316330544;29272;29839.70160298391;30430.84784576085;30508.932187373557;2906.6076079729387;2935.5303151495873;2945.837978911159;2977.8064425812468;3043.8173709577495;262761;263519;263948;264329;265123;32030;51485.74257128765;52070.47929520732;52196.73901630544;52379.47620523822;31746.682533174833;33128.1717957053;33195;33657.831710841776;33675.15812104668;13056.281904495345;13221.405036773369;13221.93389033068;13225.933870330588;13237.07340486176;9930.354526955725;10701.83947240792;10754.408507532004;10762.623308184176;10782.191335649857;7627.389808815282;7810.1408845027;7883.172266911892;7968.362530997506;8044.074931382966;3104.068779366181;3117.922051948674;3122.625284965773;3129.0769223079246;3187.1713354527988;872.7687162901836;873.1399571422144;917.2982668258787;931.9394239374419;992.2508506078009;27890.581641275396;28006.159815205578;28273.71726282752;28430.573541396894;28850.71149288522;935.6631612619451;952.4380615436926;954.7756277274835;990.7077412163285;1021.3842995794952;14679.19264440466;15530.844691553166;16678.416255431002;16727.247273872705;17064.008591890088;382288;383523;384935;384975;385170;50892;50996;51143.7442812791;51217.487825122014;51309;1073.1361254190297;1159.1538177130574;1198.5685153344964;1215.5077193736552;1226.7239871029126;27608.447831043668;29697;29842.850785745934;30247;30394.392112158075;42843.57156428396;43219.81362236552;43411;43422;43625;333945;335902;336454;336606;337431;23278.3016509505;24153.63769543423;24717;24875.751242487342;24964.251072467854;40907;41229;41628.37557436701;41818.37272440977;42593.78703106465;35347.29305413826;35528.82235588909;36225.27549449049;36233.45649815202;36245.63754362528;35720.285594288485;35893;36083;36132.81933590315;36250.27499450049;34602.65397346095;35349.82325088461;35469.82265088658;35904.10239744027;35996.46005309975;30544.541831872095;32438.35123297568;32862.34275314528;32981.17547061342;33248.833755832035;24216.87891560531;25123.24630261095;25217.873910631064;25632.48735025252;25663.615045773953 17:47:08 INFO - PROCESS | 4012 | |2;jquery.html;377.2793963529659;378.8711837975089;383.3502213747698;391.6572998626202;392.77611761296055;10052.296339256254;10556.524956376963;10578.947105264462;10594.364338139707;15559.844401555982;17341.566460838487;17699.64600707985;17878;17973;18094.457166285;5482.23248745176;6100.389961003909;6111.2666480022235;6114.144019837204;6119.173911521954;5973.850653733648;6033.125196846455;6033.728482218289;6038.667873266969;6723.327667233287;7089.5037347385705;7198.064251647278;7211.278872112799;7228.674709638052;7240.493165478419;6837.418819400357;7001.509894307401;7010.298970102949;7016.964915175443;7188.568685878864;6559.836004099888;6721.1598550181225;6723.125993620847;6755.594664320157;7033.226345102034;24070.63894041591;24096.156634517884;24163.87918060416;24515.896784644556;24850.751492485026;2031.197676917624;2085.8227050700707;2145.0883374565747;2585.340738111788;2770.570561562961;14061.156330620195;15038.32327545263;15402.306896189699;15487.148206848618;15824.208789560476;1697.855682267009;1745.389113810169;1755.6839768841603;1764.1884733022696;1816.7093265077656;82920.17079829185;86552;87405.56297218536;87838;88385.55807220987;14327.645051194539;16630.916845415697;16817.579560511083;16876;16897.746533802;29713.55429668557;29817.40365192684;30036.849815750782;30059.398812024076;30103.397932041236;8484.957575212207;8868.246199073023;8902.408061055268;8987.101289870961;8996.280297576179;7135.607541585263;7162.212156662763;7194.460415468756;7320.414366850746;7330.413566914634;8314.501129932223;8382.413231073888;8554.657813687383;8562.61468233931;8591.914080859236;3157.3211759471824;3269.395161895057;3305.190228394059;3359.9664003359653;3396.0151556048963;783.6669415498504;820.1962077164412;839.3830534557096;845.361751877341;907.8774365460711;16686.499405017625;17091.743623845654;17477.563060923578;17520.912395437943;17645.911770441067;801.266840840636;820.4011071917533;827.5283088639538;852.3564708645057;854.3464249848871;9622.47076410804;10272.897271027343;10451.529681164366;10747.731306717395;10774.030337269684;359242;369936;371741;371743;376620;82833;84266.57866710627;85905;86388.13611863801;86396.56801716077;894.4365050018447;905.0587389115246;926.5737760630186;941.9529023548795;947.9383840050375;12872.613821585368;15329.313775484465;15829.366825326859;16610.75083873767;17012.914935425244;39068.21863562656;39730.60269397269;39906.2018759629;40403.393949091376;40680.3897941537;45709.54290457053;49053.79406841009;56657.71671141618;58121.4187858116;59004.40995590161;4496.303073023687;4611.423572053493;6582.11141495911;7198.956151357919;7254.709811607477;9082.682106126254;10919.727006824893;11065.502052407823;11184.720381990515;11267.605633803105;9178.265738741018;9329.626814927327;9473;9590.952045240008;10160.593576257163;9344.626214951326;9391.85912211331;9587.18508926749;9962.601495940082;10102.09081182697;9677.75690503124;9753.561089750836;9781.755456113655;9793.608255669978;9947.602095916081;6657.600543967377;6766.830829229309;6875.724971001304;6939.681460522686;7058.153021637231;7348.742794002184;8939.418937769024;9781;9788.706338809847;9978.700638980843 17:47:08 INFO - PROCESS | 4012 | |3;mootools.html;1395.3790563199377;1442.9062110962786;1521.208971334906;1684.9578760530992;1719.4497760716567;7602.543847369155;8001.319887809544;8101.635426405811;8103.756887293376;8104.149064348232;6834.624095674736;7595.240475952402;7767.611619419021;7815.49199302045;7916.683332666701;2187.7374715034216;2202.427368884086;2206.6359050756605;2215.501512159767;2216.7229096362953;2204.1073365287084;2211.3587059752654;2257.525919556895;2258.9435264118447;2261.604219261631;1876.6809642360831;2160.82713382929;2231.2190733243397;2236.329101269621;2247.1573160064977;2139.657654775236;2146.238085479648;2154.2244791874914;2157.9460513487134;2208.580369729746;2188.1466228171025;2191.430228140695;2193.3529608765452;2195.9780402195934;2197.461621902628;7967.083785364699;8002.7199048033035;8004.759857204293;8017.559034253114;8019.077806052321;4515.367848501212;4578.244589642705;4635.46692130406;4640.071985602893;4649.442066951988;2704.91885243443;2756.1731480555954;2855.457463082008;2855.486012517746;2865.126136528358;886.3706768194589;894.3113802372137;897.9820403591957;1533.3100104952816;1577.9289931952974;10994.890051099466;11012.944935275353;11073.557057717762;11076.058535024533;11137.554497820158;3953.7825419601622;3980.482537270136;4137.81379837908;4141.689373297015;4146.771927544014;8518.87221691675;8533;8541.487510749375;8542.060373358925;8543;4435.112977404532;4440.4671439427475;4440.666949978699;4442.111577684412;4442.911141777211;4077.91844163121;4087.1008378157353;4110.856120035784;4111.383292506148;4117.670586353084;3354.496825476198;3396.371671240779;3460.3944309745693;3478.9304213916084;3487.075924879909;963.643451922793;1007.9294449388473;1024.702836177515;1026.296986564206;1028.6245520385005;720.330093013492;757.6287619066728;766.6818270417825;782.978213431466;808.3937047214589;5284.550813180846;5334.51989320963;5343.145096784496;5593.776248950077;5628.465295796893;441.1375760388433;441.2366605772032;443.0562901020805;443.4833419066751;599.7136142973297;3433.210361616842;3687.59436461989;3694.649008344203;3729.7948612826012;3813;9558.187554057844;9858;9875.950620246853;9943.105120539187;9987.051230133126;8755.912440875638;9263.722088337361;9593.040695930351;9594.568244429018;9974.251931105196;7439.107307123071;7486.401087912954;7567.621618919142;7577.242275772379;7596.582187979714;5394.1099718546;5493.368262649847;5509.858202909582;5559.694216818114;5669.461401166883;9129.5891684873;9166.17504424605;9257;9296.07039296092;9300.767480813034;9089;9112.271018318386;9328.860067098864;9330;9331.533423328941;6468;6520.706568204348;6526.869462610816;6526.9020964686515;6539.574927629689;7365.447591430557;7423.480356375002;7425.331720145213;7435.03344565203;7452.776416707507;6339.714712837841;6373.044043393528;6403.423691867754;6704.094947182068;6771.119754431892;6584.736610535525;6792.184937807495;6829.112215412163;6846.657667116525;6956.5478243913985;6423.678816059271;6445.903311450238;6474.1907261592305;6486.805395838132;6492.577982431127;4443.488998765183;4514.954850451585;4570.931436028529;4640.791164397678;4703.176944034849;4469.597736203757;4694.694844835075;4707.035057813208;4764.9047019058735;4774.498677638798 17:47:08 INFO - PROCESS | 4012 | |4;prototype.html;296.19287441721315;298.36001776190074;303.97872148949574;307.0665177859308;309.6903096903097;4855;4861.343718597988;4885.511448855113;4890.559849613534;4906.852794416173;4626.329182268569;4734.976325118379;4768.380110585627;4773.307870358796;4877.317175595419;3694.649008344203;3790.5361515015325;3791.184895247521;3827.3684842001035;3851.557070936836;3808.9428658570146;3811.9428208576755;3834.811208525366;3836.3478208704446;3837.808109594523;3634.1459756957092;3766.8681596144143;3779.9433008504893;3796.316663000659;3818.8472461101524;3741.6071312512204;3763.454299126611;3770.26479836432;3799.25914446683;3816.2939856126704;3333.6499667534804;3344.615369232545;3344.715699165574;3346.1300061983816;3348.7321014318795;4776.80892764289;4790.281457781361;4815.686980346301;4822.95177048232;4847.285520108715;4126.958730412687;4327.7619730914785;4332.653387729006;4338.566143385668;4369.890752731176;5078.085944529983;5089.236614507817;5104.2088476286235;5119.129747942859;5121.206213036985;3645.198056427582;3653.634636536325;3660.6156353583024;3661.7986010769396;3668.3763760160837;5145.871353216162;5322.547583455411;5332.92000619991;5354.812581559666;5366.892662146735;3714.8699795507027;3739.7569158004644;3752.549694036733;3760.9247815043545;3761.736678432538;3794.317022935898;3797.8290976906105;3806.8667596633986;3811.104390468238;3816.637419445148;4356.019895523482;4362.650987920959;4365.4761428628135;4368.257396242647;4376.540463251313;4858.902821943541;5068.730668718729;5074.467180945948;5118.206677964921;5125.384953805567;1228.3305598448867;1288.7873500872438;1303.9022073344538;1303.9739205216033;1304.4390911907972;863.9136086391436;886.1847100667272;890.6615486115364;898.4429653614801;898.5327629632685;4408.9559104408545;4417.889552761142;4443.4445694288215;4465.59809617136;4476.2837945928495;5190.844274671766;5198;5204.297419848348;5217.139172036572;5231.3199284092825;4335.739855608674;4388.166248412791;4404.713693609905;4421.40311058003;4463.575960283768;2712.403271280315;2739.5068887600423;2740.260129764992;2746.4507098580366;2748.780097592228;4850.75746212688;4857.732824694605;4886.413630364308;4892.19278818998;4912.975435122801;5043.293938848564;5276.472352764769;5283.630145889828;5294.100002999499;5314.5748340132695;4821.879453013703;4839.806407743651;4864.927026094682;4867.829625963074;4868.245421959602;5145.382554093383;5163.251328557263;5182.870428239325;5186.351706036746;5188.792448302177;4914.140025495452;5057.898842023213;5070.011347787294;5087;5089.211172268304;4784.258439941815;4801.18379875429;4809.951900480951;4838.612910967185;4842.4673285939225;3690.892732180389;3693.778373297611;3713.7586056906216;3728.198437335986;3735.7011439084263;4965.30485732005;5122.743862806919;5141.562967147835;5152.716600586854;5246.31797866275;4893.241547560134;5006.549410553068;5027.436007636059;5039.319691841554;5040.722760248075;4994.700317980933;5021.949780502295;5041.42023667283;5048.974755126201;5065.240213967934;4724.740139292235;4807.995003123048;4902.607791376753;4931.408231012301;5076.873078173076;5172.482751724798;5173.534381905646;5202.24567437727;5207.661502002509;5212.687238765686;5049;5068.189089745623;5072.51811077947;5092.185250359925;5111.795528178831 17:47:08 INFO - PROCESS | 4012 | |5;yui.html;629.2951893878856;632.4813652804702;655.5804285257435;667.966601669916;686.6944209826629;12871.356432178389;14253.14481131133;14283;14496.565103046925;15019.549413517585;15081.170535620564;15210.315535800888;15228.467003654847;15336.923315383436;15351.155686437241;629.8897692903746;758.5183408535564;768.8462307538487;788.7081779741503;796.6454927557239;788.5426452657445;789.6486063701655;792.3423558446505;795.3239746215728;796.0526972902256;834.0033659776569;834.6869923778584;835.4444294544152;835.9582020898961;836.1847198981005;651.2608189704696;670.0083875863749;671.513152964102;672.9966350168218;827.0530242871909;578.9681567513785;597.799737088076;599.8320470268332;602.1449541650866;602.8342205893371;13225;13269.336533173302;13289.401976911062;13395.598132056053;13401;12135.393230338448;12639.368031598475;12745.553905613258;12785.808212876722;13070.346482675923;10947.890521094767;11302.15233857464;11489.368084755335;11512.424378781028;11950.521979120826;3674.3018826423163;3709.2952339055764;3733.3653278942643;3800.182960663443;3857.035741064734;63140;63380.683096584224;63455.04817427789;64469.35530644727;64753.35246647568;10160;10203.591856325664;10283.331583447052;10328.48357582118;10366.274360794672;17897.642047158984;17939.820601793814;17982.5504362392;18006.279748809902;18123.36568220132;6671.39957403836;6912.274211207851;6917.481188910851;6945.51381403307;7093.680784364716;3581.6418358163974;3586.049696830342;3649.416093425092;3668.3947148720695;3685.2997930393676;2790.9581356279673;2910.3306239565018;2913.7086291371115;2914.519104347801;2914.6210992571255;505.4036237240092;514.3647595219901;514.9922751158736;516.26432333924;541.6506353402112;438.52639149718226;453.71869440946824;467.18942634529066;515.8607176062442;540.586198158627;7731.884021739678;7790.065192176975;7881.911293507225;7911.84176316482;7993.200679932076;445.5588966922788;494.86391242408627;504.29650637360675;516.8681986093598;527.7387693091868;3512.5784905811465;3546.66306700863;3657.642287373339;3663.395539735967;3776.4712940188397;105083;106314;108450;108743;109122.45438772914;92300.07699923048;93734.53132734292;93813;94213;94306.52846735722;80390.5980470094;81880.59059704663;83269.16730832735;83650.58174709209;84582;7052.471064670068;7118.537295075804;7294.671739771829;7313.890291645736;7335.376492998155;41610.375844361755;42745.78627106844;49209.75395123001;49817.75091124521;51776;44190.33714494349;56745.71627142003;65646;66356.33643663501;70636.64681676765;10657.520411581652;10881.238313317992;11104;11358.318500889973;11500.597479088527;12408.131430799758;12476.563320283747;12556.058295628047;12580.87419125797;13151.93424032912;11294.491747871201;11760.647180584596;11914.344711040976;11918.821217681569;11928.224665396721;11782.882171178178;12045.63863084109;12090.15368924202;12392.876071239532;12443;10590.099841513558;10627.787444251226;10656.73358166021;10961.068309193808;11515.53937842477;9207.585658645243;9293.581788819383;9456.952715236379;9542.713718588453;9583.616655333708;9405.905940940504;9636.46999415039;10031.448270345201;10096.798064038825;10161.491925403849 17:47:08 INFO - PROCESS | 4012 | __end_tp_report 17:47:08 INFO - PROCESS | 4012 | __start_cc_report 17:47:08 INFO - PROCESS | 4012 | _x_x_mozilla_cycle_collect,1034 17:47:08 INFO - PROCESS | 4012 | __end_cc_report 17:47:08 INFO - PROCESS | 4012 | __startTimestamp1468457228877__endTimestamp 17:47:08 INFO - PROCESS | 4012 | 17:47:08 INFO - PROCESS | 4012 | ------- Summary: start ------- 17:47:08 INFO - PROCESS | 4012 | Number of tests: 6 17:47:08 INFO - PROCESS | 4012 | 17:47:08 INFO - PROCESS | 4012 | [#0] dojo.html Cycles:165 Average:4670.48 Median:4787.16 stddev:491.27 (10.3%) stddev-sans-first:465.73 17:47:08 INFO - PROCESS | 4012 | Values: 2620.9 2627.5 2667.4 2675.9 2675.9 4526.9 4597.5 4671.5 4689.9 4737.1 4679.5 4748.8 4761.0 4806.5 4856.9 4258.4 4320.8 4374.3 4428.1 4502.8 4412.3 4452.4 4469.5 4470.8 4482.8 4269.8 4308.2 4309.4 4317.3 4346.1 4340.2 4353.3 4355.2 4355.4 4446.3 4380.1 4381.5 4390.1 4422.1 4424.6 4581.6 4639.4 4771.0 4771.7 4833.9 5018.1 5054.7 5099.1 5106.0 5111.8 5088.2 5126.3 5129.0 5131.5 5142.7 4583.0 4681.9 4746.2 4754.3 4792.9 5165.4 5172.9 5183.9 5233.3 5242.6 4975.0 4991.5 5019.0 5043.9 5047.3 4830.3 4997.5 5020.9 5061.2 5063.3 5008.5 5024.4 5024.6 5029.8 5102.0 5022.2 5026.8 5028.0 5035.3 5038.8 4211.9 4255.0 4259.8 4289.5 4298.7 3699.2 3721.3 3742.9 3776.0 3798.4 4217.0 4219.4 4220.6 4231.6 4276.5 4911.2 4963.6 4965.6 4973.1 5007.9 4250.1 4304.6 4305.2 4311.0 4314.7 4563.0 4567.5 4579.7 4611.6 4613.7 4555.7 4719.0 4726.7 4754.1 4765.8 5036.2 5041.4 5064.5 5068.0 5101.0 4757.3 4765.1 4767.3 4774.7 4825.3 4787.2 4978.5 5026.7 5030.1 5072.7 5074.5 5081.7 5105.9 5115.8 5153.2 4998.6 5003.9 5015.3 5016.6 5039.5 4755.7 4846.1 4874.1 4923.8 4977.1 4820.3 4839.2 4841.4 4888.4 4905.3 4920.0 4929.6 4932.4 4947.3 4988.2 4651.7 4823.5 4862.2 4867.7 4886.3 17:47:08 INFO - PROCESS | 4012 | 17:47:08 INFO - PROCESS | 4012 | [#1] ext.html Cycles:180 Average:47387.34 Median:336178.00 stddev:87431.85 (26.0%) stddev-sans-first:87606.45 17:47:08 INFO - PROCESS | 4012 | Values: 567.0 574.5 578.6 578.9 579.2 27691.0 39841.0 41020.2 41292.4 44664.6 41595.8 41870.4 41874.8 41875.4 41932.4 7467.7 7915.4 8042.1 8052.7 8060.4 7435.1 7654.8 7662.8 10070.4 10324.6 10325.6 10358.3 10382.6 10409.9 10411.4 10199.8 10210.5 10259.7 10293.2 10301.2 7518.0 9932.9 10259.4 10264.2 10604.5 39001.0 39261.2 39292.0 39310.2 39391.8 2975.0 3031.1 3035.5 3131.1 3465.7 29256.1 29272.0 29839.7 30430.8 30508.9 2906.6 2935.5 2945.8 2977.8 3043.8 262761.0 263519.0 263948.0 264329.0 265123.0 32030.0 51485.7 52070.5 52196.7 52379.5 31746.7 33128.2 33195.0 33657.8 33675.2 13056.3 13221.4 13221.9 13225.9 13237.1 9930.4 10701.8 10754.4 10762.6 10782.2 7627.4 7810.1 7883.2 7968.4 8044.1 3104.1 3117.9 3122.6 3129.1 3187.2 872.8 873.1 917.3 931.9 992.3 27890.6 28006.2 28273.7 28430.6 28850.7 935.7 952.4 954.8 990.7 1021.4 14679.2 15530.8 16678.4 16727.2 17064.0 382288.0 383523.0 384935.0 384975.0 385170.0 50892.0 50996.0 51143.7 51217.5 51309.0 1073.1 1159.2 1198.6 1215.5 1226.7 27608.4 29697.0 29842.9 30247.0 30394.4 42843.6 43219.8 43411.0 43422.0 43625.0 333945.0 335902.0 336454.0 336606.0 337431.0 23278.3 24153.6 24717.0 24875.8 24964.3 40907.0 41229.0 41628.4 41818.4 42593.8 35347.3 35528.8 36225.3 36233.5 36245.6 35720.3 35893.0 36083.0 36132.8 36250.3 34602.7 35349.8 35469.8 35904.1 35996.5 30544.5 32438.4 32862.3 32981.2 33248.8 24216.9 25123.2 25217.9 25632.5 25663.6 17:47:08 INFO - PROCESS | 4012 | 17:47:08 INFO - PROCESS | 4012 | [#2] jquery.html Cycles:180 Average:25647.55 Median:6036.20 stddev:61752.10 (1023.0%) stddev-sans-first:61896.18 17:47:08 INFO - PROCESS | 4012 | Values: 377.3 378.9 383.4 391.7 392.8 10052.3 10556.5 10578.9 10594.4 15559.8 17341.6 17699.6 17878.0 17973.0 18094.5 5482.2 6100.4 6111.3 6114.1 6119.2 5973.9 6033.1 6033.7 6038.7 6723.3 7089.5 7198.1 7211.3 7228.7 7240.5 6837.4 7001.5 7010.3 7017.0 7188.6 6559.8 6721.2 6723.1 6755.6 7033.2 24070.6 24096.2 24163.9 24515.9 24850.8 2031.2 2085.8 2145.1 2585.3 2770.6 14061.2 15038.3 15402.3 15487.1 15824.2 1697.9 1745.4 1755.7 1764.2 1816.7 82920.2 86552.0 87405.6 87838.0 88385.6 14327.6 16630.9 16817.6 16876.0 16897.7 29713.6 29817.4 30036.8 30059.4 30103.4 8485.0 8868.2 8902.4 8987.1 8996.3 7135.6 7162.2 7194.5 7320.4 7330.4 8314.5 8382.4 8554.7 8562.6 8591.9 3157.3 3269.4 3305.2 3360.0 3396.0 783.7 820.2 839.4 845.4 907.9 16686.5 17091.7 17477.6 17520.9 17645.9 801.3 820.4 827.5 852.4 854.3 9622.5 10272.9 10451.5 10747.7 10774.0 359242.0 369936.0 371741.0 371743.0 376620.0 82833.0 84266.6 85905.0 86388.1 86396.6 894.4 905.1 926.6 942.0 947.9 12872.6 15329.3 15829.4 16610.8 17012.9 39068.2 39730.6 39906.2 40403.4 40680.4 45709.5 49053.8 56657.7 58121.4 59004.4 4496.3 4611.4 6582.1 7199.0 7254.7 9082.7 10919.7 11065.5 11184.7 11267.6 9178.3 9329.6 9473.0 9591.0 10160.6 9344.6 9391.9 9587.2 9962.6 10102.1 9677.8 9753.6 9781.8 9793.6 9947.6 6657.6 6766.8 6875.7 6939.7 7058.2 7348.7 8939.4 9781.0 9788.7 9978.7 17:47:08 INFO - PROCESS | 4012 | 17:47:08 INFO - PROCESS | 4012 | [#3] mootools.html Cycles:180 Average:5150.88 Median:5309.54 stddev:2929.88 (55.2%) stddev-sans-first:2924.51 17:47:08 INFO - PROCESS | 4012 | Values: 1395.4 1442.9 1521.2 1685.0 1719.4 7602.5 8001.3 8101.6 8103.8 8104.1 6834.6 7595.2 7767.6 7815.5 7916.7 2187.7 2202.4 2206.6 2215.5 2216.7 2204.1 2211.4 2257.5 2258.9 2261.6 1876.7 2160.8 2231.2 2236.3 2247.2 2139.7 2146.2 2154.2 2157.9 2208.6 2188.1 2191.4 2193.4 2196.0 2197.5 7967.1 8002.7 8004.8 8017.6 8019.1 4515.4 4578.2 4635.5 4640.1 4649.4 2704.9 2756.2 2855.5 2855.5 2865.1 886.4 894.3 898.0 1533.3 1577.9 10994.9 11012.9 11073.6 11076.1 11137.6 3953.8 3980.5 4137.8 4141.7 4146.8 8518.9 8533.0 8541.5 8542.1 8543.0 4435.1 4440.5 4440.7 4442.1 4442.9 4077.9 4087.1 4110.9 4111.4 4117.7 3354.5 3396.4 3460.4 3478.9 3487.1 963.6 1007.9 1024.7 1026.3 1028.6 720.3 757.6 766.7 783.0 808.4 5284.6 5334.5 5343.1 5593.8 5628.5 441.1 441.2 443.1 443.5 599.7 3433.2 3687.6 3694.6 3729.8 3813.0 9558.2 9858.0 9876.0 9943.1 9987.1 8755.9 9263.7 9593.0 9594.6 9974.3 7439.1 7486.4 7567.6 7577.2 7596.6 5394.1 5493.4 5509.9 5559.7 5669.5 9129.6 9166.2 9257.0 9296.1 9300.8 9089.0 9112.3 9328.9 9330.0 9331.5 6468.0 6520.7 6526.9 6526.9 6539.6 7365.4 7423.5 7425.3 7435.0 7452.8 6339.7 6373.0 6403.4 6704.1 6771.1 6584.7 6792.2 6829.1 6846.7 6956.5 6423.7 6445.9 6474.2 6486.8 6492.6 4443.5 4515.0 4570.9 4640.8 4703.2 4469.6 4694.7 4707.0 4764.9 4774.5 17:47:08 INFO - PROCESS | 4012 | 17:47:08 INFO - PROCESS | 4012 | [#4] prototype.html Cycles:180 Average:4210.69 Median:4812.82 stddev:1212.99 (25.2%) stddev-sans-first:1180.28 17:47:08 INFO - PROCESS | 4012 | Values: 296.2 298.4 304.0 307.1 309.7 4855.0 4861.3 4885.5 4890.6 4906.9 4626.3 4735.0 4768.4 4773.3 4877.3 3694.6 3790.5 3791.2 3827.4 3851.6 3808.9 3811.9 3834.8 3836.3 3837.8 3634.1 3766.9 3779.9 3796.3 3818.8 3741.6 3763.5 3770.3 3799.3 3816.3 3333.6 3344.6 3344.7 3346.1 3348.7 4776.8 4790.3 4815.7 4823.0 4847.3 4127.0 4327.8 4332.7 4338.6 4369.9 5078.1 5089.2 5104.2 5119.1 5121.2 3645.2 3653.6 3660.6 3661.8 3668.4 5145.9 5322.5 5332.9 5354.8 5366.9 3714.9 3739.8 3752.5 3760.9 3761.7 3794.3 3797.8 3806.9 3811.1 3816.6 4356.0 4362.7 4365.5 4368.3 4376.5 4858.9 5068.7 5074.5 5118.2 5125.4 1228.3 1288.8 1303.9 1304.0 1304.4 863.9 886.2 890.7 898.4 898.5 4409.0 4417.9 4443.4 4465.6 4476.3 5190.8 5198.0 5204.3 5217.1 5231.3 4335.7 4388.2 4404.7 4421.4 4463.6 2712.4 2739.5 2740.3 2746.5 2748.8 4850.8 4857.7 4886.4 4892.2 4913.0 5043.3 5276.5 5283.6 5294.1 5314.6 4821.9 4839.8 4864.9 4867.8 4868.2 5145.4 5163.3 5182.9 5186.4 5188.8 4914.1 5057.9 5070.0 5087.0 5089.2 4784.3 4801.2 4810.0 4838.6 4842.5 3690.9 3693.8 3713.8 3728.2 3735.7 4965.3 5122.7 5141.6 5152.7 5246.3 4893.2 5006.5 5027.4 5039.3 5040.7 4994.7 5021.9 5041.4 5049.0 5065.2 4724.7 4808.0 4902.6 4931.4 5076.9 5172.5 5173.5 5202.2 5207.7 5212.7 5049.0 5068.2 5072.5 5092.2 5111.8 17:47:08 INFO - PROCESS | 4012 | 17:47:08 INFO - PROCESS | 4012 | [#5] yui.html Cycles:180 Average:18616.76 Median:22314.43 stddev:27572.29 (123.6%) stddev-sans-first:27616.56 17:47:08 INFO - PROCESS | 4012 | Values: 629.3 632.5 655.6 668.0 686.7 12871.4 14253.1 14283.0 14496.6 15019.5 15081.2 15210.3 15228.5 15336.9 15351.2 629.9 758.5 768.8 788.7 796.6 788.5 789.6 792.3 795.3 796.1 834.0 834.7 835.4 836.0 836.2 651.3 670.0 671.5 673.0 827.1 579.0 597.8 599.8 602.1 602.8 13225.0 13269.3 13289.4 13395.6 13401.0 12135.4 12639.4 12745.6 12785.8 13070.3 10947.9 11302.2 11489.4 11512.4 11950.5 3674.3 3709.3 3733.4 3800.2 3857.0 63140.0 63380.7 63455.0 64469.4 64753.4 10160.0 10203.6 10283.3 10328.5 10366.3 17897.6 17939.8 17982.6 18006.3 18123.4 6671.4 6912.3 6917.5 6945.5 7093.7 3581.6 3586.0 3649.4 3668.4 3685.3 2791.0 2910.3 2913.7 2914.5 2914.6 505.4 514.4 515.0 516.3 541.7 438.5 453.7 467.2 515.9 540.6 7731.9 7790.1 7881.9 7911.8 7993.2 445.6 494.9 504.3 516.9 527.7 3512.6 3546.7 3657.6 3663.4 3776.5 105083.0 106314.0 108450.0 108743.0 109122.5 92300.1 93734.5 93813.0 94213.0 94306.5 80390.6 81880.6 83269.2 83650.6 84582.0 7052.5 7118.5 7294.7 7313.9 7335.4 41610.4 42745.8 49209.8 49817.8 51776.0 44190.3 56745.7 65646.0 66356.3 70636.6 10657.5 10881.2 11104.0 11358.3 11500.6 12408.1 12476.6 12556.1 12580.9 13151.9 11294.5 11760.6 11914.3 11918.8 11928.2 11782.9 12045.6 12090.2 12392.9 12443.0 10590.1 10627.8 10656.7 10961.1 11515.5 9207.6 9293.6 9457.0 9542.7 9583.6 9405.9 9636.5 10031.4 10096.8 10161.5 17:47:08 INFO - PROCESS | 4012 | -------- Summary: end -------- 17:47:08 INFO - PROCESS | 4012 | 17:47:09 INFO - TEST-INFO | 4012: exit 0 17:47:09 INFO - TEST-OK | dromaeo_css | took 1121700ms 17:47:09 INFO - TEST-START | kraken 17:47:09 INFO - operating with platform_type : linux_ 17:47:09 INFO - Initialising browser for kraken test... 17:47:09 INFO - TEST-INFO | started process 4205 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIhhp5O/profile http://localhost:38096/getInfo.html) 17:47:14 INFO - PROCESS | 4205 | __metrics Screen width/height:1600/1200 17:47:14 INFO - PROCESS | 4205 | colorDepth:24 17:47:14 INFO - PROCESS | 4205 | Browser inner width/height: 1024/697 17:47:14 INFO - PROCESS | 4205 | __metrics 17:47:15 INFO - PROCESS | 4205 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 17:47:15 INFO - PROCESS | 4205 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:47:16 INFO - PROCESS | 4205 | console.error: PushService: 17:47:16 INFO - PROCESS | 4205 | stateChangeProcessEnqueue: Error transitioning state 17:47:16 INFO - PROCESS | 4205 | UnknownError 17:47:16 INFO - TEST-INFO | 4205: exit 0 17:47:16 INFO - Browser initialized. 17:47:16 INFO - Running cycle 1/1 for kraken test... 17:47:16 INFO - TEST-INFO | started process 4287 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIhhp5O/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:47:28 INFO - PROCESS | 4287 | RSS: Main: 158752768 17:47:28 INFO - PROCESS | 4287 | 17:47:31 INFO - PROCESS | 4287 | Cycle 1(1): loaded http://localhost:38096/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38096/tests/kraken/driver.html?testName=audio-beat-detection) 17:47:32 INFO - PROCESS | 4287 | RSS: Main: 217415680 17:47:32 INFO - PROCESS | 4287 | 17:47:35 INFO - PROCESS | 4287 | Cycle 1(1): loaded http://localhost:38096/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38096/tests/kraken/driver.html?testName=audio-dft) 17:47:35 INFO - PROCESS | 4287 | RSS: Main: 205111296 17:47:35 INFO - PROCESS | 4287 | 17:47:38 INFO - PROCESS | 4287 | Cycle 1(1): loaded http://localhost:38096/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38096/tests/kraken/driver.html?testName=audio-fft) 17:47:39 INFO - PROCESS | 4287 | RSS: Main: 271327232 17:47:39 INFO - PROCESS | 4287 | 17:47:41 INFO - PROCESS | 4287 | Cycle 1(1): loaded http://localhost:38096/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38096/tests/kraken/driver.html?testName=audio-oscillator) 17:47:42 INFO - PROCESS | 4287 | RSS: Main: 181997568 17:47:42 INFO - PROCESS | 4287 | 17:47:44 INFO - PROCESS | 4287 | Cycle 1(1): loaded http://localhost:38096/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38096/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:47:45 INFO - PROCESS | 4287 | RSS: Main: 185847808 17:47:45 INFO - PROCESS | 4287 | 17:47:48 INFO - PROCESS | 4287 | Cycle 1(1): loaded http://localhost:38096/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38096/tests/kraken/driver.html?testName=imaging-darkroom) 17:47:48 INFO - PROCESS | 4287 | RSS: Main: 221913088 17:47:48 INFO - PROCESS | 4287 | 17:47:52 INFO - PROCESS | 4287 | Cycle 1(1): loaded http://localhost:38096/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38096/tests/kraken/driver.html?testName=imaging-desaturate) 17:47:52 INFO - PROCESS | 4287 | RSS: Main: 217219072 17:47:52 INFO - PROCESS | 4287 | 17:47:55 INFO - PROCESS | 4287 | Cycle 1(1): loaded http://localhost:38096/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38096/tests/kraken/driver.html?testName=json-parse-financial) 17:47:56 INFO - PROCESS | 4287 | RSS: Main: 220303360 17:47:56 INFO - PROCESS | 4287 | 17:47:58 INFO - PROCESS | 4287 | Cycle 1(1): loaded http://localhost:38096/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38096/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:47:58 INFO - PROCESS | 4287 | RSS: Main: 207495168 17:47:58 INFO - PROCESS | 4287 | 17:48:00 INFO - PROCESS | 4287 | Cycle 1(1): loaded http://localhost:38096/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38096/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:48:01 INFO - PROCESS | 4287 | RSS: Main: 211718144 17:48:01 INFO - PROCESS | 4287 | 17:48:03 INFO - PROCESS | 4287 | Cycle 1(1): loaded http://localhost:38096/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38096/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:48:04 INFO - PROCESS | 4287 | RSS: Main: 209780736 17:48:04 INFO - PROCESS | 4287 | 17:48:06 INFO - PROCESS | 4287 | Cycle 1(1): loaded http://localhost:38096/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38096/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:48:07 INFO - PROCESS | 4287 | RSS: Main: 224022528 17:48:07 INFO - PROCESS | 4287 | 17:48:10 INFO - PROCESS | 4287 | Cycle 1(1): loaded http://localhost:38096/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38096/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:48:10 INFO - PROCESS | 4287 | RSS: Main: 223350784 17:48:10 INFO - PROCESS | 4287 | 17:48:12 INFO - PROCESS | 4287 | Cycle 1(1): loaded http://localhost:38096/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38096/tests/kraken/driver.html?testName=ai-astar) 17:48:12 INFO - PROCESS | 4287 | RSS: Main: 266059776 17:48:12 INFO - PROCESS | 4287 | 17:48:12 INFO - PROCESS | 4287 | __start_tp_report 17:48:12 INFO - PROCESS | 4287 | _x_x_mozilla_page_load 17:48:12 INFO - PROCESS | 4287 | _x_x_mozilla_page_load_details 17:48:12 INFO - PROCESS | 4287 | |i|pagename|runs| 17:48:12 INFO - PROCESS | 4287 | |0;ai-astar;104;114;113;113;113;113;113;112;114;113 17:48:12 INFO - PROCESS | 4287 | |1;audio-beat-detection;155;122;122;175;124;124;152;122;152;128 17:48:12 INFO - PROCESS | 4287 | |2;audio-dft;161;162;160;159;161;160;161;162;163;162 17:48:12 INFO - PROCESS | 4287 | |3;audio-fft;75;74;76;127;78;77;76;75;100;76 17:48:12 INFO - PROCESS | 4287 | |4;audio-oscillator;84;85;112;85;86;85;115;86;87;129 17:48:12 INFO - PROCESS | 4287 | |5;imaging-gaussian-blur;116;117;117;117;117;117;117;117;117;117 17:48:12 INFO - PROCESS | 4287 | |6;imaging-darkroom;147;147;147;147;147;147;146;146;147;147 17:48:12 INFO - PROCESS | 4287 | |7;imaging-desaturate;94;95;95;96;95;95;94;95;95;95 17:48:12 INFO - PROCESS | 4287 | |8;json-parse-financial;66;66;66;65;66;65;66;65;66;66 17:48:12 INFO - PROCESS | 4287 | |9;json-stringify-tinderbox;65;66;66;66;65;65;66;66;66;66 17:48:12 INFO - PROCESS | 4287 | |10;stanford-crypto-aes;79;78;84;78;78;79;77;79;78;87 17:48:12 INFO - PROCESS | 4287 | |11;stanford-crypto-ccm;139;128;129;128;129;129;137;126;183;129 17:48:12 INFO - PROCESS | 4287 | |12;stanford-crypto-pbkdf2;169;167;165;166;168;165;162;168;167;162 17:48:12 INFO - PROCESS | 4287 | |13;stanford-crypto-sha256-iterative;66;66;66;68;67;68;65;67;68;66 17:48:12 INFO - PROCESS | 4287 | __end_tp_report 17:48:12 INFO - PROCESS | 4287 | __start_cc_report 17:48:12 INFO - PROCESS | 4287 | _x_x_mozilla_cycle_collect,1917 17:48:12 INFO - PROCESS | 4287 | __end_cc_report 17:48:12 INFO - PROCESS | 4287 | __startTimestamp1468457292801__endTimestamp 17:48:12 INFO - PROCESS | 4287 | 17:48:12 INFO - PROCESS | 4287 | ------- Summary: start ------- 17:48:12 INFO - PROCESS | 4287 | Number of tests: 14 17:48:12 INFO - PROCESS | 4287 | 17:48:12 INFO - PROCESS | 4287 | [#0] ai-astar Cycles:10 Average:112.20 Median:113.00 stddev:2.94 (2.6%) stddev-sans-first:0.60 17:48:12 INFO - PROCESS | 4287 | Values: 104.0 114.0 113.0 113.0 113.0 113.0 113.0 112.0 114.0 113.0 17:48:12 INFO - PROCESS | 4287 | 17:48:12 INFO - PROCESS | 4287 | [#1] audio-beat-detection Cycles:10 Average:137.60 Median:140.00 stddev:19.17 (13.7%) stddev-sans-first:19.27 17:48:12 INFO - PROCESS | 4287 | Values: 155.0 122.0 122.0 175.0 124.0 124.0 152.0 122.0 152.0 128.0 17:48:12 INFO - PROCESS | 4287 | 17:48:12 INFO - PROCESS | 4287 | [#2] audio-dft Cycles:10 Average:161.10 Median:161.50 stddev:1.20 (0.7%) stddev-sans-first:1.27 17:48:12 INFO - PROCESS | 4287 | Values: 161.0 162.0 160.0 159.0 161.0 160.0 161.0 162.0 163.0 162.0 17:48:12 INFO - PROCESS | 4287 | 17:48:12 INFO - PROCESS | 4287 | [#3] audio-fft Cycles:10 Average:83.40 Median:76.00 stddev:17.13 (22.5%) stddev-sans-first:17.90 17:48:12 INFO - PROCESS | 4287 | Values: 75.0 74.0 76.0 127.0 78.0 77.0 76.0 75.0 100.0 76.0 17:48:12 INFO - PROCESS | 4287 | 17:48:12 INFO - PROCESS | 4287 | [#4] audio-oscillator Cycles:10 Average:95.40 Median:85.00 stddev:16.63 (19.6%) stddev-sans-first:17.12 17:48:12 INFO - PROCESS | 4287 | Values: 84.0 85.0 112.0 85.0 86.0 85.0 115.0 86.0 87.0 129.0 17:48:12 INFO - PROCESS | 4287 | 17:48:12 INFO - PROCESS | 4287 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.00 17:48:12 INFO - PROCESS | 4287 | Values: 116.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 17:48:12 INFO - PROCESS | 4287 | 17:48:12 INFO - PROCESS | 4287 | [#6] imaging-darkroom Cycles:10 Average:146.80 Median:147.00 stddev:0.42 (0.3%) stddev-sans-first:0.44 17:48:12 INFO - PROCESS | 4287 | Values: 147.0 147.0 147.0 147.0 147.0 147.0 146.0 146.0 147.0 147.0 17:48:12 INFO - PROCESS | 4287 | 17:48:12 INFO - PROCESS | 4287 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.50 17:48:12 INFO - PROCESS | 4287 | Values: 94.0 95.0 95.0 96.0 95.0 95.0 94.0 95.0 95.0 95.0 17:48:12 INFO - PROCESS | 4287 | 17:48:12 INFO - PROCESS | 4287 | [#8] json-parse-financial Cycles:10 Average:65.70 Median:66.00 stddev:0.48 (0.7%) stddev-sans-first:0.50 17:48:12 INFO - PROCESS | 4287 | Values: 66.0 66.0 66.0 65.0 66.0 65.0 66.0 65.0 66.0 66.0 17:48:12 INFO - PROCESS | 4287 | 17:48:12 INFO - PROCESS | 4287 | [#9] json-stringify-tinderbox Cycles:10 Average:65.70 Median:66.00 stddev:0.48 (0.7%) stddev-sans-first:0.44 17:48:12 INFO - PROCESS | 4287 | Values: 65.0 66.0 66.0 66.0 65.0 65.0 66.0 66.0 66.0 66.0 17:48:12 INFO - PROCESS | 4287 | 17:48:12 INFO - PROCESS | 4287 | [#10] stanford-crypto-aes Cycles:10 Average:79.70 Median:79.00 stddev:3.20 (4.0%) stddev-sans-first:3.38 17:48:12 INFO - PROCESS | 4287 | Values: 79.0 78.0 84.0 78.0 78.0 79.0 77.0 79.0 78.0 87.0 17:48:12 INFO - PROCESS | 4287 | 17:48:12 INFO - PROCESS | 4287 | [#11] stanford-crypto-ccm Cycles:10 Average:135.70 Median:129.00 stddev:17.13 (13.3%) stddev-sans-first:18.13 17:48:12 INFO - PROCESS | 4287 | Values: 139.0 128.0 129.0 128.0 129.0 129.0 137.0 126.0 183.0 129.0 17:48:12 INFO - PROCESS | 4287 | 17:48:12 INFO - PROCESS | 4287 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.90 Median:167.00 stddev:2.42 (1.5%) stddev-sans-first:2.30 17:48:12 INFO - PROCESS | 4287 | Values: 169.0 167.0 165.0 166.0 168.0 165.0 162.0 168.0 167.0 162.0 17:48:12 INFO - PROCESS | 4287 | 17:48:12 INFO - PROCESS | 4287 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.70 Median:67.00 stddev:1.06 (1.6%) stddev-sans-first:1.09 17:48:12 INFO - PROCESS | 4287 | Values: 66.0 66.0 66.0 68.0 67.0 68.0 65.0 67.0 68.0 66.0 17:48:12 INFO - PROCESS | 4287 | -------- Summary: end -------- 17:48:12 INFO - PROCESS | 4287 | 17:48:13 INFO - TEST-INFO | 4287: exit 0 17:48:13 INFO - TEST-OK | kraken | took 64254ms 17:48:13 INFO - SUITE-END | took 1185s 17:48:14 INFO - Completed test suite (00:19:46) 17:48:14 INFO - javascript benchmark 17:48:14 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2620.882060307287, 2627.461370419064, 2667.399835037116, 2675.879585418656, 2675.892964281428, 4526.932096018562, 4597.5402459754005, 4671.4861365249835, 4689.906201875965, 4737.147313483576, 4679.485256621769, 4748.786304616292, 4760.976195119019, 4806.543378379049, 4856.902861942759, 4258.361245813137, 4320.783960801955, 4374.321980093091, 4428.092241090569, 4502.77486125694, 4412.294032954728, 4452.376667266585, 4469.463664360282, 4470.843520476784, 4482.820687172509, 4269.807858646368, 4308.18144552534, 4309.375140604595, 4317.330813723846, 4346.087321662455, 4340.240457919851, 4353.346997950302, 4355.194289056503, 4355.433793606842, 4446.288593825005, 4380.0582874682095, 4381.4961279452955, 4390.121975604892, 4422.137683151786, 4424.60178583929, 4581.587657110843, 4639.396878405786, 4771.045790841846, 4771.66598338113, 4833.927491087637, 5018.121828679967, 5054.7472626368535, 5099.056674515226, 5106.0, 5111.795528178868, 5088.211327244283, 5126.256692779526, 5129.025485157808, 5131.486851314876, 5142.665726727751, 4582.9541704582525, 4681.882952926204, 4746.240601503778, 4754.334393184957, 4792.9281060784115, 5165.354330708661, 5172.922406163911, 5183.948160518422, 5233.345831771028, 5242.606804489678, 4975.004999000214, 4991.50084991498, 5019.02129084825, 5043.949560504421, 5047.293378926953, 4830.347903033045, 4997.450280469146, 5020.899582008413, 5061.240813877874, 5063.341765570526, 5008.474110218374, 5024.397072351341, 5024.648274620741, 5029.84910452687, 5101.974490127525, 5022.221555658879, 5026.824061157915, 5027.974860125749, 5035.320231768737, 5038.773255203525, 4211.947013246689, 4254.957450425518, 4259.765712885821, 4289.549597292302, 4298.699091063596, 3699.241655460678, 3721.3115573618966, 3742.9064273393383, 3775.9804852690168, 3798.4492248624347, 4216.978915105405, 4219.38818871262, 4220.599043090901, 4231.597998190228, 4276.5082015568605, 4911.16510193268, 4963.5780958618925, 4965.602751779849, 4973.079980203602, 5007.899842003139, 4250.149970006011, 4304.634106100953, 4305.203537345601, 4310.978445107754, 4314.654827613784, 4562.954370456319, 4567.497575266718, 4579.7252164870215, 4611.584957353787, 4613.6770426070525, 4555.658325625525, 4719.0, 4726.71639701619, 4754.120487709715, 4765.833195838268, 5036.169032109808, 5041.42023667283, 5064.518870707277, 5068.037072956126, 5101.0, 4757.33397324368, 4765.142274390504, 4767.284907263938, 4774.665773395829, 4825.300331451849, 4787.162246606899, 4978.452370239198, 5026.698398096126, 5030.0945829751, 5072.67027643202, 5074.492550744896, 5081.669691470042, 5105.897882042413, 5115.769790359517, 5153.175491921274, 4998.60011199096, 5003.874903127451, 5015.2978582997675, 5016.573591244785, 5039.470855560114, 4755.667103302736, 4846.103470857903, 4874.122657921608, 4923.753812309442, 4977.104121258209, 4820.325154478446, 4839.1531481991215, 4841.419029716316, 4888.364512613338, 4905.337779399735, 4919.950800492093, 4929.580985616263, 4932.4327702314695, 4947.282644016669, 4988.2018876980965, 4651.697639653412, 4823.493533178966, 4862.222044473009, 4867.732274724783, 4886.291487734187], "value": 4639.2236780661715, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [566.9737774627922, 574.4973148495067, 578.5689661202402, 578.878435528539, 579.1775678536478, 27691.0, 39841.0, 41020.17959640805, 41292.38061429077, 44664.55335446644, 41595.79202103993, 41870.39425663175, 41874.7906260469, 41875.371869421906, 41932.37101443481, 7467.738629147953, 7915.366770658348, 8042.075161356431, 8052.718154864581, 8060.355171586259, 7435.070616172979, 7654.8469030619635, 7662.770116896474, 10070.395776253412, 10324.58701651933, 10325.638602648909, 10358.326708763943, 10382.636607718732, 10409.947950260239, 10411.375317480937, 10199.796004079913, 10210.540525676362, 10259.69220923366, 10293.2280078994, 10301.175905927583, 7518.0, 9932.851007234898, 10259.384436933808, 10264.178865690727, 10604.469776511143, 39001.0, 39261.21477570433, 39292.0, 39310.21379572421, 39391.8030409849, 2975.0, 3031.1058237819675, 3035.453618348696, 3131.0998685416002, 3465.6880880720605, 29256.122316330544, 29272.0, 29839.70160298391, 30430.84784576085, 30508.932187373557, 2906.6076079729387, 2935.5303151495873, 2945.837978911159, 2977.8064425812468, 3043.8173709577495, 262761.0, 263519.0, 263948.0, 264329.0, 265123.0, 32030.0, 51485.74257128765, 52070.47929520732, 52196.73901630544, 52379.47620523822, 31746.682533174833, 33128.1717957053, 33195.0, 33657.831710841776, 33675.15812104668, 13056.281904495345, 13221.405036773369, 13221.93389033068, 13225.933870330588, 13237.07340486176, 9930.354526955725, 10701.83947240792, 10754.408507532004, 10762.623308184176, 10782.191335649857, 7627.389808815282, 7810.1408845027, 7883.172266911892, 7968.362530997506, 8044.074931382966, 3104.068779366181, 3117.922051948674, 3122.625284965773, 3129.0769223079246, 3187.1713354527988, 872.7687162901836, 873.1399571422144, 917.2982668258787, 931.9394239374419, 992.2508506078009, 27890.581641275396, 28006.159815205578, 28273.71726282752, 28430.573541396894, 28850.71149288522, 935.6631612619451, 952.4380615436926, 954.7756277274835, 990.7077412163285, 1021.3842995794952, 14679.19264440466, 15530.844691553166, 16678.416255431002, 16727.247273872705, 17064.008591890088, 382288.0, 383523.0, 384935.0, 384975.0, 385170.0, 50892.0, 50996.0, 51143.7442812791, 51217.487825122014, 51309.0, 1073.1361254190297, 1159.1538177130574, 1198.5685153344964, 1215.5077193736552, 1226.7239871029126, 27608.447831043668, 29697.0, 29842.850785745934, 30247.0, 30394.392112158075, 42843.57156428396, 43219.81362236552, 43411.0, 43422.0, 43625.0, 333945.0, 335902.0, 336454.0, 336606.0, 337431.0, 23278.3016509505, 24153.63769543423, 24717.0, 24875.751242487342, 24964.251072467854, 40907.0, 41229.0, 41628.37557436701, 41818.37272440977, 42593.78703106465, 35347.29305413826, 35528.82235588909, 36225.27549449049, 36233.45649815202, 36245.63754362528, 35720.285594288485, 35893.0, 36083.0, 36132.81933590315, 36250.27499450049, 34602.65397346095, 35349.82325088461, 35469.82265088658, 35904.10239744027, 35996.46005309975, 30544.541831872095, 32438.35123297568, 32862.34275314528, 32981.17547061342, 33248.833755832035, 24216.87891560531, 25123.24630261095, 25217.873910631064, 25632.48735025252, 25663.615045773953], "value": 16899.141950194396, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [377.2793963529659, 378.8711837975089, 383.3502213747698, 391.6572998626202, 392.77611761296055, 10052.296339256254, 10556.524956376963, 10578.947105264462, 10594.364338139707, 15559.844401555982, 17341.566460838487, 17699.64600707985, 17878.0, 17973.0, 18094.457166285, 5482.23248745176, 6100.389961003909, 6111.2666480022235, 6114.144019837204, 6119.173911521954, 5973.850653733648, 6033.125196846455, 6033.728482218289, 6038.667873266969, 6723.327667233287, 7089.5037347385705, 7198.064251647278, 7211.278872112799, 7228.674709638052, 7240.493165478419, 6837.418819400357, 7001.509894307401, 7010.298970102949, 7016.964915175443, 7188.568685878864, 6559.836004099888, 6721.1598550181225, 6723.125993620847, 6755.594664320157, 7033.226345102034, 24070.63894041591, 24096.156634517884, 24163.87918060416, 24515.896784644556, 24850.751492485026, 2031.197676917624, 2085.8227050700707, 2145.0883374565747, 2585.340738111788, 2770.570561562961, 14061.156330620195, 15038.32327545263, 15402.306896189699, 15487.148206848618, 15824.208789560476, 1697.855682267009, 1745.389113810169, 1755.6839768841603, 1764.1884733022696, 1816.7093265077656, 82920.17079829185, 86552.0, 87405.56297218536, 87838.0, 88385.55807220987, 14327.645051194539, 16630.916845415697, 16817.579560511083, 16876.0, 16897.746533802, 29713.55429668557, 29817.40365192684, 30036.849815750782, 30059.398812024076, 30103.397932041236, 8484.957575212207, 8868.246199073023, 8902.408061055268, 8987.101289870961, 8996.280297576179, 7135.607541585263, 7162.212156662763, 7194.460415468756, 7320.414366850746, 7330.413566914634, 8314.501129932223, 8382.413231073888, 8554.657813687383, 8562.61468233931, 8591.914080859236, 3157.3211759471824, 3269.395161895057, 3305.190228394059, 3359.9664003359653, 3396.0151556048963, 783.6669415498504, 820.1962077164412, 839.3830534557096, 845.361751877341, 907.8774365460711, 16686.499405017625, 17091.743623845654, 17477.563060923578, 17520.912395437943, 17645.911770441067, 801.266840840636, 820.4011071917533, 827.5283088639538, 852.3564708645057, 854.3464249848871, 9622.47076410804, 10272.897271027343, 10451.529681164366, 10747.731306717395, 10774.030337269684, 359242.0, 369936.0, 371741.0, 371743.0, 376620.0, 82833.0, 84266.57866710627, 85905.0, 86388.13611863801, 86396.56801716077, 894.4365050018447, 905.0587389115246, 926.5737760630186, 941.9529023548795, 947.9383840050375, 12872.613821585368, 15329.313775484465, 15829.366825326859, 16610.75083873767, 17012.914935425244, 39068.21863562656, 39730.60269397269, 39906.2018759629, 40403.393949091376, 40680.3897941537, 45709.54290457053, 49053.79406841009, 56657.71671141618, 58121.4187858116, 59004.40995590161, 4496.303073023687, 4611.423572053493, 6582.11141495911, 7198.956151357919, 7254.709811607477, 9082.682106126254, 10919.727006824893, 11065.502052407823, 11184.720381990515, 11267.605633803105, 9178.265738741018, 9329.626814927327, 9473.0, 9590.952045240008, 10160.593576257163, 9344.626214951326, 9391.85912211331, 9587.18508926749, 9962.601495940082, 10102.09081182697, 9677.75690503124, 9753.561089750836, 9781.755456113655, 9793.608255669978, 9947.602095916081, 6657.600543967377, 6766.830829229309, 6875.724971001304, 6939.681460522686, 7058.153021637231, 7348.742794002184, 8939.418937769024, 9781.0, 9788.706338809847, 9978.700638980843], "value": 9203.360446153505, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1395.3790563199377, 1442.9062110962786, 1521.208971334906, 1684.9578760530992, 1719.4497760716567, 7602.543847369155, 8001.319887809544, 8101.635426405811, 8103.756887293376, 8104.149064348232, 6834.624095674736, 7595.240475952402, 7767.611619419021, 7815.49199302045, 7916.683332666701, 2187.7374715034216, 2202.427368884086, 2206.6359050756605, 2215.501512159767, 2216.7229096362953, 2204.1073365287084, 2211.3587059752654, 2257.525919556895, 2258.9435264118447, 2261.604219261631, 1876.6809642360831, 2160.82713382929, 2231.2190733243397, 2236.329101269621, 2247.1573160064977, 2139.657654775236, 2146.238085479648, 2154.2244791874914, 2157.9460513487134, 2208.580369729746, 2188.1466228171025, 2191.430228140695, 2193.3529608765452, 2195.9780402195934, 2197.461621902628, 7967.083785364699, 8002.7199048033035, 8004.759857204293, 8017.559034253114, 8019.077806052321, 4515.367848501212, 4578.244589642705, 4635.46692130406, 4640.071985602893, 4649.442066951988, 2704.91885243443, 2756.1731480555954, 2855.457463082008, 2855.486012517746, 2865.126136528358, 886.3706768194589, 894.3113802372137, 897.9820403591957, 1533.3100104952816, 1577.9289931952974, 10994.890051099466, 11012.944935275353, 11073.557057717762, 11076.058535024533, 11137.554497820158, 3953.7825419601622, 3980.482537270136, 4137.81379837908, 4141.689373297015, 4146.771927544014, 8518.87221691675, 8533.0, 8541.487510749375, 8542.060373358925, 8543.0, 4435.112977404532, 4440.4671439427475, 4440.666949978699, 4442.111577684412, 4442.911141777211, 4077.91844163121, 4087.1008378157353, 4110.856120035784, 4111.383292506148, 4117.670586353084, 3354.496825476198, 3396.371671240779, 3460.3944309745693, 3478.9304213916084, 3487.075924879909, 963.643451922793, 1007.9294449388473, 1024.702836177515, 1026.296986564206, 1028.6245520385005, 720.330093013492, 757.6287619066728, 766.6818270417825, 782.978213431466, 808.3937047214589, 5284.550813180846, 5334.51989320963, 5343.145096784496, 5593.776248950077, 5628.465295796893, 441.1375760388433, 441.2366605772032, 443.0562901020805, 443.4833419066751, 599.7136142973297, 3433.210361616842, 3687.59436461989, 3694.649008344203, 3729.7948612826012, 3813.0, 9558.187554057844, 9858.0, 9875.950620246853, 9943.105120539187, 9987.051230133126, 8755.912440875638, 9263.722088337361, 9593.040695930351, 9594.568244429018, 9974.251931105196, 7439.107307123071, 7486.401087912954, 7567.621618919142, 7577.242275772379, 7596.582187979714, 5394.1099718546, 5493.368262649847, 5509.858202909582, 5559.694216818114, 5669.461401166883, 9129.5891684873, 9166.17504424605, 9257.0, 9296.07039296092, 9300.767480813034, 9089.0, 9112.271018318386, 9328.860067098864, 9330.0, 9331.533423328941, 6468.0, 6520.706568204348, 6526.869462610816, 6526.9020964686515, 6539.574927629689, 7365.447591430557, 7423.480356375002, 7425.331720145213, 7435.03344565203, 7452.776416707507, 6339.714712837841, 6373.044043393528, 6403.423691867754, 6704.094947182068, 6771.119754431892, 6584.736610535525, 6792.184937807495, 6829.112215412163, 6846.657667116525, 6956.5478243913985, 6423.678816059271, 6445.903311450238, 6474.1907261592305, 6486.805395838132, 6492.577982431127, 4443.488998765183, 4514.954850451585, 4570.931436028529, 4640.791164397678, 4703.176944034849, 4469.597736203757, 4694.694844835075, 4707.035057813208, 4764.9047019058735, 4774.498677638798], "value": 4082.1509863072756, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [296.19287441721315, 298.36001776190074, 303.97872148949574, 307.0665177859308, 309.6903096903097, 4855.0, 4861.343718597988, 4885.511448855113, 4890.559849613534, 4906.852794416173, 4626.329182268569, 4734.976325118379, 4768.380110585627, 4773.307870358796, 4877.317175595419, 3694.649008344203, 3790.5361515015325, 3791.184895247521, 3827.3684842001035, 3851.557070936836, 3808.9428658570146, 3811.9428208576755, 3834.811208525366, 3836.3478208704446, 3837.808109594523, 3634.1459756957092, 3766.8681596144143, 3779.9433008504893, 3796.316663000659, 3818.8472461101524, 3741.6071312512204, 3763.454299126611, 3770.26479836432, 3799.25914446683, 3816.2939856126704, 3333.6499667534804, 3344.615369232545, 3344.715699165574, 3346.1300061983816, 3348.7321014318795, 4776.80892764289, 4790.281457781361, 4815.686980346301, 4822.95177048232, 4847.285520108715, 4126.958730412687, 4327.7619730914785, 4332.653387729006, 4338.566143385668, 4369.890752731176, 5078.085944529983, 5089.236614507817, 5104.2088476286235, 5119.129747942859, 5121.206213036985, 3645.198056427582, 3653.634636536325, 3660.6156353583024, 3661.7986010769396, 3668.3763760160837, 5145.871353216162, 5322.547583455411, 5332.92000619991, 5354.812581559666, 5366.892662146735, 3714.8699795507027, 3739.7569158004644, 3752.549694036733, 3760.9247815043545, 3761.736678432538, 3794.317022935898, 3797.8290976906105, 3806.8667596633986, 3811.104390468238, 3816.637419445148, 4356.019895523482, 4362.650987920959, 4365.4761428628135, 4368.257396242647, 4376.540463251313, 4858.902821943541, 5068.730668718729, 5074.467180945948, 5118.206677964921, 5125.384953805567, 1228.3305598448867, 1288.7873500872438, 1303.9022073344538, 1303.9739205216033, 1304.4390911907972, 863.9136086391436, 886.1847100667272, 890.6615486115364, 898.4429653614801, 898.5327629632685, 4408.9559104408545, 4417.889552761142, 4443.4445694288215, 4465.59809617136, 4476.2837945928495, 5190.844274671766, 5198.0, 5204.297419848348, 5217.139172036572, 5231.3199284092825, 4335.739855608674, 4388.166248412791, 4404.713693609905, 4421.40311058003, 4463.575960283768, 2712.403271280315, 2739.5068887600423, 2740.260129764992, 2746.4507098580366, 2748.780097592228, 4850.75746212688, 4857.732824694605, 4886.413630364308, 4892.19278818998, 4912.975435122801, 5043.293938848564, 5276.472352764769, 5283.630145889828, 5294.100002999499, 5314.5748340132695, 4821.879453013703, 4839.806407743651, 4864.927026094682, 4867.829625963074, 4868.245421959602, 5145.382554093383, 5163.251328557263, 5182.870428239325, 5186.351706036746, 5188.792448302177, 4914.140025495452, 5057.898842023213, 5070.011347787294, 5087.0, 5089.211172268304, 4784.258439941815, 4801.18379875429, 4809.951900480951, 4838.612910967185, 4842.4673285939225, 3690.892732180389, 3693.778373297611, 3713.7586056906216, 3728.198437335986, 3735.7011439084263, 4965.30485732005, 5122.743862806919, 5141.562967147835, 5152.716600586854, 5246.31797866275, 4893.241547560134, 5006.549410553068, 5027.436007636059, 5039.319691841554, 5040.722760248075, 4994.700317980933, 5021.949780502295, 5041.42023667283, 5048.974755126201, 5065.240213967934, 4724.740139292235, 4807.995003123048, 4902.607791376753, 4931.408231012301, 5076.873078173076, 5172.482751724798, 5173.534381905646, 5202.24567437727, 5207.661502002509, 5212.687238765686, 5049.0, 5068.189089745623, 5072.51811077947, 5092.185250359925, 5111.795528178831], "value": 3826.7596747297825, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [629.2951893878856, 632.4813652804702, 655.5804285257435, 667.966601669916, 686.6944209826629, 12871.356432178389, 14253.14481131133, 14283.0, 14496.565103046925, 15019.549413517585, 15081.170535620564, 15210.315535800888, 15228.467003654847, 15336.923315383436, 15351.155686437241, 629.8897692903746, 758.5183408535564, 768.8462307538487, 788.7081779741503, 796.6454927557239, 788.5426452657445, 789.6486063701655, 792.3423558446505, 795.3239746215728, 796.0526972902256, 834.0033659776569, 834.6869923778584, 835.4444294544152, 835.9582020898961, 836.1847198981005, 651.2608189704696, 670.0083875863749, 671.513152964102, 672.9966350168218, 827.0530242871909, 578.9681567513785, 597.799737088076, 599.8320470268332, 602.1449541650866, 602.8342205893371, 13225.0, 13269.336533173302, 13289.401976911062, 13395.598132056053, 13401.0, 12135.393230338448, 12639.368031598475, 12745.553905613258, 12785.808212876722, 13070.346482675923, 10947.890521094767, 11302.15233857464, 11489.368084755335, 11512.424378781028, 11950.521979120826, 3674.3018826423163, 3709.2952339055764, 3733.3653278942643, 3800.182960663443, 3857.035741064734, 63140.0, 63380.683096584224, 63455.04817427789, 64469.35530644727, 64753.35246647568, 10160.0, 10203.591856325664, 10283.331583447052, 10328.48357582118, 10366.274360794672, 17897.642047158984, 17939.820601793814, 17982.5504362392, 18006.279748809902, 18123.36568220132, 6671.39957403836, 6912.274211207851, 6917.481188910851, 6945.51381403307, 7093.680784364716, 3581.6418358163974, 3586.049696830342, 3649.416093425092, 3668.3947148720695, 3685.2997930393676, 2790.9581356279673, 2910.3306239565018, 2913.7086291371115, 2914.519104347801, 2914.6210992571255, 505.4036237240092, 514.3647595219901, 514.9922751158736, 516.26432333924, 541.6506353402112, 438.52639149718226, 453.71869440946824, 467.18942634529066, 515.8607176062442, 540.586198158627, 7731.884021739678, 7790.065192176975, 7881.911293507225, 7911.84176316482, 7993.200679932076, 445.5588966922788, 494.86391242408627, 504.29650637360675, 516.8681986093598, 527.7387693091868, 3512.5784905811465, 3546.66306700863, 3657.642287373339, 3663.395539735967, 3776.4712940188397, 105083.0, 106314.0, 108450.0, 108743.0, 109122.45438772914, 92300.07699923048, 93734.53132734292, 93813.0, 94213.0, 94306.52846735722, 80390.5980470094, 81880.59059704663, 83269.16730832735, 83650.58174709209, 84582.0, 7052.471064670068, 7118.537295075804, 7294.671739771829, 7313.890291645736, 7335.376492998155, 41610.375844361755, 42745.78627106844, 49209.75395123001, 49817.75091124521, 51776.0, 44190.33714494349, 56745.71627142003, 65646.0, 66356.33643663501, 70636.64681676765, 10657.520411581652, 10881.238313317992, 11104.0, 11358.318500889973, 11500.597479088527, 12408.131430799758, 12476.563320283747, 12556.058295628047, 12580.87419125797, 13151.93424032912, 11294.491747871201, 11760.647180584596, 11914.344711040976, 11918.821217681569, 11928.224665396721, 11782.882171178178, 12045.63863084109, 12090.15368924202, 12392.876071239532, 12443.0, 10590.099841513558, 10627.787444251226, 10656.73358166021, 10961.068309193808, 11515.53937842477, 9207.585658645243, 9293.581788819383, 9456.952715236379, 9542.713718588453, 9583.616655333708, 9405.905940940504, 9636.46999415039, 10031.448270345201, 10096.798064038825, 10161.491925403849], "value": 6538.092382518731, "unit": "score"}], "name": "dromaeo_css", "value": 6475.0979711025475, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 114.0, 113.0, 113.0, 113.0, 113.0, 113.0, 112.0, 114.0, 113.0], "value": 112.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 122.0, 122.0, 175.0, 124.0, 124.0, 152.0, 122.0, 152.0, 128.0], "value": 137.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 160.0, 159.0, 161.0, 160.0, 161.0, 162.0, 163.0, 162.0], "value": 161.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 76.0, 127.0, 78.0, 77.0, 76.0, 75.0, 100.0, 76.0], "value": 83.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 112.0, 85.0, 86.0, 85.0, 115.0, 86.0, 87.0, 129.0], "value": 95.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 147.0, 147.0, 147.0, 146.0, 146.0, 147.0, 147.0], "value": 146.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 96.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 66.0, 65.0, 66.0, 65.0, 66.0, 65.0, 66.0, 66.0], "value": 65.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 66.0, 66.0, 65.0, 65.0, 66.0, 66.0, 66.0, 66.0], "value": 65.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 78.0, 84.0, 78.0, 78.0, 79.0, 77.0, 79.0, 78.0, 87.0], "value": 79.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 128.0, 129.0, 128.0, 129.0, 129.0, 137.0, 126.0, 183.0, 129.0], "value": 135.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 167.0, 165.0, 166.0, 168.0, 165.0, 162.0, 168.0, 167.0, 162.0], "value": 165.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 66.0, 68.0, 67.0, 68.0, 65.0, 67.0, 68.0, 66.0], "value": 66.7, "unit": "score"}], "name": "kraken", "value": 1527.7, "alertThreshold": 2.0}]} 17:48:14 INFO - Return code: 0 17:48:14 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:48:14 INFO - # TBPL SUCCESS # 17:48:14 INFO - Running post-action listener: _resource_record_post_action 17:48:14 INFO - ##### 17:48:14 INFO - ##### Finished run-tests step (success) 17:48:14 INFO - ##### 17:48:14 INFO - Running post-run listener: _resource_record_post_run 17:48:14 INFO - Total resource usage - Wall time: 1203s; CPU: 13.0%; Read bytes: 425984; Write bytes: 309460992; Read time: 44; Write time: 322444 17:48:14 INFO - TinderboxPrint: CPU usage
13.0% 17:48:14 INFO - TinderboxPrint: I/O read bytes / time
425,984 / 44 17:48:14 INFO - TinderboxPrint: I/O write bytes / time
309,460,992 / 322,444 17:48:14 INFO - TinderboxPrint: CPU idle
8,357.1 (87.0%) 17:48:14 INFO - TinderboxPrint: CPU user
1,200.5 (12.5%) 17:48:14 INFO - TinderboxPrint: Swap in / out
0 / 0 17:48:14 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 14086144; Read time: 0; Write time: 2476 17:48:14 INFO - run-tests - Wall time: 1187s; CPU: 13.0%; Read bytes: 421888; Write bytes: 295374848; Read time: 36; Write time: 319968 17:48:15 INFO - Running post-run listener: _upload_blobber_files 17:48:15 INFO - Blob upload gear active. 17:48:15 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:48:15 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 17:48:15 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'] 17:48:15 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 17:48:15 INFO - (blobuploader) - INFO - Open directory for files ... 17:48:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:48:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:48:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:48:20 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:48:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:48:20 INFO - (blobuploader) - INFO - Done attempting. 17:48:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 17:48:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:48:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:48:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:48:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:48:20 INFO - (blobuploader) - INFO - Done attempting. 17:48:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:48:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:48:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:48:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:48:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:48:21 INFO - (blobuploader) - INFO - Done attempting. 17:48:21 INFO - (blobuploader) - INFO - Iteration through files over. 17:48:21 INFO - Return code: 0 17:48:21 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:48:21 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:48:21 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/3fcb5934c3073e6110fe00c025614390345f2ac780665ee061c96651107f6872cc3a25ab1e51d09ab69098c923a040cd84cbe9361d316d2e8394f73966854453", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/3a3ce07c023ba7f3f707c91aec334167109fd5a94935fb66414f57379447b189a4ff189036508ee322316619c28c99c7d32888603a4091d667ce2cf02f293540", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/77139148a8af15f0c47ed8cf0c8641a00c8e2250f2f74ac0052756bb6cf115f524a088e8685fb77365213e2dea60774f7909ccc4d95e5bc58d3d19e0190ba709"} 17:48:21 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:48:21 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:48:21 INFO - Contents: 17:48:21 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/3fcb5934c3073e6110fe00c025614390345f2ac780665ee061c96651107f6872cc3a25ab1e51d09ab69098c923a040cd84cbe9361d316d2e8394f73966854453", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/3a3ce07c023ba7f3f707c91aec334167109fd5a94935fb66414f57379447b189a4ff189036508ee322316619c28c99c7d32888603a4091d667ce2cf02f293540", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/77139148a8af15f0c47ed8cf0c8641a00c8e2250f2f74ac0052756bb6cf115f524a088e8685fb77365213e2dea60774f7909ccc4d95e5bc58d3d19e0190ba709"} 17:48:21 INFO - Running post-run listener: copy_logs_to_upload_dir 17:48:21 INFO - Copying logs to upload dir... 17:48:21 INFO - mkdir: /builds/slave/test/build/upload/logs 17:48:21 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1265.612149 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-07-13 17:48:21.877191) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-13 17:48:21.880603) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1468454512.712890-1328747229 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/3fcb5934c3073e6110fe00c025614390345f2ac780665ee061c96651107f6872cc3a25ab1e51d09ab69098c923a040cd84cbe9361d316d2e8394f73966854453", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/3a3ce07c023ba7f3f707c91aec334167109fd5a94935fb66414f57379447b189a4ff189036508ee322316619c28c99c7d32888603a4091d667ce2cf02f293540", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/77139148a8af15f0c47ed8cf0c8641a00c8e2250f2f74ac0052756bb6cf115f524a088e8685fb77365213e2dea60774f7909ccc4d95e5bc58d3d19e0190ba709"} build_url:https://queue.taskcluster.net/v1/task/ACicjUrcQCW01OzNCv9oDw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011352 build_url: 'https://queue.taskcluster.net/v1/task/ACicjUrcQCW01OzNCv9oDw/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/3fcb5934c3073e6110fe00c025614390345f2ac780665ee061c96651107f6872cc3a25ab1e51d09ab69098c923a040cd84cbe9361d316d2e8394f73966854453", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/3a3ce07c023ba7f3f707c91aec334167109fd5a94935fb66414f57379447b189a4ff189036508ee322316619c28c99c7d32888603a4091d667ce2cf02f293540", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/77139148a8af15f0c47ed8cf0c8641a00c8e2250f2f74ac0052756bb6cf115f524a088e8685fb77365213e2dea60774f7909ccc4d95e5bc58d3d19e0190ba709"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-13 17:48:21.905494) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 17:48:21.905793) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1468454512.712890-1328747229 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004431 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 17:48:21.987974) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-13 17:48:21.988276) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-13 17:48:21.988558) ========= ========= Total master_lag: 0.21 =========