builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-036 starttime: 1467958140.57 results: success (0) buildid: 20160707203023 builduid: 579889a6bf8e4c319edfdbba30cacf10 revision: 74dd49dcf6c944a1de2b1762ee328710aa4358a4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-07 23:09:00.574383) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-07 23:09:00.574833) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-07 23:09:00.575150) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-07 23:09:00.618571) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 23:09:00.618871) ========= 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=14ef55db36f7623abb31b9cf000001d5-1467957784.914821-962732232 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-07 23:09: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.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 41.2M=0s 2016-07-07 23:09:00 (41.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.150506 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 23:09:00.783607) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 23:09:00.783929) ========= 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=14ef55db36f7623abb31b9cf000001d5-1467957784.914821-962732232 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017481 ========= master_lag: 0.07 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 23:09:00.869538) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-07 23:09:00.869926) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 74dd49dcf6c944a1de2b1762ee328710aa4358a4 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 74dd49dcf6c944a1de2b1762ee328710aa4358a4 --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=14ef55db36f7623abb31b9cf000001d5-1467957784.914821-962732232 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-07 23:09:00,938 truncating revision to first 12 chars 2016-07-07 23:09:00,938 Setting DEBUG logging. 2016-07-07 23:09:00,938 attempt 1/10 2016-07-07 23:09:00,938 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/74dd49dcf6c9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-07 23:09:02,252 unpacking tar archive at: fx-team-74dd49dcf6c9/testing/mozharness/ program finished with exit code 0 elapsedTime=1.645428 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-07 23:09:02.529322) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-07 23:09:02.529674) ========= script_repo_revision: 74dd49dcf6c944a1de2b1762ee328710aa4358a4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-07 23:09:02.530071) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-07 23:09:02.530353) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-07 23:09:02.539858) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-07-07 23:09:02.540326) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=14ef55db36f7623abb31b9cf000001d5-1467957784.914821-962732232 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 23:09:02 INFO - MultiFileLogger online at 20160707 23:09:02 in /builds/slave/test 23:09:02 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 23:09:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 23:09:02 INFO - {'append_to_log': False, 23:09:02 INFO - 'base_work_dir': '/builds/slave/test', 23:09:02 INFO - 'blob_upload_branch': 'Fx-Team', 23:09:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 23:09:02 INFO - 'branch': 'Fx-Team', 23:09:02 INFO - 'buildbot_json_path': 'buildprops.json', 23:09:02 INFO - 'config_files': ('talos/linux_config.py',), 23:09:02 INFO - 'default_actions': ('clobber', 23:09:02 INFO - 'read-buildbot-config', 23:09:02 INFO - 'download-and-extract', 23:09:02 INFO - 'populate-webroot', 23:09:02 INFO - 'create-virtualenv', 23:09:02 INFO - 'install', 23:09:02 INFO - 'run-tests'), 23:09:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 23:09:02 INFO - 'download_minidump_stackwalk': True, 23:09:02 INFO - 'download_symbols': 'ondemand', 23:09:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 23:09:02 INFO - 'tooltool.py': '/tools/tooltool.py', 23:09:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 23:09:02 INFO - '/tools/misc-python/virtualenv.py')}, 23:09:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 23:09:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 23:09:02 INFO - 'installer_path': 'installer.exe', 23:09:02 INFO - 'log_level': 'info', 23:09:02 INFO - 'log_name': 'talos', 23:09:02 INFO - 'log_to_console': True, 23:09:02 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 23:09:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 23:09:02 INFO - 'opt_config_files': (), 23:09:02 INFO - 'pip_index': False, 23:09:02 INFO - 'sps_profile': False, 23:09:02 INFO - 'sps_profile_interval': 0, 23:09:02 INFO - 'suite': 'dromaeojs', 23:09:02 INFO - 'system_bits': '32', 23:09:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 23:09:02 INFO - 'title': 'talos-linux64-ix-036', 23:09:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 23:09:02 INFO - 'use_talos_json': True, 23:09:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 23:09:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 23:09:02 INFO - 'work_dir': 'build'} 23:09:02 INFO - ##### 23:09:02 INFO - ##### Running clobber step. 23:09:02 INFO - ##### 23:09:02 INFO - Running pre-action listener: _resource_record_pre_action 23:09:02 INFO - Running main action method: clobber 23:09:02 INFO - rmtree: /builds/slave/test/build 23:09:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 23:09:03 INFO - Running post-action listener: _resource_record_post_action 23:09:03 INFO - ##### 23:09:03 INFO - ##### Finished clobber step (success) 23:09:03 INFO - ##### 23:09:03 INFO - ##### 23:09:03 INFO - ##### Running read-buildbot-config step. 23:09:03 INFO - ##### 23:09:03 INFO - Running pre-action listener: _resource_record_pre_action 23:09:03 INFO - Running main action method: read_buildbot_config 23:09:03 INFO - Using buildbot properties: 23:09:03 INFO - { 23:09:03 INFO - "project": "", 23:09:03 INFO - "product": "firefox", 23:09:03 INFO - "script_repo_revision": "production", 23:09:03 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 23:09:03 INFO - "repository": "", 23:09:03 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 23:09:03 INFO - "buildid": "20160707203023", 23:09:03 INFO - "pgo_build": "True", 23:09:03 INFO - "basedir": "/builds/slave/test", 23:09:03 INFO - "buildnumber": 261, 23:09:03 INFO - "slavename": "talos-linux64-ix-036", 23:09:03 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 23:09:03 INFO - "platform": "ubuntu64_hw", 23:09:03 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 23:09:03 INFO - "branch": "fx-team", 23:09:03 INFO - "repo_path": "integration/fx-team", 23:09:03 INFO - "revision": "74dd49dcf6c944a1de2b1762ee328710aa4358a4", 23:09:03 INFO - "stage_platform": "linux64-pgo", 23:09:03 INFO - "builduid": "579889a6bf8e4c319edfdbba30cacf10", 23:09:03 INFO - "slavebuilddir": "test" 23:09:03 INFO - } 23:09:03 INFO - Found installer url https://queue.taskcluster.net/v1/task/Sve-B5ImQDq2r89yn4q2Fw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 23:09:03 INFO - Running post-action listener: _resource_record_post_action 23:09:03 INFO - ##### 23:09:03 INFO - ##### Finished read-buildbot-config step (success) 23:09:03 INFO - ##### 23:09:03 INFO - ##### 23:09:03 INFO - ##### Running download-and-extract step. 23:09:03 INFO - ##### 23:09:03 INFO - Running pre-action listener: _resource_record_pre_action 23:09:03 INFO - Running main action method: download_and_extract 23:09:03 INFO - mkdir: /builds/slave/test/build/tests 23:09: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')]} 23:09:03 INFO - https://queue.taskcluster.net/v1/task/Sve-B5ImQDq2r89yn4q2Fw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 23:09:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sve-B5ImQDq2r89yn4q2Fw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 23:09:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sve-B5ImQDq2r89yn4q2Fw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 23:09:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sve-B5ImQDq2r89yn4q2Fw/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 23:09:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sve-B5ImQDq2r89yn4q2Fw/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 23:09:04 INFO - Downloaded 1361 bytes. 23:09:04 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 23:09:04 INFO - Using the following test package requirements: 23:09:04 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 23:09:04 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:09:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 23:09:04 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:09:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 23:09:04 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:09:04 INFO - u'jsshell-linux-x86_64.zip'], 23:09:04 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:09:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 23:09:04 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 23:09:04 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:09:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 23:09:04 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:09:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 23:09:04 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:09:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 23:09:04 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:09:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 23:09:04 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 23:09:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 23:09:04 INFO - https://queue.taskcluster.net/v1/task/Sve-B5ImQDq2r89yn4q2Fw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:09:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sve-B5ImQDq2r89yn4q2Fw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 23:09:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sve-B5ImQDq2r89yn4q2Fw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 23:09:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sve-B5ImQDq2r89yn4q2Fw/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 23:09:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sve-B5ImQDq2r89yn4q2Fw/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 23:09:11 INFO - Downloaded 24304424 bytes. 23:09:11 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'] 23:09:11 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 23:09:12 INFO - Return code: 0 23:09:12 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 23:09:12 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')]} 23:09:12 INFO - https://queue.taskcluster.net/v1/task/Sve-B5ImQDq2r89yn4q2Fw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:09:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sve-B5ImQDq2r89yn4q2Fw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 23:09:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sve-B5ImQDq2r89yn4q2Fw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 23:09:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sve-B5ImQDq2r89yn4q2Fw/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 23:09:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sve-B5ImQDq2r89yn4q2Fw/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 23:09:15 INFO - Downloaded 24304424 bytes. 23:09:15 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'] 23:09:15 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 23:09:17 INFO - Return code: 0 23:09:17 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')]} 23:09:17 INFO - https://queue.taskcluster.net/v1/task/Sve-B5ImQDq2r89yn4q2Fw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 23:09:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sve-B5ImQDq2r89yn4q2Fw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 23:09:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sve-B5ImQDq2r89yn4q2Fw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 23:09:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sve-B5ImQDq2r89yn4q2Fw/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 23:09:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sve-B5ImQDq2r89yn4q2Fw/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 23:09:18 INFO - Downloaded 14403333 bytes. 23:09:18 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'] 23:09:18 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 23:09:18 INFO - Return code: 0 23:09:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:09:18 INFO - https://queue.taskcluster.net/v1/task/Sve-B5ImQDq2r89yn4q2Fw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 23:09:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sve-B5ImQDq2r89yn4q2Fw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 23:09:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sve-B5ImQDq2r89yn4q2Fw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 23:09:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sve-B5ImQDq2r89yn4q2Fw/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 23:09:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Sve-B5ImQDq2r89yn4q2Fw/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 23:09:22 INFO - Downloaded 60445099 bytes. 23:09:22 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Sve-B5ImQDq2r89yn4q2Fw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 23:09:22 INFO - mkdir: /builds/slave/test/properties 23:09:22 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 23:09:22 INFO - Writing to file /builds/slave/test/properties/build_url 23:09:22 INFO - Contents: 23:09:22 INFO - build_url:https://queue.taskcluster.net/v1/task/Sve-B5ImQDq2r89yn4q2Fw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 23:09:24 INFO - Running post-action listener: _resource_record_post_action 23:09:24 INFO - Running post-action listener: set_extra_try_arguments 23:09:24 INFO - ##### 23:09:24 INFO - ##### Finished download-and-extract step (success) 23:09:24 INFO - ##### 23:09:24 INFO - ##### 23:09:24 INFO - ##### Running populate-webroot step. 23:09:24 INFO - ##### 23:09:24 INFO - Running pre-action listener: _resource_record_pre_action 23:09:24 INFO - Running main action method: populate_webroot 23:09:24 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 23:09:24 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 23:09:24 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 23:09:24 INFO - '--tppagecycles', 23:09:24 INFO - '7'], 23:09:24 INFO - 'tests': ['tsvgm']}}, 23:09:24 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 23:09:24 INFO - 'tests': ['tresize', 'tcanvasmark']}, 23:09:24 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 23:09:24 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 23:09:24 INFO - 'tests': ['dromaeo_css', 'kraken']}, 23:09:24 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 23:09:24 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:09:24 INFO - 'talos_options': ['--disable-e10s'], 23:09:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:09:24 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:09:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:09:24 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:09:24 INFO - 'talos_options': ['--disable-e10s'], 23:09:24 INFO - 'tests': ['damp', 'tps']}, 23:09:24 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:09:24 INFO - 'tests': ['damp', 'tps']}, 23:09:24 INFO - 'g3': {'talos_options': ['--disable-e10s'], 23:09:24 INFO - 'tests': ['dromaeo_dom']}, 23:09:24 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 23:09:24 INFO - 'g4': {'talos_options': ['--disable-e10s'], 23:09:24 INFO - 'tests': ['basic_compositor_video']}, 23:09:24 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 23:09:24 INFO - 'other': {'talos_options': ['--disable-e10s'], 23:09:24 INFO - 'tests': ['a11yr', 23:09:24 INFO - 'ts_paint', 23:09:24 INFO - 'tpaint', 23:09:24 INFO - 'sessionrestore', 23:09:24 INFO - 'sessionrestore_no_auto_restore', 23:09:24 INFO - 'tabpaint']}, 23:09:24 INFO - 'other-e10s': {'tests': ['a11yr', 23:09:24 INFO - 'ts_paint', 23:09:24 INFO - 'tpaint', 23:09:24 INFO - 'sessionrestore', 23:09:24 INFO - 'sessionrestore_no_auto_restore', 23:09:24 INFO - 'tabpaint']}, 23:09:24 INFO - 'other-e10s_l64': {'tests': ['a11yr', 23:09:24 INFO - 'ts_paint', 23:09:24 INFO - 'tpaint', 23:09:24 INFO - 'sessionrestore', 23:09:24 INFO - 'sessionrestore_no_auto_restore', 23:09:24 INFO - 'tabpaint']}, 23:09:24 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 23:09:24 INFO - 'ts_paint', 23:09:24 INFO - 'tpaint', 23:09:24 INFO - 'sessionrestore', 23:09:24 INFO - 'sessionrestore_no_auto_restore', 23:09:24 INFO - 'tabpaint']}, 23:09:24 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 23:09:24 INFO - 'tests': ['a11yr', 23:09:24 INFO - 'ts_paint', 23:09:24 INFO - 'tpaint', 23:09:24 INFO - 'sessionrestore', 23:09:24 INFO - 'sessionrestore_no_auto_restore', 23:09:24 INFO - 'tabpaint']}, 23:09:24 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 23:09:24 INFO - 'tests': ['a11yr', 23:09:24 INFO - 'ts_paint', 23:09:24 INFO - 'tpaint', 23:09:24 INFO - 'sessionrestore', 23:09:24 INFO - 'sessionrestore_no_auto_restore', 23:09:24 INFO - 'tabpaint']}, 23:09:24 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 23:09:24 INFO - 'tests': ['tsvgx', 23:09:24 INFO - 'tsvgr_opacity', 23:09:24 INFO - 'tart', 23:09:24 INFO - 'tscrollx', 23:09:24 INFO - 'cart']}, 23:09:24 INFO - 'svgr-e10s': {'tests': ['tsvgx', 23:09:24 INFO - 'tsvgr_opacity', 23:09:24 INFO - 'tart', 23:09:24 INFO - 'tscrollx', 23:09:24 INFO - 'cart']}, 23:09:24 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:09:24 INFO - 'talos_options': ['--disable-e10s'], 23:09:24 INFO - 'tests': ['tp5o']}, 23:09:24 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:09:24 INFO - 'tests': ['tp5o']}, 23:09:24 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:09:24 INFO - 'talos_options': ['--disable-e10s', 23:09:24 INFO - '--xperf_path', 23:09:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:09:24 INFO - 'tests': ['tp5n']}, 23:09:24 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:09:24 INFO - 'talos_options': ['--xperf_path', 23:09:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:09:24 INFO - 'tests': ['tp5n']}}, 23:09:24 INFO - 'talos.zip': {'path': '', 23:09:24 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 23:09:24 INFO - Running post-action listener: _resource_record_post_action 23:09:24 INFO - ##### 23:09:24 INFO - ##### Finished populate-webroot step (success) 23:09:24 INFO - ##### 23:09:24 INFO - ##### 23:09:24 INFO - ##### Running create-virtualenv step. 23:09:24 INFO - ##### 23:09:24 INFO - Running pre-action listener: _resource_record_pre_action 23:09:24 INFO - Running main action method: create_virtualenv 23:09:24 INFO - Creating virtualenv /builds/slave/test/build/venv 23:09:24 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 23:09:24 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 23:09:24 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 23:09:24 INFO - Using real prefix '/usr' 23:09:24 INFO - New python executable in /builds/slave/test/build/venv/bin/python 23:09:24 INFO - Installing distribute.............................................................................................................................................................................................done. 23:09:26 INFO - Installing pip.................done. 23:09:26 INFO - Return code: 0 23:09:26 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 23:09: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')]} 23:09:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:09:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:09: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')]} 23:09:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:09:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:09: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 0x2aab030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c0e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2d6c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d6a3b0>, '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 0x2d6b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d6b740>, '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': '14ef55db36f7623abb31b9cf000001d5-1467957784.914821-962732232', '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 23:09: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 23:09: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 23:09:26 INFO - Using env: {'DISPLAY': ':0', 23:09:26 INFO - 'HOME': '/home/cltbld', 23:09:26 INFO - 'LANG': 'en_US.UTF-8', 23:09:26 INFO - 'LANGUAGE': 'en_US:en', 23:09:26 INFO - 'LOGNAME': 'cltbld', 23:09:26 INFO - 'MAIL': '/var/mail/cltbld', 23:09:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:09:26 INFO - 'MOZ_NO_REMOTE': '1', 23:09:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:09:26 INFO - 'NO_EM_RESTART': '1', 23:09:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:09:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:09:26 INFO - 'PWD': '/builds/slave/test', 23:09:26 INFO - 'SHELL': '/bin/bash', 23:09:26 INFO - 'SHLVL': '1', 23:09:26 INFO - 'TERM': 'linux', 23:09:26 INFO - 'TMOUT': '86400', 23:09:26 INFO - 'USER': 'cltbld', 23:09:26 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1467957784.914821-962732232', 23:09:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:09:26 INFO - '_': '/tools/buildbot/bin/python'} 23:09:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:09: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 23:09:26 INFO - Cleaning up... 23:09:26 INFO - Return code: 0 23:09:26 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 23:09: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')]} 23:09:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:09:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:09: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')]} 23:09:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:09:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:09: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 0x2aab030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c0e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2d6c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d6a3b0>, '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 0x2d6b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d6b740>, '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': '14ef55db36f7623abb31b9cf000001d5-1467957784.914821-962732232', '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 23:09: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 23:09: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 23:09:26 INFO - Using env: {'DISPLAY': ':0', 23:09:26 INFO - 'HOME': '/home/cltbld', 23:09:26 INFO - 'LANG': 'en_US.UTF-8', 23:09:26 INFO - 'LANGUAGE': 'en_US:en', 23:09:26 INFO - 'LOGNAME': 'cltbld', 23:09:26 INFO - 'MAIL': '/var/mail/cltbld', 23:09:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:09:26 INFO - 'MOZ_NO_REMOTE': '1', 23:09:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:09:26 INFO - 'NO_EM_RESTART': '1', 23:09:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:09:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:09:26 INFO - 'PWD': '/builds/slave/test', 23:09:26 INFO - 'SHELL': '/bin/bash', 23:09:26 INFO - 'SHLVL': '1', 23:09:26 INFO - 'TERM': 'linux', 23:09:26 INFO - 'TMOUT': '86400', 23:09:26 INFO - 'USER': 'cltbld', 23:09:26 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1467957784.914821-962732232', 23:09:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:09:26 INFO - '_': '/tools/buildbot/bin/python'} 23:09:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:09:27 INFO - Downloading/unpacking psutil>=3.1.1 23:09:27 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 23:09:27 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 23:09:27 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 23:09:27 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 23:09:27 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 23:09:27 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 23:09:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 23:09:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:09:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:09:29 INFO - Installing collected packages: psutil 23:09:29 INFO - Running setup.py install for psutil 23:09:29 INFO - building 'psutil._psutil_linux' extension 23:09:29 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 23:09:29 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 23:09:29 INFO - building 'psutil._psutil_posix' extension 23:09:29 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 23:09:29 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 23:09:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:09:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:09:29 INFO - Successfully installed psutil 23:09:29 INFO - Cleaning up... 23:09:29 INFO - Return code: 0 23:09:29 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 23:09: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')]} 23:09:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:09:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:09: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')]} 23:09:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:09:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:09: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 0x2aab030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c0e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2d6c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d6a3b0>, '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 0x2d6b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d6b740>, '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': '14ef55db36f7623abb31b9cf000001d5-1467957784.914821-962732232', '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 23:09: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 23:09: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 23:09:29 INFO - Using env: {'DISPLAY': ':0', 23:09:29 INFO - 'HOME': '/home/cltbld', 23:09:29 INFO - 'LANG': 'en_US.UTF-8', 23:09:29 INFO - 'LANGUAGE': 'en_US:en', 23:09:29 INFO - 'LOGNAME': 'cltbld', 23:09:29 INFO - 'MAIL': '/var/mail/cltbld', 23:09:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:09:29 INFO - 'MOZ_NO_REMOTE': '1', 23:09:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:09:29 INFO - 'NO_EM_RESTART': '1', 23:09:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:09:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:09:29 INFO - 'PWD': '/builds/slave/test', 23:09:29 INFO - 'SHELL': '/bin/bash', 23:09:29 INFO - 'SHLVL': '1', 23:09:29 INFO - 'TERM': 'linux', 23:09:29 INFO - 'TMOUT': '86400', 23:09:29 INFO - 'USER': 'cltbld', 23:09:29 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1467957784.914821-962732232', 23:09:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:09:29 INFO - '_': '/tools/buildbot/bin/python'} 23:09:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:09:29 INFO - Downloading/unpacking mozsystemmonitor==0.3 23:09: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 23:09: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 23:09: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 23:09: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 23:09: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 23:09: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 23:09:31 INFO - Downloading mozsystemmonitor-0.3.tar.gz 23:09:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 23:09:31 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 23:09:31 INFO - Installing collected packages: mozsystemmonitor 23:09:31 INFO - Running setup.py install for mozsystemmonitor 23:09:32 INFO - Successfully installed mozsystemmonitor 23:09:32 INFO - Cleaning up... 23:09:33 INFO - Return code: 0 23:09:33 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 23:09:33 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')]} 23:09:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:09:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:09:33 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')]} 23:09:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:09:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:09:33 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 0x2aab030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c0e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2d6c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d6a3b0>, '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 0x2d6b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d6b740>, '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': '14ef55db36f7623abb31b9cf000001d5-1467957784.914821-962732232', '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 23:09:33 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 23:09:33 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 23:09:33 INFO - Using env: {'DISPLAY': ':0', 23:09:33 INFO - 'HOME': '/home/cltbld', 23:09:33 INFO - 'LANG': 'en_US.UTF-8', 23:09:33 INFO - 'LANGUAGE': 'en_US:en', 23:09:33 INFO - 'LOGNAME': 'cltbld', 23:09:33 INFO - 'MAIL': '/var/mail/cltbld', 23:09:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:09:33 INFO - 'MOZ_NO_REMOTE': '1', 23:09:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:09:33 INFO - 'NO_EM_RESTART': '1', 23:09:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:09:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:09:33 INFO - 'PWD': '/builds/slave/test', 23:09:33 INFO - 'SHELL': '/bin/bash', 23:09:33 INFO - 'SHLVL': '1', 23:09:33 INFO - 'TERM': 'linux', 23:09:33 INFO - 'TMOUT': '86400', 23:09:33 INFO - 'USER': 'cltbld', 23:09:33 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1467957784.914821-962732232', 23:09:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:09:33 INFO - '_': '/tools/buildbot/bin/python'} 23:09:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:09:34 INFO - Downloading/unpacking jsonschema==2.5.1 23:09: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 23:09: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 23:09: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 23:09: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 23:09: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 23:09: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 23:09:36 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 23:09:36 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 23:09: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 23:09: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 23:09: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 23:09: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 23:09: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 23:09: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 23:09:36 INFO - Downloading functools32-3.2.3-2.tar.gz 23:09:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 23:09:36 INFO - warning: no files found matching '*.txt' 23:09:36 INFO - no previously-included directories found matching 'build' 23:09:36 INFO - no previously-included directories found matching 'dist' 23:09:36 INFO - no previously-included directories found matching '.git*' 23:09:36 INFO - Installing collected packages: jsonschema, functools32 23:09:36 INFO - Running setup.py install for functools32 23:09:36 INFO - warning: no files found matching '*.txt' 23:09:36 INFO - no previously-included directories found matching 'build' 23:09:36 INFO - no previously-included directories found matching 'dist' 23:09:36 INFO - no previously-included directories found matching '.git*' 23:09:36 INFO - Successfully installed jsonschema functools32 23:09:36 INFO - Cleaning up... 23:09:36 INFO - Return code: 0 23:09:36 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 23:09:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 23:09:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:09:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:09:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 23:09:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:09:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:09:36 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 0x2aab030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c0e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2d6c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d6a3b0>, '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 0x2d6b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d6b740>, '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': '14ef55db36f7623abb31b9cf000001d5-1467957784.914821-962732232', '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 23:09:36 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 23:09:36 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 23:09:36 INFO - Using env: {'DISPLAY': ':0', 23:09:36 INFO - 'HOME': '/home/cltbld', 23:09:36 INFO - 'LANG': 'en_US.UTF-8', 23:09:36 INFO - 'LANGUAGE': 'en_US:en', 23:09:36 INFO - 'LOGNAME': 'cltbld', 23:09:36 INFO - 'MAIL': '/var/mail/cltbld', 23:09:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:09:36 INFO - 'MOZ_NO_REMOTE': '1', 23:09:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:09:36 INFO - 'NO_EM_RESTART': '1', 23:09:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:09:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:09:36 INFO - 'PWD': '/builds/slave/test', 23:09:36 INFO - 'SHELL': '/bin/bash', 23:09:36 INFO - 'SHLVL': '1', 23:09:36 INFO - 'TERM': 'linux', 23:09:36 INFO - 'TMOUT': '86400', 23:09:36 INFO - 'USER': 'cltbld', 23:09:36 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1467957784.914821-962732232', 23:09:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:09:36 INFO - '_': '/tools/buildbot/bin/python'} 23:09:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:09:36 INFO - Downloading/unpacking blobuploader==1.2.4 23:09: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 23:09: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 23:09: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 23:09: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 23:09: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 23:09: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 23:09:38 INFO - Downloading blobuploader-1.2.4.tar.gz 23:09:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 23:09:38 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 23:09:38 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 23:09:38 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 23:09:38 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 23:09:38 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 23:09:38 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 23:09:38 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 23:09:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 23:09:39 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 23:09:39 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 23:09:39 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 23:09:39 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 23:09:39 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 23:09:39 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 23:09:39 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 23:09:39 INFO - Downloading docopt-0.6.1.tar.gz 23:09:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 23:09:39 INFO - Installing collected packages: blobuploader, requests, docopt 23:09:39 INFO - Running setup.py install for blobuploader 23:09:39 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 23:09:39 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 23:09:39 INFO - Running setup.py install for requests 23:09:39 INFO - Running setup.py install for docopt 23:09:40 INFO - Successfully installed blobuploader requests docopt 23:09:40 INFO - Cleaning up... 23:09:40 INFO - Return code: 0 23:09:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:09: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')]} 23:09:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:09:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:09: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')]} 23:09:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:09:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:09:40 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 0x2aab030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c0e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2d6c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d6a3b0>, '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 0x2d6b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d6b740>, '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': '14ef55db36f7623abb31b9cf000001d5-1467957784.914821-962732232', '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 23:09:40 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 23:09:40 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 23:09:40 INFO - Using env: {'DISPLAY': ':0', 23:09:40 INFO - 'HOME': '/home/cltbld', 23:09:40 INFO - 'LANG': 'en_US.UTF-8', 23:09:40 INFO - 'LANGUAGE': 'en_US:en', 23:09:40 INFO - 'LOGNAME': 'cltbld', 23:09:40 INFO - 'MAIL': '/var/mail/cltbld', 23:09:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:09:40 INFO - 'MOZ_NO_REMOTE': '1', 23:09:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:09:40 INFO - 'NO_EM_RESTART': '1', 23:09:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:09:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:09:40 INFO - 'PWD': '/builds/slave/test', 23:09:40 INFO - 'SHELL': '/bin/bash', 23:09:40 INFO - 'SHLVL': '1', 23:09:40 INFO - 'TERM': 'linux', 23:09:40 INFO - 'TMOUT': '86400', 23:09:40 INFO - 'USER': 'cltbld', 23:09:40 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1467957784.914821-962732232', 23:09:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:09:40 INFO - '_': '/tools/buildbot/bin/python'} 23:09:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:09:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:09:40 INFO - Running setup.py (path:/tmp/pip-vgBU5U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:09:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:09:40 INFO - Running setup.py (path:/tmp/pip-HeetqA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:09:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:09:40 INFO - Running setup.py (path:/tmp/pip-tagCQb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:09:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:09:40 INFO - Running setup.py (path:/tmp/pip-4yvFTw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:09:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:09:40 INFO - Running setup.py (path:/tmp/pip-89Z5sc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:09:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:09:40 INFO - Running setup.py (path:/tmp/pip-Ns1_Lr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:09:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:09:40 INFO - Running setup.py (path:/tmp/pip-UHZCto-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:09:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:09:40 INFO - Running setup.py (path:/tmp/pip-QiyH_B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:09:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:09:40 INFO - Running setup.py (path:/tmp/pip-0lSmi7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:09:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:09:40 INFO - Running setup.py (path:/tmp/pip-WbqC6Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:09:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:09:41 INFO - Running setup.py (path:/tmp/pip-pNHmno-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:09:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:09:41 INFO - Running setup.py (path:/tmp/pip-Mcm0_Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:09:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:09:41 INFO - Running setup.py (path:/tmp/pip-QzW6Bu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:09:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:09:41 INFO - Running setup.py (path:/tmp/pip-DDrxof-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:09:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:09:41 INFO - Running setup.py (path:/tmp/pip-ourisa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:09:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:09:41 INFO - Running setup.py (path:/tmp/pip-T9A_pH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:09:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:09:41 INFO - Running setup.py (path:/tmp/pip-2Lf6Tb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:09:41 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 23:09:41 INFO - Running setup.py install for manifestparser 23:09:41 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 23:09:41 INFO - Running setup.py install for mozcrash 23:09:41 INFO - Running setup.py install for mozdebug 23:09:41 INFO - Running setup.py install for mozdevice 23:09:41 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 23:09:41 INFO - Installing dm script to /builds/slave/test/build/venv/bin 23:09:41 INFO - Running setup.py install for mozfile 23:09:42 INFO - Running setup.py install for mozhttpd 23:09:42 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 23:09:42 INFO - Running setup.py install for mozinfo 23:09:42 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 23:09:42 INFO - Running setup.py install for mozInstall 23:09:42 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 23:09:42 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 23:09:42 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 23:09:42 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 23:09:42 INFO - Running setup.py install for mozleak 23:09:42 INFO - Running setup.py install for mozlog 23:09:42 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 23:09:42 INFO - Running setup.py install for moznetwork 23:09:42 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 23:09:42 INFO - Running setup.py install for mozprocess 23:09:42 INFO - Running setup.py install for mozprofile 23:09:42 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 23:09:42 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 23:09:42 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 23:09:42 INFO - Running setup.py install for mozrunner 23:09:42 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 23:09:42 INFO - Running setup.py install for mozscreenshot 23:09:43 INFO - Running setup.py install for moztest 23:09:43 INFO - Running setup.py install for mozversion 23:09:43 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 23:09:43 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 23:09:43 INFO - Cleaning up... 23:09:43 INFO - Return code: 0 23:09:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:09:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:09:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:09:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:09:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:09:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:09:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:09:43 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 0x2aab030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c0e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2d6c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d6a3b0>, '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 0x2d6b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d6b740>, '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': '14ef55db36f7623abb31b9cf000001d5-1467957784.914821-962732232', '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 23:09:43 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 23:09:43 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 23:09:43 INFO - Using env: {'DISPLAY': ':0', 23:09:43 INFO - 'HOME': '/home/cltbld', 23:09:43 INFO - 'LANG': 'en_US.UTF-8', 23:09:43 INFO - 'LANGUAGE': 'en_US:en', 23:09:43 INFO - 'LOGNAME': 'cltbld', 23:09:43 INFO - 'MAIL': '/var/mail/cltbld', 23:09:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:09:43 INFO - 'MOZ_NO_REMOTE': '1', 23:09:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:09:43 INFO - 'NO_EM_RESTART': '1', 23:09:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:09:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:09:43 INFO - 'PWD': '/builds/slave/test', 23:09:43 INFO - 'SHELL': '/bin/bash', 23:09:43 INFO - 'SHLVL': '1', 23:09:43 INFO - 'TERM': 'linux', 23:09:43 INFO - 'TMOUT': '86400', 23:09:43 INFO - 'USER': 'cltbld', 23:09:43 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1467957784.914821-962732232', 23:09:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:09:43 INFO - '_': '/tools/buildbot/bin/python'} 23:09:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:09:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:09:43 INFO - Running setup.py (path:/tmp/pip-dacRDQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:09:43 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)) 23:09:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:09:43 INFO - Running setup.py (path:/tmp/pip-XMFJL2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:09:43 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)) 23:09:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:09:43 INFO - Running setup.py (path:/tmp/pip-htSXUe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:09:43 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)) 23:09:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:09:43 INFO - Running setup.py (path:/tmp/pip-SWhkBq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:09:43 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)) 23:09:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:09:43 INFO - Running setup.py (path:/tmp/pip-Kfcemr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:09:43 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)) 23:09:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:09:43 INFO - Running setup.py (path:/tmp/pip-vQ1tkI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:09:43 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)) 23:09:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:09:43 INFO - Running setup.py (path:/tmp/pip-8leFrq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:09:44 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)) 23:09:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:09:44 INFO - Running setup.py (path:/tmp/pip-YkLb2p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:09:44 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)) 23:09:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:09:44 INFO - Running setup.py (path:/tmp/pip-YRPvgt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:09:44 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)) 23:09:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:09:44 INFO - Running setup.py (path:/tmp/pip-3ex7no-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:09:44 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)) 23:09:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:09:44 INFO - Running setup.py (path:/tmp/pip-2u0kkn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:09:44 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)) 23:09:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:09:44 INFO - Running setup.py (path:/tmp/pip-QHc61A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:09:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 23:09:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:09:44 INFO - Running setup.py (path:/tmp/pip-u7VZy9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:09:44 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)) 23:09:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:09:44 INFO - Running setup.py (path:/tmp/pip-zUw8ZW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:09:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 23:09:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:09:44 INFO - Running setup.py (path:/tmp/pip-wivEYW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:09:44 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)) 23:09:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:09:44 INFO - Running setup.py (path:/tmp/pip-wnmJgU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:09:44 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)) 23:09:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:09:44 INFO - Running setup.py (path:/tmp/pip-ZoziYy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:09:44 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)) 23:09:44 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)) 23:09:44 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)) 23:09:44 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)) 23:09:44 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)) 23:09:44 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)) 23:09:44 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:09:44 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 23:09:44 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 23:09:44 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 23:09:44 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 23:09:44 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 23:09:44 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 23:09:46 INFO - Downloading blessings-1.6.tar.gz 23:09:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 23:09:46 INFO - Installing collected packages: blessings 23:09:46 INFO - Running setup.py install for blessings 23:09:46 INFO - Successfully installed blessings 23:09:46 INFO - Cleaning up... 23:09:46 INFO - Return code: 0 23:09:46 INFO - Done creating virtualenv /builds/slave/test/build/venv. 23:09:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:09:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:09:47 INFO - Reading from file tmpfile_stdout 23:09:47 INFO - Current package versions: 23:09:47 INFO - argparse == 1.2.1 23:09:47 INFO - blessings == 1.6 23:09:47 INFO - blobuploader == 1.2.4 23:09:47 INFO - docopt == 0.6.1 23:09:47 INFO - functools32 == 3.2.3-2 23:09:47 INFO - jsonschema == 2.5.1 23:09:47 INFO - manifestparser == 1.1 23:09:47 INFO - mozInstall == 1.12 23:09:47 INFO - mozcrash == 0.17 23:09:47 INFO - mozdebug == 0.1 23:09:47 INFO - mozdevice == 0.48 23:09:47 INFO - mozfile == 1.2 23:09:47 INFO - mozhttpd == 0.7 23:09:47 INFO - mozinfo == 0.9 23:09:47 INFO - mozleak == 0.1 23:09:47 INFO - mozlog == 3.2 23:09:47 INFO - moznetwork == 0.27 23:09:47 INFO - mozprocess == 0.23 23:09:47 INFO - mozprofile == 0.28 23:09:47 INFO - mozrunner == 6.12 23:09:47 INFO - mozscreenshot == 0.1 23:09:47 INFO - mozsystemmonitor == 0.3 23:09:47 INFO - moztest == 0.7 23:09:47 INFO - mozversion == 1.4 23:09:47 INFO - psutil == 3.1.1 23:09:47 INFO - requests == 1.2.3 23:09:47 INFO - wsgiref == 0.1.2 23:09:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:09:47 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')]} 23:09:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:09:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:09:47 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')]} 23:09:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:09:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:09:47 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 0x2aab030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c0e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2d6c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d6a3b0>, '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 0x2d6b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d6b740>, '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': '14ef55db36f7623abb31b9cf000001d5-1467957784.914821-962732232', '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 23:09:47 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 23:09:47 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 23:09:47 INFO - Using env: {'DISPLAY': ':0', 23:09:47 INFO - 'HOME': '/home/cltbld', 23:09:47 INFO - 'LANG': 'en_US.UTF-8', 23:09:47 INFO - 'LANGUAGE': 'en_US:en', 23:09:47 INFO - 'LOGNAME': 'cltbld', 23:09:47 INFO - 'MAIL': '/var/mail/cltbld', 23:09:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:09:47 INFO - 'MOZ_NO_REMOTE': '1', 23:09:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:09:47 INFO - 'NO_EM_RESTART': '1', 23:09:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:09:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:09:47 INFO - 'PWD': '/builds/slave/test', 23:09:47 INFO - 'SHELL': '/bin/bash', 23:09:47 INFO - 'SHLVL': '1', 23:09:47 INFO - 'TERM': 'linux', 23:09:47 INFO - 'TMOUT': '86400', 23:09:47 INFO - 'USER': 'cltbld', 23:09:47 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1467957784.914821-962732232', 23:09:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:09:47 INFO - '_': '/tools/buildbot/bin/python'} 23:09:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:09:47 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)) 23:09:47 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)) 23:09:47 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)) 23:09:47 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)) 23:09:47 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)) 23:09:47 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)) 23:09:47 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)) 23:09:47 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)) 23:09:47 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)) 23:09:47 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)) 23:09:47 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)) 23:09:47 INFO - Cleaning up... 23:09:47 INFO - Return code: 0 23:09:47 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 23:09:47 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')]} 23:09:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:09:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:09:47 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')]} 23:09:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:09:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:09:47 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 0x2aab030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c0e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2d6c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2d6a3b0>, '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 0x2d6b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d6b740>, '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': '14ef55db36f7623abb31b9cf000001d5-1467957784.914821-962732232', '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 23:09:47 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 23:09:47 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 23:09:47 INFO - Using env: {'DISPLAY': ':0', 23:09:47 INFO - 'HOME': '/home/cltbld', 23:09:47 INFO - 'LANG': 'en_US.UTF-8', 23:09:47 INFO - 'LANGUAGE': 'en_US:en', 23:09:47 INFO - 'LOGNAME': 'cltbld', 23:09:47 INFO - 'MAIL': '/var/mail/cltbld', 23:09:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:09:47 INFO - 'MOZ_NO_REMOTE': '1', 23:09:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:09:47 INFO - 'NO_EM_RESTART': '1', 23:09:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:09:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:09:47 INFO - 'PWD': '/builds/slave/test', 23:09:47 INFO - 'SHELL': '/bin/bash', 23:09:47 INFO - 'SHLVL': '1', 23:09:47 INFO - 'TERM': 'linux', 23:09:47 INFO - 'TMOUT': '86400', 23:09:47 INFO - 'USER': 'cltbld', 23:09:47 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1467957784.914821-962732232', 23:09:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:09:47 INFO - '_': '/tools/buildbot/bin/python'} 23:09:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:09:47 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 23:09:47 INFO - Cleaning up... 23:09:47 INFO - Return code: 0 23:09:47 INFO - Running post-action listener: _resource_record_post_action 23:09:47 INFO - Running post-action listener: _start_resource_monitoring 23:09:47 INFO - Starting resource monitoring. 23:09:47 INFO - ##### 23:09:47 INFO - ##### Finished create-virtualenv step (success) 23:09:47 INFO - ##### 23:09:47 INFO - ##### 23:09:47 INFO - ##### Running install step. 23:09:47 INFO - ##### 23:09:47 INFO - Running pre-action listener: _resource_record_pre_action 23:09:47 INFO - Running main action method: install 23:09:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:09:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:09:47 INFO - Reading from file tmpfile_stdout 23:09:47 INFO - Detecting whether we're running mozinstall >=1.0... 23:09:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 23:09:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 23:09:47 INFO - Reading from file tmpfile_stdout 23:09:47 INFO - Output received: 23:09:47 INFO - Usage: mozinstall [options] installer 23:09:47 INFO - Options: 23:09:47 INFO - -h, --help show this help message and exit 23:09:47 INFO - -d DEST, --destination=DEST 23:09:47 INFO - Directory to install application into. [default: 23:09:47 INFO - "/builds/slave/test"] 23:09:47 INFO - --app=APP Application being installed. [default: firefox] 23:09:47 INFO - mkdir: /builds/slave/test/build/application 23:09:47 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'] 23:09:47 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 23:10:05 INFO - Reading from file tmpfile_stdout 23:10:05 INFO - Output received: 23:10:05 INFO - /builds/slave/test/build/application/firefox/firefox 23:10:05 INFO - Running post-action listener: _resource_record_post_action 23:10:05 INFO - ##### 23:10:05 INFO - ##### Finished install step (success) 23:10:05 INFO - ##### 23:10:05 INFO - ##### 23:10:05 INFO - ##### Running run-tests step. 23:10:05 INFO - ##### 23:10:05 INFO - Running pre-action listener: _resource_record_pre_action 23:10:05 INFO - Running main action method: run_tests 23:10:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 23:10:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 23:10:05 INFO - Python 2.7.3 23:10:05 INFO - Return code: 0 23:10:05 INFO - grabbing minidump binary from tooltool 23:10:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:10:05 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 0x2d6a3b0>, '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 0x2d6b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2d6b740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 23:10:05 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 23:10:05 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 23:10:05 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 23:10:05 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 23:10:05 INFO - Return code: 0 23:10:05 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 23:10:05 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 23:10:05 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 23:10:05 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 23:10:05 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 23:10:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Sve-B5ImQDq2r89yn4q2Fw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-036', '--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 23:10:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Sve-B5ImQDq2r89yn4q2Fw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-036 --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 23:10:05 INFO - Using env: {'DISPLAY': ':0', 23:10:05 INFO - 'HOME': '/home/cltbld', 23:10:05 INFO - 'LANG': 'en_US.UTF-8', 23:10:05 INFO - 'LANGUAGE': 'en_US:en', 23:10:05 INFO - 'LOGNAME': 'cltbld', 23:10:05 INFO - 'MAIL': '/var/mail/cltbld', 23:10:05 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 23:10:05 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 23:10:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:10:05 INFO - 'MOZ_NO_REMOTE': '1', 23:10:05 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 23:10:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:10:05 INFO - 'NO_EM_RESTART': '1', 23:10:05 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:10:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:10:05 INFO - 'PWD': '/builds/slave/test', 23:10:05 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 23:10:05 INFO - 'SHELL': '/bin/bash', 23:10:05 INFO - 'SHLVL': '1', 23:10:05 INFO - 'TERM': 'linux', 23:10:05 INFO - 'TMOUT': '86400', 23:10:05 INFO - 'USER': 'cltbld', 23:10:05 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1467957784.914821-962732232', 23:10:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:10:05 INFO - '_': '/tools/buildbot/bin/python'} 23:10:05 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Sve-B5ImQDq2r89yn4q2Fw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-036', '--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 23:10:05 INFO - mozversion application_buildid: 20160707203023 23:10:05 INFO - mozversion application_changeset: 74dd49dcf6c944a1de2b1762ee328710aa4358a4 23:10:05 INFO - mozversion application_display_name: Nightly 23:10:05 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 23:10:05 INFO - mozversion application_name: Firefox 23:10:05 INFO - mozversion application_remotingname: firefox 23:10:05 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 23:10:05 INFO - mozversion application_vendor: Mozilla 23:10:05 INFO - mozversion application_version: 50.0a1 23:10:05 INFO - mozversion platform_buildid: 20160707203023 23:10:05 INFO - mozversion platform_changeset: 74dd49dcf6c944a1de2b1762ee328710aa4358a4 23:10:05 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 23:10:05 INFO - mozversion platform_version: 50.0a1 23:10:05 INFO - using testdate: 1467958205 23:10:05 INFO - actual date: 1467958205 23:10:05 INFO - starting webserver on 'localhost:43625' 23:10:05 INFO - SUITE-START | Running 2 tests 23:10:05 INFO - TEST-START | dromaeo_css 23:10:05 INFO - operating with platform_type : linux_ 23:10:05 INFO - Initialising browser for dromaeo_css test... 23:10:05 INFO - TEST-INFO | started process 10790 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRX9Xtq/profile http://localhost:43625/getInfo.html) 23:10:09 INFO - PROCESS | 10790 | __metrics Screen width/height:1600/1200 23:10:09 INFO - PROCESS | 10790 | colorDepth:24 23:10:09 INFO - PROCESS | 10790 | Browser inner width/height: 1024/697 23:10:09 INFO - PROCESS | 10790 | __metrics 23:10:10 INFO - PROCESS | 10790 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 23:10:11 INFO - TEST-INFO | 10790: exit 0 23:10:11 INFO - Browser initialized. 23:10:11 INFO - Running cycle 1/1 for dromaeo_css test... 23:10:11 INFO - TEST-INFO | started process 10877 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRX9Xtq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:10:23 INFO - PROCESS | 10877 | RSS: Main: 157233152 23:10:23 INFO - PROCESS | 10877 | 23:11:15 INFO - PROCESS | 10877 | 1467958275000 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] 23:13:22 INFO - PROCESS | 10877 | Cycle 1(1): loaded http://localhost:43625/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43625/tests/dromaeo/cssquery-ext.html) 23:13:23 INFO - PROCESS | 10877 | RSS: Main: 255770624 23:13:23 INFO - PROCESS | 10877 | 23:16:26 INFO - PROCESS | 10877 | Cycle 1(1): loaded http://localhost:43625/tests/dromaeo/cssquery-ext.html (next: http://localhost:43625/tests/dromaeo/cssquery-jquery.html) 23:16:26 INFO - PROCESS | 10877 | RSS: Main: 232763392 23:16:26 INFO - PROCESS | 10877 | 23:19:28 INFO - PROCESS | 10877 | Cycle 1(1): loaded http://localhost:43625/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43625/tests/dromaeo/cssquery-mootools.html) 23:19:29 INFO - PROCESS | 10877 | RSS: Main: 244424704 23:19:29 INFO - PROCESS | 10877 | 23:22:31 INFO - PROCESS | 10877 | Cycle 1(1): loaded http://localhost:43625/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43625/tests/dromaeo/cssquery-prototype.html) 23:22:32 INFO - PROCESS | 10877 | RSS: Main: 238338048 23:22:32 INFO - PROCESS | 10877 | 23:25:34 INFO - PROCESS | 10877 | Cycle 1(1): loaded http://localhost:43625/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43625/tests/dromaeo/cssquery-yui.html) 23:25:35 INFO - PROCESS | 10877 | RSS: Main: 222646272 23:25:35 INFO - PROCESS | 10877 | 23:28:38 INFO - PROCESS | 10877 | Cycle 1(1): loaded http://localhost:43625/tests/dromaeo/cssquery-yui.html (next: http://localhost:43625/tests/dromaeo/cssquery-dojo.html) 23:28:38 INFO - PROCESS | 10877 | RSS: Main: 292884480 23:28:38 INFO - PROCESS | 10877 | 23:28:38 INFO - PROCESS | 10877 | __start_tp_report 23:28:38 INFO - PROCESS | 10877 | _x_x_mozilla_page_load 23:28:38 INFO - PROCESS | 10877 | _x_x_mozilla_page_load_details 23:28:38 INFO - PROCESS | 10877 | |i|pagename|runs| 23:28:38 INFO - PROCESS | 10877 | |0;dojo.html;2975.6131702878624;2976.761859051275;3017.7585793136536;3021.3050998270405;3023.4406634772567;5059.443461219272;5091.669041512304;5150.69095854249;5188.818391356303;5256.526912577862;5162.845114646567;5170.793168273264;5182.3262975813095;5210.478952104788;5259.815906443275;4665.906681866369;4730.148573256813;4746.786394612251;4782.04359128174;4871.5615594596475;4817.373741413611;4820.325154478376;4854.150523658363;4869.561739443449;4889.731064791435;4663.183942810012;4665.09030739006;4680.180968330528;4689.062187562484;4733.905321893577;4707.552782485658;4729.716217026955;4730.148573256813;4792.544708252711;4824.035192961422;4735.1713450146435;4741.668083234175;4763.214069678499;4768.165571025092;4815.398075240595;5033.496650334974;5068.2144267638205;5068.923966140511;5114.744262786846;5145.9485405146215;5391.838244852661;5426.75579598915;5428.701421421821;5468.535174510172;5496.917546236809;5364.195370694388;5488.69812160331;5520.613557051008;5538.972305138489;5542.5565954723925;5091;5135.229715542661;5140.665856719302;5174.456682048406;5205.219217117463;5661.46216109469;5673.687947162863;5674.914876276859;5677.659340439587;5678.517326027334;5301.867453313698;5314.388845282842;5427.29445172133;5429.158480435539;5439.4288599696465;5496.835094947158;5584.134459158837;5597;5604.60767746262;5604.803831865946;5531.308586426697;5543.334799824047;5546.029444847216;5548.0845660466375;5587.7485513152005;5333.333333333333;5440.319960004999;5488.506034456918;5515.972420137874;5520.1167813150505;4233.343831706091;4248.4052232687445;4260.382244574581;4275.957240427556;4301.569843015736;3764.6235376462682;3794.3359912015285;3795.9750867265684;3831.501904752364;3838.654521093059;5124.92312615311;5152.124138896396;5190.169572868398;5201.375834899836;5282.788688452419;5432.076546987022;5458.2904222450825;5463.399026107125;5474.370447398521;5515.172724091338;5136.768845401966;5138.229265610188;5141.305923700253;5167.793288268427;5197.272381866542;4693.835715749932;4740.099381117577;4744.1934871072;4744.383230180055;4788.449328327218;5633.295838020247;5663.490285874291;5672.829815105553;5723.370429252862;5740.483356498019;5380.811671591476;5512.944870551243;5528.751206195811;5530.7511161997;5575.581831362583;5695.345035320825;5723.5707321950185;5756.395578464201;5760.769569217352;5765.250517432874;5470.343558772973;5480.177973304037;5480.451954804487;5486.478784515464;5487.314085739283;5393.946060539344;5471.151971444432;5543.833684989457;5555.638883472561;5585.832425027255;5366.302380690485;5422.48486393792;5428.240046393587;5430.104032834696;5477.534409575072;5405.0270951227585;5411.540019098421;5414.214938833768;5415.83752487426;5458.61789674719;5218.817341393033;5297.735113244245;5320.57435405159;5339.919901201562;5348.224507446476;5427.674339539641;5433.891322173456;5491.478309560585;5499.780008799603;5500.697461639648;5317.1226747586215;5318.1490961447535;5329.600279979095;5337.492938170868;5339.0389729849 23:28:38 INFO - PROCESS | 10877 | |1;ext.html;561.3824792727997;596.4065754574199;599.0265818045676;614.8893199224141;620.4601996263249;33246;35786.46320305194;43635.34546981794;44530;44672.553274467246;45109.323360149625;45484;45521.54478455223;45522.0895582089;45572;8209.58952052398;9010.008899021102;9151.313651476132;9157.221636160933;9159.908400916005;10595.152387808957;10898.073663738593;10925.235233533656;11232.831507527393;11243.100551955824;11005.284656497342;11096.33421994683;11097.500612472419;11108.61119860805;11110.16673749468;8207.835843283161;10567.207459440573;10853.403062831541;10904.945475272652;10978.12175026;10788.5684572617;10837.078848297904;10853.620123295646;10863.891361086446;10870.076043536308;42761.78619106916;42872.356914646305;43002;43049;43075.784621076695;2771.3071732066983;3403.5915690117095;3634.218642991743;3675.4303083022173;3761.9435708464393;31502.684973150434;33488.33023339544;33856.153596160046;33926.49110263348;35140.472892906626;4345.652347812199;4379.321205213165;4428.092241090569;4516.299973504112;4562.58936695699;346198;346245;347916.26041869883;348568;349605;61728.38271617316;62371;62383.6880815593;62396.68801655962;62497.37502625006;34982.300353992774;35772.46341304883;35841.103972400895;38039;38186.80906595449;16898.40855570049;16992.62103305538;17096.316147353966;17097;17099.23053462597;12448.128630995743;12493.063020273516;12509.874901251053;12512.874871251171;12521.373931303398;19871.40385788429;19971.60056798885;19980.50048748764;19983.600327993357;20023.899880500503;5860.824175274749;7164.570125792469;7192.676329565182;7342.669579868919;7369.189389167187;1017.2828156149897;1119.5521791283552;1146.810776221914;1151.5911851292838;1187.7624475105013;33477.49783753246;33660.83169584136;33713;33882.66117338844;34037;1108.778244351133;1145.1583086431467;1156.3582211872324;1202.903767698582;1226.7669142862828;16951;17655.73516397255;17747.378841740476;17815.643687126445;17863.642727145383;552813;553566;558593;558695;559319;58987;60478.39521604816;60497;60505.69747151324;60541;1288.2528133682442;1323;1347.3196036001757;1348.5077946549634;1350.1089281074444;30938.0718578443;32582.511262331558;32691.34617307688;32710.34579308448;33208.667913320554;51006.74496627493;51672.74163629308;51686.22470662868;51708;51753;341627;348112;348256;348358;348767;24758.38104047413;27049.1885243443;28019.859900700365;28510;28854.855725721238;48417;49130.263046053624;49200.50799491959;49502.50497494979;50538.747306263234;40457;41310.586894130676;41803.163936720484;41981;42753.78623106865;40908.38637420501;41775.58224417717;41883.37174942439;42405.57594424016;42574.78712606417;41138.38292425556;42293.36559951542;42298.36552451777;42539.57460425356;42583.78708106564;34187.829060854536;36631.26737465289;36884.07789805169;37232.81383593173;37360.626393735714;28534.143975680763;28598;28678.569821452278;28845.990390337076;28892.27769305784 23:28:38 INFO - PROCESS | 10877 | |2;jquery.html;385.5084766922176;386.3625018719113;393.55331698522167;401.2156234561432;419.1031193246453;13187.323902750755;18747.3438429655;20377;20387.898060509695;20404;13766.311684415788;17414.30342786287;17930.37243696471;18165.364212252574;18200.726989095176;5569.637973531718;5757.251557297545;5757.42425757423;5759.251297331341;5762;3888.9805550972346;5655.236543066674;5725.656460612356;5725.885482290351;5733.598648094635;5161.225816127573;6232.8130156095385;6246.937530624704;6328.778492752755;6336.936630633681;6107.81676549702;6304.432601065903;6318.210223722035;6350.841228969312;6367.108604795332;5604.8318550443555;5606.383297837235;5612.719364031823;5626.268585083953;5642.758593109509;22805.657915131287;22957.311280661608;23535;23605.29184124479;23784;2596.4417650205296;2686.059879042339;2792.5252707039854;2873.8850445982134;3190.0748782852943;14043.438262469488;14145.858541414556;14581.270936453135;14714.190719510423;14781.926090369587;1898.2407037185098;1984.1269841269939;2018.6770116781245;2020.5150763816725;2037.2767667478129;77809.61095194488;77912.61043694802;79545;79979.6001019997;80273.19726802716;10420.332746760634;10496.212784041227;10600.508880413097;10816.566272588605;11041.944790275997;14873;14937.925310373595;14950.700985980437;14954.551363459113;14972.775408368883;7950.920490795133;8128.065272493621;8176.918230817735;8251.628676709443;8366.665333386718;7911.050673919167;7915;7958.761237162895;8134.877976830352;8156.632951517077;5866.911996320058;6187.969060154671;6486.156799616114;6635.535512514078;6712.362325579063;1872.7378167056622;1911.5890083631807;1953;1953.6092781443767;1960.2453055573708;970.6699722094522;1013.3514550687565;1037.662759603132;1043.0820877627639;1120.6496172112584;19223.807761922482;19272.962999900326;20047;20241;20440.182392704424;1002.0380434782691;1019.1541020952592;1049.7847941172042;1055.6832950114936;1067.9946600266949;10564.630237941636;11491.942540287413;11494.13793965456;11512.712182195344;11524.36615986112;521348.7190768566;535280;537650;542298.750581211;552746;76520.61739691377;78797;79564;79646.20353796388;80274;958.8561715742555;990.9157721593601;1013.8428543575758;1019.8266294729914;1030.4538594544904;17145.142742862557;17587.718860178815;17687.38094166698;17782.644347112728;17900.731489027414;44725;45079.49205079466;45744.54255457403;46130.308045380014;46394.768026159654;59683.403165969525;62480.68759656173;63042;63308;64093;8379.790505237417;8537.914620853711;8647.697330593399;8652.091530389218;8748.912510875065;8136.75589732309;12912.16070955385;13056.281904495345;13283.136596121221;13387.665308367368;11695.76608467809;11798;11852.881471185177;11957.581484647995;12005.63983080509;11507.942460287644;11738.70653233676;12189.512419503475;12318.75362492763;12576.371181440709;11956.701082473008;12319.63041108768;12342.44458999365;12488.500459981862;12583.811242831182;8514.148585141436;8604.870926935975;8741.475511469333;8774.561271936505;9076.818463630558;11040.282381645167;11767.76464470723;11802.232854864405;11874.46564904564;11900.226485278428 23:28:38 INFO - PROCESS | 10877 | |3;mootools.html;1354.14012102315;1475.9335829887655;1493.626593351662;1632.7061128996777;1799.1633890241044;8353.540555269457;8744.693935712252;8753.037165911752;8992.8651070234;8997.235235005033;8734.737957861274;8878.334124940639;8882.067382924797;8890.911090889089;8902.866457003134;2353.235198560462;2382.4520360317138;2383.7139543254834;2387.522495500898;2389.713234411873;2358.917437889674;2391.390195500145;2392.342105920877;2404.8557086574774;2405.627127795186;2304.1474654377903;2310.89600967956;2324.976750232501;2327.767223277676;2347.471818840764;2268.6937263469467;2269.954600907989;2295.8048565871836;2296.850704704197;2300.332903457995;2295.426143464134;2307.088699963522;2310.191432998454;2310.4801419680607;2312.988435057831;8829.072947340564;8856.822863542693;8896.822063558757;8956.149165829302;9142.634294628207;5234.084035293847;5349.037173308803;5361.035013697533;5363.517283444469;5366.838994830161;3340.6659334066644;3352.715019223369;3389.745769067305;3389.9661003389897;3416.4021296273054;1154.2324354304378;1157.548556063136;1158.5192145259707;1159.6084698361915;1160.9883901160965;12490.81263781044;12607.180533265308;12607.243565386198;12628.936855315756;12642.051846111579;4338.349247612883;4445.51099379068;4537.546245375502;4552.362669226311;4567.36056952027;9864.408135511892;9870.654527091518;9876.061774131445;9890.60437582503;9905.158061564847;5201.791928322825;5202.167653175549;5202.401723801811;5202.843914682566;5203.115470370046;4167.770772607475;4623.815047398134;4799.66402351832;4810.494898035656;4832.758362081881;3832.1186127190344;3873.4577159197734;3943.940840887389;3969.702272329587;3975.264576053439;1127.1321082766224;1139.1342579639534;1145.5990403358758;1153.4924633161381;1157.3056166300153;777.8755399136224;840.8570543007703;928.90853247434;988.461288597716;1017.5268500147318;6194.938050619527;6202.627842329474;6215.9378406215355;6245.5401474058635;6436.549441539048;970.403202030746;1006.6929586476049;1009.8232809258351;1014.5028935821394;1019.8572199892021;4189.162167566499;4355.651547876162;4356.803943822536;4364.367166760865;4365.476142862877;10918.672439826818;11188;11199.040167970572;11241.213115081866;11271.605493807678;10580;10951.507182176822;10994.120470362352;11122.49948752308;11291.209615327012;8119.79700507492;8185.79535511617;8190.221928916743;8217.506949583045;8252.587370631445;6046.57673962836;6314.368563143649;6389.9041514376395;6405.679716014274;6470.223573171062;9661.13049825491;10139.695809125738;10225.386476811414;10278.434686092038;10297.897021029694;10187.235957303084;10187.541560629938;10332.741681458023;10333.74165645865;10346.689599312032;7196.604186769778;7459;7613.5431874087735;7961.084475285416;8091.797705057421;8442.873356899774;8468.153184681483;8531.23218910301;8537.402381833212;8542.231199192103;7378.114626244885;7534.623268836426;7581.786914093718;7590.8102297443;7687.7309294176675;7364.079490063742;7451.3666338361845;7508.061492313461;7535.171131175457;7685.5004424712215;6973.372396484341;7010.614416207158;7034.261402552863;7037.437005039482;7039.120109986252;4969.527894849984;5116.1046816806165;5242.370915490165;5245.0821106307;5272.76272567743;5289.550388217045;5311.123664595299;5338.46615338463;5365.651232669864;5390.218418329398 23:28:38 INFO - PROCESS | 10877 | |4;prototype.html;318.6399368713355;324.6445142568889;325.5166078373616;330.2931726106133;333.4631243697647;5324.174752913295;5327.481667724699;5377.542908852747;5381.923615276941;5396.460353964597;5233.764480598373;5318.441563635821;5332.706701131437;5334.959682861843;5372.194170874361;4021.8391264349466;4075.2257071156387;4183.518895327031;4215.082137627388;4215.135897141079;4149.692846753263;4178.185253875496;4182.682455026672;4190.350495673176;4203.600657937506;4001.8799436016966;4144.689148313873;4177.289860723669;4187.8324867005285;4194.3498757692605;4079.8984274245936;4148.668106551469;4179.6029377209115;4188.350805625133;4188.560201178893;3693;3707.4253490708984;3715.6284371562897;3717.739758216926;3718.7025037996896;5265.315508983846;5266.315379000744;5268.92096618551;5273.209018647195;5274.340707411574;4427.468703755538;4694.389729335198;4712.952870471286;4713.646476514241;4715.669903106784;5453.509184173404;5478;5486.259354987065;5494.395616482184;5564;3990.7206495545324;3992.845651934968;3993.4409182714153;3995.220931918277;4000.079981604247;5565.5825813063775;5727.656340619576;5732.140178973187;5744.138379243147;5761.683107429089;3999.6600288975765;4004.4994375703036;4009.8997525061523;4027.718059735849;4042.211768705133;4082.4488694026522;4082.714210005271;4099.569545197771;4100.815463304159;4111.383292506088;4574.336721175411;4640.976795116003;4650.930236046462;4684.414448193976;4696.671233013656;5512.91730624041;5533.1976863354585;5559.694216818114;5561.416051314553;5580.1629755537;1406.69052808382;1417.2346932656455;1418.7517184492672;1424.7577911755027;1428.2573062007905;898.4294972692256;908.4957848394205;924.8936372317135;931.6226928094133;947.673052796784;5352.625316227826;5383.353997520323;5396.952285785661;5397.163439666858;5402.459754024566;5637.267155269788;5641.40765219646;5679.574031947621;5702.914456283159;5709.143628455682;5311.840644780663;5363.651362661414;5380.3274590676165;5395.8938417624295;5443.755031023614;2975.494165991743;2978.8212707237635;2985.000024991652;2995.82025078496;3004.6544647365395;5533.474319939599;5776.631581051749;5806.332271788799;5861.824145275648;5882.941170588325;5641.915371269434;5686.2039314496005;5695.316562012502;5699.971500142473;5705.258316418839;5741.224934633855;5746.655200687972;5757.65454072757;5828.213191219216;5835.153902684002;5460.31746031746;5533.6403133796175;5581.804636837854;5614.831555053355;5616.887662246814;5550.4745340869;5552.389237183826;5562.276904002454;5595.384507704231;5610.9158362623775;5648.943510564842;5784.21913041734;5788.411185065118;5817.563682723898;5845.298564172326;4017.116234428421;4019.2363450945395;4029.6574791141907;4041.4139949707715;4066.2477441673386;5654.293213348332;5661.377248502744;5666.931569977011;5722.7710891563875;5742.5118864895285;5441.122812629795;5579.497845193952;5585.385607583244;5590.217369568182;5590.972045139748;5505.146702261156;5517.2275881377445;5518.972405137949;5522.3649280331665;5526.834194974157;5251.501107394792;5344.732763361894;5346.8395948121615;5356.276902618097;5449.64577302474;5561.553995960999;5567.24842146305;5577.776888924398;5593.916091258553;5595.888082238251;5411.972940135274;5432.29380180574;5477.616566840283;5509.862253443535;5514.393416724238 23:28:38 INFO - PROCESS | 10877 | |5;yui.html;756.1946526948799;774.8992630957974;842.4566154830131;846.2848892685682;879.2394578689432;15635.687286254268;16403.58991025225;16486.587835304108;16493.422730204446;16503.50489485316;14399.78400323996;14506.202158881257;14672.413103475876;14683.559493215194;14768.556943291691;646.8156575376019;760.6272926266117;779.4465929190268;783.2676447521585;795.3915254830059;792.3938187286731;796.7769024673072;798.1260519730886;798.3054742374143;798.3134504326304;833.4957350802767;843.8565443874556;844.0588743550927;844.6536919862857;845.0915266088948;681.4071757570896;813.8616435206029;835.7367429259824;839.2530647723531;841.7264389073575;607.7234858139536;609.0438012320658;609.0620444515441;609.7012463892705;610.3743662745677;14905.552833415015;14930.626734331729;14967;14976.550703478804;14983;14116.505922292774;14356.569302920929;14454;14484.42062317506;14629.853701462956;12974.545890893867;13030.80453793194;13116.6720831979;13149.802752958713;13693.863061369459;4490.9304411159765;4523.683342166049;4598.379218805452;4662.790174442158;4742.549457801503;64734.352656473304;67094.66452667705;67243.3275667242;72377;72487.27512724858;12024.87975120255;12082.637520874388;12100.213486123374;12200.694982625328;12624.684382890502;21971.23100691468;21986.230481933057;22018.44953876134;22038.669419958715;22059.558808824055;8941.731748047569;8944.105589441004;9012.63949442028;9019.413738107001;9310.72067837966;4975.726335051534;5051.318072060299;5074.771635276422;5090.9236361454605;5119.667221630582;3438.1920248742026;3543.1496440854526;3546.1843775931166;3548.4854696068924;3554.0937061049267;604.7067172421372;620.8230654263514;625.1716475669756;635.3455940381415;639.4852144024105;722.7723267170825;747.4356860570234;763.5991104670093;771.8572064168147;775.8215610409637;10243.641472548425;10262.640807571699;10273.589056437808;10488.475576221159;10573.488341884702;656.3633275722541;675.9556485230232;705.5272967112047;726.3680597879772;745.3738859358057;4854.781534830941;4902.362692849907;4966.652334336562;4978.427480839678;4987.750612469435;112218.43890780494;113605;117062;122050.96413912514;122355;102661;104269;105009;105589;105736;85044.57477712572;85407.57296213479;87393.99999999873;87838.56080719683;89593.65609515863;10333.586656533655;10342.31899945207;10532.631357902437;10634;10891;50271;51588.74205628948;52313.21530177126;52346.21480677717;53812.461875380744;72472.27527724655;77516.61241693981;77548.22451775636;77833.61083194548;78241.21758782567;12584.93707531493;12672.619821405373;12782.48870045225;12804.167729097579;13912.095713778572;14482.203478808346;14742.336594853043;15142.470013549473;15185;16138.838611614203;13864.653383665489;14274;14421.351039203471;14431.639209019859;14891.255437228312;13999.300034998005;14300.213488258245;14320.14079155254;14446.855531444551;14481.92759036198;13778.448862045407;13867.722645547234;13943.30283485842;13982.930085349508;14017.158970461805;11058.093761183436;11109.444527773741;11223.158263130135;11309.604163854226;11968;11971.820422693492;12034.458449369624;12135.767846132328;12434.689132771753;12475.438605262603 23:28:38 INFO - PROCESS | 10877 | __end_tp_report 23:28:38 INFO - PROCESS | 10877 | __start_cc_report 23:28:38 INFO - PROCESS | 10877 | _x_x_mozilla_cycle_collect,884 23:28:38 INFO - PROCESS | 10877 | __end_cc_report 23:28:38 INFO - PROCESS | 10877 | __startTimestamp1467959318476__endTimestamp 23:28:38 INFO - PROCESS | 10877 | 23:28:38 INFO - PROCESS | 10877 | ------- Summary: start ------- 23:28:38 INFO - PROCESS | 10877 | Number of tests: 6 23:28:38 INFO - PROCESS | 10877 | 23:28:38 INFO - PROCESS | 10877 | [#0] dojo.html Cycles:165 Average:5135.77 Median:5329.60 stddev:567.68 (10.7%) stddev-sans-first:543.54 23:28:38 INFO - PROCESS | 10877 | Values: 2975.6 2976.8 3017.8 3021.3 3023.4 5059.4 5091.7 5150.7 5188.8 5256.5 5162.8 5170.8 5182.3 5210.5 5259.8 4665.9 4730.1 4746.8 4782.0 4871.6 4817.4 4820.3 4854.2 4869.6 4889.7 4663.2 4665.1 4680.2 4689.1 4733.9 4707.6 4729.7 4730.1 4792.5 4824.0 4735.2 4741.7 4763.2 4768.2 4815.4 5033.5 5068.2 5068.9 5114.7 5145.9 5391.8 5426.8 5428.7 5468.5 5496.9 5364.2 5488.7 5520.6 5539.0 5542.6 5091.0 5135.2 5140.7 5174.5 5205.2 5661.5 5673.7 5674.9 5677.7 5678.5 5301.9 5314.4 5427.3 5429.2 5439.4 5496.8 5584.1 5597.0 5604.6 5604.8 5531.3 5543.3 5546.0 5548.1 5587.7 5333.3 5440.3 5488.5 5516.0 5520.1 4233.3 4248.4 4260.4 4276.0 4301.6 3764.6 3794.3 3796.0 3831.5 3838.7 5124.9 5152.1 5190.2 5201.4 5282.8 5432.1 5458.3 5463.4 5474.4 5515.2 5136.8 5138.2 5141.3 5167.8 5197.3 4693.8 4740.1 4744.2 4744.4 4788.4 5633.3 5663.5 5672.8 5723.4 5740.5 5380.8 5512.9 5528.8 5530.8 5575.6 5695.3 5723.6 5756.4 5760.8 5765.3 5470.3 5480.2 5480.5 5486.5 5487.3 5393.9 5471.2 5543.8 5555.6 5585.8 5366.3 5422.5 5428.2 5430.1 5477.5 5405.0 5411.5 5414.2 5415.8 5458.6 5218.8 5297.7 5320.6 5339.9 5348.2 5427.7 5433.9 5491.5 5499.8 5500.7 5317.1 5318.1 5329.6 5337.5 5339.0 23:28:38 INFO - PROCESS | 10877 | 23:28:38 INFO - PROCESS | 10877 | [#1] ext.html Cycles:180 Average:58236.90 Median:349186.00 stddev:113580.60 (32.5%) stddev-sans-first:113816.68 23:28:38 INFO - PROCESS | 10877 | Values: 561.4 596.4 599.0 614.9 620.5 33246.0 35786.5 43635.3 44530.0 44672.6 45109.3 45484.0 45521.5 45522.1 45572.0 8209.6 9010.0 9151.3 9157.2 9159.9 10595.2 10898.1 10925.2 11232.8 11243.1 11005.3 11096.3 11097.5 11108.6 11110.2 8207.8 10567.2 10853.4 10904.9 10978.1 10788.6 10837.1 10853.6 10863.9 10870.1 42761.8 42872.4 43002.0 43049.0 43075.8 2771.3 3403.6 3634.2 3675.4 3761.9 31502.7 33488.3 33856.2 33926.5 35140.5 4345.7 4379.3 4428.1 4516.3 4562.6 346198.0 346245.0 347916.3 348568.0 349605.0 61728.4 62371.0 62383.7 62396.7 62497.4 34982.3 35772.5 35841.1 38039.0 38186.8 16898.4 16992.6 17096.3 17097.0 17099.2 12448.1 12493.1 12509.9 12512.9 12521.4 19871.4 19971.6 19980.5 19983.6 20023.9 5860.8 7164.6 7192.7 7342.7 7369.2 1017.3 1119.6 1146.8 1151.6 1187.8 33477.5 33660.8 33713.0 33882.7 34037.0 1108.8 1145.2 1156.4 1202.9 1226.8 16951.0 17655.7 17747.4 17815.6 17863.6 552813.0 553566.0 558593.0 558695.0 559319.0 58987.0 60478.4 60497.0 60505.7 60541.0 1288.3 1323.0 1347.3 1348.5 1350.1 30938.1 32582.5 32691.3 32710.3 33208.7 51006.7 51672.7 51686.2 51708.0 51753.0 341627.0 348112.0 348256.0 348358.0 348767.0 24758.4 27049.2 28019.9 28510.0 28854.9 48417.0 49130.3 49200.5 49502.5 50538.7 40457.0 41310.6 41803.2 41981.0 42753.8 40908.4 41775.6 41883.4 42405.6 42574.8 41138.4 42293.4 42298.4 42539.6 42583.8 34187.8 36631.3 36884.1 37232.8 37360.6 28534.1 28598.0 28678.6 28846.0 28892.3 23:28:38 INFO - PROCESS | 10877 | 23:28:38 INFO - PROCESS | 10877 | [#2] jquery.html Cycles:180 Average:30312.03 Median:13190.22 stddev:88220.14 (668.8%) stddev-sans-first:88439.00 23:28:38 INFO - PROCESS | 10877 | Values: 385.5 386.4 393.6 401.2 419.1 13187.3 18747.3 20377.0 20387.9 20404.0 13766.3 17414.3 17930.4 18165.4 18200.7 5569.6 5757.3 5757.4 5759.3 5762.0 3889.0 5655.2 5725.7 5725.9 5733.6 5161.2 6232.8 6246.9 6328.8 6336.9 6107.8 6304.4 6318.2 6350.8 6367.1 5604.8 5606.4 5612.7 5626.3 5642.8 22805.7 22957.3 23535.0 23605.3 23784.0 2596.4 2686.1 2792.5 2873.9 3190.1 14043.4 14145.9 14581.3 14714.2 14781.9 1898.2 1984.1 2018.7 2020.5 2037.3 77809.6 77912.6 79545.0 79979.6 80273.2 10420.3 10496.2 10600.5 10816.6 11041.9 14873.0 14937.9 14950.7 14954.6 14972.8 7950.9 8128.1 8176.9 8251.6 8366.7 7911.1 7915.0 7958.8 8134.9 8156.6 5866.9 6188.0 6486.2 6635.5 6712.4 1872.7 1911.6 1953.0 1953.6 1960.2 970.7 1013.4 1037.7 1043.1 1120.6 19223.8 19273.0 20047.0 20241.0 20440.2 1002.0 1019.2 1049.8 1055.7 1068.0 10564.6 11491.9 11494.1 11512.7 11524.4 521348.7 535280.0 537650.0 542298.8 552746.0 76520.6 78797.0 79564.0 79646.2 80274.0 958.9 990.9 1013.8 1019.8 1030.5 17145.1 17587.7 17687.4 17782.6 17900.7 44725.0 45079.5 45744.5 46130.3 46394.8 59683.4 62480.7 63042.0 63308.0 64093.0 8379.8 8537.9 8647.7 8652.1 8748.9 8136.8 12912.2 13056.3 13283.1 13387.7 11695.8 11798.0 11852.9 11957.6 12005.6 11507.9 11738.7 12189.5 12318.8 12576.4 11956.7 12319.6 12342.4 12488.5 12583.8 8514.1 8604.9 8741.5 8774.6 9076.8 11040.3 11767.8 11802.2 11874.5 11900.2 23:28:38 INFO - PROCESS | 10877 | 23:28:38 INFO - PROCESS | 10877 | [#3] mootools.html Cycles:180 Average:5829.91 Median:4711.74 stddev:3318.02 (70.4%) stddev-sans-first:3310.28 23:28:38 INFO - PROCESS | 10877 | Values: 1354.1 1475.9 1493.6 1632.7 1799.2 8353.5 8744.7 8753.0 8992.9 8997.2 8734.7 8878.3 8882.1 8890.9 8902.9 2353.2 2382.5 2383.7 2387.5 2389.7 2358.9 2391.4 2392.3 2404.9 2405.6 2304.1 2310.9 2325.0 2327.8 2347.5 2268.7 2270.0 2295.8 2296.9 2300.3 2295.4 2307.1 2310.2 2310.5 2313.0 8829.1 8856.8 8896.8 8956.1 9142.6 5234.1 5349.0 5361.0 5363.5 5366.8 3340.7 3352.7 3389.7 3390.0 3416.4 1154.2 1157.5 1158.5 1159.6 1161.0 12490.8 12607.2 12607.2 12628.9 12642.1 4338.3 4445.5 4537.5 4552.4 4567.4 9864.4 9870.7 9876.1 9890.6 9905.2 5201.8 5202.2 5202.4 5202.8 5203.1 4167.8 4623.8 4799.7 4810.5 4832.8 3832.1 3873.5 3943.9 3969.7 3975.3 1127.1 1139.1 1145.6 1153.5 1157.3 777.9 840.9 928.9 988.5 1017.5 6194.9 6202.6 6215.9 6245.5 6436.5 970.4 1006.7 1009.8 1014.5 1019.9 4189.2 4355.7 4356.8 4364.4 4365.5 10918.7 11188.0 11199.0 11241.2 11271.6 10580.0 10951.5 10994.1 11122.5 11291.2 8119.8 8185.8 8190.2 8217.5 8252.6 6046.6 6314.4 6389.9 6405.7 6470.2 9661.1 10139.7 10225.4 10278.4 10297.9 10187.2 10187.5 10332.7 10333.7 10346.7 7196.6 7459.0 7613.5 7961.1 8091.8 8442.9 8468.2 8531.2 8537.4 8542.2 7378.1 7534.6 7581.8 7590.8 7687.7 7364.1 7451.4 7508.1 7535.2 7685.5 6973.4 7010.6 7034.3 7037.4 7039.1 4969.5 5116.1 5242.4 5245.1 5272.8 5289.6 5311.1 5338.5 5365.7 5390.2 23:28:38 INFO - PROCESS | 10877 | 23:28:38 INFO - PROCESS | 10877 | [#4] prototype.html Cycles:180 Average:4663.54 Median:5381.13 stddev:1363.85 (25.3%) stddev-sans-first:1328.11 23:28:38 INFO - PROCESS | 10877 | Values: 318.6 324.6 325.5 330.3 333.5 5324.2 5327.5 5377.5 5381.9 5396.5 5233.8 5318.4 5332.7 5335.0 5372.2 4021.8 4075.2 4183.5 4215.1 4215.1 4149.7 4178.2 4182.7 4190.4 4203.6 4001.9 4144.7 4177.3 4187.8 4194.3 4079.9 4148.7 4179.6 4188.4 4188.6 3693.0 3707.4 3715.6 3717.7 3718.7 5265.3 5266.3 5268.9 5273.2 5274.3 4427.5 4694.4 4713.0 4713.6 4715.7 5453.5 5478.0 5486.3 5494.4 5564.0 3990.7 3992.8 3993.4 3995.2 4000.1 5565.6 5727.7 5732.1 5744.1 5761.7 3999.7 4004.5 4009.9 4027.7 4042.2 4082.4 4082.7 4099.6 4100.8 4111.4 4574.3 4641.0 4650.9 4684.4 4696.7 5512.9 5533.2 5559.7 5561.4 5580.2 1406.7 1417.2 1418.8 1424.8 1428.3 898.4 908.5 924.9 931.6 947.7 5352.6 5383.4 5397.0 5397.2 5402.5 5637.3 5641.4 5679.6 5702.9 5709.1 5311.8 5363.7 5380.3 5395.9 5443.8 2975.5 2978.8 2985.0 2995.8 3004.7 5533.5 5776.6 5806.3 5861.8 5882.9 5641.9 5686.2 5695.3 5700.0 5705.3 5741.2 5746.7 5757.7 5828.2 5835.2 5460.3 5533.6 5581.8 5614.8 5616.9 5550.5 5552.4 5562.3 5595.4 5610.9 5648.9 5784.2 5788.4 5817.6 5845.3 4017.1 4019.2 4029.7 4041.4 4066.2 5654.3 5661.4 5666.9 5722.8 5742.5 5441.1 5579.5 5585.4 5590.2 5591.0 5505.1 5517.2 5519.0 5522.4 5526.8 5251.5 5344.7 5346.8 5356.3 5449.6 5561.6 5567.2 5577.8 5593.9 5595.9 5412.0 5432.3 5477.6 5509.9 5514.4 23:28:38 INFO - PROCESS | 10877 | 23:28:38 INFO - PROCESS | 10877 | [#5] yui.html Cycles:180 Average:21207.34 Median:3490.67 stddev:30310.54 (868.3%) stddev-sans-first:30356.67 23:28:38 INFO - PROCESS | 10877 | Values: 756.2 774.9 842.5 846.3 879.2 15635.7 16403.6 16486.6 16493.4 16503.5 14399.8 14506.2 14672.4 14683.6 14768.6 646.8 760.6 779.4 783.3 795.4 792.4 796.8 798.1 798.3 798.3 833.5 843.9 844.1 844.7 845.1 681.4 813.9 835.7 839.3 841.7 607.7 609.0 609.1 609.7 610.4 14905.6 14930.6 14967.0 14976.6 14983.0 14116.5 14356.6 14454.0 14484.4 14629.9 12974.5 13030.8 13116.7 13149.8 13693.9 4490.9 4523.7 4598.4 4662.8 4742.5 64734.4 67094.7 67243.3 72377.0 72487.3 12024.9 12082.6 12100.2 12200.7 12624.7 21971.2 21986.2 22018.4 22038.7 22059.6 8941.7 8944.1 9012.6 9019.4 9310.7 4975.7 5051.3 5074.8 5090.9 5119.7 3438.2 3543.1 3546.2 3548.5 3554.1 604.7 620.8 625.2 635.3 639.5 722.8 747.4 763.6 771.9 775.8 10243.6 10262.6 10273.6 10488.5 10573.5 656.4 676.0 705.5 726.4 745.4 4854.8 4902.4 4966.7 4978.4 4987.8 112218.4 113605.0 117062.0 122051.0 122355.0 102661.0 104269.0 105009.0 105589.0 105736.0 85044.6 85407.6 87394.0 87838.6 89593.7 10333.6 10342.3 10532.6 10634.0 10891.0 50271.0 51588.7 52313.2 52346.2 53812.5 72472.3 77516.6 77548.2 77833.6 78241.2 12584.9 12672.6 12782.5 12804.2 13912.1 14482.2 14742.3 15142.5 15185.0 16138.8 13864.7 14274.0 14421.4 14431.6 14891.3 13999.3 14300.2 14320.1 14446.9 14481.9 13778.4 13867.7 13943.3 13982.9 14017.2 11058.1 11109.4 11223.2 11309.6 11968.0 11971.8 12034.5 12135.8 12434.7 12475.4 23:28:38 INFO - PROCESS | 10877 | -------- Summary: end -------- 23:28:38 INFO - PROCESS | 10877 | 23:28:39 INFO - TEST-INFO | 10877: exit 0 23:28:39 INFO - TEST-OK | dromaeo_css | took 1113981ms 23:28:39 INFO - TEST-START | kraken 23:28:39 INFO - operating with platform_type : linux_ 23:28:39 INFO - Initialising browser for kraken test... 23:28:39 INFO - TEST-INFO | started process 11067 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaa2KvL/profile http://localhost:43625/getInfo.html) 23:28:43 INFO - PROCESS | 11067 | __metrics Screen width/height:1600/1200 23:28:43 INFO - PROCESS | 11067 | colorDepth:24 23:28:43 INFO - PROCESS | 11067 | Browser inner width/height: 1024/697 23:28:43 INFO - PROCESS | 11067 | __metrics 23:28:44 INFO - PROCESS | 11067 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 23:28:45 INFO - TEST-INFO | 11067: exit 0 23:28:45 INFO - Browser initialized. 23:28:45 INFO - Running cycle 1/1 for kraken test... 23:28:45 INFO - TEST-INFO | started process 11153 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaa2KvL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:28:57 INFO - PROCESS | 11153 | RSS: Main: 157487104 23:28:57 INFO - PROCESS | 11153 | 23:28:59 INFO - PROCESS | 11153 | Cycle 1(1): loaded http://localhost:43625/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43625/tests/kraken/driver.html?testName=audio-beat-detection) 23:29:00 INFO - PROCESS | 11153 | RSS: Main: 215678976 23:29:00 INFO - PROCESS | 11153 | 23:29:03 INFO - PROCESS | 11153 | Cycle 1(1): loaded http://localhost:43625/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43625/tests/kraken/driver.html?testName=audio-dft) 23:29:03 INFO - PROCESS | 11153 | RSS: Main: 203464704 23:29:03 INFO - PROCESS | 11153 | 23:29:07 INFO - PROCESS | 11153 | Cycle 1(1): loaded http://localhost:43625/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43625/tests/kraken/driver.html?testName=audio-fft) 23:29:07 INFO - PROCESS | 11153 | RSS: Main: 269512704 23:29:07 INFO - PROCESS | 11153 | 23:29:09 INFO - PROCESS | 11153 | Cycle 1(1): loaded http://localhost:43625/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43625/tests/kraken/driver.html?testName=audio-oscillator) 23:29:10 INFO - PROCESS | 11153 | RSS: Main: 180142080 23:29:10 INFO - PROCESS | 11153 | 23:29:12 INFO - PROCESS | 11153 | Cycle 1(1): loaded http://localhost:43625/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43625/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:29:13 INFO - PROCESS | 11153 | RSS: Main: 184516608 23:29:13 INFO - PROCESS | 11153 | 23:29:16 INFO - PROCESS | 11153 | Cycle 1(1): loaded http://localhost:43625/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43625/tests/kraken/driver.html?testName=imaging-darkroom) 23:29:16 INFO - PROCESS | 11153 | RSS: Main: 219176960 23:29:16 INFO - PROCESS | 11153 | 23:29:20 INFO - PROCESS | 11153 | Cycle 1(1): loaded http://localhost:43625/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43625/tests/kraken/driver.html?testName=imaging-desaturate) 23:29:20 INFO - PROCESS | 11153 | RSS: Main: 221356032 23:29:20 INFO - PROCESS | 11153 | 23:29:23 INFO - PROCESS | 11153 | Cycle 1(1): loaded http://localhost:43625/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43625/tests/kraken/driver.html?testName=json-parse-financial) 23:29:24 INFO - PROCESS | 11153 | RSS: Main: 221470720 23:29:24 INFO - PROCESS | 11153 | 23:29:25 INFO - PROCESS | 11153 | Cycle 1(1): loaded http://localhost:43625/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43625/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:29:26 INFO - PROCESS | 11153 | RSS: Main: 207802368 23:29:26 INFO - PROCESS | 11153 | 23:29:27 INFO - PROCESS | 11153 | Cycle 1(1): loaded http://localhost:43625/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43625/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:29:28 INFO - PROCESS | 11153 | RSS: Main: 210948096 23:29:28 INFO - PROCESS | 11153 | 23:29:30 INFO - PROCESS | 11153 | Cycle 1(1): loaded http://localhost:43625/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43625/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:29:31 INFO - PROCESS | 11153 | RSS: Main: 210604032 23:29:31 INFO - PROCESS | 11153 | 23:29:33 INFO - PROCESS | 11153 | Cycle 1(1): loaded http://localhost:43625/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43625/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:29:34 INFO - PROCESS | 11153 | RSS: Main: 223932416 23:29:34 INFO - PROCESS | 11153 | 23:29:37 INFO - PROCESS | 11153 | Cycle 1(1): loaded http://localhost:43625/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43625/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:29:37 INFO - PROCESS | 11153 | RSS: Main: 224178176 23:29:37 INFO - PROCESS | 11153 | 23:29:39 INFO - PROCESS | 11153 | Cycle 1(1): loaded http://localhost:43625/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43625/tests/kraken/driver.html?testName=ai-astar) 23:29:39 INFO - PROCESS | 11153 | RSS: Main: 267329536 23:29:39 INFO - PROCESS | 11153 | 23:29:39 INFO - PROCESS | 11153 | __start_tp_report 23:29:39 INFO - PROCESS | 11153 | _x_x_mozilla_page_load 23:29:39 INFO - PROCESS | 11153 | _x_x_mozilla_page_load_details 23:29:39 INFO - PROCESS | 11153 | |i|pagename|runs| 23:29:39 INFO - PROCESS | 11153 | |0;ai-astar;102;111;110;110;112;111;111;112;113;112 23:29:39 INFO - PROCESS | 11153 | |1;audio-beat-detection;148;117;120;171;120;123;146;116;159;118 23:29:39 INFO - PROCESS | 11153 | |2;audio-dft;160;160;159;158;160;159;161;161;160;159 23:29:39 INFO - PROCESS | 11153 | |3;audio-fft;75;75;75;126;75;75;74;75;103;76 23:29:39 INFO - PROCESS | 11153 | |4;audio-oscillator;84;85;115;84;85;85;126;84;85;120 23:29:39 INFO - PROCESS | 11153 | |5;imaging-gaussian-blur;117;117;116;117;117;117;117;118;117;117 23:29:39 INFO - PROCESS | 11153 | |6;imaging-darkroom;146;146;146;147;146;145;146;146;145;145 23:29:39 INFO - PROCESS | 11153 | |7;imaging-desaturate;96;95;96;95;95;95;94;95;96;95 23:29:39 INFO - PROCESS | 11153 | |8;json-parse-financial;53;53;54;53;52;51;53;53;51;53 23:29:39 INFO - PROCESS | 11153 | |9;json-stringify-tinderbox;61;63;62;61;62;62;61;62;63;62 23:29:39 INFO - PROCESS | 11153 | |10;stanford-crypto-aes;79;74;73;76;84;74;83;74;75;77 23:29:39 INFO - PROCESS | 11153 | |11;stanford-crypto-ccm;118;127;118;124;119;119;122;127;158;119 23:29:39 INFO - PROCESS | 11153 | |12;stanford-crypto-pbkdf2;159;168;157;159;157;161;159;166;160;156 23:29:39 INFO - PROCESS | 11153 | |13;stanford-crypto-sha256-iterative;64;64;64;64;64;64;63;67;64;62 23:29:39 INFO - PROCESS | 11153 | __end_tp_report 23:29:39 INFO - PROCESS | 11153 | __start_cc_report 23:29:39 INFO - PROCESS | 11153 | _x_x_mozilla_cycle_collect,1625 23:29:39 INFO - PROCESS | 11153 | __end_cc_report 23:29:39 INFO - PROCESS | 11153 | __startTimestamp1467959379550__endTimestamp 23:29:39 INFO - PROCESS | 11153 | 23:29:39 INFO - PROCESS | 11153 | ------- Summary: start ------- 23:29:39 INFO - PROCESS | 11153 | Number of tests: 14 23:29:39 INFO - PROCESS | 11153 | 23:29:39 INFO - PROCESS | 11153 | [#0] ai-astar Cycles:10 Average:110.40 Median:111.50 stddev:3.10 (2.8%) stddev-sans-first:1.00 23:29:39 INFO - PROCESS | 11153 | Values: 102.0 111.0 110.0 110.0 112.0 111.0 111.0 112.0 113.0 112.0 23:29:39 INFO - PROCESS | 11153 | 23:29:39 INFO - PROCESS | 11153 | [#1] audio-beat-detection Cycles:10 Average:133.80 Median:134.50 stddev:20.32 (15.1%) stddev-sans-first:20.89 23:29:39 INFO - PROCESS | 11153 | Values: 148.0 117.0 120.0 171.0 120.0 123.0 146.0 116.0 159.0 118.0 23:29:39 INFO - PROCESS | 11153 | 23:29:39 INFO - PROCESS | 11153 | [#2] audio-dft Cycles:10 Average:159.70 Median:160.00 stddev:0.95 (0.6%) stddev-sans-first:1.00 23:29:39 INFO - PROCESS | 11153 | Values: 160.0 160.0 159.0 158.0 160.0 159.0 161.0 161.0 160.0 159.0 23:29:39 INFO - PROCESS | 11153 | 23:29:39 INFO - PROCESS | 11153 | [#3] audio-fft Cycles:10 Average:82.90 Median:75.00 stddev:17.52 (23.4%) stddev-sans-first:18.35 23:29:39 INFO - PROCESS | 11153 | Values: 75.0 75.0 75.0 126.0 75.0 75.0 74.0 75.0 103.0 76.0 23:29:39 INFO - PROCESS | 11153 | 23:29:39 INFO - PROCESS | 11153 | [#4] audio-oscillator Cycles:10 Average:95.30 Median:84.50 stddev:17.47 (20.7%) stddev-sans-first:18.05 23:29:39 INFO - PROCESS | 11153 | Values: 84.0 85.0 115.0 84.0 85.0 85.0 126.0 84.0 85.0 120.0 23:29:39 INFO - PROCESS | 11153 | 23:29:39 INFO - PROCESS | 11153 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.47 (0.4%) stddev-sans-first:0.50 23:29:39 INFO - PROCESS | 11153 | Values: 117.0 117.0 116.0 117.0 117.0 117.0 117.0 118.0 117.0 117.0 23:29:39 INFO - PROCESS | 11153 | 23:29:39 INFO - PROCESS | 11153 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 23:29:39 INFO - PROCESS | 11153 | Values: 146.0 146.0 146.0 147.0 146.0 145.0 146.0 146.0 145.0 145.0 23:29:39 INFO - PROCESS | 11153 | 23:29:39 INFO - PROCESS | 11153 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.63 (0.7%) stddev-sans-first:0.60 23:29:39 INFO - PROCESS | 11153 | Values: 96.0 95.0 96.0 95.0 95.0 95.0 94.0 95.0 96.0 95.0 23:29:39 INFO - PROCESS | 11153 | 23:29:39 INFO - PROCESS | 11153 | [#8] json-parse-financial Cycles:10 Average:52.60 Median:53.00 stddev:0.97 (1.8%) stddev-sans-first:1.01 23:29:39 INFO - PROCESS | 11153 | Values: 53.0 53.0 54.0 53.0 52.0 51.0 53.0 53.0 51.0 53.0 23:29:39 INFO - PROCESS | 11153 | 23:29:39 INFO - PROCESS | 11153 | [#9] json-stringify-tinderbox Cycles:10 Average:61.90 Median:62.00 stddev:0.74 (1.2%) stddev-sans-first:0.71 23:29:39 INFO - PROCESS | 11153 | Values: 61.0 63.0 62.0 61.0 62.0 62.0 61.0 62.0 63.0 62.0 23:29:39 INFO - PROCESS | 11153 | 23:29:39 INFO - PROCESS | 11153 | [#10] stanford-crypto-aes Cycles:10 Average:76.90 Median:76.50 stddev:3.90 (5.1%) stddev-sans-first:4.06 23:29:39 INFO - PROCESS | 11153 | Values: 79.0 74.0 73.0 76.0 84.0 74.0 83.0 74.0 75.0 77.0 23:29:39 INFO - PROCESS | 11153 | 23:29:39 INFO - PROCESS | 11153 | [#11] stanford-crypto-ccm Cycles:10 Average:125.10 Median:123.00 stddev:12.08 (9.8%) stddev-sans-first:12.53 23:29:39 INFO - PROCESS | 11153 | Values: 118.0 127.0 118.0 124.0 119.0 119.0 122.0 127.0 158.0 119.0 23:29:39 INFO - PROCESS | 11153 | 23:29:39 INFO - PROCESS | 11153 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.20 Median:159.50 stddev:3.91 (2.5%) stddev-sans-first:4.12 23:29:39 INFO - PROCESS | 11153 | Values: 159.0 168.0 157.0 159.0 157.0 161.0 159.0 166.0 160.0 156.0 23:29:39 INFO - PROCESS | 11153 | 23:29:39 INFO - PROCESS | 11153 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.00 Median:64.00 stddev:1.25 (1.9%) stddev-sans-first:1.32 23:29:39 INFO - PROCESS | 11153 | Values: 64.0 64.0 64.0 64.0 64.0 64.0 63.0 67.0 64.0 62.0 23:29:39 INFO - PROCESS | 11153 | -------- Summary: end -------- 23:29:39 INFO - PROCESS | 11153 | 23:29:40 INFO - TEST-INFO | 11153: exit 0 23:29:40 INFO - TEST-OK | kraken | took 61293ms 23:29:40 INFO - SUITE-END | took 1175s 23:29:40 INFO - Completed test suite (00:19:35) 23:29:40 INFO - javascript benchmark 23:29:40 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2975.6131702878624, 2976.761859051275, 3017.7585793136536, 3021.3050998270405, 3023.4406634772567, 5059.443461219272, 5091.669041512304, 5150.69095854249, 5188.818391356303, 5256.526912577862, 5162.845114646567, 5170.793168273264, 5182.3262975813095, 5210.478952104788, 5259.815906443275, 4665.906681866369, 4730.148573256813, 4746.786394612251, 4782.04359128174, 4871.5615594596475, 4817.373741413611, 4820.325154478376, 4854.150523658363, 4869.561739443449, 4889.731064791435, 4663.183942810012, 4665.09030739006, 4680.180968330528, 4689.062187562484, 4733.905321893577, 4707.552782485658, 4729.716217026955, 4730.148573256813, 4792.544708252711, 4824.035192961422, 4735.1713450146435, 4741.668083234175, 4763.214069678499, 4768.165571025092, 4815.398075240595, 5033.496650334974, 5068.2144267638205, 5068.923966140511, 5114.744262786846, 5145.9485405146215, 5391.838244852661, 5426.75579598915, 5428.701421421821, 5468.535174510172, 5496.917546236809, 5364.195370694388, 5488.69812160331, 5520.613557051008, 5538.972305138489, 5542.5565954723925, 5091.0, 5135.229715542661, 5140.665856719302, 5174.456682048406, 5205.219217117463, 5661.46216109469, 5673.687947162863, 5674.914876276859, 5677.659340439587, 5678.517326027334, 5301.867453313698, 5314.388845282842, 5427.29445172133, 5429.158480435539, 5439.4288599696465, 5496.835094947158, 5584.134459158837, 5597.0, 5604.60767746262, 5604.803831865946, 5531.308586426697, 5543.334799824047, 5546.029444847216, 5548.0845660466375, 5587.7485513152005, 5333.333333333333, 5440.319960004999, 5488.506034456918, 5515.972420137874, 5520.1167813150505, 4233.343831706091, 4248.4052232687445, 4260.382244574581, 4275.957240427556, 4301.569843015736, 3764.6235376462682, 3794.3359912015285, 3795.9750867265684, 3831.501904752364, 3838.654521093059, 5124.92312615311, 5152.124138896396, 5190.169572868398, 5201.375834899836, 5282.788688452419, 5432.076546987022, 5458.2904222450825, 5463.399026107125, 5474.370447398521, 5515.172724091338, 5136.768845401966, 5138.229265610188, 5141.305923700253, 5167.793288268427, 5197.272381866542, 4693.835715749932, 4740.099381117577, 4744.1934871072, 4744.383230180055, 4788.449328327218, 5633.295838020247, 5663.490285874291, 5672.829815105553, 5723.370429252862, 5740.483356498019, 5380.811671591476, 5512.944870551243, 5528.751206195811, 5530.7511161997, 5575.581831362583, 5695.345035320825, 5723.5707321950185, 5756.395578464201, 5760.769569217352, 5765.250517432874, 5470.343558772973, 5480.177973304037, 5480.451954804487, 5486.478784515464, 5487.314085739283, 5393.946060539344, 5471.151971444432, 5543.833684989457, 5555.638883472561, 5585.832425027255, 5366.302380690485, 5422.48486393792, 5428.240046393587, 5430.104032834696, 5477.534409575072, 5405.0270951227585, 5411.540019098421, 5414.214938833768, 5415.83752487426, 5458.61789674719, 5218.817341393033, 5297.735113244245, 5320.57435405159, 5339.919901201562, 5348.224507446476, 5427.674339539641, 5433.891322173456, 5491.478309560585, 5499.780008799603, 5500.697461639648, 5317.1226747586215, 5318.1490961447535, 5329.600279979095, 5337.492938170868, 5339.0389729849], "value": 5098.279905305966, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [561.3824792727997, 596.4065754574199, 599.0265818045676, 614.8893199224141, 620.4601996263249, 33246.0, 35786.46320305194, 43635.34546981794, 44530.0, 44672.553274467246, 45109.323360149625, 45484.0, 45521.54478455223, 45522.0895582089, 45572.0, 8209.58952052398, 9010.008899021102, 9151.313651476132, 9157.221636160933, 9159.908400916005, 10595.152387808957, 10898.073663738593, 10925.235233533656, 11232.831507527393, 11243.100551955824, 11005.284656497342, 11096.33421994683, 11097.500612472419, 11108.61119860805, 11110.16673749468, 8207.835843283161, 10567.207459440573, 10853.403062831541, 10904.945475272652, 10978.12175026, 10788.5684572617, 10837.078848297904, 10853.620123295646, 10863.891361086446, 10870.076043536308, 42761.78619106916, 42872.356914646305, 43002.0, 43049.0, 43075.784621076695, 2771.3071732066983, 3403.5915690117095, 3634.218642991743, 3675.4303083022173, 3761.9435708464393, 31502.684973150434, 33488.33023339544, 33856.153596160046, 33926.49110263348, 35140.472892906626, 4345.652347812199, 4379.321205213165, 4428.092241090569, 4516.299973504112, 4562.58936695699, 346198.0, 346245.0, 347916.26041869883, 348568.0, 349605.0, 61728.38271617316, 62371.0, 62383.6880815593, 62396.68801655962, 62497.37502625006, 34982.300353992774, 35772.46341304883, 35841.103972400895, 38039.0, 38186.80906595449, 16898.40855570049, 16992.62103305538, 17096.316147353966, 17097.0, 17099.23053462597, 12448.128630995743, 12493.063020273516, 12509.874901251053, 12512.874871251171, 12521.373931303398, 19871.40385788429, 19971.60056798885, 19980.50048748764, 19983.600327993357, 20023.899880500503, 5860.824175274749, 7164.570125792469, 7192.676329565182, 7342.669579868919, 7369.189389167187, 1017.2828156149897, 1119.5521791283552, 1146.810776221914, 1151.5911851292838, 1187.7624475105013, 33477.49783753246, 33660.83169584136, 33713.0, 33882.66117338844, 34037.0, 1108.778244351133, 1145.1583086431467, 1156.3582211872324, 1202.903767698582, 1226.7669142862828, 16951.0, 17655.73516397255, 17747.378841740476, 17815.643687126445, 17863.642727145383, 552813.0, 553566.0, 558593.0, 558695.0, 559319.0, 58987.0, 60478.39521604816, 60497.0, 60505.69747151324, 60541.0, 1288.2528133682442, 1323.0, 1347.3196036001757, 1348.5077946549634, 1350.1089281074444, 30938.0718578443, 32582.511262331558, 32691.34617307688, 32710.34579308448, 33208.667913320554, 51006.74496627493, 51672.74163629308, 51686.22470662868, 51708.0, 51753.0, 341627.0, 348112.0, 348256.0, 348358.0, 348767.0, 24758.38104047413, 27049.1885243443, 28019.859900700365, 28510.0, 28854.855725721238, 48417.0, 49130.263046053624, 49200.50799491959, 49502.50497494979, 50538.747306263234, 40457.0, 41310.586894130676, 41803.163936720484, 41981.0, 42753.78623106865, 40908.38637420501, 41775.58224417717, 41883.37174942439, 42405.57594424016, 42574.78712606417, 41138.38292425556, 42293.36559951542, 42298.36552451777, 42539.57460425356, 42583.78708106564, 34187.829060854536, 36631.26737465289, 36884.07789805169, 37232.81383593173, 37360.626393735714, 28534.143975680763, 28598.0, 28678.569821452278, 28845.990390337076, 28892.27769305784], "value": 20426.810549109065, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [385.5084766922176, 386.3625018719113, 393.55331698522167, 401.2156234561432, 419.1031193246453, 13187.323902750755, 18747.3438429655, 20377.0, 20387.898060509695, 20404.0, 13766.311684415788, 17414.30342786287, 17930.37243696471, 18165.364212252574, 18200.726989095176, 5569.637973531718, 5757.251557297545, 5757.42425757423, 5759.251297331341, 5762.0, 3888.9805550972346, 5655.236543066674, 5725.656460612356, 5725.885482290351, 5733.598648094635, 5161.225816127573, 6232.8130156095385, 6246.937530624704, 6328.778492752755, 6336.936630633681, 6107.81676549702, 6304.432601065903, 6318.210223722035, 6350.841228969312, 6367.108604795332, 5604.8318550443555, 5606.383297837235, 5612.719364031823, 5626.268585083953, 5642.758593109509, 22805.657915131287, 22957.311280661608, 23535.0, 23605.29184124479, 23784.0, 2596.4417650205296, 2686.059879042339, 2792.5252707039854, 2873.8850445982134, 3190.0748782852943, 14043.438262469488, 14145.858541414556, 14581.270936453135, 14714.190719510423, 14781.926090369587, 1898.2407037185098, 1984.1269841269939, 2018.6770116781245, 2020.5150763816725, 2037.2767667478129, 77809.61095194488, 77912.61043694802, 79545.0, 79979.6001019997, 80273.19726802716, 10420.332746760634, 10496.212784041227, 10600.508880413097, 10816.566272588605, 11041.944790275997, 14873.0, 14937.925310373595, 14950.700985980437, 14954.551363459113, 14972.775408368883, 7950.920490795133, 8128.065272493621, 8176.918230817735, 8251.628676709443, 8366.665333386718, 7911.050673919167, 7915.0, 7958.761237162895, 8134.877976830352, 8156.632951517077, 5866.911996320058, 6187.969060154671, 6486.156799616114, 6635.535512514078, 6712.362325579063, 1872.7378167056622, 1911.5890083631807, 1953.0, 1953.6092781443767, 1960.2453055573708, 970.6699722094522, 1013.3514550687565, 1037.662759603132, 1043.0820877627639, 1120.6496172112584, 19223.807761922482, 19272.962999900326, 20047.0, 20241.0, 20440.182392704424, 1002.0380434782691, 1019.1541020952592, 1049.7847941172042, 1055.6832950114936, 1067.9946600266949, 10564.630237941636, 11491.942540287413, 11494.13793965456, 11512.712182195344, 11524.36615986112, 521348.7190768566, 535280.0, 537650.0, 542298.750581211, 552746.0, 76520.61739691377, 78797.0, 79564.0, 79646.20353796388, 80274.0, 958.8561715742555, 990.9157721593601, 1013.8428543575758, 1019.8266294729914, 1030.4538594544904, 17145.142742862557, 17587.718860178815, 17687.38094166698, 17782.644347112728, 17900.731489027414, 44725.0, 45079.49205079466, 45744.54255457403, 46130.308045380014, 46394.768026159654, 59683.403165969525, 62480.68759656173, 63042.0, 63308.0, 64093.0, 8379.790505237417, 8537.914620853711, 8647.697330593399, 8652.091530389218, 8748.912510875065, 8136.75589732309, 12912.16070955385, 13056.281904495345, 13283.136596121221, 13387.665308367368, 11695.76608467809, 11798.0, 11852.881471185177, 11957.581484647995, 12005.63983080509, 11507.942460287644, 11738.70653233676, 12189.512419503475, 12318.75362492763, 12576.371181440709, 11956.701082473008, 12319.63041108768, 12342.44458999365, 12488.500459981862, 12583.811242831182, 8514.148585141436, 8604.870926935975, 8741.475511469333, 8774.561271936505, 9076.818463630558, 11040.282381645167, 11767.76464470723, 11802.232854864405, 11874.46564904564, 11900.226485278428], "value": 9498.714113177313, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1354.14012102315, 1475.9335829887655, 1493.626593351662, 1632.7061128996777, 1799.1633890241044, 8353.540555269457, 8744.693935712252, 8753.037165911752, 8992.8651070234, 8997.235235005033, 8734.737957861274, 8878.334124940639, 8882.067382924797, 8890.911090889089, 8902.866457003134, 2353.235198560462, 2382.4520360317138, 2383.7139543254834, 2387.522495500898, 2389.713234411873, 2358.917437889674, 2391.390195500145, 2392.342105920877, 2404.8557086574774, 2405.627127795186, 2304.1474654377903, 2310.89600967956, 2324.976750232501, 2327.767223277676, 2347.471818840764, 2268.6937263469467, 2269.954600907989, 2295.8048565871836, 2296.850704704197, 2300.332903457995, 2295.426143464134, 2307.088699963522, 2310.191432998454, 2310.4801419680607, 2312.988435057831, 8829.072947340564, 8856.822863542693, 8896.822063558757, 8956.149165829302, 9142.634294628207, 5234.084035293847, 5349.037173308803, 5361.035013697533, 5363.517283444469, 5366.838994830161, 3340.6659334066644, 3352.715019223369, 3389.745769067305, 3389.9661003389897, 3416.4021296273054, 1154.2324354304378, 1157.548556063136, 1158.5192145259707, 1159.6084698361915, 1160.9883901160965, 12490.81263781044, 12607.180533265308, 12607.243565386198, 12628.936855315756, 12642.051846111579, 4338.349247612883, 4445.51099379068, 4537.546245375502, 4552.362669226311, 4567.36056952027, 9864.408135511892, 9870.654527091518, 9876.061774131445, 9890.60437582503, 9905.158061564847, 5201.791928322825, 5202.167653175549, 5202.401723801811, 5202.843914682566, 5203.115470370046, 4167.770772607475, 4623.815047398134, 4799.66402351832, 4810.494898035656, 4832.758362081881, 3832.1186127190344, 3873.4577159197734, 3943.940840887389, 3969.702272329587, 3975.264576053439, 1127.1321082766224, 1139.1342579639534, 1145.5990403358758, 1153.4924633161381, 1157.3056166300153, 777.8755399136224, 840.8570543007703, 928.90853247434, 988.461288597716, 1017.5268500147318, 6194.938050619527, 6202.627842329474, 6215.9378406215355, 6245.5401474058635, 6436.549441539048, 970.403202030746, 1006.6929586476049, 1009.8232809258351, 1014.5028935821394, 1019.8572199892021, 4189.162167566499, 4355.651547876162, 4356.803943822536, 4364.367166760865, 4365.476142862877, 10918.672439826818, 11188.0, 11199.040167970572, 11241.213115081866, 11271.605493807678, 10580.0, 10951.507182176822, 10994.120470362352, 11122.49948752308, 11291.209615327012, 8119.79700507492, 8185.79535511617, 8190.221928916743, 8217.506949583045, 8252.587370631445, 6046.57673962836, 6314.368563143649, 6389.9041514376395, 6405.679716014274, 6470.223573171062, 9661.13049825491, 10139.695809125738, 10225.386476811414, 10278.434686092038, 10297.897021029694, 10187.235957303084, 10187.541560629938, 10332.741681458023, 10333.74165645865, 10346.689599312032, 7196.604186769778, 7459.0, 7613.5431874087735, 7961.084475285416, 8091.797705057421, 8442.873356899774, 8468.153184681483, 8531.23218910301, 8537.402381833212, 8542.231199192103, 7378.114626244885, 7534.623268836426, 7581.786914093718, 7590.8102297443, 7687.7309294176675, 7364.079490063742, 7451.3666338361845, 7508.061492313461, 7535.171131175457, 7685.5004424712215, 6973.372396484341, 7010.614416207158, 7034.261402552863, 7037.437005039482, 7039.120109986252, 4969.527894849984, 5116.1046816806165, 5242.370915490165, 5245.0821106307, 5272.76272567743, 5289.550388217045, 5311.123664595299, 5338.46615338463, 5365.651232669864, 5390.218418329398], "value": 4655.748033561788, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [318.6399368713355, 324.6445142568889, 325.5166078373616, 330.2931726106133, 333.4631243697647, 5324.174752913295, 5327.481667724699, 5377.542908852747, 5381.923615276941, 5396.460353964597, 5233.764480598373, 5318.441563635821, 5332.706701131437, 5334.959682861843, 5372.194170874361, 4021.8391264349466, 4075.2257071156387, 4183.518895327031, 4215.082137627388, 4215.135897141079, 4149.692846753263, 4178.185253875496, 4182.682455026672, 4190.350495673176, 4203.600657937506, 4001.8799436016966, 4144.689148313873, 4177.289860723669, 4187.8324867005285, 4194.3498757692605, 4079.8984274245936, 4148.668106551469, 4179.6029377209115, 4188.350805625133, 4188.560201178893, 3693.0, 3707.4253490708984, 3715.6284371562897, 3717.739758216926, 3718.7025037996896, 5265.315508983846, 5266.315379000744, 5268.92096618551, 5273.209018647195, 5274.340707411574, 4427.468703755538, 4694.389729335198, 4712.952870471286, 4713.646476514241, 4715.669903106784, 5453.509184173404, 5478.0, 5486.259354987065, 5494.395616482184, 5564.0, 3990.7206495545324, 3992.845651934968, 3993.4409182714153, 3995.220931918277, 4000.079981604247, 5565.5825813063775, 5727.656340619576, 5732.140178973187, 5744.138379243147, 5761.683107429089, 3999.6600288975765, 4004.4994375703036, 4009.8997525061523, 4027.718059735849, 4042.211768705133, 4082.4488694026522, 4082.714210005271, 4099.569545197771, 4100.815463304159, 4111.383292506088, 4574.336721175411, 4640.976795116003, 4650.930236046462, 4684.414448193976, 4696.671233013656, 5512.91730624041, 5533.1976863354585, 5559.694216818114, 5561.416051314553, 5580.1629755537, 1406.69052808382, 1417.2346932656455, 1418.7517184492672, 1424.7577911755027, 1428.2573062007905, 898.4294972692256, 908.4957848394205, 924.8936372317135, 931.6226928094133, 947.673052796784, 5352.625316227826, 5383.353997520323, 5396.952285785661, 5397.163439666858, 5402.459754024566, 5637.267155269788, 5641.40765219646, 5679.574031947621, 5702.914456283159, 5709.143628455682, 5311.840644780663, 5363.651362661414, 5380.3274590676165, 5395.8938417624295, 5443.755031023614, 2975.494165991743, 2978.8212707237635, 2985.000024991652, 2995.82025078496, 3004.6544647365395, 5533.474319939599, 5776.631581051749, 5806.332271788799, 5861.824145275648, 5882.941170588325, 5641.915371269434, 5686.2039314496005, 5695.316562012502, 5699.971500142473, 5705.258316418839, 5741.224934633855, 5746.655200687972, 5757.65454072757, 5828.213191219216, 5835.153902684002, 5460.31746031746, 5533.6403133796175, 5581.804636837854, 5614.831555053355, 5616.887662246814, 5550.4745340869, 5552.389237183826, 5562.276904002454, 5595.384507704231, 5610.9158362623775, 5648.943510564842, 5784.21913041734, 5788.411185065118, 5817.563682723898, 5845.298564172326, 4017.116234428421, 4019.2363450945395, 4029.6574791141907, 4041.4139949707715, 4066.2477441673386, 5654.293213348332, 5661.377248502744, 5666.931569977011, 5722.7710891563875, 5742.5118864895285, 5441.122812629795, 5579.497845193952, 5585.385607583244, 5590.217369568182, 5590.972045139748, 5505.146702261156, 5517.2275881377445, 5518.972405137949, 5522.3649280331665, 5526.834194974157, 5251.501107394792, 5344.732763361894, 5346.8395948121615, 5356.276902618097, 5449.64577302474, 5561.553995960999, 5567.24842146305, 5577.776888924398, 5593.916091258553, 5595.888082238251, 5411.972940135274, 5432.29380180574, 5477.616566840283, 5509.862253443535, 5514.393416724238], "value": 4224.818260073024, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [756.1946526948799, 774.8992630957974, 842.4566154830131, 846.2848892685682, 879.2394578689432, 15635.687286254268, 16403.58991025225, 16486.587835304108, 16493.422730204446, 16503.50489485316, 14399.78400323996, 14506.202158881257, 14672.413103475876, 14683.559493215194, 14768.556943291691, 646.8156575376019, 760.6272926266117, 779.4465929190268, 783.2676447521585, 795.3915254830059, 792.3938187286731, 796.7769024673072, 798.1260519730886, 798.3054742374143, 798.3134504326304, 833.4957350802767, 843.8565443874556, 844.0588743550927, 844.6536919862857, 845.0915266088948, 681.4071757570896, 813.8616435206029, 835.7367429259824, 839.2530647723531, 841.7264389073575, 607.7234858139536, 609.0438012320658, 609.0620444515441, 609.7012463892705, 610.3743662745677, 14905.552833415015, 14930.626734331729, 14967.0, 14976.550703478804, 14983.0, 14116.505922292774, 14356.569302920929, 14454.0, 14484.42062317506, 14629.853701462956, 12974.545890893867, 13030.80453793194, 13116.6720831979, 13149.802752958713, 13693.863061369459, 4490.9304411159765, 4523.683342166049, 4598.379218805452, 4662.790174442158, 4742.549457801503, 64734.352656473304, 67094.66452667705, 67243.3275667242, 72377.0, 72487.27512724858, 12024.87975120255, 12082.637520874388, 12100.213486123374, 12200.694982625328, 12624.684382890502, 21971.23100691468, 21986.230481933057, 22018.44953876134, 22038.669419958715, 22059.558808824055, 8941.731748047569, 8944.105589441004, 9012.63949442028, 9019.413738107001, 9310.72067837966, 4975.726335051534, 5051.318072060299, 5074.771635276422, 5090.9236361454605, 5119.667221630582, 3438.1920248742026, 3543.1496440854526, 3546.1843775931166, 3548.4854696068924, 3554.0937061049267, 604.7067172421372, 620.8230654263514, 625.1716475669756, 635.3455940381415, 639.4852144024105, 722.7723267170825, 747.4356860570234, 763.5991104670093, 771.8572064168147, 775.8215610409637, 10243.641472548425, 10262.640807571699, 10273.589056437808, 10488.475576221159, 10573.488341884702, 656.3633275722541, 675.9556485230232, 705.5272967112047, 726.3680597879772, 745.3738859358057, 4854.781534830941, 4902.362692849907, 4966.652334336562, 4978.427480839678, 4987.750612469435, 112218.43890780494, 113605.0, 117062.0, 122050.96413912514, 122355.0, 102661.0, 104269.0, 105009.0, 105589.0, 105736.0, 85044.57477712572, 85407.57296213479, 87393.99999999873, 87838.56080719683, 89593.65609515863, 10333.586656533655, 10342.31899945207, 10532.631357902437, 10634.0, 10891.0, 50271.0, 51588.74205628948, 52313.21530177126, 52346.21480677717, 53812.461875380744, 72472.27527724655, 77516.61241693981, 77548.22451775636, 77833.61083194548, 78241.21758782567, 12584.93707531493, 12672.619821405373, 12782.48870045225, 12804.167729097579, 13912.095713778572, 14482.203478808346, 14742.336594853043, 15142.470013549473, 15185.0, 16138.838611614203, 13864.653383665489, 14274.0, 14421.351039203471, 14431.639209019859, 14891.255437228312, 13999.300034998005, 14300.213488258245, 14320.14079155254, 14446.855531444551, 14481.92759036198, 13778.448862045407, 13867.722645547234, 13943.30283485842, 13982.930085349508, 14017.158970461805, 11058.093761183436, 11109.444527773741, 11223.158263130135, 11309.604163854226, 11968.0, 11971.820422693492, 12034.458449369624, 12135.767846132328, 12434.689132771753, 12475.438605262603], "value": 7769.356770050307, "unit": "score"}], "name": "dromaeo_css", "value": 7298.82788710092, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 111.0, 110.0, 110.0, 112.0, 111.0, 111.0, 112.0, 113.0, 112.0], "value": 110.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 117.0, 120.0, 171.0, 120.0, 123.0, 146.0, 116.0, 159.0, 118.0], "value": 133.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 159.0, 158.0, 160.0, 159.0, 161.0, 161.0, 160.0, 159.0], "value": 159.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 126.0, 75.0, 75.0, 74.0, 75.0, 103.0, 76.0], "value": 82.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 115.0, 84.0, 85.0, 85.0, 126.0, 84.0, 85.0, 120.0], "value": 95.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 118.0, 117.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 147.0, 146.0, 145.0, 146.0, 146.0, 145.0, 145.0], "value": 145.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 96.0, 95.0, 95.0, 95.0, 94.0, 95.0, 96.0, 95.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 53.0, 54.0, 53.0, 52.0, 51.0, 53.0, 53.0, 51.0, 53.0], "value": 52.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 63.0, 62.0, 61.0, 62.0, 62.0, 61.0, 62.0, 63.0, 62.0], "value": 61.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 74.0, 73.0, 76.0, 84.0, 74.0, 83.0, 74.0, 75.0, 77.0], "value": 76.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 127.0, 118.0, 124.0, 119.0, 119.0, 122.0, 127.0, 158.0, 119.0], "value": 125.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 168.0, 157.0, 159.0, 157.0, 161.0, 159.0, 166.0, 160.0, 156.0], "value": 160.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 64.0, 64.0, 64.0, 64.0, 63.0, 67.0, 64.0, 62.0], "value": 64.0, "unit": "score"}], "name": "kraken", "value": 1480.8, "alertThreshold": 2.0}]} 23:29:40 INFO - Return code: 0 23:29:40 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 23:29:40 INFO - # TBPL SUCCESS # 23:29:40 INFO - Running post-action listener: _resource_record_post_action 23:29:40 INFO - ##### 23:29:40 INFO - ##### Finished run-tests step (success) 23:29:40 INFO - ##### 23:29:40 INFO - Running post-run listener: _resource_record_post_run 23:29:40 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 45056; Write bytes: 297803776; Read time: 152; Write time: 328640 23:29:40 INFO - TinderboxPrint: CPU usage
13.0% 23:29:40 INFO - TinderboxPrint: I/O read bytes / time
45,056 / 152 23:29:40 INFO - TinderboxPrint: I/O write bytes / time
297,803,776 / 328,640 23:29:40 INFO - TinderboxPrint: CPU idle
8,284.3 (87.0%) 23:29:40 INFO - TinderboxPrint: CPU user
1,193.9 (12.5%) 23:29:40 INFO - TinderboxPrint: Swap in / out
0 / 0 23:29:40 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 5271552; Read time: 0; Write time: 384 23:29:40 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 40960; Write bytes: 292532224; Read time: 132; Write time: 328256 23:29:41 INFO - Running post-run listener: _upload_blobber_files 23:29:41 INFO - Blob upload gear active. 23:29:41 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 23:29:41 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 23:29:41 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', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 23:29:41 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 Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 23:29:41 INFO - (blobuploader) - INFO - Open directory for files ... 23:29:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 23:29:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:29:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:29:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 23:29:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:29:42 INFO - (blobuploader) - INFO - Done attempting. 23:29:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 23:29:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:29:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:29:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 23:29:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:29:43 INFO - (blobuploader) - INFO - Done attempting. 23:29:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 23:29:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:29:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:29:47 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 23:29:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:29:47 INFO - (blobuploader) - INFO - Done attempting. 23:29:47 INFO - (blobuploader) - INFO - Iteration through files over. 23:29:47 INFO - Return code: 0 23:29:47 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 23:29:47 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 23:29:47 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/dbd3a3b424fa872996ef67348a6c72ed2e8ffc4d9fe2e8b8d50c41b3142ee1349f8bbba31c4ee775187fa070faed54023b7f53644f8ea27df5f08f6b12442696", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/49e24627d852be2d059d40fae9f496a83f88a64e04646c8f57d9438ba98a994104b1c1b4be482cd1d3d47940c9bbecdab5a14d4a86178183b3880da580a5c11f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a8523ae80a44d2329334c6051f7ddaee7f9609009b1bc3ad7ee1f9c96b1efc39fc27fb35d5d546067fa0908dbccf4fd7c05408a9b0ce5110a569244295a5972d"} 23:29:47 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 23:29:47 INFO - Writing to file /builds/slave/test/properties/blobber_files 23:29:47 INFO - Contents: 23:29:47 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/dbd3a3b424fa872996ef67348a6c72ed2e8ffc4d9fe2e8b8d50c41b3142ee1349f8bbba31c4ee775187fa070faed54023b7f53644f8ea27df5f08f6b12442696", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/49e24627d852be2d059d40fae9f496a83f88a64e04646c8f57d9438ba98a994104b1c1b4be482cd1d3d47940c9bbecdab5a14d4a86178183b3880da580a5c11f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a8523ae80a44d2329334c6051f7ddaee7f9609009b1bc3ad7ee1f9c96b1efc39fc27fb35d5d546067fa0908dbccf4fd7c05408a9b0ce5110a569244295a5972d"} 23:29:47 INFO - Running post-run listener: copy_logs_to_upload_dir 23:29:47 INFO - Copying logs to upload dir... 23:29:47 INFO - mkdir: /builds/slave/test/build/upload/logs 23:29:47 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1244.484842 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-07-07 23:29:47.045604) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-07 23:29:47.049164) ========= 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=14ef55db36f7623abb31b9cf000001d5-1467957784.914821-962732232 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/dbd3a3b424fa872996ef67348a6c72ed2e8ffc4d9fe2e8b8d50c41b3142ee1349f8bbba31c4ee775187fa070faed54023b7f53644f8ea27df5f08f6b12442696", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/49e24627d852be2d059d40fae9f496a83f88a64e04646c8f57d9438ba98a994104b1c1b4be482cd1d3d47940c9bbecdab5a14d4a86178183b3880da580a5c11f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a8523ae80a44d2329334c6051f7ddaee7f9609009b1bc3ad7ee1f9c96b1efc39fc27fb35d5d546067fa0908dbccf4fd7c05408a9b0ce5110a569244295a5972d"} build_url:https://queue.taskcluster.net/v1/task/Sve-B5ImQDq2r89yn4q2Fw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011471 build_url: 'https://queue.taskcluster.net/v1/task/Sve-B5ImQDq2r89yn4q2Fw/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/Fx-Team/sha512/dbd3a3b424fa872996ef67348a6c72ed2e8ffc4d9fe2e8b8d50c41b3142ee1349f8bbba31c4ee775187fa070faed54023b7f53644f8ea27df5f08f6b12442696", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/49e24627d852be2d059d40fae9f496a83f88a64e04646c8f57d9438ba98a994104b1c1b4be482cd1d3d47940c9bbecdab5a14d4a86178183b3880da580a5c11f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a8523ae80a44d2329334c6051f7ddaee7f9609009b1bc3ad7ee1f9c96b1efc39fc27fb35d5d546067fa0908dbccf4fd7c05408a9b0ce5110a569244295a5972d"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-07 23:29:47.078600) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 23:29:47.078955) ========= 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=14ef55db36f7623abb31b9cf000001d5-1467957784.914821-962732232 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004428 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 23:29:47.160665) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-07 23:29:47.160990) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-07 23:29:47.161326) ========= ========= Total master_lag: 0.21 =========