builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-047 starttime: 1467186540.69 results: success (0) buildid: 20160628071022 builduid: 17a19734969742aa8e8d11147118e308 revision: e45890951ce77c3df05575bd54072b9f300d77b0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-29 00:49:00.688374) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-29 00:49:00.688866) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-29 00:49:00.689286) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-29 00:49:00.705941) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 00:49:00.706326) ========= 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=03627c79f6bb3d1578c4a402000001ba-1467186540.145069-536717880 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-29 00:49:00-- 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% 97.4M=0s 2016-06-29 00:49:01 (97.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.429865 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 00:49:01.152839) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 00:49:01.153357) ========= 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=03627c79f6bb3d1578c4a402000001ba-1467186540.145069-536717880 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020758 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 00:49:01.204806) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 00:49:01.205414) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev e45890951ce77c3df05575bd54072b9f300d77b0 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev e45890951ce77c3df05575bd54072b9f300d77b0 --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=03627c79f6bb3d1578c4a402000001ba-1467186540.145069-536717880 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-29 00:49:01,417 truncating revision to first 12 chars 2016-06-29 00:49:01,417 Setting DEBUG logging. 2016-06-29 00:49:01,417 attempt 1/10 2016-06-29 00:49:01,417 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/e45890951ce7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-29 00:49:01,729 unpacking tar archive at: mozilla-central-e45890951ce7/testing/mozharness/ program finished with exit code 0 elapsedTime=0.690557 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 00:49:01.910680) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-29 00:49:01.910985) ========= script_repo_revision: e45890951ce77c3df05575bd54072b9f300d77b0 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-29 00:49:01.911388) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-29 00:49:01.911670) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-29 00:49:01.920785) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-06-29 00:49:01.921154) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-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', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-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=03627c79f6bb3d1578c4a402000001ba-1467186540.145069-536717880 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 00:49:02 INFO - MultiFileLogger online at 20160629 00:49:02 in /builds/slave/test 00:49:02 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 00:49:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 00:49:02 INFO - {'append_to_log': False, 00:49:02 INFO - 'base_work_dir': '/builds/slave/test', 00:49:02 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 00:49:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 00:49:02 INFO - 'branch': 'Firefox-Non-PGO', 00:49:02 INFO - 'buildbot_json_path': 'buildprops.json', 00:49:02 INFO - 'config_files': ('talos/linux_config.py',), 00:49:02 INFO - 'default_actions': ('clobber', 00:49:02 INFO - 'read-buildbot-config', 00:49:02 INFO - 'download-and-extract', 00:49:02 INFO - 'populate-webroot', 00:49:02 INFO - 'create-virtualenv', 00:49:02 INFO - 'install', 00:49:02 INFO - 'run-tests'), 00:49:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 00:49:02 INFO - 'download_minidump_stackwalk': True, 00:49:02 INFO - 'download_symbols': 'ondemand', 00:49:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 00:49:02 INFO - 'tooltool.py': '/tools/tooltool.py', 00:49:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 00:49:02 INFO - '/tools/misc-python/virtualenv.py')}, 00:49:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 00:49:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 00:49:02 INFO - 'installer_path': 'installer.exe', 00:49:02 INFO - 'log_level': 'info', 00:49:02 INFO - 'log_name': 'talos', 00:49:02 INFO - 'log_to_console': True, 00:49:02 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 00:49:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 00:49:02 INFO - 'opt_config_files': (), 00:49:02 INFO - 'pip_index': False, 00:49:02 INFO - 'sps_profile': False, 00:49:02 INFO - 'sps_profile_interval': 0, 00:49:02 INFO - 'suite': 'dromaeojs', 00:49:02 INFO - 'system_bits': '32', 00:49:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 00:49:02 INFO - 'title': 'talos-linux64-ix-047', 00:49:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 00:49:02 INFO - 'use_talos_json': True, 00:49:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 00:49:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 00:49:02 INFO - 'work_dir': 'build'} 00:49:02 INFO - ##### 00:49:02 INFO - ##### Running clobber step. 00:49:02 INFO - ##### 00:49:02 INFO - Running pre-action listener: _resource_record_pre_action 00:49:02 INFO - Running main action method: clobber 00:49:02 INFO - rmtree: /builds/slave/test/build 00:49:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 00:49:02 INFO - Running post-action listener: _resource_record_post_action 00:49:02 INFO - ##### 00:49:02 INFO - ##### Finished clobber step (success) 00:49:02 INFO - ##### 00:49:02 INFO - ##### 00:49:02 INFO - ##### Running read-buildbot-config step. 00:49:02 INFO - ##### 00:49:02 INFO - Running pre-action listener: _resource_record_pre_action 00:49:02 INFO - Running main action method: read_buildbot_config 00:49:02 INFO - Using buildbot properties: 00:49:02 INFO - { 00:49:02 INFO - "project": "", 00:49:02 INFO - "product": "firefox", 00:49:02 INFO - "script_repo_revision": "production", 00:49:02 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 00:49:02 INFO - "repository": "", 00:49:02 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 00:49:02 INFO - "buildid": "20160628071022", 00:49:02 INFO - "pgo_build": "False", 00:49:02 INFO - "basedir": "/builds/slave/test", 00:49:02 INFO - "buildnumber": 131, 00:49:02 INFO - "slavename": "talos-linux64-ix-047", 00:49:02 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 00:49:02 INFO - "platform": "ubuntu64_hw", 00:49:02 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 00:49:02 INFO - "branch": "mozilla-central", 00:49:02 INFO - "repo_path": "mozilla-central", 00:49:02 INFO - "revision": "e45890951ce77c3df05575bd54072b9f300d77b0", 00:49:02 INFO - "stage_platform": "linux64", 00:49:02 INFO - "builduid": "17a19734969742aa8e8d11147118e308", 00:49:02 INFO - "slavebuilddir": "test" 00:49:02 INFO - } 00:49:02 INFO - Found installer url https://queue.taskcluster.net/v1/task/Hi81xJZlSzOxDiRAmFIe7g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 00:49:02 INFO - Running post-action listener: _resource_record_post_action 00:49:02 INFO - ##### 00:49:02 INFO - ##### Finished read-buildbot-config step (success) 00:49:02 INFO - ##### 00:49:02 INFO - ##### 00:49:02 INFO - ##### Running download-and-extract step. 00:49:02 INFO - ##### 00:49:02 INFO - Running pre-action listener: _resource_record_pre_action 00:49:02 INFO - Running main action method: download_and_extract 00:49:02 INFO - mkdir: /builds/slave/test/build/tests 00:49:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:49:02 INFO - https://queue.taskcluster.net/v1/task/Hi81xJZlSzOxDiRAmFIe7g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 00:49:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hi81xJZlSzOxDiRAmFIe7g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 00:49:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hi81xJZlSzOxDiRAmFIe7g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 00:49:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hi81xJZlSzOxDiRAmFIe7g/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 00:49:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hi81xJZlSzOxDiRAmFIe7g/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 00:49:03 INFO - Downloaded 1361 bytes. 00:49:03 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 00:49:03 INFO - Using the following test package requirements: 00:49:03 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 00:49:03 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 00:49:03 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 00:49:03 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 00:49:03 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 00:49:03 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 00:49:03 INFO - u'jsshell-linux-x86_64.zip'], 00:49:03 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 00:49:03 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 00:49:03 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 00:49:03 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 00:49:03 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 00:49:03 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 00:49:03 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 00:49:03 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 00:49:03 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 00:49:03 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 00:49:03 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 00:49:03 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 00:49: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')]} 00:49:03 INFO - https://queue.taskcluster.net/v1/task/Hi81xJZlSzOxDiRAmFIe7g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 00:49:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hi81xJZlSzOxDiRAmFIe7g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 00:49:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hi81xJZlSzOxDiRAmFIe7g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 00:49:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hi81xJZlSzOxDiRAmFIe7g/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 00:49:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hi81xJZlSzOxDiRAmFIe7g/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 00:49:06 INFO - Downloaded 22700070 bytes. 00:49:06 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'] 00:49:06 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 00:49:07 INFO - Return code: 0 00:49:07 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 00:49:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:49:07 INFO - https://queue.taskcluster.net/v1/task/Hi81xJZlSzOxDiRAmFIe7g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 00:49:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hi81xJZlSzOxDiRAmFIe7g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 00:49:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hi81xJZlSzOxDiRAmFIe7g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 00:49:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hi81xJZlSzOxDiRAmFIe7g/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 00:49:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hi81xJZlSzOxDiRAmFIe7g/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 00:49:08 INFO - Downloaded 22700070 bytes. 00:49:08 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'] 00:49:08 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 00:49:10 INFO - Return code: 0 00:49: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')]} 00:49:10 INFO - https://queue.taskcluster.net/v1/task/Hi81xJZlSzOxDiRAmFIe7g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 00:49:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hi81xJZlSzOxDiRAmFIe7g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 00:49:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hi81xJZlSzOxDiRAmFIe7g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 00:49:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hi81xJZlSzOxDiRAmFIe7g/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 00:49:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hi81xJZlSzOxDiRAmFIe7g/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 00:49:11 INFO - Downloaded 14405245 bytes. 00:49:11 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'] 00:49:11 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 00:49:11 INFO - Return code: 0 00:49:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:49:11 INFO - https://queue.taskcluster.net/v1/task/Hi81xJZlSzOxDiRAmFIe7g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 00:49:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hi81xJZlSzOxDiRAmFIe7g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 00:49:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hi81xJZlSzOxDiRAmFIe7g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 00:49:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hi81xJZlSzOxDiRAmFIe7g/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 00:49:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hi81xJZlSzOxDiRAmFIe7g/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 00:49:22 INFO - Downloaded 56431652 bytes. 00:49:22 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Hi81xJZlSzOxDiRAmFIe7g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 00:49:22 INFO - mkdir: /builds/slave/test/properties 00:49:22 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 00:49:22 INFO - Writing to file /builds/slave/test/properties/build_url 00:49:22 INFO - Contents: 00:49:22 INFO - build_url:https://queue.taskcluster.net/v1/task/Hi81xJZlSzOxDiRAmFIe7g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 00:49:23 INFO - Running post-action listener: _resource_record_post_action 00:49:23 INFO - Running post-action listener: set_extra_try_arguments 00:49:23 INFO - ##### 00:49:23 INFO - ##### Finished download-and-extract step (success) 00:49:23 INFO - ##### 00:49:23 INFO - ##### 00:49:23 INFO - ##### Running populate-webroot step. 00:49:23 INFO - ##### 00:49:23 INFO - Running pre-action listener: _resource_record_pre_action 00:49:23 INFO - Running main action method: populate_webroot 00:49:23 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 00:49:23 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 00:49:23 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 00:49:23 INFO - '--tppagecycles', 00:49:23 INFO - '7'], 00:49:23 INFO - 'tests': ['tsvgm']}}, 00:49:23 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 00:49:23 INFO - 'tests': ['tresize', 'tcanvasmark']}, 00:49:23 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 00:49:23 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 00:49:23 INFO - 'tests': ['dromaeo_css', 'kraken']}, 00:49:23 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 00:49:23 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:49:23 INFO - 'talos_options': ['--disable-e10s'], 00:49:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:49:23 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:49:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:49:23 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:49:23 INFO - 'talos_options': ['--disable-e10s'], 00:49:23 INFO - 'tests': ['damp', 'tps']}, 00:49:23 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:49:23 INFO - 'tests': ['damp', 'tps']}, 00:49:23 INFO - 'g3': {'talos_options': ['--disable-e10s'], 00:49:23 INFO - 'tests': ['dromaeo_dom']}, 00:49:23 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 00:49:23 INFO - 'g4': {'talos_options': ['--disable-e10s'], 00:49:23 INFO - 'tests': ['basic_compositor_video']}, 00:49:23 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 00:49:23 INFO - 'other': {'talos_options': ['--disable-e10s'], 00:49:23 INFO - 'tests': ['a11yr', 00:49:23 INFO - 'ts_paint', 00:49:23 INFO - 'tpaint', 00:49:23 INFO - 'sessionrestore', 00:49:23 INFO - 'sessionrestore_no_auto_restore', 00:49:23 INFO - 'tabpaint']}, 00:49:23 INFO - 'other-e10s': {'tests': ['a11yr', 00:49:23 INFO - 'ts_paint', 00:49:23 INFO - 'tpaint', 00:49:23 INFO - 'sessionrestore', 00:49:23 INFO - 'sessionrestore_no_auto_restore', 00:49:23 INFO - 'tabpaint']}, 00:49:23 INFO - 'other-e10s_l64': {'tests': ['a11yr', 00:49:23 INFO - 'ts_paint', 00:49:23 INFO - 'tpaint', 00:49:23 INFO - 'sessionrestore', 00:49:23 INFO - 'sessionrestore_no_auto_restore', 00:49:23 INFO - 'tabpaint']}, 00:49:23 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 00:49:23 INFO - 'ts_paint', 00:49:23 INFO - 'tpaint', 00:49:23 INFO - 'sessionrestore', 00:49:23 INFO - 'sessionrestore_no_auto_restore', 00:49:23 INFO - 'tabpaint']}, 00:49:23 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 00:49:23 INFO - 'tests': ['a11yr', 00:49:23 INFO - 'ts_paint', 00:49:23 INFO - 'tpaint', 00:49:23 INFO - 'sessionrestore', 00:49:23 INFO - 'sessionrestore_no_auto_restore', 00:49:23 INFO - 'tabpaint']}, 00:49:23 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 00:49:23 INFO - 'tests': ['a11yr', 00:49:23 INFO - 'ts_paint', 00:49:23 INFO - 'tpaint', 00:49:23 INFO - 'sessionrestore', 00:49:23 INFO - 'sessionrestore_no_auto_restore', 00:49:23 INFO - 'tabpaint']}, 00:49:23 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 00:49:23 INFO - 'tests': ['tsvgx', 00:49:23 INFO - 'tsvgr_opacity', 00:49:23 INFO - 'tart', 00:49:23 INFO - 'tscrollx', 00:49:23 INFO - 'cart']}, 00:49:23 INFO - 'svgr-e10s': {'tests': ['tsvgx', 00:49:23 INFO - 'tsvgr_opacity', 00:49:23 INFO - 'tart', 00:49:23 INFO - 'tscrollx', 00:49:23 INFO - 'cart']}, 00:49:23 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:49:23 INFO - 'talos_options': ['--disable-e10s'], 00:49:23 INFO - 'tests': ['tp5o']}, 00:49:23 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:49:23 INFO - 'tests': ['tp5o']}, 00:49:23 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:49:23 INFO - 'talos_options': ['--disable-e10s', 00:49:23 INFO - '--xperf_path', 00:49:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:49:23 INFO - 'tests': ['tp5n']}, 00:49:23 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:49:23 INFO - 'talos_options': ['--xperf_path', 00:49:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:49:23 INFO - 'tests': ['tp5n']}}, 00:49:23 INFO - 'talos.zip': {'path': '', 00:49:23 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 00:49:23 INFO - Running post-action listener: _resource_record_post_action 00:49:23 INFO - ##### 00:49:23 INFO - ##### Finished populate-webroot step (success) 00:49:23 INFO - ##### 00:49:23 INFO - ##### 00:49:23 INFO - ##### Running create-virtualenv step. 00:49:23 INFO - ##### 00:49:23 INFO - Running pre-action listener: _resource_record_pre_action 00:49:23 INFO - Running main action method: create_virtualenv 00:49:23 INFO - Creating virtualenv /builds/slave/test/build/venv 00:49:23 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 00:49:23 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 00:49:23 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 00:49:23 INFO - Using real prefix '/usr' 00:49:23 INFO - New python executable in /builds/slave/test/build/venv/bin/python 00:49:24 INFO - Installing distribute.............................................................................................................................................................................................done. 00:49:26 INFO - Installing pip.................done. 00:49:26 INFO - Return code: 0 00:49:26 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 00:49:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:49:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:49:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:49:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:49:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:49:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:49:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dbb030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f1e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x207c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x207a3b0>, '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 0x207b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x207b740>, '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': '03627c79f6bb3d1578c4a402000001ba-1467186540.145069-536717880', '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 00:49:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 00:49:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 00:49:26 INFO - Using env: {'DISPLAY': ':0', 00:49:26 INFO - 'HOME': '/home/cltbld', 00:49:26 INFO - 'LANG': 'en_US.UTF-8', 00:49:26 INFO - 'LANGUAGE': 'en_US:en', 00:49:26 INFO - 'LOGNAME': 'cltbld', 00:49:26 INFO - 'MAIL': '/var/mail/cltbld', 00:49:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:49:26 INFO - 'MOZ_NO_REMOTE': '1', 00:49:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:49:26 INFO - 'NO_EM_RESTART': '1', 00:49:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:49:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:49:26 INFO - 'PWD': '/builds/slave/test', 00:49:26 INFO - 'SHELL': '/bin/bash', 00:49:26 INFO - 'SHLVL': '1', 00:49:26 INFO - 'TERM': 'linux', 00:49:26 INFO - 'TMOUT': '86400', 00:49:26 INFO - 'USER': 'cltbld', 00:49:26 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1467186540.145069-536717880', 00:49:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:49:26 INFO - '_': '/tools/buildbot/bin/python'} 00:49:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:49:26 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 00:49:26 INFO - Cleaning up... 00:49:26 INFO - Return code: 0 00:49:26 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 00:49:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:49:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:49:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:49:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:49:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:49:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:49:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1dbb030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f1e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x207c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x207a3b0>, '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 0x207b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x207b740>, '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': '03627c79f6bb3d1578c4a402000001ba-1467186540.145069-536717880', '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 00:49:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 00:49:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 00:49:26 INFO - Using env: {'DISPLAY': ':0', 00:49:26 INFO - 'HOME': '/home/cltbld', 00:49:26 INFO - 'LANG': 'en_US.UTF-8', 00:49:26 INFO - 'LANGUAGE': 'en_US:en', 00:49:26 INFO - 'LOGNAME': 'cltbld', 00:49:26 INFO - 'MAIL': '/var/mail/cltbld', 00:49:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:49:26 INFO - 'MOZ_NO_REMOTE': '1', 00:49:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:49:26 INFO - 'NO_EM_RESTART': '1', 00:49:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:49:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:49:26 INFO - 'PWD': '/builds/slave/test', 00:49:26 INFO - 'SHELL': '/bin/bash', 00:49:26 INFO - 'SHLVL': '1', 00:49:26 INFO - 'TERM': 'linux', 00:49:26 INFO - 'TMOUT': '86400', 00:49:26 INFO - 'USER': 'cltbld', 00:49:26 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1467186540.145069-536717880', 00:49:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:49:26 INFO - '_': '/tools/buildbot/bin/python'} 00:49:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:49:26 INFO - Downloading/unpacking psutil>=3.1.1 00:49:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:49:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:49:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:49:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:49:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:49:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:49:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 00:49:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:49:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:49:28 INFO - Installing collected packages: psutil 00:49:28 INFO - Running setup.py install for psutil 00:49:28 INFO - building 'psutil._psutil_linux' extension 00:49:28 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 00:49:28 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 00:49:28 INFO - building 'psutil._psutil_posix' extension 00:49:28 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 00:49:28 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 00:49:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:49:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:49:29 INFO - Successfully installed psutil 00:49:29 INFO - Cleaning up... 00:49:29 INFO - Return code: 0 00:49:29 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 00:49:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 00:49:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:49:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:49:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 00:49:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:49:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:49:29 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 0x1dbb030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f1e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x207c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x207a3b0>, '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 0x207b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x207b740>, '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': '03627c79f6bb3d1578c4a402000001ba-1467186540.145069-536717880', '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 00:49:29 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 00:49:29 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 00:49:29 INFO - Using env: {'DISPLAY': ':0', 00:49:29 INFO - 'HOME': '/home/cltbld', 00:49:29 INFO - 'LANG': 'en_US.UTF-8', 00:49:29 INFO - 'LANGUAGE': 'en_US:en', 00:49:29 INFO - 'LOGNAME': 'cltbld', 00:49:29 INFO - 'MAIL': '/var/mail/cltbld', 00:49:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:49:29 INFO - 'MOZ_NO_REMOTE': '1', 00:49:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:49:29 INFO - 'NO_EM_RESTART': '1', 00:49:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:49:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:49:29 INFO - 'PWD': '/builds/slave/test', 00:49:29 INFO - 'SHELL': '/bin/bash', 00:49:29 INFO - 'SHLVL': '1', 00:49:29 INFO - 'TERM': 'linux', 00:49:29 INFO - 'TMOUT': '86400', 00:49:29 INFO - 'USER': 'cltbld', 00:49:29 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1467186540.145069-536717880', 00:49:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:49:29 INFO - '_': '/tools/buildbot/bin/python'} 00:49:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:49:29 INFO - Downloading/unpacking mozsystemmonitor==0.3 00:49:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:49:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:49:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:49:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:49:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:49:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:49:31 INFO - Downloading mozsystemmonitor-0.3.tar.gz 00:49:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 00:49:31 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 00:49:31 INFO - Installing collected packages: mozsystemmonitor 00:49:31 INFO - Running setup.py install for mozsystemmonitor 00:49:31 INFO - Successfully installed mozsystemmonitor 00:49:31 INFO - Cleaning up... 00:49:31 INFO - Return code: 0 00:49:31 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 00:49: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')]} 00:49:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:49:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:49: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')]} 00:49:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:49:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:49:31 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 0x1dbb030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f1e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x207c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x207a3b0>, '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 0x207b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x207b740>, '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': '03627c79f6bb3d1578c4a402000001ba-1467186540.145069-536717880', '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 00:49:31 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 00:49:31 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 00:49:31 INFO - Using env: {'DISPLAY': ':0', 00:49:31 INFO - 'HOME': '/home/cltbld', 00:49:31 INFO - 'LANG': 'en_US.UTF-8', 00:49:31 INFO - 'LANGUAGE': 'en_US:en', 00:49:31 INFO - 'LOGNAME': 'cltbld', 00:49:31 INFO - 'MAIL': '/var/mail/cltbld', 00:49:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:49:31 INFO - 'MOZ_NO_REMOTE': '1', 00:49:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:49:31 INFO - 'NO_EM_RESTART': '1', 00:49:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:49:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:49:31 INFO - 'PWD': '/builds/slave/test', 00:49:31 INFO - 'SHELL': '/bin/bash', 00:49:31 INFO - 'SHLVL': '1', 00:49:31 INFO - 'TERM': 'linux', 00:49:31 INFO - 'TMOUT': '86400', 00:49:31 INFO - 'USER': 'cltbld', 00:49:31 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1467186540.145069-536717880', 00:49:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:49:31 INFO - '_': '/tools/buildbot/bin/python'} 00:49:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:49:31 INFO - Downloading/unpacking jsonschema==2.5.1 00:49:31 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 00:49:31 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 00:49:31 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 00:49:31 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 00:49:31 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 00:49:31 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 00:49:33 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 00:49:33 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 00:49:33 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 00:49:33 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 00:49:33 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 00:49:33 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 00:49:33 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 00:49:33 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 00:49:33 INFO - Downloading functools32-3.2.3-2.tar.gz 00:49:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 00:49:34 INFO - warning: no files found matching '*.txt' 00:49:34 INFO - no previously-included directories found matching 'build' 00:49:34 INFO - no previously-included directories found matching 'dist' 00:49:34 INFO - no previously-included directories found matching '.git*' 00:49:34 INFO - Installing collected packages: jsonschema, functools32 00:49:34 INFO - Running setup.py install for functools32 00:49:34 INFO - warning: no files found matching '*.txt' 00:49:34 INFO - no previously-included directories found matching 'build' 00:49:34 INFO - no previously-included directories found matching 'dist' 00:49:34 INFO - no previously-included directories found matching '.git*' 00:49:34 INFO - Successfully installed jsonschema functools32 00:49:34 INFO - Cleaning up... 00:49:34 INFO - Return code: 0 00:49:34 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 00:49:34 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')]} 00:49:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:49:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:49:34 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')]} 00:49:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:49:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:49:34 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 0x1dbb030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f1e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x207c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x207a3b0>, '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 0x207b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x207b740>, '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': '03627c79f6bb3d1578c4a402000001ba-1467186540.145069-536717880', '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 00:49:34 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 00:49:34 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 00:49:34 INFO - Using env: {'DISPLAY': ':0', 00:49:34 INFO - 'HOME': '/home/cltbld', 00:49:34 INFO - 'LANG': 'en_US.UTF-8', 00:49:34 INFO - 'LANGUAGE': 'en_US:en', 00:49:34 INFO - 'LOGNAME': 'cltbld', 00:49:34 INFO - 'MAIL': '/var/mail/cltbld', 00:49:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:49:34 INFO - 'MOZ_NO_REMOTE': '1', 00:49:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:49:34 INFO - 'NO_EM_RESTART': '1', 00:49:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:49:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:49:34 INFO - 'PWD': '/builds/slave/test', 00:49:34 INFO - 'SHELL': '/bin/bash', 00:49:34 INFO - 'SHLVL': '1', 00:49:34 INFO - 'TERM': 'linux', 00:49:34 INFO - 'TMOUT': '86400', 00:49:34 INFO - 'USER': 'cltbld', 00:49:34 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1467186540.145069-536717880', 00:49:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:49:34 INFO - '_': '/tools/buildbot/bin/python'} 00:49:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:49:34 INFO - Downloading/unpacking blobuploader==1.2.4 00:49:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:49:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:49:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:49:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:49:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:49:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:49:36 INFO - Downloading blobuploader-1.2.4.tar.gz 00:49:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 00:49:36 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 00:49:36 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 00:49:36 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 00:49:36 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 00:49:36 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 00:49:36 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 00:49:36 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 00:49:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 00:49:36 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 00:49:36 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 00:49:36 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 00:49:36 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 00:49:36 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 00:49:36 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 00:49:36 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 00:49:37 INFO - Downloading docopt-0.6.1.tar.gz 00:49:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 00:49:37 INFO - Installing collected packages: blobuploader, requests, docopt 00:49:37 INFO - Running setup.py install for blobuploader 00:49:37 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 00:49:37 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 00:49:37 INFO - Running setup.py install for requests 00:49:37 INFO - Running setup.py install for docopt 00:49:37 INFO - Successfully installed blobuploader requests docopt 00:49:37 INFO - Cleaning up... 00:49:37 INFO - Return code: 0 00:49:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:49:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:49:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:49:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:49:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:49:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:49:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:49:37 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 0x1dbb030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f1e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x207c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x207a3b0>, '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 0x207b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x207b740>, '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': '03627c79f6bb3d1578c4a402000001ba-1467186540.145069-536717880', '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 00:49:37 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 00:49:37 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 00:49:37 INFO - Using env: {'DISPLAY': ':0', 00:49:37 INFO - 'HOME': '/home/cltbld', 00:49:37 INFO - 'LANG': 'en_US.UTF-8', 00:49:37 INFO - 'LANGUAGE': 'en_US:en', 00:49:37 INFO - 'LOGNAME': 'cltbld', 00:49:37 INFO - 'MAIL': '/var/mail/cltbld', 00:49:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:49:37 INFO - 'MOZ_NO_REMOTE': '1', 00:49:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:49:37 INFO - 'NO_EM_RESTART': '1', 00:49:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:49:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:49:37 INFO - 'PWD': '/builds/slave/test', 00:49:37 INFO - 'SHELL': '/bin/bash', 00:49:37 INFO - 'SHLVL': '1', 00:49:37 INFO - 'TERM': 'linux', 00:49:37 INFO - 'TMOUT': '86400', 00:49:37 INFO - 'USER': 'cltbld', 00:49:37 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1467186540.145069-536717880', 00:49:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:49:37 INFO - '_': '/tools/buildbot/bin/python'} 00:49:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:49:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:49:37 INFO - Running setup.py (path:/tmp/pip-fueyzF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:49:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:49:38 INFO - Running setup.py (path:/tmp/pip-HdeDJ7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:49:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:49:38 INFO - Running setup.py (path:/tmp/pip-TYsTv7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:49:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:49:38 INFO - Running setup.py (path:/tmp/pip-onRnLm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:49:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:49:38 INFO - Running setup.py (path:/tmp/pip-QtMvIG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:49:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:49:38 INFO - Running setup.py (path:/tmp/pip-gG0Ino-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:49:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:49:38 INFO - Running setup.py (path:/tmp/pip-Rt1Gss-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:49:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:49:38 INFO - Running setup.py (path:/tmp/pip-0Jbnph-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:49:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:49:38 INFO - Running setup.py (path:/tmp/pip-Vupxyu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:49:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:49:38 INFO - Running setup.py (path:/tmp/pip-ovmIUl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:49:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:49:38 INFO - Running setup.py (path:/tmp/pip-UYyu__-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:49:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:49:38 INFO - Running setup.py (path:/tmp/pip-68NdBl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:49:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:49:38 INFO - Running setup.py (path:/tmp/pip-zxSBIV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:49:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:49:38 INFO - Running setup.py (path:/tmp/pip-0sHs4V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:49:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:49:38 INFO - Running setup.py (path:/tmp/pip-XKlP6U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:49:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:49:39 INFO - Running setup.py (path:/tmp/pip-DYLIYG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:49:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:49:39 INFO - Running setup.py (path:/tmp/pip-s6uU8O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:49:39 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 00:49:39 INFO - Running setup.py install for manifestparser 00:49:39 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 00:49:39 INFO - Running setup.py install for mozcrash 00:49:39 INFO - Running setup.py install for mozdebug 00:49:39 INFO - Running setup.py install for mozdevice 00:49:39 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 00:49:39 INFO - Installing dm script to /builds/slave/test/build/venv/bin 00:49:39 INFO - Running setup.py install for mozfile 00:49:39 INFO - Running setup.py install for mozhttpd 00:49:39 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 00:49:39 INFO - Running setup.py install for mozinfo 00:49:39 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 00:49:39 INFO - Running setup.py install for mozInstall 00:49:39 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 00:49:39 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 00:49:39 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 00:49:39 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 00:49:39 INFO - Running setup.py install for mozleak 00:49:40 INFO - Running setup.py install for mozlog 00:49:40 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 00:49:40 INFO - Running setup.py install for moznetwork 00:49:40 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 00:49:40 INFO - Running setup.py install for mozprocess 00:49:40 INFO - Running setup.py install for mozprofile 00:49:40 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 00:49:40 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 00:49:40 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 00:49:40 INFO - Running setup.py install for mozrunner 00:49:40 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 00:49:40 INFO - Running setup.py install for mozscreenshot 00:49:40 INFO - Running setup.py install for moztest 00:49:40 INFO - Running setup.py install for mozversion 00:49:40 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 00:49:40 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 00:49:40 INFO - Cleaning up... 00:49:40 INFO - Return code: 0 00:49:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:49:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:49:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:49:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:49:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:49:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:49:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:49:40 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 0x1dbb030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f1e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x207c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x207a3b0>, '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 0x207b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x207b740>, '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': '03627c79f6bb3d1578c4a402000001ba-1467186540.145069-536717880', '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 00:49:40 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 00:49:40 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 00:49:40 INFO - Using env: {'DISPLAY': ':0', 00:49:40 INFO - 'HOME': '/home/cltbld', 00:49:40 INFO - 'LANG': 'en_US.UTF-8', 00:49:40 INFO - 'LANGUAGE': 'en_US:en', 00:49:40 INFO - 'LOGNAME': 'cltbld', 00:49:40 INFO - 'MAIL': '/var/mail/cltbld', 00:49:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:49:40 INFO - 'MOZ_NO_REMOTE': '1', 00:49:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:49:40 INFO - 'NO_EM_RESTART': '1', 00:49:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:49:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:49:40 INFO - 'PWD': '/builds/slave/test', 00:49:40 INFO - 'SHELL': '/bin/bash', 00:49:41 INFO - 'SHLVL': '1', 00:49:41 INFO - 'TERM': 'linux', 00:49:41 INFO - 'TMOUT': '86400', 00:49:41 INFO - 'USER': 'cltbld', 00:49:41 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1467186540.145069-536717880', 00:49:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:49:41 INFO - '_': '/tools/buildbot/bin/python'} 00:49:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:49:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:49:41 INFO - Running setup.py (path:/tmp/pip-hnCUqg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:49:41 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)) 00:49:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:49:41 INFO - Running setup.py (path:/tmp/pip-_AdUru-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:49:41 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)) 00:49:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:49:41 INFO - Running setup.py (path:/tmp/pip-XmTKDo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:49:41 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)) 00:49:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:49:41 INFO - Running setup.py (path:/tmp/pip-dYNqm8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:49:41 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)) 00:49:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:49:41 INFO - Running setup.py (path:/tmp/pip-EV6XLx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:49:41 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)) 00:49:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:49:41 INFO - Running setup.py (path:/tmp/pip-a_SfhA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:49:41 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)) 00:49:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:49:41 INFO - Running setup.py (path:/tmp/pip-Q5bvuE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:49:41 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)) 00:49:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:49:41 INFO - Running setup.py (path:/tmp/pip-R58hnq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:49:41 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)) 00:49:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:49:41 INFO - Running setup.py (path:/tmp/pip-U13BlG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:49:41 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)) 00:49:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:49:41 INFO - Running setup.py (path:/tmp/pip-x1v7UI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:49:41 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)) 00:49:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:49:41 INFO - Running setup.py (path:/tmp/pip-g3fVw1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:49:42 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)) 00:49:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:49:42 INFO - Running setup.py (path:/tmp/pip-5jul7s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:49:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 00:49:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:49:42 INFO - Running setup.py (path:/tmp/pip-4mrUxt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:49:42 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)) 00:49:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:49:42 INFO - Running setup.py (path:/tmp/pip-6LhaEX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:49:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 00:49:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:49:42 INFO - Running setup.py (path:/tmp/pip-2oaAxE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:49:42 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)) 00:49:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:49:42 INFO - Running setup.py (path:/tmp/pip-dpIQFi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:49:42 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)) 00:49:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:49:42 INFO - Running setup.py (path:/tmp/pip-VcYfrW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:49:42 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)) 00:49:42 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)) 00:49:42 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)) 00:49:42 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)) 00:49:42 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)) 00:49:42 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)) 00:49:42 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 00:49:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:49:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:49:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:49:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:49:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:49:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:49:44 INFO - Downloading blessings-1.6.tar.gz 00:49:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 00:49:44 INFO - Installing collected packages: blessings 00:49:44 INFO - Running setup.py install for blessings 00:49:44 INFO - Successfully installed blessings 00:49:44 INFO - Cleaning up... 00:49:44 INFO - Return code: 0 00:49:44 INFO - Done creating virtualenv /builds/slave/test/build/venv. 00:49:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:49:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:49:44 INFO - Reading from file tmpfile_stdout 00:49:44 INFO - Current package versions: 00:49:44 INFO - argparse == 1.2.1 00:49:44 INFO - blessings == 1.6 00:49:44 INFO - blobuploader == 1.2.4 00:49:44 INFO - docopt == 0.6.1 00:49:44 INFO - functools32 == 3.2.3-2 00:49:44 INFO - jsonschema == 2.5.1 00:49:44 INFO - manifestparser == 1.1 00:49:44 INFO - mozInstall == 1.12 00:49:44 INFO - mozcrash == 0.17 00:49:44 INFO - mozdebug == 0.1 00:49:44 INFO - mozdevice == 0.48 00:49:44 INFO - mozfile == 1.2 00:49:44 INFO - mozhttpd == 0.7 00:49:44 INFO - mozinfo == 0.9 00:49:44 INFO - mozleak == 0.1 00:49:44 INFO - mozlog == 3.2 00:49:44 INFO - moznetwork == 0.27 00:49:44 INFO - mozprocess == 0.22 00:49:44 INFO - mozprofile == 0.28 00:49:44 INFO - mozrunner == 6.11 00:49:44 INFO - mozscreenshot == 0.1 00:49:44 INFO - mozsystemmonitor == 0.3 00:49:44 INFO - moztest == 0.7 00:49:44 INFO - mozversion == 1.4 00:49:44 INFO - psutil == 3.1.1 00:49:44 INFO - requests == 1.2.3 00:49:44 INFO - wsgiref == 0.1.2 00:49:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:49: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')]} 00:49:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:49:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:49: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')]} 00:49:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:49:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:49:44 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 0x1dbb030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f1e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x207c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x207a3b0>, '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 0x207b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x207b740>, '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': '03627c79f6bb3d1578c4a402000001ba-1467186540.145069-536717880', '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 00:49:44 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 00:49:44 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 00:49:44 INFO - Using env: {'DISPLAY': ':0', 00:49:44 INFO - 'HOME': '/home/cltbld', 00:49:44 INFO - 'LANG': 'en_US.UTF-8', 00:49:44 INFO - 'LANGUAGE': 'en_US:en', 00:49:44 INFO - 'LOGNAME': 'cltbld', 00:49:44 INFO - 'MAIL': '/var/mail/cltbld', 00:49:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:49:44 INFO - 'MOZ_NO_REMOTE': '1', 00:49:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:49:44 INFO - 'NO_EM_RESTART': '1', 00:49:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:49:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:49:44 INFO - 'PWD': '/builds/slave/test', 00:49:44 INFO - 'SHELL': '/bin/bash', 00:49:44 INFO - 'SHLVL': '1', 00:49:44 INFO - 'TERM': 'linux', 00:49:44 INFO - 'TMOUT': '86400', 00:49:44 INFO - 'USER': 'cltbld', 00:49:44 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1467186540.145069-536717880', 00:49:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:49:44 INFO - '_': '/tools/buildbot/bin/python'} 00:49:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:49:45 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)) 00:49:45 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)) 00:49:45 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)) 00:49:45 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)) 00:49:45 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)) 00:49:45 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)) 00:49:45 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)) 00:49:45 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)) 00:49:45 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)) 00:49:45 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)) 00:49:45 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)) 00:49:45 INFO - Cleaning up... 00:49:45 INFO - Return code: 0 00:49:45 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 00:49: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')]} 00:49:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:49:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:49: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')]} 00:49:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:49:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:49:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dbb030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f1e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x207c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x207a3b0>, '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 0x207b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x207b740>, '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': '03627c79f6bb3d1578c4a402000001ba-1467186540.145069-536717880', '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 00:49:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 00:49:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 00:49:45 INFO - Using env: {'DISPLAY': ':0', 00:49:45 INFO - 'HOME': '/home/cltbld', 00:49:45 INFO - 'LANG': 'en_US.UTF-8', 00:49:45 INFO - 'LANGUAGE': 'en_US:en', 00:49:45 INFO - 'LOGNAME': 'cltbld', 00:49:45 INFO - 'MAIL': '/var/mail/cltbld', 00:49:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:49:45 INFO - 'MOZ_NO_REMOTE': '1', 00:49:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:49:45 INFO - 'NO_EM_RESTART': '1', 00:49:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:49:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:49:45 INFO - 'PWD': '/builds/slave/test', 00:49:45 INFO - 'SHELL': '/bin/bash', 00:49:45 INFO - 'SHLVL': '1', 00:49:45 INFO - 'TERM': 'linux', 00:49:45 INFO - 'TMOUT': '86400', 00:49:45 INFO - 'USER': 'cltbld', 00:49:45 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1467186540.145069-536717880', 00:49:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:49:45 INFO - '_': '/tools/buildbot/bin/python'} 00:49:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:49:45 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 00:49:45 INFO - Cleaning up... 00:49:45 INFO - Return code: 0 00:49:45 INFO - Running post-action listener: _resource_record_post_action 00:49:45 INFO - Running post-action listener: _start_resource_monitoring 00:49:45 INFO - Starting resource monitoring. 00:49:45 INFO - ##### 00:49:45 INFO - ##### Finished create-virtualenv step (success) 00:49:45 INFO - ##### 00:49:45 INFO - ##### 00:49:45 INFO - ##### Running install step. 00:49:45 INFO - ##### 00:49:45 INFO - Running pre-action listener: _resource_record_pre_action 00:49:45 INFO - Running main action method: install 00:49:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:49:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:49:45 INFO - Reading from file tmpfile_stdout 00:49:45 INFO - Detecting whether we're running mozinstall >=1.0... 00:49:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 00:49:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 00:49:45 INFO - Reading from file tmpfile_stdout 00:49:45 INFO - Output received: 00:49:45 INFO - Usage: mozinstall [options] installer 00:49:45 INFO - Options: 00:49:45 INFO - -h, --help show this help message and exit 00:49:45 INFO - -d DEST, --destination=DEST 00:49:45 INFO - Directory to install application into. [default: 00:49:45 INFO - "/builds/slave/test"] 00:49:45 INFO - --app=APP Application being installed. [default: firefox] 00:49:45 INFO - mkdir: /builds/slave/test/build/application 00:49:45 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'] 00:49:45 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 00:50:01 INFO - Reading from file tmpfile_stdout 00:50:01 INFO - Output received: 00:50:01 INFO - /builds/slave/test/build/application/firefox/firefox 00:50:01 INFO - Running post-action listener: _resource_record_post_action 00:50:01 INFO - ##### 00:50:01 INFO - ##### Finished install step (success) 00:50:01 INFO - ##### 00:50:01 INFO - ##### 00:50:01 INFO - ##### Running run-tests step. 00:50:01 INFO - ##### 00:50:01 INFO - Running pre-action listener: _resource_record_pre_action 00:50:01 INFO - Running main action method: run_tests 00:50:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 00:50:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 00:50:01 INFO - Python 2.7.3 00:50:01 INFO - Return code: 0 00:50:01 INFO - grabbing minidump binary from tooltool 00:50:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:50:01 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 0x207a3b0>, '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 0x207b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x207b740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 00:50:01 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 00:50:01 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 00:50:01 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 00:50:01 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 00:50:01 INFO - Return code: 0 00:50:01 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 00:50:01 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 00:50:01 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 00:50:01 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 00:50:01 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 00:50:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Hi81xJZlSzOxDiRAmFIe7g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--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 00:50:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Hi81xJZlSzOxDiRAmFIe7g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-047 --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 00:50:01 INFO - Using env: {'DISPLAY': ':0', 00:50:01 INFO - 'HOME': '/home/cltbld', 00:50:01 INFO - 'LANG': 'en_US.UTF-8', 00:50:01 INFO - 'LANGUAGE': 'en_US:en', 00:50:01 INFO - 'LOGNAME': 'cltbld', 00:50:01 INFO - 'MAIL': '/var/mail/cltbld', 00:50:01 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 00:50:01 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 00:50:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:50:01 INFO - 'MOZ_NO_REMOTE': '1', 00:50:01 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 00:50:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:50:01 INFO - 'NO_EM_RESTART': '1', 00:50:01 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:50:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:50:01 INFO - 'PWD': '/builds/slave/test', 00:50:01 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 00:50:01 INFO - 'SHELL': '/bin/bash', 00:50:01 INFO - 'SHLVL': '1', 00:50:01 INFO - 'TERM': 'linux', 00:50:01 INFO - 'TMOUT': '86400', 00:50:01 INFO - 'USER': 'cltbld', 00:50:01 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1467186540.145069-536717880', 00:50:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:50:01 INFO - '_': '/tools/buildbot/bin/python'} 00:50:01 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Hi81xJZlSzOxDiRAmFIe7g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--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 00:50:02 INFO - mozversion application_buildid: 20160628071022 00:50:02 INFO - mozversion application_changeset: e45890951ce77c3df05575bd54072b9f300d77b0 00:50:02 INFO - mozversion application_display_name: Nightly 00:50:02 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 00:50:02 INFO - mozversion application_name: Firefox 00:50:02 INFO - mozversion application_remotingname: firefox 00:50:02 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 00:50:02 INFO - mozversion application_vendor: Mozilla 00:50:02 INFO - mozversion application_version: 50.0a1 00:50:02 INFO - mozversion platform_buildid: 20160628071022 00:50:02 INFO - mozversion platform_changeset: e45890951ce77c3df05575bd54072b9f300d77b0 00:50:02 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 00:50:02 INFO - mozversion platform_version: 50.0a1 00:50:02 INFO - using testdate: 1467186602 00:50:02 INFO - actual date: 1467186602 00:50:02 INFO - starting webserver on 'localhost:40580' 00:50:02 INFO - SUITE-START | Running 2 tests 00:50:02 INFO - TEST-START | dromaeo_css 00:50:02 INFO - operating with platform_type : linux_ 00:50:02 INFO - Initialising browser for dromaeo_css test... 00:50:02 INFO - TEST-INFO | started process 9242 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprXtpsk/profile http://localhost:40580/getInfo.html) 00:50:06 INFO - PROCESS | 9242 | __metrics Screen width/height:1600/1200 00:50:06 INFO - PROCESS | 9242 | colorDepth:24 00:50:06 INFO - PROCESS | 9242 | Browser inner width/height: 1024/697 00:50:06 INFO - PROCESS | 9242 | __metrics 00:50:07 INFO - PROCESS | 9242 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 00:50:08 INFO - TEST-INFO | 9242: exit 0 00:50:08 INFO - Browser initialized. 00:50:08 INFO - Running cycle 1/1 for dromaeo_css test... 00:50:08 INFO - TEST-INFO | started process 9323 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprXtpsk/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:50:20 INFO - PROCESS | 9323 | RSS: Main: 158232576 00:50:20 INFO - PROCESS | 9323 | 00:51:11 INFO - PROCESS | 9323 | 1467186671194 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] 00:53:24 INFO - PROCESS | 9323 | Cycle 1(1): loaded http://localhost:40580/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40580/tests/dromaeo/cssquery-ext.html) 00:53:25 INFO - PROCESS | 9323 | RSS: Main: 242909184 00:53:25 INFO - PROCESS | 9323 | 00:56:27 INFO - PROCESS | 9323 | Cycle 1(1): loaded http://localhost:40580/tests/dromaeo/cssquery-ext.html (next: http://localhost:40580/tests/dromaeo/cssquery-jquery.html) 00:56:28 INFO - PROCESS | 9323 | RSS: Main: 241950720 00:56:28 INFO - PROCESS | 9323 | 00:59:30 INFO - PROCESS | 9323 | Cycle 1(1): loaded http://localhost:40580/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40580/tests/dromaeo/cssquery-mootools.html) 00:59:31 INFO - PROCESS | 9323 | RSS: Main: 245760000 00:59:31 INFO - PROCESS | 9323 | 01:02:33 INFO - PROCESS | 9323 | Cycle 1(1): loaded http://localhost:40580/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40580/tests/dromaeo/cssquery-prototype.html) 01:02:34 INFO - PROCESS | 9323 | RSS: Main: 237838336 01:02:34 INFO - PROCESS | 9323 | 01:05:37 INFO - PROCESS | 9323 | Cycle 1(1): loaded http://localhost:40580/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40580/tests/dromaeo/cssquery-yui.html) 01:05:37 INFO - PROCESS | 9323 | RSS: Main: 219496448 01:05:37 INFO - PROCESS | 9323 | 01:08:40 INFO - PROCESS | 9323 | Cycle 1(1): loaded http://localhost:40580/tests/dromaeo/cssquery-yui.html (next: http://localhost:40580/tests/dromaeo/cssquery-dojo.html) 01:08:40 INFO - PROCESS | 9323 | RSS: Main: 310714368 01:08:40 INFO - PROCESS | 9323 | 01:08:40 INFO - PROCESS | 9323 | __start_tp_report 01:08:40 INFO - PROCESS | 9323 | _x_x_mozilla_page_load 01:08:40 INFO - PROCESS | 9323 | _x_x_mozilla_page_load_details 01:08:40 INFO - PROCESS | 9323 | |i|pagename|runs| 01:08:40 INFO - PROCESS | 9323 | |0;dojo.html;2607.6610040694713;2619.476104779045;2645.206438068579;2663.360793409581;2667.466506698661;4633.235516139841;4690.882727931804;4705.858824235274;4768.570828625423;4832.903341933159;4721.315409265654;4722.50413706561;4724.834630787923;4734.431868175815;4775.976120119394;4305.22505948929;4351.042770590481;4397.098594788077;4424.115176964604;4555.589996900295;4458.8885277867985;4495.595396414322;4511.165434394631;4522;4539.841105561306;4231.026863821323;4298.656107511391;4306.332518459612;4309.461317335333;4320.956790432087;4294.377315289296;4298.527162012208;4347.217500849846;4352.499462561815;4357.607815296638;4345.239583072949;4348.760818155;4351.847685331029;4384.408104905829;4388.210122178007;4627.23650597651;4729.739864307462;4760.690555113941;4781.952180478185;4844.055409195208;5127.5385215330425;5167.974160129213;5184.611154163453;5188.584913206934;5193.039287731782;4948.0103979204305;5199.064168449678;5227.242049902743;5228.137357336035;5234.895302093937;4783.258594917794;4813.975930120397;4820.493848145964;4829;4836.153673107192;5342.011727830364;5351.919721204185;5352.384475785257;5355.277037599874;5358.223057656696;4864.148773964613;4987.476314986947;5144.536991670768;5148.073346797538;5151.098557752378;5128.435872054146;5150.304708864255;5168.9224661630105;5174.223866419992;5223.738813059332;5106.4382917879;5124;5129.281900533928;5134.204198349262;5181.041507321158;4923.187674033744;4977.776000080005;4999.800007999712;5106.285120083191;5124.615653825978;4336.306191009487;4348.760818155032;4358.694891357638;4389.890252743643;4401.097774956126;3774.358359078963;3803.125281185343;3807.7905715185375;3830.9616903830606;3833.559140698855;4338.696291259645;4375.518692943773;4380.846670366522;4395.099004704028;4404.493483249404;5108.872278193075;5124.205748109049;5128.640995130379;5128.897422051613;5174.404943431554;4411.250087485135;4412.029353542215;4413.051193993307;4446.1330040642415;4458.420405347284;4470.418845550058;4542.613877820422;4549.499555048942;4552.476465206478;4576.450825900846;4724.858254252378;4732.124556956974;4732.881677958078;4760.190767569452;4809.158397280392;5048.848534543969;5089.134847075932;5092.821751238837;5099.898002040012;5150.304708864405;4671.995520963009;4790.496997815179;4813.302071199727;4830.95169048305;4854.077725232336;5088.542031217208;5090.694558326512;5094.312267843794;5098.439171691037;5157;4958.801647934042;5172.353455818023;5179.19722443022;5179.585633149263;5179.766910488962;4875.902481950412;4893.559579637707;4908.754562271801;4923.852284431473;4941.579965702956;4912.45962944083;4931.087748766489;4933.087378834927;4939.43196532389;4975.676581022222;4762.071396077731;4770.833020844392;4862.927056094232;4864.464908859952;4911.656184067081;4890.266460031024;4897.583705385082;4908.509149085063;4910.508949105061;4961.652684312064;4824.734639594715;4832.033593281428;4832.855014349575;4834.274858771212;4865.245886887538 01:08:40 INFO - PROCESS | 9323 | |1;ext.html;553.4189101443484;584.1879787095935;587.4125874125873;606.6693651959683;612.8988716861718;28986.420271594554;31852.20369490761;40428.9892752681;41353.37969930453;41507.96230094249;41252.17495650085;41627.58372416275;41657.791711041406;41721.16557668852;41770.37344439828;7491.587962662052;7821.843563128748;7978.760637180865;7982.600869956508;10249.128824049965;9897.307188496809;10308.123809476203;10309.690709278733;10312.278140530167;10324.380537167757;10407.323523970956;10456.634017809378;10457.58169673212;10460.424676642782;10464.162866970624;7567.772966811004;10115.494225288707;10277.075063244307;10397.84403233952;10402.167826573932;10158.542865570993;10224.795504089876;10229.232807539463;10233.334833235816;10233.89766102337;38689.61310386888;38974.22051558981;39057;39078.60921390778;39100.41349379761;3085.6605773364913;3266.950995735066;3405.012546361577;3649.4525821127045;3688.2992231475932;29767.553486697718;29956.251093722614;29975.250618734488;30380.696193038228;31294.37411251785;3587.246678197582;3601.549806274216;3607.062163837395;3626.34725749365;3689.8524059037604;258471;258893;259518;259574;260620;31916.521252181235;52337.7383113082;52480.47519524832;52678;52709.73645131826;34035.829820851235;34218;34219;34220.48669269963;34278.65721342804;13908.791368129487;13988.790168147487;14004.159750414803;14086.43654253839;14089.859101408854;9820.803583928424;11581.07351411885;11794.410279485992;11846.052315814713;12272.202306850026;7980.600969951595;8009.3192078673965;8017.238362355567;8088.029436467544;8112.959435202786;3123.6563977962405;3136.153238625604;3140.309131990958;3149.165471150147;3152.180433087414;858.2961971183694;898.7842917699705;943.2878176976476;952.4095061062047;980.9705708828747;27452.313692157855;28154;28691.14544103181;28756.568651470243;29038.709612904022;924.9722508324761;973.4500007495742;983.7835676151235;1017.7737318867668;1050.5797680927537;15111.924440377728;15340.15629140408;15418.152001640017;15557.611059723598;16131.274092665859;395304;398839;399017;399821;400016;50845;52002.219966700526;52076.218856717176;52106.47893521092;52116.47883521192;1088.314361951981;1114.053054903342;1121.1199208621192;1183.6386409113873;1220.6765207220094;24589.38526536851;30130.749299824663;30919.2270193247;31292.217694556908;31610.841945790125;46574;47230.291545626154;47340.7632961833;47355;47367.52632473769;363143;366261;367047;367427;367478;24982.875085624455;25412.364690882136;33183.668163318056;37922.43116353312;38433.615663843004;42291.3656295162;42715.35926961036;42933.785331074396;43210;43299.56700433081;35603.28793424065;35812.28375432529;36959;37481.62518374781;37537.4369384454;36226.456603150444;36556;36653.26693466169;36716.26567468582;36895;35863.64136358603;36180;37304;37310.62689373072;40018.199636007696;28508.85745571259;31037.689623104383;31282.53076203813;31292.843535782176;31529.05412837527;24166.63750043786;24640.753592464564;24901.128460503794;24961.750382495942;25146.24561263165 01:08:40 INFO - PROCESS | 9323 | |2;jquery.html;356.5097990263386;360.3711523391682;363.3078984534461;374.6927519434065;375.0642147841137;16976.320947162116;16987.23557439915;17663.38178163766;17670.116494175272;17674.734878976826;16624.58438539037;17108.31566737332;17713.1143442828;17718;17725.82274177258;4997.250412438136;5215.843524694265;5258.47415258473;5264.1051021326275;5268.4994925482015;3761.8495260189698;3971.960280397188;5125.538701516863;5892.322382925954;6273.905891411609;6271.529635277349;6314.273858506284;6343.873122537547;6347.143135676693;6351.33311002345;5973.163757074013;6188.350223226541;6208.596441231328;6213.161223234851;6214.912390331697;3370.7303415726683;5081.18701007837;5394.379646340682;5405.37838148614;5411;20522;21103;21242.36272911815;21403.892980535154;21422.25022124234;1948.6297603455298;1978.0604212998853;2010.4672261850621;2169.8481106322565;2365.207655435431;13528.323583820867;13537.187768733907;13584.320783960762;13625;14090;1768.9823101768945;1819.8089200634008;1835.9357422490282;1837.5589858434014;1839.5768973136253;64380.678096609685;66965.33034669688;67210.66394668045;68130.31869681289;69269.65365173142;9381.5309234538;9465.580162975471;9659.90340096604;9706.466144361986;9854.704358869245;13053.869461305456;13143.211407315592;13162.473501060042;13172.60482185536;13183.14309569875;7626.847463050708;7673.11759147694;7763.262490063435;7812.53124812513;7830.725924592726;7506.28690274423;7578.962105189439;7583.582902940281;7678.462507624413;7701.92298077012;6222.906656400158;6258.561900666909;6315.147455093595;6315.747370105236;6471.352864713491;1603.7995250593676;1651.5045486354286;1762.154166000327;1773.4768243368237;1808.7919889212908;850.2730165708354;958.1903291718487;972.6012334942781;1000.6747806962766;1014.518103900656;17001.319947201973;17109.315627375014;17593.384231551834;17630.911845440947;17924.193411296525;855.4354126276628;878.4421892098436;898.1108702384723;905.9729502361938;927.1794461901266;9970.501474926225;10126.443045632413;10170.08469237772;10176.898231017594;10208.081272685346;396982;398172;404701;412580.6854828593;413025;69474;70264.64867675731;71736.28263717401;71820.28179718241;72332.63833680903;893.9329550283754;929.7675581104724;941.8445956417114;950.273041123541;953.5232383808096;15779.447719329768;15933.442329518411;16076.356945722508;16192.67614647677;16381.836181638508;30825.691743082283;33468.33063338671;38035.809820950715;38783;38840.41739373855;49595;50724.239136412245;51795.482045179066;53006.469935300156;53024.2046369297;6319.273283572448;6588.275289718032;6725.697343619451;6816.2502124767225;6970.79087627372;8351.916480835114;11393.544258229578;11873.406329683308;11894.881051189377;12001;9957;10009;10263.58945642166;10585.047345738612;10626.058882619618;5261.631685782112;6281.780137695158;9916.504174791376;10542.736431588964;10775.191860610328;10469.26715129964;10588.735281618021;10652.680419587425;10728.195385345975;10896.673099807018;7422.294881986203;7446.627668616439;7457.925420745723;7545.584992825227;7596.088469383489;7619.9238007619215;9545.904540954501;10262;10590.470476475992;10742.462876856282 01:08:40 INFO - PROCESS | 9323 | |3;mootools.html;1189.762047590482;1371.7530844448;1408.3873515020966;1445.8843292536599;1644.4737683941137;7240.058792356993;7634.160242373335;7649.541027538345;7799.805004874881;7821.2178782121755;7567.167611562723;7725.845483090335;7744.651490682919;7744.9612751936165;7748.96125519373;1830.524063743423;1891.5649400637863;1898.098403258455;2153.7846215378454;2180.084364566878;1900.885946843187;2102.4113248290428;2186.3222401055646;2189.890505474728;2205.40454077399;2067.3177851309033;2102.938016301773;2113.471632091977;2121.883296418704;2124.62819006674;1790.8030116687155;2100.4538819906857;2113.9048742806613;2116.9470763230966;2117.04732870209;2049.6720524716125;2127.7872212778752;2128.9893550532147;2139.3474990128007;2142.9571408571896;7576.924230757677;7586.127595326553;7590.127135379446;7633.5419874807685;7641.694332226704;4358.128374325148;4478.731276123411;4478.843240486567;4481.327800829869;4485.484169320537;2670.198940317897;2729.549624311986;2786.289496178482;2881.0492537462796;2883.4377296427206;858.6951632170552;863.8358711844729;896.1262768800433;911.8541033434618;955.861400096982;10090.192784577217;10141.797164056825;10149.898501015043;10162.644307449278;10171.694849154537;4009.1981603679383;4024.4969378827645;4124.752514849119;4125.546189919107;4129.421880936671;8682;8699.956500217459;8704;8704.260137888225;8704.52125133111;4443.8000289986385;4446.933296000562;4448.043670610834;4448.110377924363;4565.931511027337;3642.581103173116;3687.4468829675225;4102.220578090153;4158.771267580312;4160.126373461547;3503.7722548034294;3621.221437390921;3664.7434679572707;3669.798161101165;3675.3751862182958;1127.1321082766224;1150.6605551362202;1151.1136424952906;1160.7504386556932;1174.3893175548667;827.5655280977414;829.9585020748939;833.6207025803245;837.7235512280932;859.4241857955185;5062.848114556569;5127.080415310407;5204.62389744155;5257.395399529027;5303.36359636846;384.22770231834215;395.77836411609593;403.12924083978464;404.56711318889097;406.0336399369482;3396.8301584920655;3457.4122399191697;3462.9653703463146;3473.044912648991;3572.7141828653644;8910.688125915562;9163.083691630916;9271.95364023189;9298.256139508823;9307.581158847868;9086.363954523253;9111.17999380059;9111.453312801254;9116.498592577473;9119.224865886474;7034.6482675866;7141.357277845019;7152.17749958751;7156.892646610305;7163.31948464895;4979.178435558092;5043.798248070183;5048.596112310933;5143.691378517301;5154.716490592903;8681.262092722189;8693.30453563726;8704.956475217583;8714.215720585178;8763.91236087631;7659.119201291923;7897.131315555399;7913.841723165619;8124.512529248264;8785.341099417441;5974.2233509643465;6323.399277068671;6453.709583068679;6727.058211850443;6837.145356830396;7281.927180728125;7298.306660867209;7352;7352.338289553966;7369.263073692802;6338.778142764981;6429.513042783481;6475.514336424692;6639.037339585637;6730.562513436611;6395.872082558416;6407.935920640734;6515.73937042532;6608.4052435281055;6659.433948114464;6085.421884920926;6213.099100630474;6225.346338634559;6245.656488892972;6251.9687401562705;4303.935440968326;4572.062727140861;4578.130155270488;4580.267157254823;4628.166929952641;4399.098184872158;4504.2793153095345;4516.1419330327135;4559.703619264737;4629.837955671535 01:08:40 INFO - PROCESS | 9323 | |4;prototype.html;289.22055061608944;289.3605132656828;290.41626331074536;296.0260742158299;298.1606776922962;4886.560209581137;4909.214525675892;4939.678920870146;4952.702837829733;4984.825531106412;4880.8047678092835;4911.680740751849;4911.82808601699;4913.803447862081;4931.80272789088;3592.371335016368;3717.275131349388;3734.3278209922205;3849.2878817418728;3885.9611403886024;3802.182530755887;3824;3845.538535375759;3846.384578467446;3876.9224615507674;3616.258666973264;3801.3960437100536;3822.73240873139;3841.481400010991;3842.615738426163;3706.22169344438;3811.5235595550557;3812.5806161322234;3824.6366595173413;3835.865744698936;3371.9325613487595;3373.4939759036097;3382.6448222936483;3383.441732114198;3392.6768560261517;4790.784414701347;4793.32893394925;4793.856184314476;4795.544423279783;4796.424429068499;4217.325227963511;4350.12997400518;4373.868783936487;4382.824687012516;4397.142557201347;5081.923771143436;5103;5111;5112.795488180468;5115.9256556123255;3682.981585092084;3692.409214525663;3695.926081478355;3699.223163135745;3705.0922523981526;5176.741162941876;5324.828537721695;5327.733613319358;5333.946660533384;5346.620753764538;3728.925421491555;3738.4579236010627;3747.681447077029;3747.700183985329;3747.775133491945;3783.4135708965155;3806.352920003606;3814.7602029340574;3815.389537673959;3816.580176180618;4328.307470804656;4356.978215108904;4363.716358436692;4374.934375984363;4387.451568553931;4981.750912454363;5130.871728206825;5144.717040562805;5147.794088236504;5155.948440515622;1293.5537239652306;1315.2174456198547;1316.1445060710614;1316.822228999092;1320.504810695989;852.9721685369116;854.2653318146389;875.0986483921571;875.9094926816027;877.1491653096487;4358.302671572596;4428.247197976351;4529.3920658166535;4543.204939135638;4576;5271.604629652791;5290.947090529045;5291.841244762663;5306.62853600252;5333;4324.524302326741;4561.585908368416;4561.635069194456;4566.360709500673;4567.520410356865;2779.6803367612983;2811.5782632604864;2819.210621026116;2825.6044153818484;2837.971620283812;4956.553910148104;4976.477469865685;4986.326845875833;4988.152014157602;5003.549680528697;5206.869828254324;5415.214793854869;5440.863978400572;5517.10352065161;5531.889362212733;5010.298558201927;5017.799288028438;5020.924686129638;5056.469070747518;5064.645474816727;5356.437574054668;5365.3293338332705;5373.220882972026;5373.220882972026;5381.300430943952;5097.260897169964;5220.791168353223;5290.418054013979;5298.8077682521125;5323.281357016908;4983.5763960063805;4995.350604421547;5000.874978125576;5009.874753131201;5020.196768517019;3746.4380342947684;3752.230792687547;3758.830852611694;3761.9278505625766;3798.8860334190017;5140.871478213075;5334.919976200283;5352.545033672026;5368.651037682538;5373.301470808769;5167.966406718596;5170.922436163536;5172.612054095883;5181.3005244291535;5204.427512973645;5159.638825282194;5165.225216217597;5188.325517682677;5192.818251361185;5202.375714914235;4837.91146991924;4850.587700045536;5089.949100508948;5105.897882042413;5110.66780659256;5071.467495912876;5208.869778255423;5212.348456442945;5219.4780521947505;5222.7127507987425;5044.747762611928;5094.261332106749;5105.2597373381395;5105.412877518985;5115.2582875483595 01:08:40 INFO - PROCESS | 9323 | |5;yui.html;608.2245137449754;626.5520153090542;646.4182235987613;708.0794966543492;734.6436978065638;12150.513979440822;13044.869551304484;13057.412416441271;13059.477620895164;13112.016598755108;12085.818712719316;12302.81545776814;12659.746805063893;12683;12701.872981270184;624.5846512069469;643.2923783837764;777.5451360953849;777.5723352156291;790.4427378698033;790.6007466229546;801.1627848897915;804.2600807257309;804.3806269172762;804.6298702596813;834.8205135895781;838.2078935406043;838.8028813228887;841.1798496465958;841.1840514700731;654.5712558274314;671.5634837355709;672.7275453441364;677.5460441504155;833.8790875323075;595.324306911654;601.0203368509345;602.286290745468;603.4749767702083;604.0938592111833;12392.070594705434;12424.37878106091;12450.688732781662;12451.066170037284;12467.750644987049;12328.630141095691;12437.62687119388;12823.807642885364;12908.54820081302;12912.16070955385;11399.86311832332;11465.885341146648;11600.709982250426;11628.534858605646;11767.470463829062;4154.273002224599;4155.563665815106;4167.249895018896;4325.307950727868;4363.629091527224;60242;61247;61352.38647613556;61439.38560614381;61560.38439615636;9314.161725444606;9560.904390956;10320.690379288482;10475.057244848;10516.211284153718;16408.09755463461;16540.172991350384;16584.83415165857;16638.084905330325;16677;6023.819285421444;6058.818235452944;6063.363346848606;6075.544334174954;6080.908786368208;3657.2695850233144;3806.2006978534264;3807.809609519513;3890.0858298299877;3893.182431689377;2802.1173330400857;2889.321009562751;2892.8698208580663;2893.218830915641;2894.623698919127;478.5453818872085;488.76294996926464;491.31216297184227;492.29355874320464;495.6406605211193;560.9102543593006;577.226516467935;581.8370856160197;586.524914818998;605.3159929279885;7808.960955195302;7894.289513943658;8006.839863202703;8016.198380162054;8184.2224988625985;510.1276816643507;530.9893802124013;532.2601583798523;545.3047364610075;547.2584647802171;3554.147004718849;3593.3531964246686;3627.7279204059273;3735.813209339522;3783.754055986352;87750.12249877547;92578.0742192583;93319.53340233391;94570;94872;79554.60222698965;80004;81391.59304203441;82887.58556207301;83810.58094709487;49233.75383123061;61345.69327153335;64056.67971660112;69193.65403172951;70207.29792702007;8195.098539160806;8866.379353445196;9013.774655633662;9036.141566551167;9056.683016094405;41414.378784317654;42822.21900043454;42956.78521607372;44352.556474434845;44975.775121124185;55567.44432555623;56222.71888640531;57658;62475.6876215616;64016.679916601985;10685.679429616814;10731.517081731497;10774.191935605018;10873.891261087289;11184.88815111871;12476.126671133297;12779.936100319439;13073.542426015043;13509.392077356739;13896.58310250694;11807.357313241373;12175.878241217475;12197.451114700038;12226.510939562319;12351.814722778985;11128.160784529324;11516.94241528787;11801.763964720485;13091.541796037092;13164;11220.607278745205;11230.494627741607;11297.774044519228;11545.82681259765;11958.820617690568;10189.43958082283;10231.130353919703;10263.58945642166;10423.270371073952;10799.244052916221;9791.608335666493;9895.65365212214;10309.948450257702;10350.792984140426;10454.42500662471 01:08:40 INFO - PROCESS | 9323 | __end_tp_report 01:08:40 INFO - PROCESS | 9323 | __start_cc_report 01:08:40 INFO - PROCESS | 9323 | _x_x_mozilla_cycle_collect,869 01:08:40 INFO - PROCESS | 9323 | __end_cc_report 01:08:40 INFO - PROCESS | 9323 | __startTimestamp1467187720937__endTimestamp 01:08:40 INFO - PROCESS | 9323 | 01:08:40 INFO - PROCESS | 9323 | ------- Summary: start ------- 01:08:40 INFO - PROCESS | 9323 | Number of tests: 6 01:08:40 INFO - PROCESS | 9323 | 01:08:40 INFO - PROCESS | 9323 | [#0] dojo.html Cycles:165 Average:4715.66 Median:4829.00 stddev:505.39 (10.5%) stddev-sans-first:479.12 01:08:40 INFO - PROCESS | 9323 | Values: 2607.7 2619.5 2645.2 2663.4 2667.5 4633.2 4690.9 4705.9 4768.6 4832.9 4721.3 4722.5 4724.8 4734.4 4776.0 4305.2 4351.0 4397.1 4424.1 4555.6 4458.9 4495.6 4511.2 4522.0 4539.8 4231.0 4298.7 4306.3 4309.5 4321.0 4294.4 4298.5 4347.2 4352.5 4357.6 4345.2 4348.8 4351.8 4384.4 4388.2 4627.2 4729.7 4760.7 4782.0 4844.1 5127.5 5168.0 5184.6 5188.6 5193.0 4948.0 5199.1 5227.2 5228.1 5234.9 4783.3 4814.0 4820.5 4829.0 4836.2 5342.0 5351.9 5352.4 5355.3 5358.2 4864.1 4987.5 5144.5 5148.1 5151.1 5128.4 5150.3 5168.9 5174.2 5223.7 5106.4 5124.0 5129.3 5134.2 5181.0 4923.2 4977.8 4999.8 5106.3 5124.6 4336.3 4348.8 4358.7 4389.9 4401.1 3774.4 3803.1 3807.8 3831.0 3833.6 4338.7 4375.5 4380.8 4395.1 4404.5 5108.9 5124.2 5128.6 5128.9 5174.4 4411.3 4412.0 4413.1 4446.1 4458.4 4470.4 4542.6 4549.5 4552.5 4576.5 4724.9 4732.1 4732.9 4760.2 4809.2 5048.8 5089.1 5092.8 5099.9 5150.3 4672.0 4790.5 4813.3 4831.0 4854.1 5088.5 5090.7 5094.3 5098.4 5157.0 4958.8 5172.4 5179.2 5179.6 5179.8 4875.9 4893.6 4908.8 4923.9 4941.6 4912.5 4931.1 4933.1 4939.4 4975.7 4762.1 4770.8 4862.9 4864.5 4911.7 4890.3 4897.6 4908.5 4910.5 4961.7 4824.7 4832.0 4832.9 4834.3 4865.2 01:08:40 INFO - PROCESS | 9323 | 01:08:40 INFO - PROCESS | 9323 | [#1] ext.html Cycles:180 Average:49014.79 Median:35837.96 stddev:91433.14 (255.1%) stddev-sans-first:91617.23 01:08:40 INFO - PROCESS | 9323 | Values: 553.4 584.2 587.4 606.7 612.9 28986.4 31852.2 40429.0 41353.4 41508.0 41252.2 41627.6 41657.8 41721.2 41770.4 7491.6 7821.8 7978.8 7982.6 10249.1 9897.3 10308.1 10309.7 10312.3 10324.4 10407.3 10456.6 10457.6 10460.4 10464.2 7567.8 10115.5 10277.1 10397.8 10402.2 10158.5 10224.8 10229.2 10233.3 10233.9 38689.6 38974.2 39057.0 39078.6 39100.4 3085.7 3267.0 3405.0 3649.5 3688.3 29767.6 29956.3 29975.3 30380.7 31294.4 3587.2 3601.5 3607.1 3626.3 3689.9 258471.0 258893.0 259518.0 259574.0 260620.0 31916.5 52337.7 52480.5 52678.0 52709.7 34035.8 34218.0 34219.0 34220.5 34278.7 13908.8 13988.8 14004.2 14086.4 14089.9 9820.8 11581.1 11794.4 11846.1 12272.2 7980.6 8009.3 8017.2 8088.0 8113.0 3123.7 3136.2 3140.3 3149.2 3152.2 858.3 898.8 943.3 952.4 981.0 27452.3 28154.0 28691.1 28756.6 29038.7 925.0 973.5 983.8 1017.8 1050.6 15111.9 15340.2 15418.2 15557.6 16131.3 395304.0 398839.0 399017.0 399821.0 400016.0 50845.0 52002.2 52076.2 52106.5 52116.5 1088.3 1114.1 1121.1 1183.6 1220.7 24589.4 30130.7 30919.2 31292.2 31610.8 46574.0 47230.3 47340.8 47355.0 47367.5 363143.0 366261.0 367047.0 367427.0 367478.0 24982.9 25412.4 33183.7 37922.4 38433.6 42291.4 42715.4 42933.8 43210.0 43299.6 35603.3 35812.3 36959.0 37481.6 37537.4 36226.5 36556.0 36653.3 36716.3 36895.0 35863.6 36180.0 37304.0 37310.6 40018.2 28508.9 31037.7 31282.5 31292.8 31529.1 24166.6 24640.8 24901.1 24961.8 25146.2 01:08:40 INFO - PROCESS | 9323 | 01:08:40 INFO - PROCESS | 9323 | [#2] jquery.html Cycles:180 Average:24712.41 Median:412802.84 stddev:66607.58 (16.1%) stddev-sans-first:66769.32 01:08:40 INFO - PROCESS | 9323 | Values: 356.5 360.4 363.3 374.7 375.1 16976.3 16987.2 17663.4 17670.1 17674.7 16624.6 17108.3 17713.1 17718.0 17725.8 4997.3 5215.8 5258.5 5264.1 5268.5 3761.8 3972.0 5125.5 5892.3 6273.9 6271.5 6314.3 6343.9 6347.1 6351.3 5973.2 6188.4 6208.6 6213.2 6214.9 3370.7 5081.2 5394.4 5405.4 5411.0 20522.0 21103.0 21242.4 21403.9 21422.3 1948.6 1978.1 2010.5 2169.8 2365.2 13528.3 13537.2 13584.3 13625.0 14090.0 1769.0 1819.8 1835.9 1837.6 1839.6 64380.7 66965.3 67210.7 68130.3 69269.7 9381.5 9465.6 9659.9 9706.5 9854.7 13053.9 13143.2 13162.5 13172.6 13183.1 7626.8 7673.1 7763.3 7812.5 7830.7 7506.3 7579.0 7583.6 7678.5 7701.9 6222.9 6258.6 6315.1 6315.7 6471.4 1603.8 1651.5 1762.2 1773.5 1808.8 850.3 958.2 972.6 1000.7 1014.5 17001.3 17109.3 17593.4 17630.9 17924.2 855.4 878.4 898.1 906.0 927.2 9970.5 10126.4 10170.1 10176.9 10208.1 396982.0 398172.0 404701.0 412580.7 413025.0 69474.0 70264.6 71736.3 71820.3 72332.6 893.9 929.8 941.8 950.3 953.5 15779.4 15933.4 16076.4 16192.7 16381.8 30825.7 33468.3 38035.8 38783.0 38840.4 49595.0 50724.2 51795.5 53006.5 53024.2 6319.3 6588.3 6725.7 6816.3 6970.8 8351.9 11393.5 11873.4 11894.9 12001.0 9957.0 10009.0 10263.6 10585.0 10626.1 5261.6 6281.8 9916.5 10542.7 10775.2 10469.3 10588.7 10652.7 10728.2 10896.7 7422.3 7446.6 7457.9 7545.6 7596.1 7619.9 9545.9 10262.0 10590.5 10742.5 01:08:40 INFO - PROCESS | 9323 | 01:08:40 INFO - PROCESS | 9323 | [#3] mootools.html Cycles:180 Average:4952.36 Median:5011.49 stddev:2773.34 (55.3%) stddev-sans-first:2766.70 01:08:40 INFO - PROCESS | 9323 | Values: 1189.8 1371.8 1408.4 1445.9 1644.5 7240.1 7634.2 7649.5 7799.8 7821.2 7567.2 7725.8 7744.7 7745.0 7749.0 1830.5 1891.6 1898.1 2153.8 2180.1 1900.9 2102.4 2186.3 2189.9 2205.4 2067.3 2102.9 2113.5 2121.9 2124.6 1790.8 2100.5 2113.9 2116.9 2117.0 2049.7 2127.8 2129.0 2139.3 2143.0 7576.9 7586.1 7590.1 7633.5 7641.7 4358.1 4478.7 4478.8 4481.3 4485.5 2670.2 2729.5 2786.3 2881.0 2883.4 858.7 863.8 896.1 911.9 955.9 10090.2 10141.8 10149.9 10162.6 10171.7 4009.2 4024.5 4124.8 4125.5 4129.4 8682.0 8700.0 8704.0 8704.3 8704.5 4443.8 4446.9 4448.0 4448.1 4565.9 3642.6 3687.4 4102.2 4158.8 4160.1 3503.8 3621.2 3664.7 3669.8 3675.4 1127.1 1150.7 1151.1 1160.8 1174.4 827.6 830.0 833.6 837.7 859.4 5062.8 5127.1 5204.6 5257.4 5303.4 384.2 395.8 403.1 404.6 406.0 3396.8 3457.4 3463.0 3473.0 3572.7 8910.7 9163.1 9272.0 9298.3 9307.6 9086.4 9111.2 9111.5 9116.5 9119.2 7034.6 7141.4 7152.2 7156.9 7163.3 4979.2 5043.8 5048.6 5143.7 5154.7 8681.3 8693.3 8705.0 8714.2 8763.9 7659.1 7897.1 7913.8 8124.5 8785.3 5974.2 6323.4 6453.7 6727.1 6837.1 7281.9 7298.3 7352.0 7352.3 7369.3 6338.8 6429.5 6475.5 6639.0 6730.6 6395.9 6407.9 6515.7 6608.4 6659.4 6085.4 6213.1 6225.3 6245.7 6252.0 4303.9 4572.1 4578.1 4580.3 4628.2 4399.1 4504.3 4516.1 4559.7 4629.8 01:08:40 INFO - PROCESS | 9323 | 01:08:40 INFO - PROCESS | 9323 | [#4] prototype.html Cycles:180 Average:4278.64 Median:4911.75 stddev:1248.85 (25.4%) stddev-sans-first:1215.93 01:08:40 INFO - PROCESS | 9323 | Values: 289.2 289.4 290.4 296.0 298.2 4886.6 4909.2 4939.7 4952.7 4984.8 4880.8 4911.7 4911.8 4913.8 4931.8 3592.4 3717.3 3734.3 3849.3 3886.0 3802.2 3824.0 3845.5 3846.4 3876.9 3616.3 3801.4 3822.7 3841.5 3842.6 3706.2 3811.5 3812.6 3824.6 3835.9 3371.9 3373.5 3382.6 3383.4 3392.7 4790.8 4793.3 4793.9 4795.5 4796.4 4217.3 4350.1 4373.9 4382.8 4397.1 5081.9 5103.0 5111.0 5112.8 5115.9 3683.0 3692.4 3695.9 3699.2 3705.1 5176.7 5324.8 5327.7 5333.9 5346.6 3728.9 3738.5 3747.7 3747.7 3747.8 3783.4 3806.4 3814.8 3815.4 3816.6 4328.3 4357.0 4363.7 4374.9 4387.5 4981.8 5130.9 5144.7 5147.8 5155.9 1293.6 1315.2 1316.1 1316.8 1320.5 853.0 854.3 875.1 875.9 877.1 4358.3 4428.2 4529.4 4543.2 4576.0 5271.6 5290.9 5291.8 5306.6 5333.0 4324.5 4561.6 4561.6 4566.4 4567.5 2779.7 2811.6 2819.2 2825.6 2838.0 4956.6 4976.5 4986.3 4988.2 5003.5 5206.9 5415.2 5440.9 5517.1 5531.9 5010.3 5017.8 5020.9 5056.5 5064.6 5356.4 5365.3 5373.2 5373.2 5381.3 5097.3 5220.8 5290.4 5298.8 5323.3 4983.6 4995.4 5000.9 5009.9 5020.2 3746.4 3752.2 3758.8 3761.9 3798.9 5140.9 5334.9 5352.5 5368.7 5373.3 5168.0 5170.9 5172.6 5181.3 5204.4 5159.6 5165.2 5188.3 5192.8 5202.4 4837.9 4850.6 5089.9 5105.9 5110.7 5071.5 5208.9 5212.3 5219.5 5222.7 5044.7 5094.3 5105.3 5105.4 5115.3 01:08:40 INFO - PROCESS | 9323 | 01:08:40 INFO - PROCESS | 9323 | [#5] yui.html Cycles:180 Average:17026.59 Median:22727.16 stddev:23780.77 (104.6%) stddev-sans-first:23815.53 01:08:40 INFO - PROCESS | 9323 | Values: 608.2 626.6 646.4 708.1 734.6 12150.5 13044.9 13057.4 13059.5 13112.0 12085.8 12302.8 12659.7 12683.0 12701.9 624.6 643.3 777.5 777.6 790.4 790.6 801.2 804.3 804.4 804.6 834.8 838.2 838.8 841.2 841.2 654.6 671.6 672.7 677.5 833.9 595.3 601.0 602.3 603.5 604.1 12392.1 12424.4 12450.7 12451.1 12467.8 12328.6 12437.6 12823.8 12908.5 12912.2 11399.9 11465.9 11600.7 11628.5 11767.5 4154.3 4155.6 4167.2 4325.3 4363.6 60242.0 61247.0 61352.4 61439.4 61560.4 9314.2 9560.9 10320.7 10475.1 10516.2 16408.1 16540.2 16584.8 16638.1 16677.0 6023.8 6058.8 6063.4 6075.5 6080.9 3657.3 3806.2 3807.8 3890.1 3893.2 2802.1 2889.3 2892.9 2893.2 2894.6 478.5 488.8 491.3 492.3 495.6 560.9 577.2 581.8 586.5 605.3 7809.0 7894.3 8006.8 8016.2 8184.2 510.1 531.0 532.3 545.3 547.3 3554.1 3593.4 3627.7 3735.8 3783.8 87750.1 92578.1 93319.5 94570.0 94872.0 79554.6 80004.0 81391.6 82887.6 83810.6 49233.8 61345.7 64056.7 69193.7 70207.3 8195.1 8866.4 9013.8 9036.1 9056.7 41414.4 42822.2 42956.8 44352.6 44975.8 55567.4 56222.7 57658.0 62475.7 64016.7 10685.7 10731.5 10774.2 10873.9 11184.9 12476.1 12779.9 13073.5 13509.4 13896.6 11807.4 12175.9 12197.5 12226.5 12351.8 11128.2 11516.9 11801.8 13091.5 13164.0 11220.6 11230.5 11297.8 11545.8 11958.8 10189.4 10231.1 10263.6 10423.3 10799.2 9791.6 9895.7 10309.9 10350.8 10454.4 01:08:40 INFO - PROCESS | 9323 | -------- Summary: end -------- 01:08:40 INFO - PROCESS | 9323 | 01:08:41 INFO - TEST-INFO | 9323: exit 0 01:08:41 INFO - TEST-OK | dromaeo_css | took 1119652ms 01:08:41 INFO - TEST-START | kraken 01:08:41 INFO - operating with platform_type : linux_ 01:08:41 INFO - Initialising browser for kraken test... 01:08:41 INFO - TEST-INFO | started process 9497 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTqLIMs/profile http://localhost:40580/getInfo.html) 01:08:45 INFO - PROCESS | 9497 | __metrics Screen width/height:1600/1200 01:08:45 INFO - PROCESS | 9497 | colorDepth:24 01:08:45 INFO - PROCESS | 9497 | Browser inner width/height: 1024/697 01:08:45 INFO - PROCESS | 9497 | __metrics 01:08:46 INFO - PROCESS | 9497 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:08:47 INFO - TEST-INFO | 9497: exit 0 01:08:47 INFO - Browser initialized. 01:08:47 INFO - Running cycle 1/1 for kraken test... 01:08:47 INFO - TEST-INFO | started process 9576 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTqLIMs/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:08:59 INFO - PROCESS | 9576 | RSS: Main: 158937088 01:08:59 INFO - PROCESS | 9576 | 01:09:02 INFO - PROCESS | 9576 | Cycle 1(1): loaded http://localhost:40580/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40580/tests/kraken/driver.html?testName=audio-beat-detection) 01:09:03 INFO - PROCESS | 9576 | RSS: Main: 216424448 01:09:03 INFO - PROCESS | 9576 | 01:09:06 INFO - PROCESS | 9576 | Cycle 1(1): loaded http://localhost:40580/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40580/tests/kraken/driver.html?testName=audio-dft) 01:09:06 INFO - PROCESS | 9576 | RSS: Main: 204189696 01:09:06 INFO - PROCESS | 9576 | 01:09:10 INFO - PROCESS | 9576 | Cycle 1(1): loaded http://localhost:40580/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40580/tests/kraken/driver.html?testName=audio-fft) 01:09:10 INFO - PROCESS | 9576 | RSS: Main: 270360576 01:09:10 INFO - PROCESS | 9576 | 01:09:12 INFO - PROCESS | 9576 | Cycle 1(1): loaded http://localhost:40580/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40580/tests/kraken/driver.html?testName=audio-oscillator) 01:09:13 INFO - PROCESS | 9576 | RSS: Main: 181186560 01:09:13 INFO - PROCESS | 9576 | 01:09:15 INFO - PROCESS | 9576 | Cycle 1(1): loaded http://localhost:40580/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40580/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:09:16 INFO - PROCESS | 9576 | RSS: Main: 185425920 01:09:16 INFO - PROCESS | 9576 | 01:09:19 INFO - PROCESS | 9576 | Cycle 1(1): loaded http://localhost:40580/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40580/tests/kraken/driver.html?testName=imaging-darkroom) 01:09:19 INFO - PROCESS | 9576 | RSS: Main: 221147136 01:09:19 INFO - PROCESS | 9576 | 01:09:23 INFO - PROCESS | 9576 | Cycle 1(1): loaded http://localhost:40580/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40580/tests/kraken/driver.html?testName=imaging-desaturate) 01:09:24 INFO - PROCESS | 9576 | RSS: Main: 216461312 01:09:24 INFO - PROCESS | 9576 | 01:09:27 INFO - PROCESS | 9576 | Cycle 1(1): loaded http://localhost:40580/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40580/tests/kraken/driver.html?testName=json-parse-financial) 01:09:27 INFO - PROCESS | 9576 | RSS: Main: 219795456 01:09:27 INFO - PROCESS | 9576 | 01:09:29 INFO - PROCESS | 9576 | Cycle 1(1): loaded http://localhost:40580/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40580/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:09:29 INFO - PROCESS | 9576 | RSS: Main: 205676544 01:09:29 INFO - PROCESS | 9576 | 01:09:31 INFO - PROCESS | 9576 | Cycle 1(1): loaded http://localhost:40580/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40580/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:09:32 INFO - PROCESS | 9576 | RSS: Main: 210018304 01:09:32 INFO - PROCESS | 9576 | 01:09:34 INFO - PROCESS | 9576 | Cycle 1(1): loaded http://localhost:40580/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40580/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:09:35 INFO - PROCESS | 9576 | RSS: Main: 217460736 01:09:35 INFO - PROCESS | 9576 | 01:09:38 INFO - PROCESS | 9576 | Cycle 1(1): loaded http://localhost:40580/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40580/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:09:38 INFO - PROCESS | 9576 | RSS: Main: 223363072 01:09:38 INFO - PROCESS | 9576 | 01:09:41 INFO - PROCESS | 9576 | Cycle 1(1): loaded http://localhost:40580/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40580/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:09:42 INFO - PROCESS | 9576 | RSS: Main: 224854016 01:09:42 INFO - PROCESS | 9576 | 01:09:43 INFO - PROCESS | 9576 | Cycle 1(1): loaded http://localhost:40580/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40580/tests/kraken/driver.html?testName=ai-astar) 01:09:44 INFO - PROCESS | 9576 | RSS: Main: 267530240 01:09:44 INFO - PROCESS | 9576 | 01:09:44 INFO - PROCESS | 9576 | __start_tp_report 01:09:44 INFO - PROCESS | 9576 | _x_x_mozilla_page_load 01:09:44 INFO - PROCESS | 9576 | _x_x_mozilla_page_load_details 01:09:44 INFO - PROCESS | 9576 | |i|pagename|runs| 01:09:44 INFO - PROCESS | 9576 | |0;ai-astar;103;115;113;114;112;112;111;111;113;112 01:09:44 INFO - PROCESS | 9576 | |1;audio-beat-detection;163;129;133;176;130;132;132;157;170;130 01:09:44 INFO - PROCESS | 9576 | |2;audio-dft;161;160;159;161;161;161;161;161;162;160 01:09:44 INFO - PROCESS | 9576 | |3;audio-fft;77;77;76;122;75;77;77;75;98;75 01:09:44 INFO - PROCESS | 9576 | |4;audio-oscillator;86;86;117;88;87;86;120;87;86;122 01:09:44 INFO - PROCESS | 9576 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;116;118 01:09:44 INFO - PROCESS | 9576 | |6;imaging-darkroom;147;148;146;146;146;146;145;145;145;147 01:09:44 INFO - PROCESS | 9576 | |7;imaging-desaturate;95;95;94;94;95;95;95;95;95;95 01:09:44 INFO - PROCESS | 9576 | |8;json-parse-financial;66;63;64;63;64;63;65;65;63;64 01:09:44 INFO - PROCESS | 9576 | |9;json-stringify-tinderbox;65;64;64;65;66;64;75;65;65;65 01:09:44 INFO - PROCESS | 9576 | |10;stanford-crypto-aes;87;88;81;83;83;84;83;83;91;84 01:09:44 INFO - PROCESS | 9576 | |11;stanford-crypto-ccm;134;142;136;131;127;142;128;142;152;130 01:09:44 INFO - PROCESS | 9576 | |12;stanford-crypto-pbkdf2;167;170;176;168;168;167;170;164;167;165 01:09:44 INFO - PROCESS | 9576 | |13;stanford-crypto-sha256-iterative;66;69;67;67;66;72;66;65;69;65 01:09:44 INFO - PROCESS | 9576 | __end_tp_report 01:09:44 INFO - PROCESS | 9576 | __start_cc_report 01:09:44 INFO - PROCESS | 9576 | _x_x_mozilla_cycle_collect,1904 01:09:44 INFO - PROCESS | 9576 | __end_cc_report 01:09:44 INFO - PROCESS | 9576 | __startTimestamp1467187784161__endTimestamp 01:09:44 INFO - PROCESS | 9576 | 01:09:44 INFO - PROCESS | 9576 | ------- Summary: start ------- 01:09:44 INFO - PROCESS | 9576 | Number of tests: 14 01:09:44 INFO - PROCESS | 9576 | 01:09:44 INFO - PROCESS | 9576 | [#0] ai-astar Cycles:10 Average:111.60 Median:112.50 stddev:3.27 (2.9%) stddev-sans-first:1.33 01:09:44 INFO - PROCESS | 9576 | Values: 103.0 115.0 113.0 114.0 112.0 112.0 111.0 111.0 113.0 112.0 01:09:44 INFO - PROCESS | 9576 | 01:09:44 INFO - PROCESS | 9576 | [#1] audio-beat-detection Cycles:10 Average:145.20 Median:145.00 stddev:18.98 (13.1%) stddev-sans-first:19.01 01:09:44 INFO - PROCESS | 9576 | Values: 163.0 129.0 133.0 176.0 130.0 132.0 132.0 157.0 170.0 130.0 01:09:44 INFO - PROCESS | 9576 | 01:09:44 INFO - PROCESS | 9576 | [#2] audio-dft Cycles:10 Average:160.70 Median:161.00 stddev:0.82 (0.5%) stddev-sans-first:0.87 01:09:44 INFO - PROCESS | 9576 | Values: 161.0 160.0 159.0 161.0 161.0 161.0 161.0 161.0 162.0 160.0 01:09:44 INFO - PROCESS | 9576 | 01:09:44 INFO - PROCESS | 9576 | [#3] audio-fft Cycles:10 Average:82.90 Median:77.00 stddev:15.39 (20.0%) stddev-sans-first:16.17 01:09:44 INFO - PROCESS | 9576 | Values: 77.0 77.0 76.0 122.0 75.0 77.0 77.0 75.0 98.0 75.0 01:09:44 INFO - PROCESS | 9576 | 01:09:44 INFO - PROCESS | 9576 | [#4] audio-oscillator Cycles:10 Average:96.50 Median:86.00 stddev:16.04 (18.7%) stddev-sans-first:16.56 01:09:44 INFO - PROCESS | 9576 | Values: 86.0 86.0 117.0 88.0 87.0 86.0 120.0 87.0 86.0 122.0 01:09:44 INFO - PROCESS | 9576 | 01:09:44 INFO - PROCESS | 9576 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.47 (0.4%) stddev-sans-first:0.50 01:09:44 INFO - PROCESS | 9576 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 116.0 118.0 01:09:44 INFO - PROCESS | 9576 | 01:09:44 INFO - PROCESS | 9576 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.99 (0.7%) stddev-sans-first:1.00 01:09:44 INFO - PROCESS | 9576 | Values: 147.0 148.0 146.0 146.0 146.0 146.0 145.0 145.0 145.0 147.0 01:09:44 INFO - PROCESS | 9576 | 01:09:44 INFO - PROCESS | 9576 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 01:09:44 INFO - PROCESS | 9576 | Values: 95.0 95.0 94.0 94.0 95.0 95.0 95.0 95.0 95.0 95.0 01:09:44 INFO - PROCESS | 9576 | 01:09:44 INFO - PROCESS | 9576 | [#8] json-parse-financial Cycles:10 Average:64.00 Median:64.00 stddev:1.05 (1.6%) stddev-sans-first:0.83 01:09:44 INFO - PROCESS | 9576 | Values: 66.0 63.0 64.0 63.0 64.0 63.0 65.0 65.0 63.0 64.0 01:09:44 INFO - PROCESS | 9576 | 01:09:44 INFO - PROCESS | 9576 | [#9] json-stringify-tinderbox Cycles:10 Average:65.80 Median:65.00 stddev:3.29 (5.1%) stddev-sans-first:3.48 01:09:44 INFO - PROCESS | 9576 | Values: 65.0 64.0 64.0 65.0 66.0 64.0 75.0 65.0 65.0 65.0 01:09:44 INFO - PROCESS | 9576 | 01:09:44 INFO - PROCESS | 9576 | [#10] stanford-crypto-aes Cycles:10 Average:84.70 Median:84.00 stddev:3.02 (3.6%) stddev-sans-first:3.09 01:09:44 INFO - PROCESS | 9576 | Values: 87.0 88.0 81.0 83.0 83.0 84.0 83.0 83.0 91.0 84.0 01:09:44 INFO - PROCESS | 9576 | 01:09:44 INFO - PROCESS | 9576 | [#11] stanford-crypto-ccm Cycles:10 Average:136.40 Median:139.00 stddev:7.97 (5.7%) stddev-sans-first:8.41 01:09:44 INFO - PROCESS | 9576 | Values: 134.0 142.0 136.0 131.0 127.0 142.0 128.0 142.0 152.0 130.0 01:09:44 INFO - PROCESS | 9576 | 01:09:44 INFO - PROCESS | 9576 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.20 Median:168.00 stddev:3.33 (2.0%) stddev-sans-first:3.50 01:09:44 INFO - PROCESS | 9576 | Values: 167.0 170.0 176.0 168.0 168.0 167.0 170.0 164.0 167.0 165.0 01:09:44 INFO - PROCESS | 9576 | 01:09:44 INFO - PROCESS | 9576 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.20 Median:67.00 stddev:2.20 (3.3%) stddev-sans-first:2.29 01:09:44 INFO - PROCESS | 9576 | Values: 66.0 69.0 67.0 67.0 66.0 72.0 66.0 65.0 69.0 65.0 01:09:44 INFO - PROCESS | 9576 | -------- Summary: end -------- 01:09:44 INFO - PROCESS | 9576 | 01:09:45 INFO - TEST-INFO | 9576: exit 0 01:09:45 INFO - TEST-OK | kraken | took 63439ms 01:09:45 INFO - SUITE-END | took 1183s 01:09:45 INFO - Completed test suite (00:19:43) 01:09:45 INFO - javascript benchmark 01:09:45 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2607.6610040694713, 2619.476104779045, 2645.206438068579, 2663.360793409581, 2667.466506698661, 4633.235516139841, 4690.882727931804, 4705.858824235274, 4768.570828625423, 4832.903341933159, 4721.315409265654, 4722.50413706561, 4724.834630787923, 4734.431868175815, 4775.976120119394, 4305.22505948929, 4351.042770590481, 4397.098594788077, 4424.115176964604, 4555.589996900295, 4458.8885277867985, 4495.595396414322, 4511.165434394631, 4522.0, 4539.841105561306, 4231.026863821323, 4298.656107511391, 4306.332518459612, 4309.461317335333, 4320.956790432087, 4294.377315289296, 4298.527162012208, 4347.217500849846, 4352.499462561815, 4357.607815296638, 4345.239583072949, 4348.760818155, 4351.847685331029, 4384.408104905829, 4388.210122178007, 4627.23650597651, 4729.739864307462, 4760.690555113941, 4781.952180478185, 4844.055409195208, 5127.5385215330425, 5167.974160129213, 5184.611154163453, 5188.584913206934, 5193.039287731782, 4948.0103979204305, 5199.064168449678, 5227.242049902743, 5228.137357336035, 5234.895302093937, 4783.258594917794, 4813.975930120397, 4820.493848145964, 4829.0, 4836.153673107192, 5342.011727830364, 5351.919721204185, 5352.384475785257, 5355.277037599874, 5358.223057656696, 4864.148773964613, 4987.476314986947, 5144.536991670768, 5148.073346797538, 5151.098557752378, 5128.435872054146, 5150.304708864255, 5168.9224661630105, 5174.223866419992, 5223.738813059332, 5106.4382917879, 5124.0, 5129.281900533928, 5134.204198349262, 5181.041507321158, 4923.187674033744, 4977.776000080005, 4999.800007999712, 5106.285120083191, 5124.615653825978, 4336.306191009487, 4348.760818155032, 4358.694891357638, 4389.890252743643, 4401.097774956126, 3774.358359078963, 3803.125281185343, 3807.7905715185375, 3830.9616903830606, 3833.559140698855, 4338.696291259645, 4375.518692943773, 4380.846670366522, 4395.099004704028, 4404.493483249404, 5108.872278193075, 5124.205748109049, 5128.640995130379, 5128.897422051613, 5174.404943431554, 4411.250087485135, 4412.029353542215, 4413.051193993307, 4446.1330040642415, 4458.420405347284, 4470.418845550058, 4542.613877820422, 4549.499555048942, 4552.476465206478, 4576.450825900846, 4724.858254252378, 4732.124556956974, 4732.881677958078, 4760.190767569452, 4809.158397280392, 5048.848534543969, 5089.134847075932, 5092.821751238837, 5099.898002040012, 5150.304708864405, 4671.995520963009, 4790.496997815179, 4813.302071199727, 4830.95169048305, 4854.077725232336, 5088.542031217208, 5090.694558326512, 5094.312267843794, 5098.439171691037, 5157.0, 4958.801647934042, 5172.353455818023, 5179.19722443022, 5179.585633149263, 5179.766910488962, 4875.902481950412, 4893.559579637707, 4908.754562271801, 4923.852284431473, 4941.579965702956, 4912.45962944083, 4931.087748766489, 4933.087378834927, 4939.43196532389, 4975.676581022222, 4762.071396077731, 4770.833020844392, 4862.927056094232, 4864.464908859952, 4911.656184067081, 4890.266460031024, 4897.583705385082, 4908.509149085063, 4910.508949105061, 4961.652684312064, 4824.734639594715, 4832.033593281428, 4832.855014349575, 4834.274858771212, 4865.245886887538], "value": 4682.828213270755, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [553.4189101443484, 584.1879787095935, 587.4125874125873, 606.6693651959683, 612.8988716861718, 28986.420271594554, 31852.20369490761, 40428.9892752681, 41353.37969930453, 41507.96230094249, 41252.17495650085, 41627.58372416275, 41657.791711041406, 41721.16557668852, 41770.37344439828, 7491.587962662052, 7821.843563128748, 7978.760637180865, 7982.600869956508, 10249.128824049965, 9897.307188496809, 10308.123809476203, 10309.690709278733, 10312.278140530167, 10324.380537167757, 10407.323523970956, 10456.634017809378, 10457.58169673212, 10460.424676642782, 10464.162866970624, 7567.772966811004, 10115.494225288707, 10277.075063244307, 10397.84403233952, 10402.167826573932, 10158.542865570993, 10224.795504089876, 10229.232807539463, 10233.334833235816, 10233.89766102337, 38689.61310386888, 38974.22051558981, 39057.0, 39078.60921390778, 39100.41349379761, 3085.6605773364913, 3266.950995735066, 3405.012546361577, 3649.4525821127045, 3688.2992231475932, 29767.553486697718, 29956.251093722614, 29975.250618734488, 30380.696193038228, 31294.37411251785, 3587.246678197582, 3601.549806274216, 3607.062163837395, 3626.34725749365, 3689.8524059037604, 258471.0, 258893.0, 259518.0, 259574.0, 260620.0, 31916.521252181235, 52337.7383113082, 52480.47519524832, 52678.0, 52709.73645131826, 34035.829820851235, 34218.0, 34219.0, 34220.48669269963, 34278.65721342804, 13908.791368129487, 13988.790168147487, 14004.159750414803, 14086.43654253839, 14089.859101408854, 9820.803583928424, 11581.07351411885, 11794.410279485992, 11846.052315814713, 12272.202306850026, 7980.600969951595, 8009.3192078673965, 8017.238362355567, 8088.029436467544, 8112.959435202786, 3123.6563977962405, 3136.153238625604, 3140.309131990958, 3149.165471150147, 3152.180433087414, 858.2961971183694, 898.7842917699705, 943.2878176976476, 952.4095061062047, 980.9705708828747, 27452.313692157855, 28154.0, 28691.14544103181, 28756.568651470243, 29038.709612904022, 924.9722508324761, 973.4500007495742, 983.7835676151235, 1017.7737318867668, 1050.5797680927537, 15111.924440377728, 15340.15629140408, 15418.152001640017, 15557.611059723598, 16131.274092665859, 395304.0, 398839.0, 399017.0, 399821.0, 400016.0, 50845.0, 52002.219966700526, 52076.218856717176, 52106.47893521092, 52116.47883521192, 1088.314361951981, 1114.053054903342, 1121.1199208621192, 1183.6386409113873, 1220.6765207220094, 24589.38526536851, 30130.749299824663, 30919.2270193247, 31292.217694556908, 31610.841945790125, 46574.0, 47230.291545626154, 47340.7632961833, 47355.0, 47367.52632473769, 363143.0, 366261.0, 367047.0, 367427.0, 367478.0, 24982.875085624455, 25412.364690882136, 33183.668163318056, 37922.43116353312, 38433.615663843004, 42291.3656295162, 42715.35926961036, 42933.785331074396, 43210.0, 43299.56700433081, 35603.28793424065, 35812.28375432529, 36959.0, 37481.62518374781, 37537.4369384454, 36226.456603150444, 36556.0, 36653.26693466169, 36716.26567468582, 36895.0, 35863.64136358603, 36180.0, 37304.0, 37310.62689373072, 40018.199636007696, 28508.85745571259, 31037.689623104383, 31282.53076203813, 31292.843535782176, 31529.05412837527, 24166.63750043786, 24640.753592464564, 24901.128460503794, 24961.750382495942, 25146.24561263165], "value": 17467.66751781242, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [356.5097990263386, 360.3711523391682, 363.3078984534461, 374.6927519434065, 375.0642147841137, 16976.320947162116, 16987.23557439915, 17663.38178163766, 17670.116494175272, 17674.734878976826, 16624.58438539037, 17108.31566737332, 17713.1143442828, 17718.0, 17725.82274177258, 4997.250412438136, 5215.843524694265, 5258.47415258473, 5264.1051021326275, 5268.4994925482015, 3761.8495260189698, 3971.960280397188, 5125.538701516863, 5892.322382925954, 6273.905891411609, 6271.529635277349, 6314.273858506284, 6343.873122537547, 6347.143135676693, 6351.33311002345, 5973.163757074013, 6188.350223226541, 6208.596441231328, 6213.161223234851, 6214.912390331697, 3370.7303415726683, 5081.18701007837, 5394.379646340682, 5405.37838148614, 5411.0, 20522.0, 21103.0, 21242.36272911815, 21403.892980535154, 21422.25022124234, 1948.6297603455298, 1978.0604212998853, 2010.4672261850621, 2169.8481106322565, 2365.207655435431, 13528.323583820867, 13537.187768733907, 13584.320783960762, 13625.0, 14090.0, 1768.9823101768945, 1819.8089200634008, 1835.9357422490282, 1837.5589858434014, 1839.5768973136253, 64380.678096609685, 66965.33034669688, 67210.66394668045, 68130.31869681289, 69269.65365173142, 9381.5309234538, 9465.580162975471, 9659.90340096604, 9706.466144361986, 9854.704358869245, 13053.869461305456, 13143.211407315592, 13162.473501060042, 13172.60482185536, 13183.14309569875, 7626.847463050708, 7673.11759147694, 7763.262490063435, 7812.53124812513, 7830.725924592726, 7506.28690274423, 7578.962105189439, 7583.582902940281, 7678.462507624413, 7701.92298077012, 6222.906656400158, 6258.561900666909, 6315.147455093595, 6315.747370105236, 6471.352864713491, 1603.7995250593676, 1651.5045486354286, 1762.154166000327, 1773.4768243368237, 1808.7919889212908, 850.2730165708354, 958.1903291718487, 972.6012334942781, 1000.6747806962766, 1014.518103900656, 17001.319947201973, 17109.315627375014, 17593.384231551834, 17630.911845440947, 17924.193411296525, 855.4354126276628, 878.4421892098436, 898.1108702384723, 905.9729502361938, 927.1794461901266, 9970.501474926225, 10126.443045632413, 10170.08469237772, 10176.898231017594, 10208.081272685346, 396982.0, 398172.0, 404701.0, 412580.6854828593, 413025.0, 69474.0, 70264.64867675731, 71736.28263717401, 71820.28179718241, 72332.63833680903, 893.9329550283754, 929.7675581104724, 941.8445956417114, 950.273041123541, 953.5232383808096, 15779.447719329768, 15933.442329518411, 16076.356945722508, 16192.67614647677, 16381.836181638508, 30825.691743082283, 33468.33063338671, 38035.809820950715, 38783.0, 38840.41739373855, 49595.0, 50724.239136412245, 51795.482045179066, 53006.469935300156, 53024.2046369297, 6319.273283572448, 6588.275289718032, 6725.697343619451, 6816.2502124767225, 6970.79087627372, 8351.916480835114, 11393.544258229578, 11873.406329683308, 11894.881051189377, 12001.0, 9957.0, 10009.0, 10263.58945642166, 10585.047345738612, 10626.058882619618, 5261.631685782112, 6281.780137695158, 9916.504174791376, 10542.736431588964, 10775.191860610328, 10469.26715129964, 10588.735281618021, 10652.680419587425, 10728.195385345975, 10896.673099807018, 7422.294881986203, 7446.627668616439, 7457.925420745723, 7545.584992825227, 7596.088469383489, 7619.9238007619215, 9545.904540954501, 10262.0, 10590.470476475992, 10742.462876856282], "value": 8422.150821533623, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1189.762047590482, 1371.7530844448, 1408.3873515020966, 1445.8843292536599, 1644.4737683941137, 7240.058792356993, 7634.160242373335, 7649.541027538345, 7799.805004874881, 7821.2178782121755, 7567.167611562723, 7725.845483090335, 7744.651490682919, 7744.9612751936165, 7748.96125519373, 1830.524063743423, 1891.5649400637863, 1898.098403258455, 2153.7846215378454, 2180.084364566878, 1900.885946843187, 2102.4113248290428, 2186.3222401055646, 2189.890505474728, 2205.40454077399, 2067.3177851309033, 2102.938016301773, 2113.471632091977, 2121.883296418704, 2124.62819006674, 1790.8030116687155, 2100.4538819906857, 2113.9048742806613, 2116.9470763230966, 2117.04732870209, 2049.6720524716125, 2127.7872212778752, 2128.9893550532147, 2139.3474990128007, 2142.9571408571896, 7576.924230757677, 7586.127595326553, 7590.127135379446, 7633.5419874807685, 7641.694332226704, 4358.128374325148, 4478.731276123411, 4478.843240486567, 4481.327800829869, 4485.484169320537, 2670.198940317897, 2729.549624311986, 2786.289496178482, 2881.0492537462796, 2883.4377296427206, 858.6951632170552, 863.8358711844729, 896.1262768800433, 911.8541033434618, 955.861400096982, 10090.192784577217, 10141.797164056825, 10149.898501015043, 10162.644307449278, 10171.694849154537, 4009.1981603679383, 4024.4969378827645, 4124.752514849119, 4125.546189919107, 4129.421880936671, 8682.0, 8699.956500217459, 8704.0, 8704.260137888225, 8704.52125133111, 4443.8000289986385, 4446.933296000562, 4448.043670610834, 4448.110377924363, 4565.931511027337, 3642.581103173116, 3687.4468829675225, 4102.220578090153, 4158.771267580312, 4160.126373461547, 3503.7722548034294, 3621.221437390921, 3664.7434679572707, 3669.798161101165, 3675.3751862182958, 1127.1321082766224, 1150.6605551362202, 1151.1136424952906, 1160.7504386556932, 1174.3893175548667, 827.5655280977414, 829.9585020748939, 833.6207025803245, 837.7235512280932, 859.4241857955185, 5062.848114556569, 5127.080415310407, 5204.62389744155, 5257.395399529027, 5303.36359636846, 384.22770231834215, 395.77836411609593, 403.12924083978464, 404.56711318889097, 406.0336399369482, 3396.8301584920655, 3457.4122399191697, 3462.9653703463146, 3473.044912648991, 3572.7141828653644, 8910.688125915562, 9163.083691630916, 9271.95364023189, 9298.256139508823, 9307.581158847868, 9086.363954523253, 9111.17999380059, 9111.453312801254, 9116.498592577473, 9119.224865886474, 7034.6482675866, 7141.357277845019, 7152.17749958751, 7156.892646610305, 7163.31948464895, 4979.178435558092, 5043.798248070183, 5048.596112310933, 5143.691378517301, 5154.716490592903, 8681.262092722189, 8693.30453563726, 8704.956475217583, 8714.215720585178, 8763.91236087631, 7659.119201291923, 7897.131315555399, 7913.841723165619, 8124.512529248264, 8785.341099417441, 5974.2233509643465, 6323.399277068671, 6453.709583068679, 6727.058211850443, 6837.145356830396, 7281.927180728125, 7298.306660867209, 7352.0, 7352.338289553966, 7369.263073692802, 6338.778142764981, 6429.513042783481, 6475.514336424692, 6639.037339585637, 6730.562513436611, 6395.872082558416, 6407.935920640734, 6515.73937042532, 6608.4052435281055, 6659.433948114464, 6085.421884920926, 6213.099100630474, 6225.346338634559, 6245.656488892972, 6251.9687401562705, 4303.935440968326, 4572.062727140861, 4578.130155270488, 4580.267157254823, 4628.166929952641, 4399.098184872158, 4504.2793153095345, 4516.1419330327135, 4559.703619264737, 4629.837955671535], "value": 3924.5883603961815, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [289.22055061608944, 289.3605132656828, 290.41626331074536, 296.0260742158299, 298.1606776922962, 4886.560209581137, 4909.214525675892, 4939.678920870146, 4952.702837829733, 4984.825531106412, 4880.8047678092835, 4911.680740751849, 4911.82808601699, 4913.803447862081, 4931.80272789088, 3592.371335016368, 3717.275131349388, 3734.3278209922205, 3849.2878817418728, 3885.9611403886024, 3802.182530755887, 3824.0, 3845.538535375759, 3846.384578467446, 3876.9224615507674, 3616.258666973264, 3801.3960437100536, 3822.73240873139, 3841.481400010991, 3842.615738426163, 3706.22169344438, 3811.5235595550557, 3812.5806161322234, 3824.6366595173413, 3835.865744698936, 3371.9325613487595, 3373.4939759036097, 3382.6448222936483, 3383.441732114198, 3392.6768560261517, 4790.784414701347, 4793.32893394925, 4793.856184314476, 4795.544423279783, 4796.424429068499, 4217.325227963511, 4350.12997400518, 4373.868783936487, 4382.824687012516, 4397.142557201347, 5081.923771143436, 5103.0, 5111.0, 5112.795488180468, 5115.9256556123255, 3682.981585092084, 3692.409214525663, 3695.926081478355, 3699.223163135745, 3705.0922523981526, 5176.741162941876, 5324.828537721695, 5327.733613319358, 5333.946660533384, 5346.620753764538, 3728.925421491555, 3738.4579236010627, 3747.681447077029, 3747.700183985329, 3747.775133491945, 3783.4135708965155, 3806.352920003606, 3814.7602029340574, 3815.389537673959, 3816.580176180618, 4328.307470804656, 4356.978215108904, 4363.716358436692, 4374.934375984363, 4387.451568553931, 4981.750912454363, 5130.871728206825, 5144.717040562805, 5147.794088236504, 5155.948440515622, 1293.5537239652306, 1315.2174456198547, 1316.1445060710614, 1316.822228999092, 1320.504810695989, 852.9721685369116, 854.2653318146389, 875.0986483921571, 875.9094926816027, 877.1491653096487, 4358.302671572596, 4428.247197976351, 4529.3920658166535, 4543.204939135638, 4576.0, 5271.604629652791, 5290.947090529045, 5291.841244762663, 5306.62853600252, 5333.0, 4324.524302326741, 4561.585908368416, 4561.635069194456, 4566.360709500673, 4567.520410356865, 2779.6803367612983, 2811.5782632604864, 2819.210621026116, 2825.6044153818484, 2837.971620283812, 4956.553910148104, 4976.477469865685, 4986.326845875833, 4988.152014157602, 5003.549680528697, 5206.869828254324, 5415.214793854869, 5440.863978400572, 5517.10352065161, 5531.889362212733, 5010.298558201927, 5017.799288028438, 5020.924686129638, 5056.469070747518, 5064.645474816727, 5356.437574054668, 5365.3293338332705, 5373.220882972026, 5373.220882972026, 5381.300430943952, 5097.260897169964, 5220.791168353223, 5290.418054013979, 5298.8077682521125, 5323.281357016908, 4983.5763960063805, 4995.350604421547, 5000.874978125576, 5009.874753131201, 5020.196768517019, 3746.4380342947684, 3752.230792687547, 3758.830852611694, 3761.9278505625766, 3798.8860334190017, 5140.871478213075, 5334.919976200283, 5352.545033672026, 5368.651037682538, 5373.301470808769, 5167.966406718596, 5170.922436163536, 5172.612054095883, 5181.3005244291535, 5204.427512973645, 5159.638825282194, 5165.225216217597, 5188.325517682677, 5192.818251361185, 5202.375714914235, 4837.91146991924, 4850.587700045536, 5089.949100508948, 5105.897882042413, 5110.66780659256, 5071.467495912876, 5208.869778255423, 5212.348456442945, 5219.4780521947505, 5222.7127507987425, 5044.747762611928, 5094.261332106749, 5105.2597373381395, 5105.412877518985, 5115.2582875483595], "value": 3877.53300982752, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [608.2245137449754, 626.5520153090542, 646.4182235987613, 708.0794966543492, 734.6436978065638, 12150.513979440822, 13044.869551304484, 13057.412416441271, 13059.477620895164, 13112.016598755108, 12085.818712719316, 12302.81545776814, 12659.746805063893, 12683.0, 12701.872981270184, 624.5846512069469, 643.2923783837764, 777.5451360953849, 777.5723352156291, 790.4427378698033, 790.6007466229546, 801.1627848897915, 804.2600807257309, 804.3806269172762, 804.6298702596813, 834.8205135895781, 838.2078935406043, 838.8028813228887, 841.1798496465958, 841.1840514700731, 654.5712558274314, 671.5634837355709, 672.7275453441364, 677.5460441504155, 833.8790875323075, 595.324306911654, 601.0203368509345, 602.286290745468, 603.4749767702083, 604.0938592111833, 12392.070594705434, 12424.37878106091, 12450.688732781662, 12451.066170037284, 12467.750644987049, 12328.630141095691, 12437.62687119388, 12823.807642885364, 12908.54820081302, 12912.16070955385, 11399.86311832332, 11465.885341146648, 11600.709982250426, 11628.534858605646, 11767.470463829062, 4154.273002224599, 4155.563665815106, 4167.249895018896, 4325.307950727868, 4363.629091527224, 60242.0, 61247.0, 61352.38647613556, 61439.38560614381, 61560.38439615636, 9314.161725444606, 9560.904390956, 10320.690379288482, 10475.057244848, 10516.211284153718, 16408.09755463461, 16540.172991350384, 16584.83415165857, 16638.084905330325, 16677.0, 6023.819285421444, 6058.818235452944, 6063.363346848606, 6075.544334174954, 6080.908786368208, 3657.2695850233144, 3806.2006978534264, 3807.809609519513, 3890.0858298299877, 3893.182431689377, 2802.1173330400857, 2889.321009562751, 2892.8698208580663, 2893.218830915641, 2894.623698919127, 478.5453818872085, 488.76294996926464, 491.31216297184227, 492.29355874320464, 495.6406605211193, 560.9102543593006, 577.226516467935, 581.8370856160197, 586.524914818998, 605.3159929279885, 7808.960955195302, 7894.289513943658, 8006.839863202703, 8016.198380162054, 8184.2224988625985, 510.1276816643507, 530.9893802124013, 532.2601583798523, 545.3047364610075, 547.2584647802171, 3554.147004718849, 3593.3531964246686, 3627.7279204059273, 3735.813209339522, 3783.754055986352, 87750.12249877547, 92578.0742192583, 93319.53340233391, 94570.0, 94872.0, 79554.60222698965, 80004.0, 81391.59304203441, 82887.58556207301, 83810.58094709487, 49233.75383123061, 61345.69327153335, 64056.67971660112, 69193.65403172951, 70207.29792702007, 8195.098539160806, 8866.379353445196, 9013.774655633662, 9036.141566551167, 9056.683016094405, 41414.378784317654, 42822.21900043454, 42956.78521607372, 44352.556474434845, 44975.775121124185, 55567.44432555623, 56222.71888640531, 57658.0, 62475.6876215616, 64016.679916601985, 10685.679429616814, 10731.517081731497, 10774.191935605018, 10873.891261087289, 11184.88815111871, 12476.126671133297, 12779.936100319439, 13073.542426015043, 13509.392077356739, 13896.58310250694, 11807.357313241373, 12175.878241217475, 12197.451114700038, 12226.510939562319, 12351.814722778985, 11128.160784529324, 11516.94241528787, 11801.763964720485, 13091.541796037092, 13164.0, 11220.607278745205, 11230.494627741607, 11297.774044519228, 11545.82681259765, 11958.820617690568, 10189.43958082283, 10231.130353919703, 10263.58945642166, 10423.270371073952, 10799.244052916221, 9791.608335666493, 9895.65365212214, 10309.948450257702, 10350.792984140426, 10454.42500662471], "value": 6450.985871174251, "unit": "score"}], "name": "dromaeo_css", "value": 6383.107066690283, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 115.0, 113.0, 114.0, 112.0, 112.0, 111.0, 111.0, 113.0, 112.0], "value": 111.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 129.0, 133.0, 176.0, 130.0, 132.0, 132.0, 157.0, 170.0, 130.0], "value": 145.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 159.0, 161.0, 161.0, 161.0, 161.0, 161.0, 162.0, 160.0], "value": 160.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 77.0, 76.0, 122.0, 75.0, 77.0, 77.0, 75.0, 98.0, 75.0], "value": 82.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 117.0, 88.0, 87.0, 86.0, 120.0, 87.0, 86.0, 122.0], "value": 96.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 118.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 146.0, 146.0, 146.0, 146.0, 145.0, 145.0, 145.0, 147.0], "value": 146.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 63.0, 64.0, 63.0, 64.0, 63.0, 65.0, 65.0, 63.0, 64.0], "value": 64.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 64.0, 65.0, 66.0, 64.0, 75.0, 65.0, 65.0, 65.0], "value": 65.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 88.0, 81.0, 83.0, 83.0, 84.0, 83.0, 83.0, 91.0, 84.0], "value": 84.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 142.0, 136.0, 131.0, 127.0, 142.0, 128.0, 142.0, 152.0, 130.0], "value": 136.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 170.0, 176.0, 168.0, 168.0, 167.0, 170.0, 164.0, 167.0, 165.0], "value": 168.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 69.0, 67.0, 67.0, 66.0, 72.0, 66.0, 65.0, 69.0, 65.0], "value": 67.2, "unit": "score"}], "name": "kraken", "value": 1541.1000000000001, "alertThreshold": 2.0}]} 01:09:45 INFO - Return code: 0 01:09:45 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 01:09:45 INFO - # TBPL SUCCESS # 01:09:45 INFO - Running post-action listener: _resource_record_post_action 01:09:45 INFO - ##### 01:09:45 INFO - ##### Finished run-tests step (success) 01:09:45 INFO - ##### 01:09:45 INFO - Running post-run listener: _resource_record_post_run 01:09:45 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 8192; Write bytes: 389443584; Read time: 24; Write time: 263036 01:09:45 INFO - TinderboxPrint: CPU usage
13.1% 01:09:45 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 24 01:09:45 INFO - TinderboxPrint: I/O write bytes / time
389,443,584 / 263,036 01:09:45 INFO - TinderboxPrint: CPU idle
8,324.8 (86.9%) 01:09:45 INFO - TinderboxPrint: CPU user
1,212.1 (12.7%) 01:09:45 INFO - TinderboxPrint: Swap in / out
0 / 0 01:09:45 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 100012032; Read time: 0; Write time: 58424 01:09:45 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 0; Write bytes: 282398720; Read time: 0; Write time: 202952 01:09:46 INFO - Running post-run listener: _upload_blobber_files 01:09:46 INFO - Blob upload gear active. 01:09:46 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 01:09:46 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 01:09:46 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', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 01:09:46 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 Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 01:09:46 INFO - (blobuploader) - INFO - Open directory for files ... 01:09:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 01:09:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:09:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:09:49 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 01:09:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:09:49 INFO - (blobuploader) - INFO - Done attempting. 01:09:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 01:09:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:09:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:09:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 01:09:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:09:50 INFO - (blobuploader) - INFO - Done attempting. 01:09:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 01:09:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:09:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:09:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 01:09:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:09:51 INFO - (blobuploader) - INFO - Done attempting. 01:09:51 INFO - (blobuploader) - INFO - Iteration through files over. 01:09:51 INFO - Return code: 0 01:09:51 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 01:09:51 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 01:09:51 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2d1991b66838a7428f30b9e377e79d1d4cbd4bafc3f4a6153c35d70759045c14b9e78a8f87f72bbce99131325d689fd2b315d13061b206dd7109c410514d2a92", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/18ed00440be1a54cff6fe3365f109d0017242bbaafc7a489afc80e47df556201917417e304845ffa9f3fbb004317536d40235f4b592159abab7d42faf15acb4f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b507245d2a309e1d9129f4770f3beeed8123b7d4a4953b3b2903db99549e9844368c957534d625263240b2295c60fe26c26934fb49637046581520a4f95d4fbc"} 01:09:51 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 01:09:51 INFO - Writing to file /builds/slave/test/properties/blobber_files 01:09:51 INFO - Contents: 01:09:51 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2d1991b66838a7428f30b9e377e79d1d4cbd4bafc3f4a6153c35d70759045c14b9e78a8f87f72bbce99131325d689fd2b315d13061b206dd7109c410514d2a92", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/18ed00440be1a54cff6fe3365f109d0017242bbaafc7a489afc80e47df556201917417e304845ffa9f3fbb004317536d40235f4b592159abab7d42faf15acb4f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b507245d2a309e1d9129f4770f3beeed8123b7d4a4953b3b2903db99549e9844368c957534d625263240b2295c60fe26c26934fb49637046581520a4f95d4fbc"} 01:09:51 INFO - Running post-run listener: copy_logs_to_upload_dir 01:09:51 INFO - Copying logs to upload dir... 01:09:51 INFO - mkdir: /builds/slave/test/build/upload/logs 01:09:51 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1249.355503 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-06-29 01:09:51.296559) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-29 01:09:51.299994) ========= 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=03627c79f6bb3d1578c4a402000001ba-1467186540.145069-536717880 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2d1991b66838a7428f30b9e377e79d1d4cbd4bafc3f4a6153c35d70759045c14b9e78a8f87f72bbce99131325d689fd2b315d13061b206dd7109c410514d2a92", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/18ed00440be1a54cff6fe3365f109d0017242bbaafc7a489afc80e47df556201917417e304845ffa9f3fbb004317536d40235f4b592159abab7d42faf15acb4f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b507245d2a309e1d9129f4770f3beeed8123b7d4a4953b3b2903db99549e9844368c957534d625263240b2295c60fe26c26934fb49637046581520a4f95d4fbc"} build_url:https://queue.taskcluster.net/v1/task/Hi81xJZlSzOxDiRAmFIe7g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011286 build_url: 'https://queue.taskcluster.net/v1/task/Hi81xJZlSzOxDiRAmFIe7g/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/Firefox-Non-PGO/sha512/2d1991b66838a7428f30b9e377e79d1d4cbd4bafc3f4a6153c35d70759045c14b9e78a8f87f72bbce99131325d689fd2b315d13061b206dd7109c410514d2a92", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/18ed00440be1a54cff6fe3365f109d0017242bbaafc7a489afc80e47df556201917417e304845ffa9f3fbb004317536d40235f4b592159abab7d42faf15acb4f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b507245d2a309e1d9129f4770f3beeed8123b7d4a4953b3b2903db99549e9844368c957534d625263240b2295c60fe26c26934fb49637046581520a4f95d4fbc"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-29 01:09:51.325930) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 01:09:51.326262) ========= 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=03627c79f6bb3d1578c4a402000001ba-1467186540.145069-536717880 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004475 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-29 01:09:51.409497) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-29 01:09:51.409874) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-29 01:09:51.410184) ========= ========= Total master_lag: 0.18 =========